Oct 8 19:29:30.202700 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd083] Oct 8 19:29:30.202744 kernel: Linux version 6.6.54-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 Tue Oct 8 18:22:02 -00 2024 Oct 8 19:29:30.202769 kernel: KASLR disabled due to lack of seed Oct 8 19:29:30.202785 kernel: efi: EFI v2.7 by EDK II Oct 8 19:29:30.202801 kernel: efi: SMBIOS=0x7bed0000 SMBIOS 3.0=0x7beb0000 ACPI=0x786e0000 ACPI 2.0=0x786e0014 MEMATTR=0x7b003a98 MEMRESERVE=0x7852ee18 Oct 8 19:29:30.202817 kernel: ACPI: Early table checksum verification disabled Oct 8 19:29:30.202834 kernel: ACPI: RSDP 0x00000000786E0014 000024 (v02 AMAZON) Oct 8 19:29:30.202850 kernel: ACPI: XSDT 0x00000000786D00E8 000064 (v01 AMAZON AMZNFACP 00000001 01000013) Oct 8 19:29:30.202866 kernel: ACPI: FACP 0x00000000786B0000 000114 (v06 AMAZON AMZNFACP 00000001 AMZN 00000001) Oct 8 19:29:30.202881 kernel: ACPI: DSDT 0x0000000078640000 00159D (v02 AMAZON AMZNDSDT 00000001 INTL 20160527) Oct 8 19:29:30.202902 kernel: ACPI: APIC 0x00000000786C0000 000108 (v04 AMAZON AMZNAPIC 00000001 AMZN 00000001) Oct 8 19:29:30.202917 kernel: ACPI: SPCR 0x00000000786A0000 000050 (v02 AMAZON AMZNSPCR 00000001 AMZN 00000001) Oct 8 19:29:30.202933 kernel: ACPI: GTDT 0x0000000078690000 000060 (v02 AMAZON AMZNGTDT 00000001 AMZN 00000001) Oct 8 19:29:30.202949 kernel: ACPI: MCFG 0x0000000078680000 00003C (v02 AMAZON AMZNMCFG 00000001 AMZN 00000001) Oct 8 19:29:30.202967 kernel: ACPI: SLIT 0x0000000078670000 00002D (v01 AMAZON AMZNSLIT 00000001 AMZN 00000001) Oct 8 19:29:30.202987 kernel: ACPI: IORT 0x0000000078660000 000078 (v01 AMAZON AMZNIORT 00000001 AMZN 00000001) Oct 8 19:29:30.203004 kernel: ACPI: PPTT 0x0000000078650000 0000EC (v01 AMAZON AMZNPPTT 00000001 AMZN 00000001) Oct 8 19:29:30.203021 kernel: ACPI: SPCR: console: uart,mmio,0x90a0000,115200 Oct 8 19:29:30.203037 kernel: earlycon: uart0 at MMIO 0x00000000090a0000 (options '115200') Oct 8 19:29:30.203053 kernel: printk: bootconsole [uart0] enabled Oct 8 19:29:30.203069 kernel: NUMA: Failed to initialise from firmware Oct 8 19:29:30.203086 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000004b5ffffff] Oct 8 19:29:30.203102 kernel: NUMA: NODE_DATA [mem 0x4b583f800-0x4b5844fff] Oct 8 19:29:30.203118 kernel: Zone ranges: Oct 8 19:29:30.203135 kernel: DMA [mem 0x0000000040000000-0x00000000ffffffff] Oct 8 19:29:30.203151 kernel: DMA32 empty Oct 8 19:29:30.203171 kernel: Normal [mem 0x0000000100000000-0x00000004b5ffffff] Oct 8 19:29:30.203188 kernel: Movable zone start for each node Oct 8 19:29:30.203204 kernel: Early memory node ranges Oct 8 19:29:30.203220 kernel: node 0: [mem 0x0000000040000000-0x000000007862ffff] Oct 8 19:29:30.203237 kernel: node 0: [mem 0x0000000078630000-0x000000007863ffff] Oct 8 19:29:30.203253 kernel: node 0: [mem 0x0000000078640000-0x00000000786effff] Oct 8 19:29:30.203269 kernel: node 0: [mem 0x00000000786f0000-0x000000007872ffff] Oct 8 19:29:30.203285 kernel: node 0: [mem 0x0000000078730000-0x000000007bbfffff] Oct 8 19:29:30.203302 kernel: node 0: [mem 0x000000007bc00000-0x000000007bfdffff] Oct 8 19:29:30.203318 kernel: node 0: [mem 0x000000007bfe0000-0x000000007fffffff] Oct 8 19:29:30.203350 kernel: node 0: [mem 0x0000000400000000-0x00000004b5ffffff] Oct 8 19:29:30.203374 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000004b5ffffff] Oct 8 19:29:30.203399 kernel: On node 0, zone Normal: 8192 pages in unavailable ranges Oct 8 19:29:30.203419 kernel: psci: probing for conduit method from ACPI. Oct 8 19:29:30.203444 kernel: psci: PSCIv1.0 detected in firmware. Oct 8 19:29:30.203462 kernel: psci: Using standard PSCI v0.2 function IDs Oct 8 19:29:30.203481 kernel: psci: Trusted OS migration not required Oct 8 19:29:30.203503 kernel: psci: SMC Calling Convention v1.1 Oct 8 19:29:30.203520 kernel: percpu: Embedded 31 pages/cpu s86632 r8192 d32152 u126976 Oct 8 19:29:30.203538 kernel: pcpu-alloc: s86632 r8192 d32152 u126976 alloc=31*4096 Oct 8 19:29:30.203556 kernel: pcpu-alloc: [0] 0 [0] 1 Oct 8 19:29:30.203574 kernel: Detected PIPT I-cache on CPU0 Oct 8 19:29:30.203591 kernel: CPU features: detected: GIC system register CPU interface Oct 8 19:29:30.203608 kernel: CPU features: detected: Spectre-v2 Oct 8 19:29:30.203626 kernel: CPU features: detected: Spectre-v3a Oct 8 19:29:30.203643 kernel: CPU features: detected: Spectre-BHB Oct 8 19:29:30.203661 kernel: CPU features: detected: ARM erratum 1742098 Oct 8 19:29:30.203678 kernel: CPU features: detected: ARM errata 1165522, 1319367, or 1530923 Oct 8 19:29:30.203700 kernel: alternatives: applying boot alternatives Oct 8 19:29:30.203720 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=c838587f25bc3913a152d0e9ed071e943b77b8dea81b67c254bbd10c29051fd2 Oct 8 19:29:30.203739 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Oct 8 19:29:30.203756 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 8 19:29:30.203774 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 8 19:29:30.203791 kernel: Fallback order for Node 0: 0 Oct 8 19:29:30.203809 kernel: Built 1 zonelists, mobility grouping on. Total pages: 991872 Oct 8 19:29:30.203826 kernel: Policy zone: Normal Oct 8 19:29:30.203844 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 8 19:29:30.203861 kernel: software IO TLB: area num 2. Oct 8 19:29:30.203879 kernel: software IO TLB: mapped [mem 0x000000007c000000-0x0000000080000000] (64MB) Oct 8 19:29:30.203902 kernel: Memory: 3820472K/4030464K available (10240K kernel code, 2184K rwdata, 8080K rodata, 39104K init, 897K bss, 209992K reserved, 0K cma-reserved) Oct 8 19:29:30.203920 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Oct 8 19:29:30.203937 kernel: trace event string verifier disabled Oct 8 19:29:30.203955 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 8 19:29:30.203973 kernel: rcu: RCU event tracing is enabled. Oct 8 19:29:30.203992 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Oct 8 19:29:30.204009 kernel: Trampoline variant of Tasks RCU enabled. Oct 8 19:29:30.204027 kernel: Tracing variant of Tasks RCU enabled. Oct 8 19:29:30.204045 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 8 19:29:30.204062 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Oct 8 19:29:30.204079 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 8 19:29:30.204101 kernel: GICv3: 96 SPIs implemented Oct 8 19:29:30.204118 kernel: GICv3: 0 Extended SPIs implemented Oct 8 19:29:30.204136 kernel: Root IRQ handler: gic_handle_irq Oct 8 19:29:30.204153 kernel: GICv3: GICv3 features: 16 PPIs Oct 8 19:29:30.204170 kernel: GICv3: CPU0: found redistributor 0 region 0:0x0000000010200000 Oct 8 19:29:30.204188 kernel: ITS [mem 0x10080000-0x1009ffff] Oct 8 19:29:30.204205 kernel: ITS@0x0000000010080000: allocated 8192 Devices @4000c0000 (indirect, esz 8, psz 64K, shr 1) Oct 8 19:29:30.204223 kernel: ITS@0x0000000010080000: allocated 8192 Interrupt Collections @4000d0000 (flat, esz 8, psz 64K, shr 1) Oct 8 19:29:30.204240 kernel: GICv3: using LPI property table @0x00000004000e0000 Oct 8 19:29:30.204258 kernel: ITS: Using hypervisor restricted LPI range [128] Oct 8 19:29:30.204275 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000004000f0000 Oct 8 19:29:30.204292 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Oct 8 19:29:30.204315 kernel: arch_timer: cp15 timer(s) running at 83.33MHz (virt). Oct 8 19:29:30.204333 kernel: clocksource: arch_sys_counter: mask: 0x1ffffffffffffff max_cycles: 0x13381ebeec, max_idle_ns: 440795203145 ns Oct 8 19:29:30.205443 kernel: sched_clock: 57 bits at 83MHz, resolution 12ns, wraps every 4398046511100ns Oct 8 19:29:30.205464 kernel: Console: colour dummy device 80x25 Oct 8 19:29:30.205482 kernel: printk: console [tty1] enabled Oct 8 19:29:30.205500 kernel: ACPI: Core revision 20230628 Oct 8 19:29:30.205518 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 166.66 BogoMIPS (lpj=83333) Oct 8 19:29:30.205536 kernel: pid_max: default: 32768 minimum: 301 Oct 8 19:29:30.205555 kernel: LSM: initializing lsm=lockdown,capability,selinux,integrity Oct 8 19:29:30.205572 kernel: SELinux: Initializing. Oct 8 19:29:30.205620 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 8 19:29:30.205641 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 8 19:29:30.205660 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1. Oct 8 19:29:30.205678 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1. Oct 8 19:29:30.205697 kernel: rcu: Hierarchical SRCU implementation. Oct 8 19:29:30.205716 kernel: rcu: Max phase no-delay instances is 400. Oct 8 19:29:30.205735 kernel: Platform MSI: ITS@0x10080000 domain created Oct 8 19:29:30.205752 kernel: PCI/MSI: ITS@0x10080000 domain created Oct 8 19:29:30.205770 kernel: Remapping and enabling EFI services. Oct 8 19:29:30.205794 kernel: smp: Bringing up secondary CPUs ... Oct 8 19:29:30.205811 kernel: Detected PIPT I-cache on CPU1 Oct 8 19:29:30.205829 kernel: GICv3: CPU1: found redistributor 1 region 0:0x0000000010220000 Oct 8 19:29:30.205847 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000400100000 Oct 8 19:29:30.205864 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd083] Oct 8 19:29:30.205882 kernel: smp: Brought up 1 node, 2 CPUs Oct 8 19:29:30.205900 kernel: SMP: Total of 2 processors activated. Oct 8 19:29:30.205918 kernel: CPU features: detected: 32-bit EL0 Support Oct 8 19:29:30.205935 kernel: CPU features: detected: 32-bit EL1 Support Oct 8 19:29:30.205958 kernel: CPU features: detected: CRC32 instructions Oct 8 19:29:30.205976 kernel: CPU: All CPU(s) started at EL1 Oct 8 19:29:30.206005 kernel: alternatives: applying system-wide alternatives Oct 8 19:29:30.206027 kernel: devtmpfs: initialized Oct 8 19:29:30.206046 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 8 19:29:30.206065 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Oct 8 19:29:30.206083 kernel: pinctrl core: initialized pinctrl subsystem Oct 8 19:29:30.206102 kernel: SMBIOS 3.0.0 present. Oct 8 19:29:30.206120 kernel: DMI: Amazon EC2 a1.large/, BIOS 1.0 11/1/2018 Oct 8 19:29:30.206143 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Oct 8 19:29:30.206162 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 8 19:29:30.206180 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 8 19:29:30.206199 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 8 19:29:30.206218 kernel: audit: initializing netlink subsys (disabled) Oct 8 19:29:30.206236 kernel: audit: type=2000 audit(0.295:1): state=initialized audit_enabled=0 res=1 Oct 8 19:29:30.206255 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 8 19:29:30.206277 kernel: cpuidle: using governor menu Oct 8 19:29:30.206315 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 8 19:29:30.206353 kernel: ASID allocator initialised with 65536 entries Oct 8 19:29:30.206385 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 8 19:29:30.206405 kernel: Serial: AMBA PL011 UART driver Oct 8 19:29:30.206424 kernel: Modules: 17584 pages in range for non-PLT usage Oct 8 19:29:30.206442 kernel: Modules: 509104 pages in range for PLT usage Oct 8 19:29:30.206461 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Oct 8 19:29:30.206479 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Oct 8 19:29:30.206505 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Oct 8 19:29:30.206524 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Oct 8 19:29:30.206543 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Oct 8 19:29:30.206561 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Oct 8 19:29:30.206580 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Oct 8 19:29:30.206599 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Oct 8 19:29:30.206617 kernel: ACPI: Added _OSI(Module Device) Oct 8 19:29:30.206635 kernel: ACPI: Added _OSI(Processor Device) Oct 8 19:29:30.206654 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Oct 8 19:29:30.206676 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 8 19:29:30.206695 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 8 19:29:30.206713 kernel: ACPI: Interpreter enabled Oct 8 19:29:30.206732 kernel: ACPI: Using GIC for interrupt routing Oct 8 19:29:30.206750 kernel: ACPI: MCFG table detected, 1 entries Oct 8 19:29:30.206768 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-0f]) Oct 8 19:29:30.207112 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 8 19:29:30.207329 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 8 19:29:30.210689 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 8 19:29:30.210902 kernel: acpi PNP0A08:00: ECAM area [mem 0x20000000-0x20ffffff] reserved by PNP0C02:00 Oct 8 19:29:30.211107 kernel: acpi PNP0A08:00: ECAM at [mem 0x20000000-0x20ffffff] for [bus 00-0f] Oct 8 19:29:30.211133 kernel: ACPI: Remapped I/O 0x000000001fff0000 to [io 0x0000-0xffff window] Oct 8 19:29:30.211152 kernel: acpiphp: Slot [1] registered Oct 8 19:29:30.211171 kernel: acpiphp: Slot [2] registered Oct 8 19:29:30.211189 kernel: acpiphp: Slot [3] registered Oct 8 19:29:30.211208 kernel: acpiphp: Slot [4] registered Oct 8 19:29:30.211226 kernel: acpiphp: Slot [5] registered Oct 8 19:29:30.211251 kernel: acpiphp: Slot [6] registered Oct 8 19:29:30.211269 kernel: acpiphp: Slot [7] registered Oct 8 19:29:30.211287 kernel: acpiphp: Slot [8] registered Oct 8 19:29:30.211306 kernel: acpiphp: Slot [9] registered Oct 8 19:29:30.211324 kernel: acpiphp: Slot [10] registered Oct 8 19:29:30.211379 kernel: acpiphp: Slot [11] registered Oct 8 19:29:30.211406 kernel: acpiphp: Slot [12] registered Oct 8 19:29:30.211426 kernel: acpiphp: Slot [13] registered Oct 8 19:29:30.211446 kernel: acpiphp: Slot [14] registered Oct 8 19:29:30.211473 kernel: acpiphp: Slot [15] registered Oct 8 19:29:30.211493 kernel: acpiphp: Slot [16] registered Oct 8 19:29:30.211512 kernel: acpiphp: Slot [17] registered Oct 8 19:29:30.211531 kernel: acpiphp: Slot [18] registered Oct 8 19:29:30.211551 kernel: acpiphp: Slot [19] registered Oct 8 19:29:30.211570 kernel: acpiphp: Slot [20] registered Oct 8 19:29:30.211589 kernel: acpiphp: Slot [21] registered Oct 8 19:29:30.211608 kernel: acpiphp: Slot [22] registered Oct 8 19:29:30.211627 kernel: acpiphp: Slot [23] registered Oct 8 19:29:30.211646 kernel: acpiphp: Slot [24] registered Oct 8 19:29:30.211672 kernel: acpiphp: Slot [25] registered Oct 8 19:29:30.211692 kernel: acpiphp: Slot [26] registered Oct 8 19:29:30.211712 kernel: acpiphp: Slot [27] registered Oct 8 19:29:30.211732 kernel: acpiphp: Slot [28] registered Oct 8 19:29:30.211751 kernel: acpiphp: Slot [29] registered Oct 8 19:29:30.211770 kernel: acpiphp: Slot [30] registered Oct 8 19:29:30.211788 kernel: acpiphp: Slot [31] registered Oct 8 19:29:30.211807 kernel: PCI host bridge to bus 0000:00 Oct 8 19:29:30.212089 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xffffffff window] Oct 8 19:29:30.212319 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 8 19:29:30.214616 kernel: pci_bus 0000:00: root bus resource [mem 0x400000000000-0x407fffffffff window] Oct 8 19:29:30.214825 kernel: pci_bus 0000:00: root bus resource [bus 00-0f] Oct 8 19:29:30.215064 kernel: pci 0000:00:00.0: [1d0f:0200] type 00 class 0x060000 Oct 8 19:29:30.215292 kernel: pci 0000:00:01.0: [1d0f:8250] type 00 class 0x070003 Oct 8 19:29:30.215542 kernel: pci 0000:00:01.0: reg 0x10: [mem 0x80118000-0x80118fff] Oct 8 19:29:30.215780 kernel: pci 0000:00:04.0: [1d0f:8061] type 00 class 0x010802 Oct 8 19:29:30.215990 kernel: pci 0000:00:04.0: reg 0x10: [mem 0x80114000-0x80117fff] Oct 8 19:29:30.216199 kernel: pci 0000:00:04.0: PME# supported from D0 D1 D2 D3hot D3cold Oct 8 19:29:30.216549 kernel: pci 0000:00:05.0: [1d0f:ec20] type 00 class 0x020000 Oct 8 19:29:30.216763 kernel: pci 0000:00:05.0: reg 0x10: [mem 0x80110000-0x80113fff] Oct 8 19:29:30.216965 kernel: pci 0000:00:05.0: reg 0x18: [mem 0x80000000-0x800fffff pref] Oct 8 19:29:30.217165 kernel: pci 0000:00:05.0: reg 0x20: [mem 0x80100000-0x8010ffff] Oct 8 19:29:30.217404 kernel: pci 0000:00:05.0: PME# supported from D0 D1 D2 D3hot D3cold Oct 8 19:29:30.217637 kernel: pci 0000:00:05.0: BAR 2: assigned [mem 0x80000000-0x800fffff pref] Oct 8 19:29:30.217852 kernel: pci 0000:00:05.0: BAR 4: assigned [mem 0x80100000-0x8010ffff] Oct 8 19:29:30.218066 kernel: pci 0000:00:04.0: BAR 0: assigned [mem 0x80110000-0x80113fff] Oct 8 19:29:30.218270 kernel: pci 0000:00:05.0: BAR 0: assigned [mem 0x80114000-0x80117fff] Oct 8 19:29:30.220580 kernel: pci 0000:00:01.0: BAR 0: assigned [mem 0x80118000-0x80118fff] Oct 8 19:29:30.220784 kernel: pci_bus 0000:00: resource 4 [mem 0x80000000-0xffffffff window] Oct 8 19:29:30.220977 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 8 19:29:30.221160 kernel: pci_bus 0000:00: resource 6 [mem 0x400000000000-0x407fffffffff window] Oct 8 19:29:30.221186 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Oct 8 19:29:30.221206 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Oct 8 19:29:30.221225 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Oct 8 19:29:30.221246 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Oct 8 19:29:30.221265 kernel: iommu: Default domain type: Translated Oct 8 19:29:30.221284 kernel: iommu: DMA domain TLB invalidation policy: strict mode Oct 8 19:29:30.221308 kernel: efivars: Registered efivars operations Oct 8 19:29:30.221327 kernel: vgaarb: loaded Oct 8 19:29:30.221378 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 8 19:29:30.221399 kernel: VFS: Disk quotas dquot_6.6.0 Oct 8 19:29:30.221419 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 8 19:29:30.221438 kernel: pnp: PnP ACPI init Oct 8 19:29:30.221695 kernel: system 00:00: [mem 0x20000000-0x2fffffff] could not be reserved Oct 8 19:29:30.221726 kernel: pnp: PnP ACPI: found 1 devices Oct 8 19:29:30.221751 kernel: NET: Registered PF_INET protocol family Oct 8 19:29:30.221771 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 8 19:29:30.221790 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 8 19:29:30.221809 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Oct 8 19:29:30.221827 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 8 19:29:30.221848 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Oct 8 19:29:30.221866 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 8 19:29:30.221885 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 8 19:29:30.221903 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 8 19:29:30.221927 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Oct 8 19:29:30.221946 kernel: PCI: CLS 0 bytes, default 64 Oct 8 19:29:30.221964 kernel: kvm [1]: HYP mode not available Oct 8 19:29:30.221983 kernel: Initialise system trusted keyrings Oct 8 19:29:30.222002 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 8 19:29:30.222020 kernel: Key type asymmetric registered Oct 8 19:29:30.222038 kernel: Asymmetric key parser 'x509' registered Oct 8 19:29:30.222057 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Oct 8 19:29:30.222075 kernel: io scheduler mq-deadline registered Oct 8 19:29:30.222098 kernel: io scheduler kyber registered Oct 8 19:29:30.222117 kernel: io scheduler bfq registered Oct 8 19:29:30.222333 kernel: pl061_gpio ARMH0061:00: PL061 GPIO chip registered Oct 8 19:29:30.222427 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 8 19:29:30.222446 kernel: ACPI: button: Power Button [PWRB] Oct 8 19:29:30.222466 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1 Oct 8 19:29:30.222485 kernel: ACPI: button: Sleep Button [SLPB] Oct 8 19:29:30.222503 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 8 19:29:30.222529 kernel: ACPI: \_SB_.PCI0.GSI2: Enabled at IRQ 37 Oct 8 19:29:30.222748 kernel: serial 0000:00:01.0: enabling device (0010 -> 0012) Oct 8 19:29:30.222774 kernel: printk: console [ttyS0] disabled Oct 8 19:29:30.222794 kernel: 0000:00:01.0: ttyS0 at MMIO 0x80118000 (irq = 14, base_baud = 115200) is a 16550A Oct 8 19:29:30.222813 kernel: printk: console [ttyS0] enabled Oct 8 19:29:30.222831 kernel: printk: bootconsole [uart0] disabled Oct 8 19:29:30.222850 kernel: thunder_xcv, ver 1.0 Oct 8 19:29:30.222868 kernel: thunder_bgx, ver 1.0 Oct 8 19:29:30.222887 kernel: nicpf, ver 1.0 Oct 8 19:29:30.222906 kernel: nicvf, ver 1.0 Oct 8 19:29:30.223136 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 8 19:29:30.223369 kernel: rtc-efi rtc-efi.0: setting system clock to 2024-10-08T19:29:29 UTC (1728415769) Oct 8 19:29:30.223399 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 8 19:29:30.223419 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 3 counters available Oct 8 19:29:30.223438 kernel: watchdog: Delayed init of the lockup detector failed: -19 Oct 8 19:29:30.223456 kernel: watchdog: Hard watchdog permanently disabled Oct 8 19:29:30.223475 kernel: NET: Registered PF_INET6 protocol family Oct 8 19:29:30.223493 kernel: Segment Routing with IPv6 Oct 8 19:29:30.223519 kernel: In-situ OAM (IOAM) with IPv6 Oct 8 19:29:30.223538 kernel: NET: Registered PF_PACKET protocol family Oct 8 19:29:30.223557 kernel: Key type dns_resolver registered Oct 8 19:29:30.223575 kernel: registered taskstats version 1 Oct 8 19:29:30.223594 kernel: Loading compiled-in X.509 certificates Oct 8 19:29:30.223613 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.54-flatcar: e5b54c43c129014ce5ace0e8cd7b641a0fcb136e' Oct 8 19:29:30.223632 kernel: Key type .fscrypt registered Oct 8 19:29:30.223650 kernel: Key type fscrypt-provisioning registered Oct 8 19:29:30.223670 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 8 19:29:30.223696 kernel: ima: Allocated hash algorithm: sha1 Oct 8 19:29:30.223717 kernel: ima: No architecture policies found Oct 8 19:29:30.223737 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Oct 8 19:29:30.223758 kernel: clk: Disabling unused clocks Oct 8 19:29:30.223777 kernel: Freeing unused kernel memory: 39104K Oct 8 19:29:30.223796 kernel: Run /init as init process Oct 8 19:29:30.223815 kernel: with arguments: Oct 8 19:29:30.223834 kernel: /init Oct 8 19:29:30.223852 kernel: with environment: Oct 8 19:29:30.223876 kernel: HOME=/ Oct 8 19:29:30.223895 kernel: TERM=linux Oct 8 19:29:30.223914 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Oct 8 19:29:30.223939 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Oct 8 19:29:30.223963 systemd[1]: Detected virtualization amazon. Oct 8 19:29:30.223984 systemd[1]: Detected architecture arm64. Oct 8 19:29:30.224005 systemd[1]: Running in initrd. Oct 8 19:29:30.224025 systemd[1]: No hostname configured, using default hostname. Oct 8 19:29:30.224050 systemd[1]: Hostname set to . Oct 8 19:29:30.224071 systemd[1]: Initializing machine ID from VM UUID. Oct 8 19:29:30.224092 systemd[1]: Queued start job for default target initrd.target. Oct 8 19:29:30.224113 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 8 19:29:30.224134 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 8 19:29:30.224157 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Oct 8 19:29:30.224177 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 8 19:29:30.224202 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Oct 8 19:29:30.224223 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Oct 8 19:29:30.224246 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Oct 8 19:29:30.224266 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Oct 8 19:29:30.224286 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 8 19:29:30.224306 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 8 19:29:30.224326 systemd[1]: Reached target paths.target - Path Units. Oct 8 19:29:30.225170 systemd[1]: Reached target slices.target - Slice Units. Oct 8 19:29:30.225194 systemd[1]: Reached target swap.target - Swaps. Oct 8 19:29:30.225215 systemd[1]: Reached target timers.target - Timer Units. Oct 8 19:29:30.225235 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Oct 8 19:29:30.225255 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 8 19:29:30.225276 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Oct 8 19:29:30.225296 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Oct 8 19:29:30.225316 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 8 19:29:30.225417 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 8 19:29:30.225450 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 8 19:29:30.225471 systemd[1]: Reached target sockets.target - Socket Units. Oct 8 19:29:30.225492 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Oct 8 19:29:30.225512 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 8 19:29:30.225532 systemd[1]: Finished network-cleanup.service - Network Cleanup. Oct 8 19:29:30.225552 systemd[1]: Starting systemd-fsck-usr.service... Oct 8 19:29:30.225572 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 8 19:29:30.225606 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 8 19:29:30.225639 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 8 19:29:30.225660 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Oct 8 19:29:30.225680 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 8 19:29:30.225700 systemd[1]: Finished systemd-fsck-usr.service. Oct 8 19:29:30.225770 systemd-journald[250]: Collecting audit messages is disabled. Oct 8 19:29:30.225820 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 8 19:29:30.225841 systemd-journald[250]: Journal started Oct 8 19:29:30.225883 systemd-journald[250]: Runtime Journal (/run/log/journal/ec22645a63ec13f6d1f75790cd86ac3a) is 8.0M, max 75.3M, 67.3M free. Oct 8 19:29:30.194462 systemd-modules-load[251]: Inserted module 'overlay' Oct 8 19:29:30.233633 systemd[1]: Started systemd-journald.service - Journal Service. Oct 8 19:29:30.236375 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Oct 8 19:29:30.234535 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 8 19:29:30.244443 systemd-modules-load[251]: Inserted module 'br_netfilter' Oct 8 19:29:30.246224 kernel: Bridge firewalling registered Oct 8 19:29:30.246558 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 8 19:29:30.267799 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 8 19:29:30.275636 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 8 19:29:30.282631 systemd[1]: Starting systemd-tmpfiles-setup.service - Create Volatile Files and Directories... Oct 8 19:29:30.283469 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 8 19:29:30.300647 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 8 19:29:30.324798 systemd[1]: Finished systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Oct 8 19:29:30.340948 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 8 19:29:30.352648 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 8 19:29:30.358470 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 8 19:29:30.383881 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 8 19:29:30.395740 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Oct 8 19:29:30.435639 dracut-cmdline[288]: dracut-dracut-053 Oct 8 19:29:30.442824 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=c838587f25bc3913a152d0e9ed071e943b77b8dea81b67c254bbd10c29051fd2 Oct 8 19:29:30.453990 systemd-resolved[284]: Positive Trust Anchors: Oct 8 19:29:30.454011 systemd-resolved[284]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 8 19:29:30.454070 systemd-resolved[284]: 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 Oct 8 19:29:30.621402 kernel: SCSI subsystem initialized Oct 8 19:29:30.629457 kernel: Loading iSCSI transport class v2.0-870. Oct 8 19:29:30.642471 kernel: iscsi: registered transport (tcp) Oct 8 19:29:30.665469 kernel: iscsi: registered transport (qla4xxx) Oct 8 19:29:30.665540 kernel: QLogic iSCSI HBA Driver Oct 8 19:29:30.717383 kernel: random: crng init done Oct 8 19:29:30.716668 systemd-resolved[284]: Defaulting to hostname 'linux'. Oct 8 19:29:30.720383 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 8 19:29:30.725315 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 8 19:29:30.751656 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Oct 8 19:29:30.765645 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Oct 8 19:29:30.799837 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Oct 8 19:29:30.799912 kernel: device-mapper: uevent: version 1.0.3 Oct 8 19:29:30.801580 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Oct 8 19:29:30.884362 kernel: raid6: neonx8 gen() 6651 MB/s Oct 8 19:29:30.886402 kernel: raid6: neonx4 gen() 6508 MB/s Oct 8 19:29:30.902387 kernel: raid6: neonx2 gen() 5419 MB/s Oct 8 19:29:30.919372 kernel: raid6: neonx1 gen() 3943 MB/s Oct 8 19:29:30.936384 kernel: raid6: int64x8 gen() 3786 MB/s Oct 8 19:29:30.953378 kernel: raid6: int64x4 gen() 3706 MB/s Oct 8 19:29:30.970392 kernel: raid6: int64x2 gen() 3580 MB/s Oct 8 19:29:30.988151 kernel: raid6: int64x1 gen() 2758 MB/s Oct 8 19:29:30.988212 kernel: raid6: using algorithm neonx8 gen() 6651 MB/s Oct 8 19:29:31.006146 kernel: raid6: .... xor() 4910 MB/s, rmw enabled Oct 8 19:29:31.006217 kernel: raid6: using neon recovery algorithm Oct 8 19:29:31.014758 kernel: xor: measuring software checksum speed Oct 8 19:29:31.014818 kernel: 8regs : 10971 MB/sec Oct 8 19:29:31.015859 kernel: 32regs : 11939 MB/sec Oct 8 19:29:31.017022 kernel: arm64_neon : 9567 MB/sec Oct 8 19:29:31.017055 kernel: xor: using function: 32regs (11939 MB/sec) Oct 8 19:29:31.104421 kernel: Btrfs loaded, zoned=no, fsverity=no Oct 8 19:29:31.123310 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Oct 8 19:29:31.132642 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 8 19:29:31.174021 systemd-udevd[470]: Using default interface naming scheme 'v255'. Oct 8 19:29:31.183326 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 8 19:29:31.194468 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Oct 8 19:29:31.232799 dracut-pre-trigger[475]: rd.md=0: removing MD RAID activation Oct 8 19:29:31.291721 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Oct 8 19:29:31.302631 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 8 19:29:31.419682 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 8 19:29:31.433772 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Oct 8 19:29:31.472100 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Oct 8 19:29:31.477140 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Oct 8 19:29:31.477524 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 8 19:29:31.481978 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 8 19:29:31.505693 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Oct 8 19:29:31.547478 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Oct 8 19:29:31.633081 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Oct 8 19:29:31.633154 kernel: ena 0000:00:05.0: enabling device (0010 -> 0012) Oct 8 19:29:31.639896 kernel: ena 0000:00:05.0: ENA device version: 0.10 Oct 8 19:29:31.640236 kernel: ena 0000:00:05.0: ENA controller version: 0.0.1 implementation version 1 Oct 8 19:29:31.644694 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 8 19:29:31.644950 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 8 19:29:31.649867 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 8 19:29:31.652025 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 8 19:29:31.678961 kernel: ena 0000:00:05.0: Elastic Network Adapter (ENA) found at mem 80114000, mac addr 06:03:76:37:a8:11 Oct 8 19:29:31.679276 kernel: ACPI: \_SB_.PCI0.GSI0: Enabled at IRQ 35 Oct 8 19:29:31.679305 kernel: nvme nvme0: pci function 0000:00:04.0 Oct 8 19:29:31.652296 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 8 19:29:31.654576 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Oct 8 19:29:31.668807 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 8 19:29:31.692189 kernel: nvme nvme0: 2/0/0 default/read/poll queues Oct 8 19:29:31.671295 (udev-worker)[517]: Network interface NamePolicy= disabled on kernel command line. Oct 8 19:29:31.706496 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Oct 8 19:29:31.706559 kernel: GPT:9289727 != 16777215 Oct 8 19:29:31.708021 kernel: GPT:Alternate GPT header not at the end of the disk. Oct 8 19:29:31.708079 kernel: GPT:9289727 != 16777215 Oct 8 19:29:31.708849 kernel: GPT: Use GNU Parted to correct GPT errors. Oct 8 19:29:31.708881 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Oct 8 19:29:31.722432 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 8 19:29:31.732704 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 8 19:29:31.768869 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 8 19:29:31.853497 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/nvme0n1p6 scanned by (udev-worker) (527) Oct 8 19:29:31.871561 kernel: BTRFS: device fsid a2a78d47-736b-4018-a518-3cfb16920575 devid 1 transid 36 /dev/nvme0n1p3 scanned by (udev-worker) (525) Oct 8 19:29:31.867107 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Amazon Elastic Block Store EFI-SYSTEM. Oct 8 19:29:31.975665 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Amazon Elastic Block Store ROOT. Oct 8 19:29:31.990013 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Amazon Elastic Block Store USR-A. Oct 8 19:29:31.990688 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Amazon Elastic Block Store USR-A. Oct 8 19:29:32.005564 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Oct 8 19:29:32.027769 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Oct 8 19:29:32.040373 disk-uuid[660]: Primary Header is updated. Oct 8 19:29:32.040373 disk-uuid[660]: Secondary Entries is updated. Oct 8 19:29:32.040373 disk-uuid[660]: Secondary Header is updated. Oct 8 19:29:32.048371 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Oct 8 19:29:32.056099 kernel: GPT:disk_guids don't match. Oct 8 19:29:32.056178 kernel: GPT: Use GNU Parted to correct GPT errors. Oct 8 19:29:32.057043 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Oct 8 19:29:32.067879 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Oct 8 19:29:33.068512 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Oct 8 19:29:33.069715 disk-uuid[661]: The operation has completed successfully. Oct 8 19:29:33.257274 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 8 19:29:33.257497 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Oct 8 19:29:33.295073 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Oct 8 19:29:33.304191 sh[1009]: Success Oct 8 19:29:33.332386 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Oct 8 19:29:33.432827 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Oct 8 19:29:33.455893 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Oct 8 19:29:33.464573 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Oct 8 19:29:33.484902 kernel: BTRFS info (device dm-0): first mount of filesystem a2a78d47-736b-4018-a518-3cfb16920575 Oct 8 19:29:33.484964 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Oct 8 19:29:33.486670 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Oct 8 19:29:33.488392 kernel: BTRFS info (device dm-0): disabling log replay at mount time Oct 8 19:29:33.488427 kernel: BTRFS info (device dm-0): using free space tree Oct 8 19:29:33.549380 kernel: BTRFS info (device dm-0): enabling ssd optimizations Oct 8 19:29:33.560581 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Oct 8 19:29:33.564487 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Oct 8 19:29:33.576620 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Oct 8 19:29:33.582640 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Oct 8 19:29:33.613744 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 95ed8f66-d8c4-4374-b329-28c20748d95f Oct 8 19:29:33.613823 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Oct 8 19:29:33.613851 kernel: BTRFS info (device nvme0n1p6): using free space tree Oct 8 19:29:33.620759 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Oct 8 19:29:33.638814 systemd[1]: mnt-oem.mount: Deactivated successfully. Oct 8 19:29:33.643440 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 95ed8f66-d8c4-4374-b329-28c20748d95f Oct 8 19:29:33.656041 systemd[1]: Finished ignition-setup.service - Ignition (setup). Oct 8 19:29:33.666761 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Oct 8 19:29:33.769445 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 8 19:29:33.782731 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 8 19:29:33.847760 systemd-networkd[1202]: lo: Link UP Oct 8 19:29:33.847787 systemd-networkd[1202]: lo: Gained carrier Oct 8 19:29:33.852575 systemd-networkd[1202]: Enumeration completed Oct 8 19:29:33.854187 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 8 19:29:33.858310 systemd-networkd[1202]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 8 19:29:33.858317 systemd-networkd[1202]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 8 19:29:33.858840 systemd[1]: Reached target network.target - Network. Oct 8 19:29:33.870191 systemd-networkd[1202]: eth0: Link UP Oct 8 19:29:33.870213 systemd-networkd[1202]: eth0: Gained carrier Oct 8 19:29:33.870233 systemd-networkd[1202]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 8 19:29:33.901481 systemd-networkd[1202]: eth0: DHCPv4 address 172.31.22.193/20, gateway 172.31.16.1 acquired from 172.31.16.1 Oct 8 19:29:34.031062 ignition[1119]: Ignition 2.18.0 Oct 8 19:29:34.031630 ignition[1119]: Stage: fetch-offline Oct 8 19:29:34.032188 ignition[1119]: no configs at "/usr/lib/ignition/base.d" Oct 8 19:29:34.032213 ignition[1119]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 8 19:29:34.032674 ignition[1119]: Ignition finished successfully Oct 8 19:29:34.042189 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Oct 8 19:29:34.050580 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Oct 8 19:29:34.083782 ignition[1212]: Ignition 2.18.0 Oct 8 19:29:34.085491 ignition[1212]: Stage: fetch Oct 8 19:29:34.086188 ignition[1212]: no configs at "/usr/lib/ignition/base.d" Oct 8 19:29:34.086215 ignition[1212]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 8 19:29:34.086404 ignition[1212]: PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 8 19:29:34.102974 ignition[1212]: PUT result: OK Oct 8 19:29:34.105692 ignition[1212]: parsed url from cmdline: "" Oct 8 19:29:34.105846 ignition[1212]: no config URL provided Oct 8 19:29:34.105930 ignition[1212]: reading system config file "/usr/lib/ignition/user.ign" Oct 8 19:29:34.105958 ignition[1212]: no config at "/usr/lib/ignition/user.ign" Oct 8 19:29:34.106139 ignition[1212]: PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 8 19:29:34.109932 ignition[1212]: PUT result: OK Oct 8 19:29:34.110034 ignition[1212]: GET http://169.254.169.254/2019-10-01/user-data: attempt #1 Oct 8 19:29:34.114435 ignition[1212]: GET result: OK Oct 8 19:29:34.114551 ignition[1212]: parsing config with SHA512: 036c99058a5eeece972b0b7e839499f99b849071e36357539c25610be46b39791b2604a58cbea86ea77440e80a5393096fd49c62884a9390b6cf2af024b02ebf Oct 8 19:29:34.130850 unknown[1212]: fetched base config from "system" Oct 8 19:29:34.130877 unknown[1212]: fetched base config from "system" Oct 8 19:29:34.130892 unknown[1212]: fetched user config from "aws" Oct 8 19:29:34.132687 ignition[1212]: fetch: fetch complete Oct 8 19:29:34.132700 ignition[1212]: fetch: fetch passed Oct 8 19:29:34.132799 ignition[1212]: Ignition finished successfully Oct 8 19:29:34.143105 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Oct 8 19:29:34.158619 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Oct 8 19:29:34.183449 ignition[1219]: Ignition 2.18.0 Oct 8 19:29:34.183470 ignition[1219]: Stage: kargs Oct 8 19:29:34.184044 ignition[1219]: no configs at "/usr/lib/ignition/base.d" Oct 8 19:29:34.184068 ignition[1219]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 8 19:29:34.184203 ignition[1219]: PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 8 19:29:34.192544 ignition[1219]: PUT result: OK Oct 8 19:29:34.196758 ignition[1219]: kargs: kargs passed Oct 8 19:29:34.196898 ignition[1219]: Ignition finished successfully Oct 8 19:29:34.201830 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Oct 8 19:29:34.209670 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Oct 8 19:29:34.243940 ignition[1227]: Ignition 2.18.0 Oct 8 19:29:34.243972 ignition[1227]: Stage: disks Oct 8 19:29:34.245661 ignition[1227]: no configs at "/usr/lib/ignition/base.d" Oct 8 19:29:34.245692 ignition[1227]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 8 19:29:34.246783 ignition[1227]: PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 8 19:29:34.252655 ignition[1227]: PUT result: OK Oct 8 19:29:34.256719 ignition[1227]: disks: disks passed Oct 8 19:29:34.256886 ignition[1227]: Ignition finished successfully Oct 8 19:29:34.261807 systemd[1]: Finished ignition-disks.service - Ignition (disks). Oct 8 19:29:34.265056 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Oct 8 19:29:34.270773 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 8 19:29:34.273761 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 8 19:29:34.277422 systemd[1]: Reached target sysinit.target - System Initialization. Oct 8 19:29:34.279368 systemd[1]: Reached target basic.target - Basic System. Oct 8 19:29:34.300831 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Oct 8 19:29:34.341425 systemd-fsck[1236]: ROOT: clean, 14/553520 files, 52654/553472 blocks Oct 8 19:29:34.346766 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Oct 8 19:29:34.357584 systemd[1]: Mounting sysroot.mount - /sysroot... Oct 8 19:29:34.454401 kernel: EXT4-fs (nvme0n1p9): mounted filesystem fbf53fb2-c32f-44fa-a235-3100e56d8882 r/w with ordered data mode. Quota mode: none. Oct 8 19:29:34.455758 systemd[1]: Mounted sysroot.mount - /sysroot. Oct 8 19:29:34.459721 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Oct 8 19:29:34.481522 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 8 19:29:34.491827 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Oct 8 19:29:34.497038 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Oct 8 19:29:34.498856 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Oct 8 19:29:34.498909 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Oct 8 19:29:34.515486 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Oct 8 19:29:34.528449 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Oct 8 19:29:34.538436 kernel: BTRFS: device label OEM devid 1 transid 13 /dev/nvme0n1p6 scanned by mount (1255) Oct 8 19:29:34.543115 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 95ed8f66-d8c4-4374-b329-28c20748d95f Oct 8 19:29:34.543206 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Oct 8 19:29:34.543234 kernel: BTRFS info (device nvme0n1p6): using free space tree Oct 8 19:29:34.558379 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Oct 8 19:29:34.560756 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 8 19:29:34.877240 initrd-setup-root[1279]: cut: /sysroot/etc/passwd: No such file or directory Oct 8 19:29:34.892568 initrd-setup-root[1286]: cut: /sysroot/etc/group: No such file or directory Oct 8 19:29:34.900722 initrd-setup-root[1293]: cut: /sysroot/etc/shadow: No such file or directory Oct 8 19:29:34.917773 initrd-setup-root[1300]: cut: /sysroot/etc/gshadow: No such file or directory Oct 8 19:29:35.218786 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Oct 8 19:29:35.231726 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Oct 8 19:29:35.237695 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Oct 8 19:29:35.259255 systemd[1]: sysroot-oem.mount: Deactivated successfully. Oct 8 19:29:35.263376 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 95ed8f66-d8c4-4374-b329-28c20748d95f Oct 8 19:29:35.293868 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Oct 8 19:29:35.311240 ignition[1369]: INFO : Ignition 2.18.0 Oct 8 19:29:35.311240 ignition[1369]: INFO : Stage: mount Oct 8 19:29:35.314437 ignition[1369]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 8 19:29:35.314437 ignition[1369]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 8 19:29:35.314437 ignition[1369]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 8 19:29:35.321235 ignition[1369]: INFO : PUT result: OK Oct 8 19:29:35.328046 ignition[1369]: INFO : mount: mount passed Oct 8 19:29:35.329728 ignition[1369]: INFO : Ignition finished successfully Oct 8 19:29:35.333782 systemd[1]: Finished ignition-mount.service - Ignition (mount). Oct 8 19:29:35.347892 systemd[1]: Starting ignition-files.service - Ignition (files)... Oct 8 19:29:35.370833 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 8 19:29:35.396036 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/nvme0n1p6 scanned by mount (1380) Oct 8 19:29:35.396120 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 95ed8f66-d8c4-4374-b329-28c20748d95f Oct 8 19:29:35.396147 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Oct 8 19:29:35.398789 kernel: BTRFS info (device nvme0n1p6): using free space tree Oct 8 19:29:35.403380 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Oct 8 19:29:35.407729 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 8 19:29:35.414482 systemd-networkd[1202]: eth0: Gained IPv6LL Oct 8 19:29:35.454458 ignition[1397]: INFO : Ignition 2.18.0 Oct 8 19:29:35.454458 ignition[1397]: INFO : Stage: files Oct 8 19:29:35.457615 ignition[1397]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 8 19:29:35.457615 ignition[1397]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 8 19:29:35.457615 ignition[1397]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 8 19:29:35.464423 ignition[1397]: INFO : PUT result: OK Oct 8 19:29:35.468091 ignition[1397]: DEBUG : files: compiled without relabeling support, skipping Oct 8 19:29:35.471973 ignition[1397]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Oct 8 19:29:35.471973 ignition[1397]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Oct 8 19:29:35.506217 ignition[1397]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Oct 8 19:29:35.509050 ignition[1397]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Oct 8 19:29:35.511986 unknown[1397]: wrote ssh authorized keys file for user: core Oct 8 19:29:35.514233 ignition[1397]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Oct 8 19:29:35.517937 ignition[1397]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Oct 8 19:29:35.521144 ignition[1397]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Oct 8 19:29:35.521144 ignition[1397]: INFO : files: op(4): [started] processing unit "etcd-member.service" Oct 8 19:29:35.521144 ignition[1397]: 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" Oct 8 19:29:35.548660 ignition[1397]: 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" Oct 8 19:29:35.548660 ignition[1397]: INFO : files: op(4): [finished] processing unit "etcd-member.service" Oct 8 19:29:35.548660 ignition[1397]: INFO : files: op(6): [started] setting preset to enabled for "etcd-member.service" Oct 8 19:29:35.548660 ignition[1397]: INFO : files: op(6): [finished] setting preset to enabled for "etcd-member.service" Oct 8 19:29:35.548660 ignition[1397]: INFO : files: createResultFile: createFiles: op(7): [started] writing file "/sysroot/etc/.ignition-result.json" Oct 8 19:29:35.548660 ignition[1397]: INFO : files: createResultFile: createFiles: op(7): [finished] writing file "/sysroot/etc/.ignition-result.json" Oct 8 19:29:35.548660 ignition[1397]: INFO : files: files passed Oct 8 19:29:35.548660 ignition[1397]: INFO : Ignition finished successfully Oct 8 19:29:35.530050 systemd[1]: Finished ignition-files.service - Ignition (files). Oct 8 19:29:35.567839 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Oct 8 19:29:35.580698 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Oct 8 19:29:35.590408 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 8 19:29:35.591541 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Oct 8 19:29:35.620792 initrd-setup-root-after-ignition[1426]: grep: /sysroot/etc/flatcar/enabled-sysext.conf Oct 8 19:29:35.623809 initrd-setup-root-after-ignition[1430]: grep: Oct 8 19:29:35.623809 initrd-setup-root-after-ignition[1426]: : No such file or directory Oct 8 19:29:35.623809 initrd-setup-root-after-ignition[1426]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Oct 8 19:29:35.632863 initrd-setup-root-after-ignition[1430]: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 8 19:29:35.629568 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 8 19:29:35.641657 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Oct 8 19:29:35.651648 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Oct 8 19:29:35.717266 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 8 19:29:35.717892 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Oct 8 19:29:35.722220 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Oct 8 19:29:35.725645 systemd[1]: Reached target initrd.target - Initrd Default Target. Oct 8 19:29:35.729444 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Oct 8 19:29:35.739595 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Oct 8 19:29:35.771654 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 8 19:29:35.780624 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Oct 8 19:29:35.818756 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Oct 8 19:29:35.819327 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 8 19:29:35.825352 systemd[1]: Stopped target timers.target - Timer Units. Oct 8 19:29:35.828291 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 8 19:29:35.828674 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 8 19:29:35.834901 systemd[1]: Stopped target initrd.target - Initrd Default Target. Oct 8 19:29:35.837163 systemd[1]: Stopped target basic.target - Basic System. Oct 8 19:29:35.842648 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Oct 8 19:29:35.844931 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Oct 8 19:29:35.853558 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Oct 8 19:29:35.856300 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Oct 8 19:29:35.859048 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Oct 8 19:29:35.863388 systemd[1]: Stopped target sysinit.target - System Initialization. Oct 8 19:29:35.866050 systemd[1]: Stopped target local-fs.target - Local File Systems. Oct 8 19:29:35.874667 systemd[1]: Stopped target swap.target - Swaps. Oct 8 19:29:35.880294 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 8 19:29:35.881796 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Oct 8 19:29:35.884647 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Oct 8 19:29:35.887498 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 8 19:29:35.891018 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Oct 8 19:29:35.896808 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 8 19:29:35.903829 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 8 19:29:35.904076 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Oct 8 19:29:35.911979 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Oct 8 19:29:35.912536 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 8 19:29:35.919517 systemd[1]: ignition-files.service: Deactivated successfully. Oct 8 19:29:35.919968 systemd[1]: Stopped ignition-files.service - Ignition (files). Oct 8 19:29:35.935163 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Oct 8 19:29:35.943747 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Oct 8 19:29:35.945590 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 8 19:29:35.945883 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Oct 8 19:29:35.955140 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 8 19:29:35.955567 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Oct 8 19:29:35.981408 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 8 19:29:35.982459 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Oct 8 19:29:35.995166 ignition[1450]: INFO : Ignition 2.18.0 Oct 8 19:29:35.997522 ignition[1450]: INFO : Stage: umount Oct 8 19:29:35.999423 ignition[1450]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 8 19:29:35.999423 ignition[1450]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 8 19:29:36.003717 ignition[1450]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 8 19:29:36.007160 ignition[1450]: INFO : PUT result: OK Oct 8 19:29:36.011879 ignition[1450]: INFO : umount: umount passed Oct 8 19:29:36.013641 ignition[1450]: INFO : Ignition finished successfully Oct 8 19:29:36.017935 systemd[1]: ignition-mount.service: Deactivated successfully. Oct 8 19:29:36.018798 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Oct 8 19:29:36.027824 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 8 19:29:36.027924 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Oct 8 19:29:36.031842 systemd[1]: ignition-kargs.service: Deactivated successfully. Oct 8 19:29:36.031940 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Oct 8 19:29:36.035406 systemd[1]: ignition-fetch.service: Deactivated successfully. Oct 8 19:29:36.035564 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Oct 8 19:29:36.041678 systemd[1]: Stopped target network.target - Network. Oct 8 19:29:36.043462 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Oct 8 19:29:36.043595 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Oct 8 19:29:36.057815 systemd[1]: Stopped target paths.target - Path Units. Oct 8 19:29:36.061518 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 8 19:29:36.063240 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 8 19:29:36.080788 systemd[1]: Stopped target slices.target - Slice Units. Oct 8 19:29:36.084351 systemd[1]: Stopped target sockets.target - Socket Units. Oct 8 19:29:36.086211 systemd[1]: iscsid.socket: Deactivated successfully. Oct 8 19:29:36.086298 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Oct 8 19:29:36.089098 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 8 19:29:36.089187 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 8 19:29:36.092094 systemd[1]: ignition-setup.service: Deactivated successfully. Oct 8 19:29:36.092195 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Oct 8 19:29:36.095829 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Oct 8 19:29:36.095935 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Oct 8 19:29:36.099211 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Oct 8 19:29:36.103277 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Oct 8 19:29:36.121423 systemd-networkd[1202]: eth0: DHCPv6 lease lost Oct 8 19:29:36.122012 systemd[1]: sysroot-boot.mount: Deactivated successfully. Oct 8 19:29:36.125097 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 8 19:29:36.125330 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Oct 8 19:29:36.136663 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 8 19:29:36.138933 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Oct 8 19:29:36.143939 systemd[1]: sysroot-boot.service: Deactivated successfully. Oct 8 19:29:36.144368 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Oct 8 19:29:36.155257 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 8 19:29:36.155606 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Oct 8 19:29:36.162042 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 8 19:29:36.162162 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Oct 8 19:29:36.178632 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Oct 8 19:29:36.184359 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Oct 8 19:29:36.184485 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 8 19:29:36.186955 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 8 19:29:36.187048 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Oct 8 19:29:36.189103 systemd[1]: systemd-modules-load.service: Deactivated successfully. Oct 8 19:29:36.189190 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Oct 8 19:29:36.191601 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 8 19:29:36.191702 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Oct 8 19:29:36.195037 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 8 19:29:36.223942 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 8 19:29:36.224302 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 8 19:29:36.237463 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 8 19:29:36.237584 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Oct 8 19:29:36.245986 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 8 19:29:36.246064 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Oct 8 19:29:36.251891 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 8 19:29:36.251993 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Oct 8 19:29:36.262420 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 8 19:29:36.262562 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Oct 8 19:29:36.264905 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 8 19:29:36.265013 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 8 19:29:36.281653 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Oct 8 19:29:36.287031 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 8 19:29:36.287150 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 8 19:29:36.289649 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Oct 8 19:29:36.289743 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 8 19:29:36.292149 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 8 19:29:36.292243 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Oct 8 19:29:36.294629 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 8 19:29:36.294738 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 8 19:29:36.301104 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 8 19:29:36.301366 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Oct 8 19:29:36.315903 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 8 19:29:36.316110 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Oct 8 19:29:36.320286 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Oct 8 19:29:36.353320 systemd[1]: Starting initrd-switch-root.service - Switch Root... Oct 8 19:29:36.371971 systemd[1]: Switching root. Oct 8 19:29:36.409233 systemd-journald[250]: Journal stopped Oct 8 19:29:38.438268 systemd-journald[250]: Received SIGTERM from PID 1 (systemd). Oct 8 19:29:38.438438 kernel: SELinux: policy capability network_peer_controls=1 Oct 8 19:29:38.438485 kernel: SELinux: policy capability open_perms=1 Oct 8 19:29:38.438517 kernel: SELinux: policy capability extended_socket_class=1 Oct 8 19:29:38.438548 kernel: SELinux: policy capability always_check_network=0 Oct 8 19:29:38.438583 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 8 19:29:38.438613 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 8 19:29:38.438640 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 8 19:29:38.438670 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Oct 8 19:29:38.438701 kernel: audit: type=1403 audit(1728415776.699:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 8 19:29:38.438741 systemd[1]: Successfully loaded SELinux policy in 63.208ms. Oct 8 19:29:38.438785 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 26.043ms. Oct 8 19:29:38.438819 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Oct 8 19:29:38.438849 systemd[1]: Detected virtualization amazon. Oct 8 19:29:38.438884 systemd[1]: Detected architecture arm64. Oct 8 19:29:38.438915 systemd[1]: Detected first boot. Oct 8 19:29:38.438947 systemd[1]: Initializing machine ID from VM UUID. Oct 8 19:29:38.438983 zram_generator::config[1493]: No configuration found. Oct 8 19:29:38.439018 systemd[1]: Populated /etc with preset unit settings. Oct 8 19:29:38.439054 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 8 19:29:38.439086 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Oct 8 19:29:38.439118 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 8 19:29:38.439153 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Oct 8 19:29:38.439185 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Oct 8 19:29:38.439214 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Oct 8 19:29:38.439246 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Oct 8 19:29:38.439277 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Oct 8 19:29:38.439310 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Oct 8 19:29:38.439367 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Oct 8 19:29:38.439403 systemd[1]: Created slice user.slice - User and Session Slice. Oct 8 19:29:38.439434 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 8 19:29:38.439466 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 8 19:29:38.439496 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Oct 8 19:29:38.439533 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Oct 8 19:29:38.439563 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Oct 8 19:29:38.439595 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 8 19:29:38.439630 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Oct 8 19:29:38.439662 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 8 19:29:38.439698 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Oct 8 19:29:38.439728 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Oct 8 19:29:38.439760 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Oct 8 19:29:38.439793 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Oct 8 19:29:38.439825 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 8 19:29:38.439856 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 8 19:29:38.439890 systemd[1]: Reached target slices.target - Slice Units. Oct 8 19:29:38.439921 systemd[1]: Reached target swap.target - Swaps. Oct 8 19:29:38.439951 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Oct 8 19:29:38.439981 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 8 19:29:38.440012 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 8 19:29:38.440041 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 8 19:29:38.440070 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 8 19:29:38.440102 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Oct 8 19:29:38.440140 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Oct 8 19:29:38.440173 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Oct 8 19:29:38.440206 systemd[1]: Mounting media.mount - External Media Directory... Oct 8 19:29:38.440235 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Oct 8 19:29:38.440264 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Oct 8 19:29:38.440293 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Oct 8 19:29:38.440325 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Oct 8 19:29:38.440384 systemd[1]: Reached target machines.target - Containers. Oct 8 19:29:38.440419 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Oct 8 19:29:38.440451 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 8 19:29:38.440489 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 8 19:29:38.440519 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Oct 8 19:29:38.440551 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 8 19:29:38.440580 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 8 19:29:38.440613 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 8 19:29:38.440643 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Oct 8 19:29:38.440672 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 8 19:29:38.440701 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Oct 8 19:29:38.440735 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 8 19:29:38.440766 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Oct 8 19:29:38.440796 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 8 19:29:38.440830 systemd[1]: Stopped systemd-fsck-usr.service. Oct 8 19:29:38.440861 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 8 19:29:38.440890 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 8 19:29:38.440919 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Oct 8 19:29:38.440951 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Oct 8 19:29:38.440982 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 8 19:29:38.441018 systemd[1]: verity-setup.service: Deactivated successfully. Oct 8 19:29:38.441048 systemd[1]: Stopped verity-setup.service. Oct 8 19:29:38.441081 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Oct 8 19:29:38.441111 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Oct 8 19:29:38.441143 systemd[1]: Mounted media.mount - External Media Directory. Oct 8 19:29:38.441172 kernel: loop: module loaded Oct 8 19:29:38.441204 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Oct 8 19:29:38.441234 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Oct 8 19:29:38.441264 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Oct 8 19:29:38.441302 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 8 19:29:38.441332 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 8 19:29:38.441393 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Oct 8 19:29:38.441424 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 8 19:29:38.441454 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 8 19:29:38.441490 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 8 19:29:38.441543 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 8 19:29:38.441576 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 8 19:29:38.441605 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 8 19:29:38.441634 kernel: fuse: init (API version 7.39) Oct 8 19:29:38.441710 systemd-journald[1574]: Collecting audit messages is disabled. Oct 8 19:29:38.441776 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 8 19:29:38.441810 systemd-journald[1574]: Journal started Oct 8 19:29:38.441862 systemd-journald[1574]: Runtime Journal (/run/log/journal/ec22645a63ec13f6d1f75790cd86ac3a) is 8.0M, max 75.3M, 67.3M free. Oct 8 19:29:37.850777 systemd[1]: Queued start job for default target multi-user.target. Oct 8 19:29:37.913646 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. Oct 8 19:29:37.914510 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 8 19:29:38.455012 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Oct 8 19:29:38.460362 systemd[1]: Started systemd-journald.service - Journal Service. Oct 8 19:29:38.461544 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 8 19:29:38.464313 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Oct 8 19:29:38.469570 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Oct 8 19:29:38.473376 kernel: ACPI: bus type drm_connector registered Oct 8 19:29:38.476553 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 8 19:29:38.476941 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 8 19:29:38.514552 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 8 19:29:38.524643 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Oct 8 19:29:38.539208 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Oct 8 19:29:38.541878 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Oct 8 19:29:38.541962 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 8 19:29:38.548502 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Oct 8 19:29:38.560123 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Oct 8 19:29:38.570087 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Oct 8 19:29:38.572267 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 8 19:29:38.580658 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Oct 8 19:29:38.589025 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Oct 8 19:29:38.591573 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 8 19:29:38.594055 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Oct 8 19:29:38.596534 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 8 19:29:38.603671 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 8 19:29:38.610199 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Oct 8 19:29:38.616046 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 8 19:29:38.622518 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Oct 8 19:29:38.625207 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Oct 8 19:29:38.627768 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Oct 8 19:29:38.632428 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Oct 8 19:29:38.706175 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Oct 8 19:29:38.710954 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Oct 8 19:29:38.717869 systemd-journald[1574]: Time spent on flushing to /var/log/journal/ec22645a63ec13f6d1f75790cd86ac3a is 46.381ms for 896 entries. Oct 8 19:29:38.717869 systemd-journald[1574]: System Journal (/var/log/journal/ec22645a63ec13f6d1f75790cd86ac3a) is 8.0M, max 195.6M, 187.6M free. Oct 8 19:29:38.778205 systemd-journald[1574]: Received client request to flush runtime journal. Oct 8 19:29:38.778277 kernel: loop0: detected capacity change from 0 to 59688 Oct 8 19:29:38.778312 kernel: block loop0: the capability attribute has been deprecated. Oct 8 19:29:38.723578 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Oct 8 19:29:38.779593 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 8 19:29:38.790436 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Oct 8 19:29:38.800929 systemd-tmpfiles[1621]: ACLs are not supported, ignoring. Oct 8 19:29:38.801738 systemd-tmpfiles[1621]: ACLs are not supported, ignoring. Oct 8 19:29:38.823409 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Oct 8 19:29:38.825447 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 8 19:29:38.837677 systemd[1]: Starting systemd-sysusers.service - Create System Users... Oct 8 19:29:38.849195 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 8 19:29:38.851786 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Oct 8 19:29:38.878400 kernel: loop1: detected capacity change from 0 to 113672 Oct 8 19:29:38.891020 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 8 19:29:38.906804 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Oct 8 19:29:38.967512 systemd[1]: Finished systemd-sysusers.service - Create System Users. Oct 8 19:29:38.982527 kernel: loop2: detected capacity change from 0 to 51896 Oct 8 19:29:38.984204 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 8 19:29:38.988554 udevadm[1642]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Oct 8 19:29:39.031587 kernel: loop3: detected capacity change from 0 to 59688 Oct 8 19:29:39.055974 kernel: loop4: detected capacity change from 0 to 113672 Oct 8 19:29:39.080401 kernel: loop5: detected capacity change from 0 to 51896 Oct 8 19:29:39.083434 systemd-tmpfiles[1645]: ACLs are not supported, ignoring. Oct 8 19:29:39.084061 systemd-tmpfiles[1645]: ACLs are not supported, ignoring. Oct 8 19:29:39.099187 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 8 19:29:39.101046 (sd-merge)[1648]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-ami'. Oct 8 19:29:39.103161 (sd-merge)[1648]: Merged extensions into '/usr'. Oct 8 19:29:39.108479 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Oct 8 19:29:39.121876 systemd[1]: Starting ensure-sysext.service... Oct 8 19:29:39.134721 systemd[1]: Starting systemd-tmpfiles-setup.service - Create Volatile Files and Directories... Oct 8 19:29:39.168308 systemd[1]: Reloading requested from client PID 1651 ('systemctl') (unit ensure-sysext.service)... Oct 8 19:29:39.168356 systemd[1]: Reloading... Oct 8 19:29:39.226711 systemd-tmpfiles[1652]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Oct 8 19:29:39.232117 systemd-tmpfiles[1652]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Oct 8 19:29:39.236204 systemd-tmpfiles[1652]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Oct 8 19:29:39.239224 systemd-tmpfiles[1652]: ACLs are not supported, ignoring. Oct 8 19:29:39.240747 systemd-tmpfiles[1652]: ACLs are not supported, ignoring. Oct 8 19:29:39.256331 systemd-tmpfiles[1652]: Detected autofs mount point /boot during canonicalization of boot. Oct 8 19:29:39.256589 systemd-tmpfiles[1652]: Skipping /boot Oct 8 19:29:39.302595 systemd-tmpfiles[1652]: Detected autofs mount point /boot during canonicalization of boot. Oct 8 19:29:39.306409 systemd-tmpfiles[1652]: Skipping /boot Oct 8 19:29:39.404392 zram_generator::config[1682]: No configuration found. Oct 8 19:29:39.735131 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Oct 8 19:29:39.852975 systemd[1]: Reloading finished in 683 ms. Oct 8 19:29:39.900319 systemd[1]: Finished systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Oct 8 19:29:39.935770 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Oct 8 19:29:39.949673 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Oct 8 19:29:39.955530 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Oct 8 19:29:39.965206 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 8 19:29:39.973703 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Oct 8 19:29:39.989773 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 8 19:29:39.995860 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 8 19:29:40.000682 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 8 19:29:40.005290 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 8 19:29:40.007491 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 8 19:29:40.014707 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 8 19:29:40.015072 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 8 19:29:40.021443 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 8 19:29:40.026820 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 8 19:29:40.028991 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 8 19:29:40.029443 systemd[1]: Reached target time-set.target - System Time Set. Oct 8 19:29:40.047442 systemd[1]: Finished ensure-sysext.service. Oct 8 19:29:40.098709 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Oct 8 19:29:40.126216 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Oct 8 19:29:40.148158 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 8 19:29:40.150493 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 8 19:29:40.164378 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 8 19:29:40.165876 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 8 19:29:40.169066 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Oct 8 19:29:40.188057 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 8 19:29:40.189586 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 8 19:29:40.192436 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 8 19:29:40.199043 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 8 19:29:40.200688 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 8 19:29:40.208110 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 8 19:29:40.266263 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Oct 8 19:29:40.270165 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Oct 8 19:29:40.299413 augenrules[1765]: No rules Oct 8 19:29:40.305667 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Oct 8 19:29:40.308252 systemd[1]: Started systemd-userdbd.service - User Database Manager. Oct 8 19:29:40.321003 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Oct 8 19:29:40.336964 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 8 19:29:40.375691 ldconfig[1615]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Oct 8 19:29:40.387955 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Oct 8 19:29:40.402704 systemd[1]: Starting systemd-update-done.service - Update is Completed... Oct 8 19:29:40.422001 systemd-udevd[1776]: Using default interface naming scheme 'v255'. Oct 8 19:29:40.454480 systemd[1]: Finished systemd-update-done.service - Update is Completed. Oct 8 19:29:40.464893 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 8 19:29:40.477711 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 8 19:29:40.485179 systemd-resolved[1736]: Positive Trust Anchors: Oct 8 19:29:40.489435 systemd-resolved[1736]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 8 19:29:40.489527 systemd-resolved[1736]: 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 Oct 8 19:29:40.511329 systemd-resolved[1736]: Defaulting to hostname 'linux'. Oct 8 19:29:40.540946 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 8 19:29:40.544581 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 8 19:29:40.617986 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Oct 8 19:29:40.635057 (udev-worker)[1793]: Network interface NamePolicy= disabled on kernel command line. Oct 8 19:29:40.642556 kernel: BTRFS info: devid 1 device path /dev/mapper/usr changed to /dev/dm-0 scanned by (udev-worker) (1786) Oct 8 19:29:40.674545 systemd-networkd[1784]: lo: Link UP Oct 8 19:29:40.676603 systemd-networkd[1784]: lo: Gained carrier Oct 8 19:29:40.681327 systemd-networkd[1784]: Enumeration completed Oct 8 19:29:40.681725 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 8 19:29:40.684266 systemd[1]: Reached target network.target - Network. Oct 8 19:29:40.690136 systemd-networkd[1784]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 8 19:29:40.690322 systemd-networkd[1784]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 8 19:29:40.694254 systemd-networkd[1784]: eth0: Link UP Oct 8 19:29:40.694677 systemd-networkd[1784]: eth0: Gained carrier Oct 8 19:29:40.694716 systemd-networkd[1784]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 8 19:29:40.719978 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Oct 8 19:29:40.729134 systemd-networkd[1784]: eth0: DHCPv4 address 172.31.22.193/20, gateway 172.31.16.1 acquired from 172.31.16.1 Oct 8 19:29:40.786093 systemd-networkd[1784]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 8 19:29:40.874394 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 36 scanned by (udev-worker) (1802) Oct 8 19:29:40.922141 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 8 19:29:41.086624 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Oct 8 19:29:41.091429 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Oct 8 19:29:41.094450 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 8 19:29:41.104697 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Oct 8 19:29:41.110726 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Oct 8 19:29:41.132141 lvm[1904]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 8 19:29:41.160843 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Oct 8 19:29:41.169172 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Oct 8 19:29:41.173734 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 8 19:29:41.176318 systemd[1]: Reached target sysinit.target - System Initialization. Oct 8 19:29:41.178827 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Oct 8 19:29:41.181248 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 8 19:29:41.183976 systemd[1]: Started logrotate.timer - Daily rotation of log files. Oct 8 19:29:41.186222 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Oct 8 19:29:41.188615 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Oct 8 19:29:41.190974 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Oct 8 19:29:41.191028 systemd[1]: Reached target paths.target - Path Units. Oct 8 19:29:41.192755 systemd[1]: Reached target timers.target - Timer Units. Oct 8 19:29:41.196203 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Oct 8 19:29:41.201276 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 8 19:29:41.220827 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Oct 8 19:29:41.225619 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Oct 8 19:29:41.228922 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 8 19:29:41.232858 systemd[1]: Reached target sockets.target - Socket Units. Oct 8 19:29:41.235000 systemd[1]: Reached target basic.target - Basic System. Oct 8 19:29:41.237082 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Oct 8 19:29:41.237309 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Oct 8 19:29:41.247715 systemd[1]: Starting containerd.service - containerd container runtime... Oct 8 19:29:41.253183 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Oct 8 19:29:41.269389 lvm[1911]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 8 19:29:41.271579 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Oct 8 19:29:41.279560 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Oct 8 19:29:41.285760 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Oct 8 19:29:41.288538 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Oct 8 19:29:41.292469 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Oct 8 19:29:41.315634 systemd[1]: Started ntpd.service - Network Time Service. Oct 8 19:29:41.328744 systemd[1]: Starting setup-oem.service - Setup OEM... Oct 8 19:29:41.340676 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Oct 8 19:29:41.345776 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Oct 8 19:29:41.358719 systemd[1]: Starting systemd-logind.service - User Login Management... Oct 8 19:29:41.361712 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Oct 8 19:29:41.362643 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 8 19:29:41.367614 systemd[1]: Starting update-engine.service - Update Engine... Oct 8 19:29:41.378047 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Oct 8 19:29:41.382244 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Oct 8 19:29:41.412397 jq[1915]: false Oct 8 19:29:41.425736 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Oct 8 19:29:41.426198 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Oct 8 19:29:41.452627 jq[1926]: true Oct 8 19:29:41.476190 jq[1937]: true Oct 8 19:29:41.495376 extend-filesystems[1916]: Found loop3 Oct 8 19:29:41.495376 extend-filesystems[1916]: Found loop4 Oct 8 19:29:41.495376 extend-filesystems[1916]: Found loop5 Oct 8 19:29:41.495376 extend-filesystems[1916]: Found nvme0n1 Oct 8 19:29:41.495376 extend-filesystems[1916]: Found nvme0n1p1 Oct 8 19:29:41.495376 extend-filesystems[1916]: Found nvme0n1p2 Oct 8 19:29:41.495376 extend-filesystems[1916]: Found nvme0n1p3 Oct 8 19:29:41.495376 extend-filesystems[1916]: Found usr Oct 8 19:29:41.495376 extend-filesystems[1916]: Found nvme0n1p4 Oct 8 19:29:41.495376 extend-filesystems[1916]: Found nvme0n1p6 Oct 8 19:29:41.495376 extend-filesystems[1916]: Found nvme0n1p7 Oct 8 19:29:41.495376 extend-filesystems[1916]: Found nvme0n1p9 Oct 8 19:29:41.484183 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 8 19:29:41.549993 ntpd[1918]: 8 Oct 19:29:41 ntpd[1918]: ntpd 4.2.8p17@1.4004-o Tue Oct 8 17:46:09 UTC 2024 (1): Starting Oct 8 19:29:41.549993 ntpd[1918]: 8 Oct 19:29:41 ntpd[1918]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Oct 8 19:29:41.549993 ntpd[1918]: 8 Oct 19:29:41 ntpd[1918]: ---------------------------------------------------- Oct 8 19:29:41.549993 ntpd[1918]: 8 Oct 19:29:41 ntpd[1918]: ntp-4 is maintained by Network Time Foundation, Oct 8 19:29:41.549993 ntpd[1918]: 8 Oct 19:29:41 ntpd[1918]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Oct 8 19:29:41.549993 ntpd[1918]: 8 Oct 19:29:41 ntpd[1918]: corporation. Support and training for ntp-4 are Oct 8 19:29:41.549993 ntpd[1918]: 8 Oct 19:29:41 ntpd[1918]: available at https://www.nwtime.org/support Oct 8 19:29:41.549993 ntpd[1918]: 8 Oct 19:29:41 ntpd[1918]: ---------------------------------------------------- Oct 8 19:29:41.549993 ntpd[1918]: 8 Oct 19:29:41 ntpd[1918]: proto: precision = 0.108 usec (-23) Oct 8 19:29:41.549993 ntpd[1918]: 8 Oct 19:29:41 ntpd[1918]: basedate set to 2024-09-26 Oct 8 19:29:41.549993 ntpd[1918]: 8 Oct 19:29:41 ntpd[1918]: gps base set to 2024-09-29 (week 2334) Oct 8 19:29:41.549993 ntpd[1918]: 8 Oct 19:29:41 ntpd[1918]: Listen and drop on 0 v6wildcard [::]:123 Oct 8 19:29:41.549993 ntpd[1918]: 8 Oct 19:29:41 ntpd[1918]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 8 19:29:41.549993 ntpd[1918]: 8 Oct 19:29:41 ntpd[1918]: Listen normally on 2 lo 127.0.0.1:123 Oct 8 19:29:41.549993 ntpd[1918]: 8 Oct 19:29:41 ntpd[1918]: Listen normally on 3 eth0 172.31.22.193:123 Oct 8 19:29:41.549993 ntpd[1918]: 8 Oct 19:29:41 ntpd[1918]: Listen normally on 4 lo [::1]:123 Oct 8 19:29:41.549993 ntpd[1918]: 8 Oct 19:29:41 ntpd[1918]: bind(21) AF_INET6 fe80::403:76ff:fe37:a811%2#123 flags 0x11 failed: Cannot assign requested address Oct 8 19:29:41.549993 ntpd[1918]: 8 Oct 19:29:41 ntpd[1918]: unable to create socket on eth0 (5) for fe80::403:76ff:fe37:a811%2#123 Oct 8 19:29:41.549993 ntpd[1918]: 8 Oct 19:29:41 ntpd[1918]: failed to init interface for address fe80::403:76ff:fe37:a811%2 Oct 8 19:29:41.549993 ntpd[1918]: 8 Oct 19:29:41 ntpd[1918]: Listening on routing socket on fd #21 for interface updates Oct 8 19:29:41.549993 ntpd[1918]: 8 Oct 19:29:41 ntpd[1918]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 8 19:29:41.549993 ntpd[1918]: 8 Oct 19:29:41 ntpd[1918]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 8 19:29:41.488197 ntpd[1918]: ntpd 4.2.8p17@1.4004-o Tue Oct 8 17:46:09 UTC 2024 (1): Starting Oct 8 19:29:41.572897 extend-filesystems[1916]: Checking size of /dev/nvme0n1p9 Oct 8 19:29:41.485851 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Oct 8 19:29:41.488243 ntpd[1918]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Oct 8 19:29:41.562915 systemd[1]: Started dbus.service - D-Bus System Message Bus. Oct 8 19:29:41.488263 ntpd[1918]: ---------------------------------------------------- Oct 8 19:29:41.569734 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Oct 8 19:29:41.488282 ntpd[1918]: ntp-4 is maintained by Network Time Foundation, Oct 8 19:29:41.569781 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Oct 8 19:29:41.488301 ntpd[1918]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Oct 8 19:29:41.574567 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Oct 8 19:29:41.488319 ntpd[1918]: corporation. Support and training for ntp-4 are Oct 8 19:29:41.574608 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Oct 8 19:29:41.488383 ntpd[1918]: available at https://www.nwtime.org/support Oct 8 19:29:41.488411 ntpd[1918]: ---------------------------------------------------- Oct 8 19:29:41.494855 ntpd[1918]: proto: precision = 0.108 usec (-23) Oct 8 19:29:41.497603 ntpd[1918]: basedate set to 2024-09-26 Oct 8 19:29:41.497635 ntpd[1918]: gps base set to 2024-09-29 (week 2334) Oct 8 19:29:41.505727 ntpd[1918]: Listen and drop on 0 v6wildcard [::]:123 Oct 8 19:29:41.505820 ntpd[1918]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 8 19:29:41.506126 ntpd[1918]: Listen normally on 2 lo 127.0.0.1:123 Oct 8 19:29:41.506197 ntpd[1918]: Listen normally on 3 eth0 172.31.22.193:123 Oct 8 19:29:41.506273 ntpd[1918]: Listen normally on 4 lo [::1]:123 Oct 8 19:29:41.506381 ntpd[1918]: bind(21) AF_INET6 fe80::403:76ff:fe37:a811%2#123 flags 0x11 failed: Cannot assign requested address Oct 8 19:29:41.506424 ntpd[1918]: unable to create socket on eth0 (5) for fe80::403:76ff:fe37:a811%2#123 Oct 8 19:29:41.506453 ntpd[1918]: failed to init interface for address fe80::403:76ff:fe37:a811%2 Oct 8 19:29:41.506508 ntpd[1918]: Listening on routing socket on fd #21 for interface updates Oct 8 19:29:41.513318 ntpd[1918]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 8 19:29:41.513403 ntpd[1918]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 8 19:29:41.556093 dbus-daemon[1914]: [system] SELinux support is enabled Oct 8 19:29:41.578157 dbus-daemon[1914]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.1' (uid=244 pid=1784 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Oct 8 19:29:41.591236 dbus-daemon[1914]: [system] Successfully activated service 'org.freedesktop.systemd1' Oct 8 19:29:41.597964 update_engine[1925]: I1008 19:29:41.597404 1925 main.cc:92] Flatcar Update Engine starting Oct 8 19:29:41.610912 extend-filesystems[1916]: Resized partition /dev/nvme0n1p9 Oct 8 19:29:41.602161 (ntainerd)[1934]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Oct 8 19:29:41.631093 update_engine[1925]: I1008 19:29:41.616101 1925 update_check_scheduler.cc:74] Next update check in 9m37s Oct 8 19:29:41.604306 systemd[1]: motdgen.service: Deactivated successfully. Oct 8 19:29:41.605908 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Oct 8 19:29:41.637627 extend-filesystems[1958]: resize2fs 1.47.0 (5-Feb-2023) Oct 8 19:29:41.639923 systemd[1]: Started update-engine.service - Update Engine. Oct 8 19:29:41.650151 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 553472 to 1489915 blocks Oct 8 19:29:41.665714 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Oct 8 19:29:41.673696 systemd[1]: Started locksmithd.service - Cluster reboot manager. Oct 8 19:29:41.694793 systemd[1]: Finished setup-oem.service - Setup OEM. Oct 8 19:29:41.738104 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 1489915 Oct 8 19:29:41.767035 extend-filesystems[1958]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Oct 8 19:29:41.767035 extend-filesystems[1958]: old_desc_blocks = 1, new_desc_blocks = 1 Oct 8 19:29:41.767035 extend-filesystems[1958]: The filesystem on /dev/nvme0n1p9 is now 1489915 (4k) blocks long. Oct 8 19:29:41.796554 extend-filesystems[1916]: Resized filesystem in /dev/nvme0n1p9 Oct 8 19:29:41.812022 bash[1986]: Updated "/home/core/.ssh/authorized_keys" Oct 8 19:29:41.837991 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 8 19:29:41.838392 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Oct 8 19:29:41.841753 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Oct 8 19:29:41.853191 systemd-logind[1924]: Watching system buttons on /dev/input/event0 (Power Button) Oct 8 19:29:41.853837 systemd-logind[1924]: Watching system buttons on /dev/input/event1 (Sleep Button) Oct 8 19:29:41.856400 systemd-logind[1924]: New seat seat0. Oct 8 19:29:41.858661 systemd[1]: Starting sshkeys.service... Oct 8 19:29:41.866765 systemd[1]: Started systemd-logind.service - User Login Management. Oct 8 19:29:41.888723 coreos-metadata[1913]: Oct 08 19:29:41.888 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Oct 8 19:29:41.895948 coreos-metadata[1913]: Oct 08 19:29:41.895 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-id: Attempt #1 Oct 8 19:29:41.897209 coreos-metadata[1913]: Oct 08 19:29:41.897 INFO Fetch successful Oct 8 19:29:41.897209 coreos-metadata[1913]: Oct 08 19:29:41.897 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-type: Attempt #1 Oct 8 19:29:41.903783 coreos-metadata[1913]: Oct 08 19:29:41.903 INFO Fetch successful Oct 8 19:29:41.903783 coreos-metadata[1913]: Oct 08 19:29:41.903 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/local-ipv4: Attempt #1 Oct 8 19:29:41.905495 coreos-metadata[1913]: Oct 08 19:29:41.905 INFO Fetch successful Oct 8 19:29:41.905495 coreos-metadata[1913]: Oct 08 19:29:41.905 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-ipv4: Attempt #1 Oct 8 19:29:41.906124 coreos-metadata[1913]: Oct 08 19:29:41.905 INFO Fetch successful Oct 8 19:29:41.906124 coreos-metadata[1913]: Oct 08 19:29:41.905 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/ipv6: Attempt #1 Oct 8 19:29:41.913636 coreos-metadata[1913]: Oct 08 19:29:41.913 INFO Fetch failed with 404: resource not found Oct 8 19:29:41.913636 coreos-metadata[1913]: Oct 08 19:29:41.913 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone: Attempt #1 Oct 8 19:29:41.919781 coreos-metadata[1913]: Oct 08 19:29:41.919 INFO Fetch successful Oct 8 19:29:41.919781 coreos-metadata[1913]: Oct 08 19:29:41.919 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone-id: Attempt #1 Oct 8 19:29:41.920844 coreos-metadata[1913]: Oct 08 19:29:41.920 INFO Fetch successful Oct 8 19:29:41.920844 coreos-metadata[1913]: Oct 08 19:29:41.920 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/hostname: Attempt #1 Oct 8 19:29:41.921655 coreos-metadata[1913]: Oct 08 19:29:41.921 INFO Fetch successful Oct 8 19:29:41.921655 coreos-metadata[1913]: Oct 08 19:29:41.921 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-hostname: Attempt #1 Oct 8 19:29:41.933608 coreos-metadata[1913]: Oct 08 19:29:41.931 INFO Fetch successful Oct 8 19:29:41.933608 coreos-metadata[1913]: Oct 08 19:29:41.931 INFO Fetching http://169.254.169.254/2021-01-03/dynamic/instance-identity/document: Attempt #1 Oct 8 19:29:41.937473 coreos-metadata[1913]: Oct 08 19:29:41.934 INFO Fetch successful Oct 8 19:29:41.938808 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Oct 8 19:29:41.944664 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 36 scanned by (udev-worker) (1788) Oct 8 19:29:41.961635 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Oct 8 19:29:42.124954 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Oct 8 19:29:42.128105 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Oct 8 19:29:42.188510 containerd[1934]: time="2024-10-08T19:29:42.186749527Z" level=info msg="starting containerd" revision=1fbfc07f8d28210e62bdbcbf7b950bac8028afbf version=v1.7.17 Oct 8 19:29:42.232987 dbus-daemon[1914]: [system] Successfully activated service 'org.freedesktop.hostname1' Oct 8 19:29:42.233254 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Oct 8 19:29:42.238900 dbus-daemon[1914]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.5' (uid=0 pid=1964 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Oct 8 19:29:42.268739 coreos-metadata[1995]: Oct 08 19:29:42.267 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Oct 8 19:29:42.268739 coreos-metadata[1995]: Oct 08 19:29:42.268 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys: Attempt #1 Oct 8 19:29:42.275507 coreos-metadata[1995]: Oct 08 19:29:42.269 INFO Fetch successful Oct 8 19:29:42.275507 coreos-metadata[1995]: Oct 08 19:29:42.269 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys/0/openssh-key: Attempt #1 Oct 8 19:29:42.275507 coreos-metadata[1995]: Oct 08 19:29:42.270 INFO Fetch successful Oct 8 19:29:42.272463 systemd[1]: Starting polkit.service - Authorization Manager... Oct 8 19:29:42.274314 unknown[1995]: wrote ssh authorized keys file for user: core Oct 8 19:29:42.319863 containerd[1934]: time="2024-10-08T19:29:42.319795423Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Oct 8 19:29:42.322603 containerd[1934]: time="2024-10-08T19:29:42.322546831Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Oct 8 19:29:42.330307 containerd[1934]: time="2024-10-08T19:29:42.328657591Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.54-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Oct 8 19:29:42.330307 containerd[1934]: time="2024-10-08T19:29:42.328724599Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Oct 8 19:29:42.330307 containerd[1934]: time="2024-10-08T19:29:42.329114947Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Oct 8 19:29:42.330307 containerd[1934]: time="2024-10-08T19:29:42.329156911Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Oct 8 19:29:42.330307 containerd[1934]: time="2024-10-08T19:29:42.329398051Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Oct 8 19:29:42.330307 containerd[1934]: time="2024-10-08T19:29:42.329546239Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Oct 8 19:29:42.330307 containerd[1934]: time="2024-10-08T19:29:42.329576155Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Oct 8 19:29:42.330307 containerd[1934]: time="2024-10-08T19:29:42.329731963Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Oct 8 19:29:42.330307 containerd[1934]: time="2024-10-08T19:29:42.330161659Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Oct 8 19:29:42.338423 containerd[1934]: time="2024-10-08T19:29:42.330208207Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Oct 8 19:29:42.338423 containerd[1934]: time="2024-10-08T19:29:42.337783495Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Oct 8 19:29:42.338423 containerd[1934]: time="2024-10-08T19:29:42.338110951Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Oct 8 19:29:42.338423 containerd[1934]: time="2024-10-08T19:29:42.338150371Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Oct 8 19:29:42.342470 containerd[1934]: time="2024-10-08T19:29:42.338333815Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Oct 8 19:29:42.344000 containerd[1934]: time="2024-10-08T19:29:42.343683571Z" level=info msg="metadata content store policy set" policy=shared Oct 8 19:29:42.363380 containerd[1934]: time="2024-10-08T19:29:42.361084675Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Oct 8 19:29:42.363380 containerd[1934]: time="2024-10-08T19:29:42.361163215Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Oct 8 19:29:42.363380 containerd[1934]: time="2024-10-08T19:29:42.361196503Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Oct 8 19:29:42.363380 containerd[1934]: time="2024-10-08T19:29:42.361264831Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Oct 8 19:29:42.363380 containerd[1934]: time="2024-10-08T19:29:42.361302139Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Oct 8 19:29:42.363380 containerd[1934]: time="2024-10-08T19:29:42.361330123Z" level=info msg="NRI interface is disabled by configuration." Oct 8 19:29:42.363380 containerd[1934]: time="2024-10-08T19:29:42.361392247Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Oct 8 19:29:42.363380 containerd[1934]: time="2024-10-08T19:29:42.361730623Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Oct 8 19:29:42.363380 containerd[1934]: time="2024-10-08T19:29:42.361780927Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Oct 8 19:29:42.363380 containerd[1934]: time="2024-10-08T19:29:42.361816579Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Oct 8 19:29:42.363380 containerd[1934]: time="2024-10-08T19:29:42.361850539Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Oct 8 19:29:42.363380 containerd[1934]: time="2024-10-08T19:29:42.361885075Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Oct 8 19:29:42.363380 containerd[1934]: time="2024-10-08T19:29:42.361926607Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Oct 8 19:29:42.363380 containerd[1934]: time="2024-10-08T19:29:42.361958635Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Oct 8 19:29:42.364145 containerd[1934]: time="2024-10-08T19:29:42.361988203Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Oct 8 19:29:42.364145 containerd[1934]: time="2024-10-08T19:29:42.362021179Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Oct 8 19:29:42.364145 containerd[1934]: time="2024-10-08T19:29:42.362054491Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Oct 8 19:29:42.364145 containerd[1934]: time="2024-10-08T19:29:42.362086987Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Oct 8 19:29:42.364145 containerd[1934]: time="2024-10-08T19:29:42.362115859Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Oct 8 19:29:42.367021 containerd[1934]: time="2024-10-08T19:29:42.366974155Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Oct 8 19:29:42.370515 containerd[1934]: time="2024-10-08T19:29:42.369986335Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Oct 8 19:29:42.370515 containerd[1934]: time="2024-10-08T19:29:42.370063627Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Oct 8 19:29:42.370515 containerd[1934]: time="2024-10-08T19:29:42.370098055Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Oct 8 19:29:42.370515 containerd[1934]: time="2024-10-08T19:29:42.370156303Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Oct 8 19:29:42.378368 containerd[1934]: time="2024-10-08T19:29:42.376066963Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Oct 8 19:29:42.378368 containerd[1934]: time="2024-10-08T19:29:42.376274239Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Oct 8 19:29:42.378368 containerd[1934]: time="2024-10-08T19:29:42.376311307Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Oct 8 19:29:42.378368 containerd[1934]: time="2024-10-08T19:29:42.376441699Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Oct 8 19:29:42.378368 containerd[1934]: time="2024-10-08T19:29:42.376479427Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Oct 8 19:29:42.378368 containerd[1934]: time="2024-10-08T19:29:42.376512859Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Oct 8 19:29:42.378368 containerd[1934]: time="2024-10-08T19:29:42.376542295Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Oct 8 19:29:42.378368 containerd[1934]: time="2024-10-08T19:29:42.376573195Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Oct 8 19:29:42.378368 containerd[1934]: time="2024-10-08T19:29:42.376607947Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Oct 8 19:29:42.378368 containerd[1934]: time="2024-10-08T19:29:42.376898587Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Oct 8 19:29:42.378368 containerd[1934]: time="2024-10-08T19:29:42.376935811Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Oct 8 19:29:42.378368 containerd[1934]: time="2024-10-08T19:29:42.376965739Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Oct 8 19:29:42.378368 containerd[1934]: time="2024-10-08T19:29:42.376996939Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Oct 8 19:29:42.378368 containerd[1934]: time="2024-10-08T19:29:42.377029135Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Oct 8 19:29:42.378368 containerd[1934]: time="2024-10-08T19:29:42.377062267Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Oct 8 19:29:42.379078 containerd[1934]: time="2024-10-08T19:29:42.377091859Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Oct 8 19:29:42.379078 containerd[1934]: time="2024-10-08T19:29:42.377120335Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Oct 8 19:29:42.379237 containerd[1934]: time="2024-10-08T19:29:42.377590459Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}" Oct 8 19:29:42.379237 containerd[1934]: time="2024-10-08T19:29:42.377700595Z" level=info msg="Connect containerd service" Oct 8 19:29:42.379237 containerd[1934]: time="2024-10-08T19:29:42.377758795Z" level=info msg="using legacy CRI server" Oct 8 19:29:42.379237 containerd[1934]: time="2024-10-08T19:29:42.377776111Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 8 19:29:42.379237 containerd[1934]: time="2024-10-08T19:29:42.377930395Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Oct 8 19:29:42.386553 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Oct 8 19:29:42.392789 containerd[1934]: time="2024-10-08T19:29:42.392701292Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Oct 8 19:29:42.393131 containerd[1934]: time="2024-10-08T19:29:42.392960768Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Oct 8 19:29:42.393351 containerd[1934]: time="2024-10-08T19:29:42.393277820Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 Oct 8 19:29:42.393543 containerd[1934]: time="2024-10-08T19:29:42.393466592Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Oct 8 19:29:42.394610 containerd[1934]: time="2024-10-08T19:29:42.393085364Z" level=info msg="Start subscribing containerd event" Oct 8 19:29:42.394610 containerd[1934]: time="2024-10-08T19:29:42.393708320Z" level=info msg="Start recovering state" Oct 8 19:29:42.394610 containerd[1934]: time="2024-10-08T19:29:42.393831080Z" level=info msg="Start event monitor" Oct 8 19:29:42.394610 containerd[1934]: time="2024-10-08T19:29:42.393854516Z" level=info msg="Start snapshots syncer" Oct 8 19:29:42.394610 containerd[1934]: time="2024-10-08T19:29:42.393875876Z" level=info msg="Start cni network conf syncer for default" Oct 8 19:29:42.394610 containerd[1934]: time="2024-10-08T19:29:42.393895304Z" level=info msg="Start streaming server" Oct 8 19:29:42.397494 containerd[1934]: time="2024-10-08T19:29:42.397420844Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Oct 8 19:29:42.397557 polkitd[2046]: Started polkitd version 121 Oct 8 19:29:42.404371 containerd[1934]: time="2024-10-08T19:29:42.398613308Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 8 19:29:42.404371 containerd[1934]: time="2024-10-08T19:29:42.398727716Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 8 19:29:42.404371 containerd[1934]: time="2024-10-08T19:29:42.398833772Z" level=info msg="containerd successfully booted in 0.240572s" Oct 8 19:29:42.399377 systemd[1]: Started containerd.service - containerd container runtime. Oct 8 19:29:42.404661 update-ssh-keys[2051]: Updated "/home/core/.ssh/authorized_keys" Oct 8 19:29:42.407548 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Oct 8 19:29:42.418163 systemd[1]: Finished sshkeys.service. Oct 8 19:29:42.429402 polkitd[2046]: Loading rules from directory /etc/polkit-1/rules.d Oct 8 19:29:42.429548 polkitd[2046]: Loading rules from directory /usr/share/polkit-1/rules.d Oct 8 19:29:42.430418 polkitd[2046]: Finished loading, compiling and executing 2 rules Oct 8 19:29:42.442660 dbus-daemon[1914]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Oct 8 19:29:42.443086 systemd[1]: Started polkit.service - Authorization Manager. Oct 8 19:29:42.449410 polkitd[2046]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Oct 8 19:29:42.477962 locksmithd[1968]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 8 19:29:42.488934 ntpd[1918]: bind(24) AF_INET6 fe80::403:76ff:fe37:a811%2#123 flags 0x11 failed: Cannot assign requested address Oct 8 19:29:42.491981 ntpd[1918]: 8 Oct 19:29:42 ntpd[1918]: bind(24) AF_INET6 fe80::403:76ff:fe37:a811%2#123 flags 0x11 failed: Cannot assign requested address Oct 8 19:29:42.491981 ntpd[1918]: 8 Oct 19:29:42 ntpd[1918]: unable to create socket on eth0 (6) for fe80::403:76ff:fe37:a811%2#123 Oct 8 19:29:42.491981 ntpd[1918]: 8 Oct 19:29:42 ntpd[1918]: failed to init interface for address fe80::403:76ff:fe37:a811%2 Oct 8 19:29:42.489004 ntpd[1918]: unable to create socket on eth0 (6) for fe80::403:76ff:fe37:a811%2#123 Oct 8 19:29:42.489034 ntpd[1918]: failed to init interface for address fe80::403:76ff:fe37:a811%2 Oct 8 19:29:42.501471 systemd-resolved[1736]: System hostname changed to 'ip-172-31-22-193'. Oct 8 19:29:42.501677 systemd-hostnamed[1964]: Hostname set to (transient) Oct 8 19:29:42.518586 systemd-networkd[1784]: eth0: Gained IPv6LL Oct 8 19:29:42.527465 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Oct 8 19:29:42.532137 systemd[1]: Reached target network-online.target - Network is Online. Oct 8 19:29:42.547170 systemd[1]: Started amazon-ssm-agent.service - amazon-ssm-agent. Oct 8 19:29:42.556022 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... Oct 8 19:29:42.562966 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Oct 8 19:29:42.608151 (-wrapper)[2117]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS Oct 8 19:29:42.693836 amazon-ssm-agent[2111]: Initializing new seelog logger Oct 8 19:29:42.693836 amazon-ssm-agent[2111]: New Seelog Logger Creation Complete Oct 8 19:29:42.696377 amazon-ssm-agent[2111]: 2024/10/08 19:29:42 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Oct 8 19:29:42.696377 amazon-ssm-agent[2111]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Oct 8 19:29:42.696377 amazon-ssm-agent[2111]: 2024/10/08 19:29:42 processing appconfig overrides Oct 8 19:29:42.698152 amazon-ssm-agent[2111]: 2024/10/08 19:29:42 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Oct 8 19:29:42.698306 amazon-ssm-agent[2111]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Oct 8 19:29:42.698567 amazon-ssm-agent[2111]: 2024/10/08 19:29:42 processing appconfig overrides Oct 8 19:29:42.698963 amazon-ssm-agent[2111]: 2024/10/08 19:29:42 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Oct 8 19:29:42.699086 amazon-ssm-agent[2111]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Oct 8 19:29:42.699291 amazon-ssm-agent[2111]: 2024/10/08 19:29:42 processing appconfig overrides Oct 8 19:29:42.700170 amazon-ssm-agent[2111]: 2024-10-08 19:29:42 INFO Proxy environment variables: Oct 8 19:29:42.702008 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Oct 8 19:29:42.707805 amazon-ssm-agent[2111]: 2024/10/08 19:29:42 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Oct 8 19:29:42.707805 amazon-ssm-agent[2111]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Oct 8 19:29:42.707975 amazon-ssm-agent[2111]: 2024/10/08 19:29:42 processing appconfig overrides Oct 8 19:29:42.804376 amazon-ssm-agent[2111]: 2024-10-08 19:29:42 INFO no_proxy: Oct 8 19:29:42.906464 amazon-ssm-agent[2111]: 2024-10-08 19:29:42 INFO https_proxy: Oct 8 19:29:42.916942 systemd[1]: Starting docker.service - Docker Application Container Engine... Oct 8 19:29:42.928404 (dockerd)[2138]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Oct 8 19:29:43.005594 amazon-ssm-agent[2111]: 2024-10-08 19:29:42 INFO http_proxy: Oct 8 19:29:43.105543 amazon-ssm-agent[2111]: 2024-10-08 19:29:42 INFO Checking if agent identity type OnPrem can be assumed Oct 8 19:29:43.203751 amazon-ssm-agent[2111]: 2024-10-08 19:29:42 INFO Checking if agent identity type EC2 can be assumed Oct 8 19:29:43.302903 amazon-ssm-agent[2111]: 2024-10-08 19:29:42 INFO Agent will take identity from EC2 Oct 8 19:29:43.369118 amazon-ssm-agent[2111]: 2024-10-08 19:29:42 INFO [amazon-ssm-agent] using named pipe channel for IPC Oct 8 19:29:43.369118 amazon-ssm-agent[2111]: 2024-10-08 19:29:42 INFO [amazon-ssm-agent] using named pipe channel for IPC Oct 8 19:29:43.369287 amazon-ssm-agent[2111]: 2024-10-08 19:29:42 INFO [amazon-ssm-agent] using named pipe channel for IPC Oct 8 19:29:43.369287 amazon-ssm-agent[2111]: 2024-10-08 19:29:42 INFO [amazon-ssm-agent] amazon-ssm-agent - v3.2.0.0 Oct 8 19:29:43.369547 amazon-ssm-agent[2111]: 2024-10-08 19:29:42 INFO [amazon-ssm-agent] OS: linux, Arch: arm64 Oct 8 19:29:43.369611 amazon-ssm-agent[2111]: 2024-10-08 19:29:42 INFO [amazon-ssm-agent] Starting Core Agent Oct 8 19:29:43.369611 amazon-ssm-agent[2111]: 2024-10-08 19:29:42 INFO [amazon-ssm-agent] registrar detected. Attempting registration Oct 8 19:29:43.369696 amazon-ssm-agent[2111]: 2024-10-08 19:29:42 INFO [Registrar] Starting registrar module Oct 8 19:29:43.369696 amazon-ssm-agent[2111]: 2024-10-08 19:29:42 INFO [EC2Identity] no registration info found for ec2 instance, attempting registration Oct 8 19:29:43.369696 amazon-ssm-agent[2111]: 2024-10-08 19:29:43 INFO [EC2Identity] EC2 registration was successful. Oct 8 19:29:43.369696 amazon-ssm-agent[2111]: 2024-10-08 19:29:43 INFO [CredentialRefresher] credentialRefresher has started Oct 8 19:29:43.369865 amazon-ssm-agent[2111]: 2024-10-08 19:29:43 INFO [CredentialRefresher] Starting credentials refresher loop Oct 8 19:29:43.369865 amazon-ssm-agent[2111]: 2024-10-08 19:29:43 INFO EC2RoleProvider Successfully connected with instance profile role credentials Oct 8 19:29:43.401672 amazon-ssm-agent[2111]: 2024-10-08 19:29:43 INFO [CredentialRefresher] Next credential rotation will be in 31.141636419466668 minutes Oct 8 19:29:43.441891 dockerd[2138]: time="2024-10-08T19:29:43.441808905Z" level=info msg="Starting up" Oct 8 19:29:43.485656 systemd[1]: var-lib-docker-check\x2doverlayfs\x2dsupport730718825-merged.mount: Deactivated successfully. Oct 8 19:29:43.508054 systemd[1]: var-lib-docker-metacopy\x2dcheck321045491-merged.mount: Deactivated successfully. Oct 8 19:29:43.522742 dockerd[2138]: time="2024-10-08T19:29:43.522694521Z" level=info msg="Loading containers: start." Oct 8 19:29:43.573948 sshd_keygen[1963]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Oct 8 19:29:43.618194 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Oct 8 19:29:43.629841 systemd[1]: Starting issuegen.service - Generate /run/issue... Oct 8 19:29:43.639535 systemd[1]: Started sshd@0-172.31.22.193:22-139.178.68.195:50010.service - OpenSSH per-connection server daemon (139.178.68.195:50010). Oct 8 19:29:43.666467 systemd[1]: issuegen.service: Deactivated successfully. Oct 8 19:29:43.668928 systemd[1]: Finished issuegen.service - Generate /run/issue. Oct 8 19:29:43.684548 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Oct 8 19:29:43.722599 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Oct 8 19:29:43.736496 systemd[1]: Started getty@tty1.service - Getty on tty1. Oct 8 19:29:43.750035 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Oct 8 19:29:43.753409 systemd[1]: Reached target getty.target - Login Prompts. Oct 8 19:29:43.862383 kernel: Initializing XFRM netlink socket Oct 8 19:29:43.879738 sshd[2165]: Accepted publickey for core from 139.178.68.195 port 50010 ssh2: RSA SHA256:IeMX6f66zb7RPZo/kruzSd2zvwuQNDsSkQpBR1XCjX8 Oct 8 19:29:43.883047 sshd[2165]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 8 19:29:43.905467 systemd-logind[1924]: New session 1 of user core. Oct 8 19:29:43.907703 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Oct 8 19:29:43.919851 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Oct 8 19:29:43.951405 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Oct 8 19:29:43.967246 systemd[1]: Starting user@500.service - User Manager for UID 500... Oct 8 19:29:43.989073 (systemd)[2217]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 8 19:29:44.076580 systemd-networkd[1784]: docker0: Link UP Oct 8 19:29:44.101261 dockerd[2138]: time="2024-10-08T19:29:44.101189780Z" level=info msg="Loading containers: done." Oct 8 19:29:44.232785 dockerd[2138]: time="2024-10-08T19:29:44.232646385Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Oct 8 19:29:44.233009 dockerd[2138]: time="2024-10-08T19:29:44.232979205Z" level=info msg="Docker daemon" commit=fca702de7f71362c8d103073c7e4a1d0a467fadd graphdriver=overlay2 version=24.0.9 Oct 8 19:29:44.233277 dockerd[2138]: time="2024-10-08T19:29:44.233222049Z" level=info msg="Daemon has completed initialization" Oct 8 19:29:44.237936 systemd[2217]: Queued start job for default target default.target. Oct 8 19:29:44.254810 systemd[2217]: Created slice app.slice - User Application Slice. Oct 8 19:29:44.255152 systemd[2217]: Reached target paths.target - Paths. Oct 8 19:29:44.255382 systemd[2217]: Reached target timers.target - Timers. Oct 8 19:29:44.258711 systemd[2217]: Starting dbus.socket - D-Bus User Message Bus Socket... Oct 8 19:29:44.289871 systemd[2217]: Listening on dbus.socket - D-Bus User Message Bus Socket. Oct 8 19:29:44.290430 systemd[2217]: Reached target sockets.target - Sockets. Oct 8 19:29:44.290735 systemd[2217]: Reached target basic.target - Basic System. Oct 8 19:29:44.291106 systemd[2217]: Reached target default.target - Main User Target. Oct 8 19:29:44.291465 systemd[2217]: Startup finished in 281ms. Oct 8 19:29:44.291964 systemd[1]: Started user@500.service - User Manager for UID 500. Oct 8 19:29:44.302688 systemd[1]: Started session-1.scope - Session 1 of User core. Oct 8 19:29:44.307672 dockerd[2138]: time="2024-10-08T19:29:44.307523901Z" level=info msg="API listen on /run/docker.sock" Oct 8 19:29:44.308123 systemd[1]: Started docker.service - Docker Application Container Engine. Oct 8 19:29:44.314214 etcd-wrapper[2126]: Error response from daemon: No such container: etcd-member Oct 8 19:29:44.341708 etcd-wrapper[2282]: Error response from daemon: No such container: etcd-member Oct 8 19:29:44.394991 etcd-wrapper[2298]: Unable to find image 'quay.io/coreos/etcd:v3.5.0-arm64' locally Oct 8 19:29:44.419785 amazon-ssm-agent[2111]: 2024-10-08 19:29:44 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker is not running, starting worker process Oct 8 19:29:44.475881 systemd[1]: Started sshd@1-172.31.22.193:22-139.178.68.195:50018.service - OpenSSH per-connection server daemon (139.178.68.195:50018). Oct 8 19:29:44.520041 amazon-ssm-agent[2111]: 2024-10-08 19:29:44 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker (pid:2307) started Oct 8 19:29:44.620542 amazon-ssm-agent[2111]: 2024-10-08 19:29:44 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] Monitor long running worker health every 60 seconds Oct 8 19:29:44.681795 sshd[2309]: Accepted publickey for core from 139.178.68.195 port 50018 ssh2: RSA SHA256:IeMX6f66zb7RPZo/kruzSd2zvwuQNDsSkQpBR1XCjX8 Oct 8 19:29:44.686603 sshd[2309]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 8 19:29:44.701669 systemd-logind[1924]: New session 2 of user core. Oct 8 19:29:44.707649 systemd[1]: Started session-2.scope - Session 2 of User core. Oct 8 19:29:44.837074 sshd[2309]: pam_unix(sshd:session): session closed for user core Oct 8 19:29:44.843712 systemd-logind[1924]: Session 2 logged out. Waiting for processes to exit. Oct 8 19:29:44.845089 systemd[1]: sshd@1-172.31.22.193:22-139.178.68.195:50018.service: Deactivated successfully. Oct 8 19:29:44.849877 systemd[1]: session-2.scope: Deactivated successfully. Oct 8 19:29:44.851885 systemd-logind[1924]: Removed session 2. Oct 8 19:29:44.875889 systemd[1]: Started sshd@2-172.31.22.193:22-139.178.68.195:50020.service - OpenSSH per-connection server daemon (139.178.68.195:50020). Oct 8 19:29:45.055125 sshd[2326]: Accepted publickey for core from 139.178.68.195 port 50020 ssh2: RSA SHA256:IeMX6f66zb7RPZo/kruzSd2zvwuQNDsSkQpBR1XCjX8 Oct 8 19:29:45.057654 sshd[2326]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 8 19:29:45.066245 systemd-logind[1924]: New session 3 of user core. Oct 8 19:29:45.073662 systemd[1]: Started session-3.scope - Session 3 of User core. Oct 8 19:29:45.204164 sshd[2326]: pam_unix(sshd:session): session closed for user core Oct 8 19:29:45.210087 systemd[1]: sshd@2-172.31.22.193:22-139.178.68.195:50020.service: Deactivated successfully. Oct 8 19:29:45.213179 systemd[1]: session-3.scope: Deactivated successfully. Oct 8 19:29:45.216462 systemd-logind[1924]: Session 3 logged out. Waiting for processes to exit. Oct 8 19:29:45.218215 systemd-logind[1924]: Removed session 3. Oct 8 19:29:46.041532 etcd-wrapper[2298]: v3.5.0-arm64: Pulling from coreos/etcd Oct 8 19:29:46.041532 etcd-wrapper[2298]: 6022c6b01d76: Pulling fs layer Oct 8 19:29:46.041532 etcd-wrapper[2298]: 1d97b1ec77fc: Pulling fs layer Oct 8 19:29:46.041532 etcd-wrapper[2298]: 99ef4b690837: Pulling fs layer Oct 8 19:29:46.041532 etcd-wrapper[2298]: 435b7bf0967c: Pulling fs layer Oct 8 19:29:46.041532 etcd-wrapper[2298]: 17e4a5f7c1b5: Pulling fs layer Oct 8 19:29:46.041532 etcd-wrapper[2298]: 5b0292999756: Pulling fs layer Oct 8 19:29:46.041532 etcd-wrapper[2298]: 435b7bf0967c: Waiting Oct 8 19:29:46.041532 etcd-wrapper[2298]: 17e4a5f7c1b5: Waiting Oct 8 19:29:46.041532 etcd-wrapper[2298]: 5b0292999756: Waiting Oct 8 19:29:46.489230 ntpd[1918]: Listen normally on 7 eth0 [fe80::403:76ff:fe37:a811%2]:123 Oct 8 19:29:46.491806 ntpd[1918]: 8 Oct 19:29:46 ntpd[1918]: Listen normally on 7 eth0 [fe80::403:76ff:fe37:a811%2]:123 Oct 8 19:29:46.514532 etcd-wrapper[2298]: 99ef4b690837: Verifying Checksum Oct 8 19:29:46.514532 etcd-wrapper[2298]: 99ef4b690837: Download complete Oct 8 19:29:46.549508 etcd-wrapper[2298]: 6022c6b01d76: Verifying Checksum Oct 8 19:29:46.552282 etcd-wrapper[2298]: 6022c6b01d76: Download complete Oct 8 19:29:46.584732 etcd-wrapper[2298]: 1d97b1ec77fc: Verifying Checksum Oct 8 19:29:46.584732 etcd-wrapper[2298]: 1d97b1ec77fc: Download complete Oct 8 19:29:46.865557 etcd-wrapper[2298]: 17e4a5f7c1b5: Verifying Checksum Oct 8 19:29:46.865557 etcd-wrapper[2298]: 17e4a5f7c1b5: Download complete Oct 8 19:29:46.892395 etcd-wrapper[2298]: 5b0292999756: Verifying Checksum Oct 8 19:29:46.892395 etcd-wrapper[2298]: 5b0292999756: Download complete Oct 8 19:29:46.893673 etcd-wrapper[2298]: 435b7bf0967c: Verifying Checksum Oct 8 19:29:46.893673 etcd-wrapper[2298]: 435b7bf0967c: Download complete Oct 8 19:29:47.995543 etcd-wrapper[2298]: 6022c6b01d76: Pull complete Oct 8 19:29:48.247750 systemd[1]: var-lib-docker-overlay2-c99fb7d64be92c6873f7638af9ad737a2ed7e4890dbb36a70e8740574986ad29-merged.mount: Deactivated successfully. Oct 8 19:29:48.271519 etcd-wrapper[2298]: 1d97b1ec77fc: Pull complete Oct 8 19:29:48.311444 kernel: overlayfs: lowerdir is in-use as upperdir/workdir of another mount, accessing files from both mounts will result in undefined behavior. Oct 8 19:29:48.546267 systemd[1]: var-lib-docker-overlay2-aecaf9a32287258b6dc22acb6e9a12548873b4b91ed89706bfbb9f825db059b4-merged.mount: Deactivated successfully. Oct 8 19:29:48.578199 etcd-wrapper[2298]: 99ef4b690837: Pull complete Oct 8 19:29:48.814845 etcd-wrapper[2298]: 435b7bf0967c: Pull complete Oct 8 19:29:48.845153 etcd-wrapper[2298]: 17e4a5f7c1b5: Pull complete Oct 8 19:29:48.882579 etcd-wrapper[2298]: 5b0292999756: Pull complete Oct 8 19:29:48.891633 etcd-wrapper[2298]: Digest: sha256:96255d1ad67e7afcea46b4dc1b7e74024b9f6971193cb7316b093b3b5671efb0 Oct 8 19:29:48.895256 etcd-wrapper[2298]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.0-arm64 Oct 8 19:29:49.010168 systemd[1]: var-lib-docker-overlay2-c280bb5495b5d5fdc04a815a3c1d73d9f9cbaef006d72fb488c2cd08c4a931aa-merged.mount: Deactivated successfully. Oct 8 19:29:49.151570 containerd[1934]: time="2024-10-08T19:29:49.150505852Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Oct 8 19:29:49.151570 containerd[1934]: time="2024-10-08T19:29:49.150687107Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 8 19:29:49.151570 containerd[1934]: time="2024-10-08T19:29:49.150787669Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Oct 8 19:29:49.151570 containerd[1934]: time="2024-10-08T19:29:49.150859981Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 8 19:29:49.188682 systemd[1]: Started docker-a9eec9fa2b3cd4ceb37ab14b8e5ed2faedf810691126288ae6340940693017b1.scope - libcontainer container a9eec9fa2b3cd4ceb37ab14b8e5ed2faedf810691126288ae6340940693017b1. Oct 8 19:29:49.278065 etcd-wrapper[2298]: {"level":"info","ts":1728415789.277641,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Oct 8 19:29:49.278777 etcd-wrapper[2298]: {"level":"info","ts":1728415789.27786,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"ec22645a63ec13f6d1f75790cd86ac3a"} Oct 8 19:29:49.278777 etcd-wrapper[2298]: {"level":"warn","ts":1728415789.2779453,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Oct 8 19:29:49.279188 etcd-wrapper[2298]: {"level":"warn","ts":1728415789.277998,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.0-arm64"} Oct 8 19:29:49.279491 etcd-wrapper[2298]: {"level":"warn","ts":1728415789.2790291,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Oct 8 19:29:49.279491 etcd-wrapper[2298]: {"level":"warn","ts":1728415789.279105,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Oct 8 19:29:49.280439 etcd-wrapper[2298]: {"level":"warn","ts":1728415789.2793758,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_UNSUPPORTED_ARCH=arm64"} Oct 8 19:29:49.280811 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:49.279Z","caller":"etcdmain/etcd.go:72","msg":"Running: ","args":["/usr/local/bin/etcd","--listen-peer-urls=http://172.31.22.193:2380","--listen-client-urls=http://0.0.0.0:2379","--initial-advertise-peer-urls=http://172.31.22.193:2380","--advertise-client-urls=http://172.31.22.193:2379","--discovery=https://discovery.etcd.io/27d3d374e50a35a2d52b5da7d3d2677d"]} Oct 8 19:29:49.280811 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:49.279Z","caller":"embed/etcd.go:131","msg":"configuring peer listeners","listen-peer-urls":["http://172.31.22.193:2380"]} Oct 8 19:29:49.280811 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:49.280Z","caller":"embed/etcd.go:139","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Oct 8 19:29:49.281417 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:49.280Z","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":"ec22645a63ec13f6d1f75790cd86ac3a","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://172.31.22.193:2380"],"listen-peer-urls":["http://172.31.22.193:2380"],"advertise-client-urls":["http://172.31.22.193:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"ec22645a63ec13f6d1f75790cd86ac3a=http://172.31.22.193:2380","initial-cluster-state":"new","initial-cluster-token":"https://discovery.etcd.io/27d3d374e50a35a2d52b5da7d3d2677d","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":"https://discovery.etcd.io/27d3d374e50a35a2d52b5da7d3d2677d","discovery-proxy":"","downgrade-check-interval":"5s"} Oct 8 19:29:49.284205 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:49.283Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"1.702223ms"} Oct 8 19:29:50.032839 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.032Z","caller":"v2discovery/discovery.go:342","msg":"found peer from discovery server","discovery-url":"https://discovery.etcd.io","peer":"df7acfb9a6d16138"} Oct 8 19:29:50.032839 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.032Z","caller":"v2discovery/discovery.go:342","msg":"found peer from discovery server","discovery-url":"https://discovery.etcd.io","peer":"5e14f82f10d71f1e"} Oct 8 19:29:50.032839 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.032Z","caller":"v2discovery/discovery.go:336","msg":"found self from discovery server","discovery-url":"https://discovery.etcd.io","self":"cdf0998b5854e7e8"} Oct 8 19:29:50.032839 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.032Z","caller":"v2discovery/discovery.go:378","msg":"found all needed peers from discovery server","discovery-url":"https://discovery.etcd.io","found-peers":3} Oct 8 19:29:50.038709 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.037Z","caller":"etcdserver/raft.go:448","msg":"starting local member","local-member-id":"cdf0998b5854e7e8","cluster-id":"a57baa3bbe9c9fb9"} Oct 8 19:29:50.038935 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.038Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cdf0998b5854e7e8 switched to configuration voters=()"} Oct 8 19:29:50.038935 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.038Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cdf0998b5854e7e8 became follower at term 0"} Oct 8 19:29:50.038935 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.038Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cdf0998b5854e7e8 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} Oct 8 19:29:50.038935 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.038Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cdf0998b5854e7e8 became follower at term 1"} Oct 8 19:29:50.038935 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.038Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cdf0998b5854e7e8 switched to configuration voters=(6779316220129124126)"} Oct 8 19:29:50.039386 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.038Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cdf0998b5854e7e8 switched to configuration voters=(6779316220129124126 14839529595947247592)"} Oct 8 19:29:50.039386 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.038Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cdf0998b5854e7e8 switched to configuration voters=(6779316220129124126 14839529595947247592 16103411813891268920)"} Oct 8 19:29:50.040587 etcd-wrapper[2298]: {"level":"warn","ts":"2024-10-08T19:29:50.040Z","caller":"auth/store.go:1220","msg":"simple token is not cryptographically signed"} Oct 8 19:29:50.043386 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.042Z","caller":"mvcc/kvstore.go:415","msg":"kvstore restored","current-rev":1} Oct 8 19:29:50.044284 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.043Z","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"} Oct 8 19:29:50.045957 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.045Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"5e14f82f10d71f1e"} Oct 8 19:29:50.045957 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.045Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"cdf0998b5854e7e8","remote-peer-id":"5e14f82f10d71f1e"} Oct 8 19:29:50.046820 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.046Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"cdf0998b5854e7e8","remote-peer-id":"5e14f82f10d71f1e"} Oct 8 19:29:50.047122 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.046Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"cdf0998b5854e7e8","remote-peer-id":"5e14f82f10d71f1e"} Oct 8 19:29:50.047911 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.047Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"5e14f82f10d71f1e"} Oct 8 19:29:50.047911 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.047Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"cdf0998b5854e7e8","remote-peer-id":"5e14f82f10d71f1e"} Oct 8 19:29:50.047911 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.047Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"cdf0998b5854e7e8","remote-peer-id":"5e14f82f10d71f1e","remote-peer-urls":["http://172.31.18.43:2380"]} Oct 8 19:29:50.047911 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.047Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"df7acfb9a6d16138"} Oct 8 19:29:50.047911 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.047Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"cdf0998b5854e7e8","remote-peer-id":"df7acfb9a6d16138"} Oct 8 19:29:50.050315 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.048Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"cdf0998b5854e7e8","remote-peer-id":"5e14f82f10d71f1e"} Oct 8 19:29:50.050315 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.049Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"cdf0998b5854e7e8","remote-peer-id":"df7acfb9a6d16138"} Oct 8 19:29:50.052110 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.051Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"5e14f82f10d71f1e"} Oct 8 19:29:50.052110 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.051Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"cdf0998b5854e7e8","remote-peer-id":"5e14f82f10d71f1e"} Oct 8 19:29:50.054067 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.053Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"cdf0998b5854e7e8","remote-peer-id":"df7acfb9a6d16138"} Oct 8 19:29:50.054743 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.054Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"df7acfb9a6d16138"} Oct 8 19:29:50.054977 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.054Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"cdf0998b5854e7e8","remote-peer-id":"df7acfb9a6d16138","remote-peer-urls":["http://172.31.23.128:2380"]} Oct 8 19:29:50.055254 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.054Z","caller":"etcdserver/server.go:843","msg":"starting etcd server","local-member-id":"cdf0998b5854e7e8","local-server-version":"3.5.0","cluster-version":"to_be_decided"} Oct 8 19:29:50.055941 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.055Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"cdf0998b5854e7e8","remote-peer-id":"df7acfb9a6d16138"} Oct 8 19:29:50.056592 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.056Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"cdf0998b5854e7e8","remote-peer-id":"df7acfb9a6d16138"} Oct 8 19:29:50.057162 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.054Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"cdf0998b5854e7e8","remote-peer-id":"5e14f82f10d71f1e"} Oct 8 19:29:50.058855 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.058Z","caller":"etcdserver/server.go:744","msg":"starting initial election tick advance","election-ticks":10} Oct 8 19:29:50.060703 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cdf0998b5854e7e8 switched to configuration voters=(6779316220129124126 14839529595947247592 16103411813891268920)"} Oct 8 19:29:50.060703 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.059Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"a57baa3bbe9c9fb9","local-member-id":"cdf0998b5854e7e8","added-peer-id":"5e14f82f10d71f1e","added-peer-peer-urls":["http://172.31.18.43:2380"]} Oct 8 19:29:50.060703 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cdf0998b5854e7e8 switched to configuration voters=(6779316220129124126 14839529595947247592 16103411813891268920)"} Oct 8 19:29:50.060703 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.059Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"a57baa3bbe9c9fb9","local-member-id":"cdf0998b5854e7e8","added-peer-id":"cdf0998b5854e7e8","added-peer-peer-urls":["http://172.31.22.193:2380"]} Oct 8 19:29:50.060703 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cdf0998b5854e7e8 switched to configuration voters=(6779316220129124126 14839529595947247592 16103411813891268920)"} Oct 8 19:29:50.060703 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.059Z","caller":"embed/etcd.go:276","msg":"now serving peer/client/metrics","local-member-id":"cdf0998b5854e7e8","initial-advertise-peer-urls":["http://172.31.22.193:2380"],"listen-peer-urls":["http://172.31.22.193:2380"],"advertise-client-urls":["http://172.31.22.193:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} Oct 8 19:29:50.060703 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.059Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"a57baa3bbe9c9fb9","local-member-id":"cdf0998b5854e7e8","added-peer-id":"df7acfb9a6d16138","added-peer-peer-urls":["http://172.31.23.128:2380"]} Oct 8 19:29:50.060703 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.059Z","caller":"embed/etcd.go:580","msg":"serving peer traffic","address":"172.31.22.193:2380"} Oct 8 19:29:50.061320 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.059Z","caller":"embed/etcd.go:552","msg":"cmux::serve","address":"172.31.22.193:2380"} Oct 8 19:29:50.061320 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.059Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"df7acfb9a6d16138"} Oct 8 19:29:50.061320 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.060Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"cdf0998b5854e7e8","remote-peer-id":"df7acfb9a6d16138"} Oct 8 19:29:50.061320 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.060Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"cdf0998b5854e7e8","remote-peer-id":"df7acfb9a6d16138"} Oct 8 19:29:50.062167 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.060Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"cdf0998b5854e7e8","to":"df7acfb9a6d16138","stream-type":"stream Message"} Oct 8 19:29:50.062167 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.060Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"cdf0998b5854e7e8","remote-peer-id":"df7acfb9a6d16138"} Oct 8 19:29:50.062167 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.061Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"cdf0998b5854e7e8","to":"df7acfb9a6d16138","stream-type":"stream MsgApp v2"} Oct 8 19:29:50.062167 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.061Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"cdf0998b5854e7e8","remote-peer-id":"df7acfb9a6d16138"} Oct 8 19:29:50.062703 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.062Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"cdf0998b5854e7e8","to":"5e14f82f10d71f1e","stream-type":"stream Message"} Oct 8 19:29:50.062703 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.062Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"cdf0998b5854e7e8","remote-peer-id":"5e14f82f10d71f1e"} Oct 8 19:29:50.066881 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.066Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"cdf0998b5854e7e8","to":"5e14f82f10d71f1e","stream-type":"stream MsgApp v2"} Oct 8 19:29:50.067147 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.066Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"cdf0998b5854e7e8","remote-peer-id":"5e14f82f10d71f1e"} Oct 8 19:29:50.073867 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cdf0998b5854e7e8 [logterm: 1, index: 3, vote: 0] cast MsgPreVote for df7acfb9a6d16138 [logterm: 1, index: 3] at term 1"} Oct 8 19:29:50.075391 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.074Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cdf0998b5854e7e8 [term: 1] received a MsgVote message with higher term from df7acfb9a6d16138 [term: 2]"} Oct 8 19:29:50.075391 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.074Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cdf0998b5854e7e8 became follower at term 2"} Oct 8 19:29:50.075391 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.075Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cdf0998b5854e7e8 [logterm: 1, index: 3, vote: 0] cast MsgVote for df7acfb9a6d16138 [logterm: 1, index: 3] at term 2"} Oct 8 19:29:50.077610 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.077Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cdf0998b5854e7e8 elected leader df7acfb9a6d16138 at term 2"} Oct 8 19:29:50.081527 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.081Z","caller":"etcdserver/server.go:2027","msg":"published local member to cluster through raft","local-member-id":"cdf0998b5854e7e8","local-member-attributes":"{Name:ec22645a63ec13f6d1f75790cd86ac3a ClientURLs:[http://172.31.22.193:2379]}","request-path":"/0/members/cdf0998b5854e7e8/attributes","cluster-id":"a57baa3bbe9c9fb9","publish-timeout":"7s"} Oct 8 19:29:50.084218 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.081Z","caller":"embed/serve.go:98","msg":"ready to serve client requests"} Oct 8 19:29:50.083270 systemd[1]: Started etcd-member.service - etcd (System Application Container). Oct 8 19:29:50.084046 systemd[1]: Reached target multi-user.target - Multi-User System. Oct 8 19:29:50.084577 systemd[1]: Startup finished in 1.218s (kernel) + 6.885s (initrd) + 13.446s (userspace) = 21.550s. Oct 8 19:29:50.086605 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.082Z","caller":"etcdmain/main.go:47","msg":"notifying init daemon"} Oct 8 19:29:50.086605 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.082Z","caller":"etcdmain/main.go:53","msg":"successfully notified init daemon"} Oct 8 19:29:50.086605 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.083Z","caller":"embed/serve.go:140","msg":"serving client traffic insecurely; this is strongly discouraged!","address":"[::]:2379"} Oct 8 19:29:50.091006 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.090Z","caller":"membership/cluster.go:531","msg":"set initial cluster version","cluster-id":"a57baa3bbe9c9fb9","local-member-id":"cdf0998b5854e7e8","cluster-version":"3.5"} Oct 8 19:29:50.091355 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.090Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Oct 8 19:29:50.109742 etcd-wrapper[2298]: {"level":"info","ts":"2024-10-08T19:29:50.109Z","caller":"etcdserver/server.go:767","msg":"initialized peer connections; fast-forwarding election ticks","local-member-id":"cdf0998b5854e7e8","forward-ticks":8,"forward-duration":"800ms","election-ticks":10,"election-timeout":"1s","active-remote-members":2} Oct 8 19:29:55.242699 systemd[1]: Started sshd@3-172.31.22.193:22-139.178.68.195:49720.service - OpenSSH per-connection server daemon (139.178.68.195:49720). Oct 8 19:29:55.425215 sshd[2417]: Accepted publickey for core from 139.178.68.195 port 49720 ssh2: RSA SHA256:IeMX6f66zb7RPZo/kruzSd2zvwuQNDsSkQpBR1XCjX8 Oct 8 19:29:55.427819 sshd[2417]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 8 19:29:55.436260 systemd-logind[1924]: New session 4 of user core. Oct 8 19:29:55.444662 systemd[1]: Started session-4.scope - Session 4 of User core. Oct 8 19:29:55.573702 sshd[2417]: pam_unix(sshd:session): session closed for user core Oct 8 19:29:55.578550 systemd[1]: sshd@3-172.31.22.193:22-139.178.68.195:49720.service: Deactivated successfully. Oct 8 19:29:55.582204 systemd[1]: session-4.scope: Deactivated successfully. Oct 8 19:29:55.585051 systemd-logind[1924]: Session 4 logged out. Waiting for processes to exit. Oct 8 19:29:55.587811 systemd-logind[1924]: Removed session 4. Oct 8 19:29:55.615921 systemd[1]: Started sshd@4-172.31.22.193:22-139.178.68.195:49732.service - OpenSSH per-connection server daemon (139.178.68.195:49732). Oct 8 19:29:55.794818 sshd[2424]: Accepted publickey for core from 139.178.68.195 port 49732 ssh2: RSA SHA256:IeMX6f66zb7RPZo/kruzSd2zvwuQNDsSkQpBR1XCjX8 Oct 8 19:29:55.797408 sshd[2424]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 8 19:29:55.805987 systemd-logind[1924]: New session 5 of user core. Oct 8 19:29:55.814660 systemd[1]: Started session-5.scope - Session 5 of User core. Oct 8 19:29:55.936147 sshd[2424]: pam_unix(sshd:session): session closed for user core Oct 8 19:29:55.942418 systemd-logind[1924]: Session 5 logged out. Waiting for processes to exit. Oct 8 19:29:55.944603 systemd[1]: sshd@4-172.31.22.193:22-139.178.68.195:49732.service: Deactivated successfully. Oct 8 19:29:55.949283 systemd[1]: session-5.scope: Deactivated successfully. Oct 8 19:29:55.950828 systemd-logind[1924]: Removed session 5. Oct 8 19:29:55.976927 systemd[1]: Started sshd@5-172.31.22.193:22-139.178.68.195:49742.service - OpenSSH per-connection server daemon (139.178.68.195:49742). Oct 8 19:29:56.159321 sshd[2431]: Accepted publickey for core from 139.178.68.195 port 49742 ssh2: RSA SHA256:IeMX6f66zb7RPZo/kruzSd2zvwuQNDsSkQpBR1XCjX8 Oct 8 19:29:56.161879 sshd[2431]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 8 19:29:56.171639 systemd-logind[1924]: New session 6 of user core. Oct 8 19:29:56.178624 systemd[1]: Started session-6.scope - Session 6 of User core. Oct 8 19:29:56.309034 sshd[2431]: pam_unix(sshd:session): session closed for user core Oct 8 19:29:56.315305 systemd[1]: sshd@5-172.31.22.193:22-139.178.68.195:49742.service: Deactivated successfully. Oct 8 19:29:56.318884 systemd[1]: session-6.scope: Deactivated successfully. Oct 8 19:29:56.322494 systemd-logind[1924]: Session 6 logged out. Waiting for processes to exit. Oct 8 19:29:56.324770 systemd-logind[1924]: Removed session 6. Oct 8 19:29:56.345879 systemd[1]: Started sshd@6-172.31.22.193:22-139.178.68.195:49744.service - OpenSSH per-connection server daemon (139.178.68.195:49744). Oct 8 19:29:56.525501 sshd[2438]: Accepted publickey for core from 139.178.68.195 port 49744 ssh2: RSA SHA256:IeMX6f66zb7RPZo/kruzSd2zvwuQNDsSkQpBR1XCjX8 Oct 8 19:29:56.528043 sshd[2438]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 8 19:29:56.537745 systemd-logind[1924]: New session 7 of user core. Oct 8 19:29:56.545655 systemd[1]: Started session-7.scope - Session 7 of User core. Oct 8 19:29:56.662543 sudo[2441]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Oct 8 19:29:56.663079 sudo[2441]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 8 19:29:56.679140 sudo[2441]: pam_unix(sudo:session): session closed for user root Oct 8 19:29:56.702723 sshd[2438]: pam_unix(sshd:session): session closed for user core Oct 8 19:29:56.709840 systemd[1]: sshd@6-172.31.22.193:22-139.178.68.195:49744.service: Deactivated successfully. Oct 8 19:29:56.714082 systemd[1]: session-7.scope: Deactivated successfully. Oct 8 19:29:56.716731 systemd-logind[1924]: Session 7 logged out. Waiting for processes to exit. Oct 8 19:29:56.718809 systemd-logind[1924]: Removed session 7. Oct 8 19:29:56.739924 systemd[1]: Started sshd@7-172.31.22.193:22-139.178.68.195:49760.service - OpenSSH per-connection server daemon (139.178.68.195:49760). Oct 8 19:29:56.922946 sshd[2446]: Accepted publickey for core from 139.178.68.195 port 49760 ssh2: RSA SHA256:IeMX6f66zb7RPZo/kruzSd2zvwuQNDsSkQpBR1XCjX8 Oct 8 19:29:56.925185 sshd[2446]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 8 19:29:56.934073 systemd-logind[1924]: New session 8 of user core. Oct 8 19:29:56.940641 systemd[1]: Started session-8.scope - Session 8 of User core. Oct 8 19:29:57.046742 sudo[2450]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Oct 8 19:29:57.047290 sudo[2450]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 8 19:29:57.053863 sudo[2450]: pam_unix(sudo:session): session closed for user root Oct 8 19:29:57.065270 sudo[2449]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules Oct 8 19:29:57.065919 sudo[2449]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 8 19:29:57.092877 systemd[1]: Stopping audit-rules.service - Load Security Auditing Rules... Oct 8 19:29:57.097877 auditctl[2453]: No rules Oct 8 19:29:57.098778 systemd[1]: audit-rules.service: Deactivated successfully. Oct 8 19:29:57.099272 systemd[1]: Stopped audit-rules.service - Load Security Auditing Rules. Oct 8 19:29:57.111277 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Oct 8 19:29:57.160049 augenrules[2471]: No rules Oct 8 19:29:57.163057 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Oct 8 19:29:57.165613 sudo[2449]: pam_unix(sudo:session): session closed for user root Oct 8 19:29:57.189971 sshd[2446]: pam_unix(sshd:session): session closed for user core Oct 8 19:29:57.197363 systemd[1]: sshd@7-172.31.22.193:22-139.178.68.195:49760.service: Deactivated successfully. Oct 8 19:29:57.201608 systemd[1]: session-8.scope: Deactivated successfully. Oct 8 19:29:57.203207 systemd-logind[1924]: Session 8 logged out. Waiting for processes to exit. Oct 8 19:29:57.205203 systemd-logind[1924]: Removed session 8. Oct 8 19:29:57.223781 systemd[1]: Started sshd@8-172.31.22.193:22-139.178.68.195:49774.service - OpenSSH per-connection server daemon (139.178.68.195:49774). Oct 8 19:29:57.409364 sshd[2479]: Accepted publickey for core from 139.178.68.195 port 49774 ssh2: RSA SHA256:IeMX6f66zb7RPZo/kruzSd2zvwuQNDsSkQpBR1XCjX8 Oct 8 19:29:57.411909 sshd[2479]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 8 19:29:57.421527 systemd-logind[1924]: New session 9 of user core. Oct 8 19:29:57.432655 systemd[1]: Started session-9.scope - Session 9 of User core. Oct 8 19:29:57.646672 sshd[2479]: pam_unix(sshd:session): session closed for user core Oct 8 19:29:57.652049 systemd-logind[1924]: Session 9 logged out. Waiting for processes to exit. Oct 8 19:29:57.654806 systemd[1]: sshd@8-172.31.22.193:22-139.178.68.195:49774.service: Deactivated successfully. Oct 8 19:29:57.659717 systemd[1]: session-9.scope: Deactivated successfully. Oct 8 19:29:57.661280 systemd-logind[1924]: Removed session 9.