Sep 3 23:23:53.107216 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd083] Sep 3 23:23:53.107260 kernel: Linux version 6.12.44-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 14.2.1_p20241221 p7) 14.2.1 20241221, GNU ld (Gentoo 2.44 p1) 2.44.0) #1 SMP PREEMPT Wed Sep 3 22:04:24 -00 2025 Sep 3 23:23:53.107284 kernel: KASLR disabled due to lack of seed Sep 3 23:23:53.107299 kernel: efi: EFI v2.7 by EDK II Sep 3 23:23:53.107314 kernel: efi: SMBIOS=0x7bed0000 SMBIOS 3.0=0x7beb0000 ACPI=0x786e0000 ACPI 2.0=0x786e0014 MEMATTR=0x7a731a98 MEMRESERVE=0x78557598 Sep 3 23:23:53.107329 kernel: secureboot: Secure boot disabled Sep 3 23:23:53.107345 kernel: ACPI: Early table checksum verification disabled Sep 3 23:23:53.107360 kernel: ACPI: RSDP 0x00000000786E0014 000024 (v02 AMAZON) Sep 3 23:23:53.107375 kernel: ACPI: XSDT 0x00000000786D00E8 000064 (v01 AMAZON AMZNFACP 00000001 01000013) Sep 3 23:23:53.107389 kernel: ACPI: FACP 0x00000000786B0000 000114 (v06 AMAZON AMZNFACP 00000001 AMZN 00000001) Sep 3 23:23:53.107433 kernel: ACPI: DSDT 0x0000000078640000 00159D (v02 AMAZON AMZNDSDT 00000001 INTL 20160527) Sep 3 23:23:53.107826 kernel: ACPI: FACS 0x0000000078630000 000040 Sep 3 23:23:53.107842 kernel: ACPI: APIC 0x00000000786C0000 000108 (v04 AMAZON AMZNAPIC 00000001 AMZN 00000001) Sep 3 23:23:53.107858 kernel: ACPI: SPCR 0x00000000786A0000 000050 (v02 AMAZON AMZNSPCR 00000001 AMZN 00000001) Sep 3 23:23:53.107876 kernel: ACPI: GTDT 0x0000000078690000 000060 (v02 AMAZON AMZNGTDT 00000001 AMZN 00000001) Sep 3 23:23:53.107891 kernel: ACPI: MCFG 0x0000000078680000 00003C (v02 AMAZON AMZNMCFG 00000001 AMZN 00000001) Sep 3 23:23:53.107912 kernel: ACPI: SLIT 0x0000000078670000 00002D (v01 AMAZON AMZNSLIT 00000001 AMZN 00000001) Sep 3 23:23:53.107927 kernel: ACPI: IORT 0x0000000078660000 000078 (v01 AMAZON AMZNIORT 00000001 AMZN 00000001) Sep 3 23:23:53.107943 kernel: ACPI: PPTT 0x0000000078650000 0000EC (v01 AMAZON AMZNPPTT 00000001 AMZN 00000001) Sep 3 23:23:53.107959 kernel: ACPI: SPCR: console: uart,mmio,0x90a0000,115200 Sep 3 23:23:53.107975 kernel: earlycon: uart0 at MMIO 0x00000000090a0000 (options '115200') Sep 3 23:23:53.107991 kernel: printk: legacy bootconsole [uart0] enabled Sep 3 23:23:53.108006 kernel: ACPI: Use ACPI SPCR as default console: No Sep 3 23:23:53.108022 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000004b5ffffff] Sep 3 23:23:53.108037 kernel: NODE_DATA(0) allocated [mem 0x4b584ca00-0x4b5853fff] Sep 3 23:23:53.108053 kernel: Zone ranges: Sep 3 23:23:53.108068 kernel: DMA [mem 0x0000000040000000-0x00000000ffffffff] Sep 3 23:23:53.108088 kernel: DMA32 empty Sep 3 23:23:53.108104 kernel: Normal [mem 0x0000000100000000-0x00000004b5ffffff] Sep 3 23:23:53.108119 kernel: Device empty Sep 3 23:23:53.108134 kernel: Movable zone start for each node Sep 3 23:23:53.108149 kernel: Early memory node ranges Sep 3 23:23:53.108164 kernel: node 0: [mem 0x0000000040000000-0x000000007862ffff] Sep 3 23:23:53.108180 kernel: node 0: [mem 0x0000000078630000-0x000000007863ffff] Sep 3 23:23:53.108195 kernel: node 0: [mem 0x0000000078640000-0x00000000786effff] Sep 3 23:23:53.108211 kernel: node 0: [mem 0x00000000786f0000-0x000000007872ffff] Sep 3 23:23:53.108226 kernel: node 0: [mem 0x0000000078730000-0x000000007bbfffff] Sep 3 23:23:53.108242 kernel: node 0: [mem 0x000000007bc00000-0x000000007bfdffff] Sep 3 23:23:53.108257 kernel: node 0: [mem 0x000000007bfe0000-0x000000007fffffff] Sep 3 23:23:53.108276 kernel: node 0: [mem 0x0000000400000000-0x00000004b5ffffff] Sep 3 23:23:53.108299 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000004b5ffffff] Sep 3 23:23:53.108315 kernel: On node 0, zone Normal: 8192 pages in unavailable ranges Sep 3 23:23:53.108332 kernel: cma: Reserved 16 MiB at 0x000000007f000000 on node -1 Sep 3 23:23:53.108348 kernel: psci: probing for conduit method from ACPI. Sep 3 23:23:53.108368 kernel: psci: PSCIv1.0 detected in firmware. Sep 3 23:23:53.108384 kernel: psci: Using standard PSCI v0.2 function IDs Sep 3 23:23:53.108571 kernel: psci: Trusted OS migration not required Sep 3 23:23:53.108590 kernel: psci: SMC Calling Convention v1.1 Sep 3 23:23:53.108607 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000001) Sep 3 23:23:53.108624 kernel: percpu: Embedded 33 pages/cpu s98200 r8192 d28776 u135168 Sep 3 23:23:53.108640 kernel: pcpu-alloc: s98200 r8192 d28776 u135168 alloc=33*4096 Sep 3 23:23:53.108657 kernel: pcpu-alloc: [0] 0 [0] 1 Sep 3 23:23:53.108674 kernel: Detected PIPT I-cache on CPU0 Sep 3 23:23:53.108691 kernel: CPU features: detected: GIC system register CPU interface Sep 3 23:23:53.108708 kernel: CPU features: detected: Spectre-v2 Sep 3 23:23:53.108730 kernel: CPU features: detected: Spectre-v3a Sep 3 23:23:53.108746 kernel: CPU features: detected: Spectre-BHB Sep 3 23:23:53.108762 kernel: CPU features: detected: ARM erratum 1742098 Sep 3 23:23:53.108779 kernel: CPU features: detected: ARM errata 1165522, 1319367, or 1530923 Sep 3 23:23:53.108795 kernel: alternatives: applying boot alternatives Sep 3 23:23:53.108814 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=cb633bb0c889435b58a5c40c9c9bc9d5899ece5018569c9fa08f911265d3f18e Sep 3 23:23:53.108832 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Sep 3 23:23:53.108848 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Sep 3 23:23:53.108864 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Sep 3 23:23:53.108881 kernel: Fallback order for Node 0: 0 Sep 3 23:23:53.108900 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1007616 Sep 3 23:23:53.108917 kernel: Policy zone: Normal Sep 3 23:23:53.108933 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Sep 3 23:23:53.108949 kernel: software IO TLB: area num 2. Sep 3 23:23:53.108965 kernel: software IO TLB: mapped [mem 0x000000006c5f0000-0x00000000705f0000] (64MB) Sep 3 23:23:53.108981 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Sep 3 23:23:53.108997 kernel: rcu: Preemptible hierarchical RCU implementation. Sep 3 23:23:53.109014 kernel: rcu: RCU event tracing is enabled. Sep 3 23:23:53.109031 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Sep 3 23:23:53.109048 kernel: Trampoline variant of Tasks RCU enabled. Sep 3 23:23:53.109064 kernel: Tracing variant of Tasks RCU enabled. Sep 3 23:23:53.109081 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Sep 3 23:23:53.109101 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Sep 3 23:23:53.109117 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Sep 3 23:23:53.109134 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Sep 3 23:23:53.109150 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Sep 3 23:23:53.109166 kernel: GICv3: 96 SPIs implemented Sep 3 23:23:53.109182 kernel: GICv3: 0 Extended SPIs implemented Sep 3 23:23:53.109198 kernel: Root IRQ handler: gic_handle_irq Sep 3 23:23:53.109214 kernel: GICv3: GICv3 features: 16 PPIs Sep 3 23:23:53.109230 kernel: GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0 Sep 3 23:23:53.109246 kernel: GICv3: CPU0: found redistributor 0 region 0:0x0000000010200000 Sep 3 23:23:53.109262 kernel: ITS [mem 0x10080000-0x1009ffff] Sep 3 23:23:53.109279 kernel: ITS@0x0000000010080000: allocated 8192 Devices @4000f0000 (indirect, esz 8, psz 64K, shr 1) Sep 3 23:23:53.109299 kernel: ITS@0x0000000010080000: allocated 8192 Interrupt Collections @400100000 (flat, esz 8, psz 64K, shr 1) Sep 3 23:23:53.109316 kernel: GICv3: using LPI property table @0x0000000400110000 Sep 3 23:23:53.109332 kernel: ITS: Using hypervisor restricted LPI range [128] Sep 3 23:23:53.109350 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000400120000 Sep 3 23:23:53.109367 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Sep 3 23:23:53.109385 kernel: arch_timer: cp15 timer(s) running at 83.33MHz (virt). Sep 3 23:23:53.109426 kernel: clocksource: arch_sys_counter: mask: 0x1ffffffffffffff max_cycles: 0x13381ebeec, max_idle_ns: 440795203145 ns Sep 3 23:23:53.109445 kernel: sched_clock: 57 bits at 83MHz, resolution 12ns, wraps every 4398046511100ns Sep 3 23:23:53.109462 kernel: Console: colour dummy device 80x25 Sep 3 23:23:53.109479 kernel: printk: legacy console [tty1] enabled Sep 3 23:23:53.109496 kernel: ACPI: Core revision 20240827 Sep 3 23:23:53.109520 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 166.66 BogoMIPS (lpj=83333) Sep 3 23:23:53.109537 kernel: pid_max: default: 32768 minimum: 301 Sep 3 23:23:53.109554 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Sep 3 23:23:53.109571 kernel: landlock: Up and running. Sep 3 23:23:53.109587 kernel: SELinux: Initializing. Sep 3 23:23:53.109603 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 3 23:23:53.109620 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 3 23:23:53.109637 kernel: rcu: Hierarchical SRCU implementation. Sep 3 23:23:53.109653 kernel: rcu: Max phase no-delay instances is 400. Sep 3 23:23:53.109675 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Sep 3 23:23:53.109692 kernel: Remapping and enabling EFI services. Sep 3 23:23:53.109710 kernel: smp: Bringing up secondary CPUs ... Sep 3 23:23:53.109726 kernel: Detected PIPT I-cache on CPU1 Sep 3 23:23:53.109743 kernel: GICv3: CPU1: found redistributor 1 region 0:0x0000000010220000 Sep 3 23:23:53.109760 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000400130000 Sep 3 23:23:53.109777 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd083] Sep 3 23:23:53.109794 kernel: smp: Brought up 1 node, 2 CPUs Sep 3 23:23:53.109811 kernel: SMP: Total of 2 processors activated. Sep 3 23:23:53.109841 kernel: CPU: All CPU(s) started at EL1 Sep 3 23:23:53.109860 kernel: CPU features: detected: 32-bit EL0 Support Sep 3 23:23:53.109889 kernel: CPU features: detected: 32-bit EL1 Support Sep 3 23:23:53.109936 kernel: CPU features: detected: CRC32 instructions Sep 3 23:23:53.109975 kernel: alternatives: applying system-wide alternatives Sep 3 23:23:53.110016 kernel: Memory: 3797032K/4030464K available (11136K kernel code, 2436K rwdata, 9076K rodata, 38976K init, 1038K bss, 212088K reserved, 16384K cma-reserved) Sep 3 23:23:53.110066 kernel: devtmpfs: initialized Sep 3 23:23:53.110095 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Sep 3 23:23:53.110113 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Sep 3 23:23:53.110131 kernel: 17040 pages in range for non-PLT usage Sep 3 23:23:53.110149 kernel: 508560 pages in range for PLT usage Sep 3 23:23:53.110166 kernel: pinctrl core: initialized pinctrl subsystem Sep 3 23:23:53.110185 kernel: SMBIOS 3.0.0 present. Sep 3 23:23:53.110202 kernel: DMI: Amazon EC2 a1.large/, BIOS 1.0 11/1/2018 Sep 3 23:23:53.110220 kernel: DMI: Memory slots populated: 0/0 Sep 3 23:23:53.110237 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Sep 3 23:23:53.110259 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Sep 3 23:23:53.110277 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Sep 3 23:23:53.110294 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Sep 3 23:23:53.110311 kernel: audit: initializing netlink subsys (disabled) Sep 3 23:23:53.110329 kernel: audit: type=2000 audit(0.226:1): state=initialized audit_enabled=0 res=1 Sep 3 23:23:53.110347 kernel: thermal_sys: Registered thermal governor 'step_wise' Sep 3 23:23:53.110364 kernel: cpuidle: using governor menu Sep 3 23:23:53.110381 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Sep 3 23:23:53.110420 kernel: ASID allocator initialised with 65536 entries Sep 3 23:23:53.110446 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Sep 3 23:23:53.110465 kernel: Serial: AMBA PL011 UART driver Sep 3 23:23:53.110482 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Sep 3 23:23:53.110499 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Sep 3 23:23:53.112495 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Sep 3 23:23:53.112521 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Sep 3 23:23:53.112540 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Sep 3 23:23:53.112558 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Sep 3 23:23:53.112575 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Sep 3 23:23:53.112600 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Sep 3 23:23:53.112618 kernel: ACPI: Added _OSI(Module Device) Sep 3 23:23:53.112635 kernel: ACPI: Added _OSI(Processor Device) Sep 3 23:23:53.112653 kernel: ACPI: Added _OSI(Processor Aggregator Device) Sep 3 23:23:53.112670 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Sep 3 23:23:53.112687 kernel: ACPI: Interpreter enabled Sep 3 23:23:53.112705 kernel: ACPI: Using GIC for interrupt routing Sep 3 23:23:53.112722 kernel: ACPI: MCFG table detected, 1 entries Sep 3 23:23:53.112740 kernel: ACPI: CPU0 has been hot-added Sep 3 23:23:53.112761 kernel: ACPI: CPU1 has been hot-added Sep 3 23:23:53.112778 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-0f]) Sep 3 23:23:53.113079 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Sep 3 23:23:53.113276 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Sep 3 23:23:53.113503 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Sep 3 23:23:53.113701 kernel: acpi PNP0A08:00: ECAM area [mem 0x20000000-0x20ffffff] reserved by PNP0C02:00 Sep 3 23:23:53.113888 kernel: acpi PNP0A08:00: ECAM at [mem 0x20000000-0x20ffffff] for [bus 00-0f] Sep 3 23:23:53.113918 kernel: ACPI: Remapped I/O 0x000000001fff0000 to [io 0x0000-0xffff window] Sep 3 23:23:53.113937 kernel: acpiphp: Slot [1] registered Sep 3 23:23:53.113955 kernel: acpiphp: Slot [2] registered Sep 3 23:23:53.113972 kernel: acpiphp: Slot [3] registered Sep 3 23:23:53.113989 kernel: acpiphp: Slot [4] registered Sep 3 23:23:53.114006 kernel: acpiphp: Slot [5] registered Sep 3 23:23:53.114023 kernel: acpiphp: Slot [6] registered Sep 3 23:23:53.114041 kernel: acpiphp: Slot [7] registered Sep 3 23:23:53.114058 kernel: acpiphp: Slot [8] registered Sep 3 23:23:53.114074 kernel: acpiphp: Slot [9] registered Sep 3 23:23:53.114096 kernel: acpiphp: Slot [10] registered Sep 3 23:23:53.114113 kernel: acpiphp: Slot [11] registered Sep 3 23:23:53.114130 kernel: acpiphp: Slot [12] registered Sep 3 23:23:53.114147 kernel: acpiphp: Slot [13] registered Sep 3 23:23:53.114164 kernel: acpiphp: Slot [14] registered Sep 3 23:23:53.114181 kernel: acpiphp: Slot [15] registered Sep 3 23:23:53.114198 kernel: acpiphp: Slot [16] registered Sep 3 23:23:53.114215 kernel: acpiphp: Slot [17] registered Sep 3 23:23:53.114232 kernel: acpiphp: Slot [18] registered Sep 3 23:23:53.114253 kernel: acpiphp: Slot [19] registered Sep 3 23:23:53.114271 kernel: acpiphp: Slot [20] registered Sep 3 23:23:53.114288 kernel: acpiphp: Slot [21] registered Sep 3 23:23:53.114305 kernel: acpiphp: Slot [22] registered Sep 3 23:23:53.114322 kernel: acpiphp: Slot [23] registered Sep 3 23:23:53.114339 kernel: acpiphp: Slot [24] registered Sep 3 23:23:53.114356 kernel: acpiphp: Slot [25] registered Sep 3 23:23:53.114374 kernel: acpiphp: Slot [26] registered Sep 3 23:23:53.114391 kernel: acpiphp: Slot [27] registered Sep 3 23:23:53.114445 kernel: acpiphp: Slot [28] registered Sep 3 23:23:53.114468 kernel: acpiphp: Slot [29] registered Sep 3 23:23:53.114486 kernel: acpiphp: Slot [30] registered Sep 3 23:23:53.114503 kernel: acpiphp: Slot [31] registered Sep 3 23:23:53.114521 kernel: PCI host bridge to bus 0000:00 Sep 3 23:23:53.114728 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xffffffff window] Sep 3 23:23:53.114903 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Sep 3 23:23:53.115073 kernel: pci_bus 0000:00: root bus resource [mem 0x400000000000-0x407fffffffff window] Sep 3 23:23:53.115247 kernel: pci_bus 0000:00: root bus resource [bus 00-0f] Sep 3 23:23:53.116069 kernel: pci 0000:00:00.0: [1d0f:0200] type 00 class 0x060000 conventional PCI endpoint Sep 3 23:23:53.116317 kernel: pci 0000:00:01.0: [1d0f:8250] type 00 class 0x070003 conventional PCI endpoint Sep 3 23:23:53.117525 kernel: pci 0000:00:01.0: BAR 0 [mem 0x80118000-0x80118fff] Sep 3 23:23:53.117766 kernel: pci 0000:00:04.0: [1d0f:8061] type 00 class 0x010802 PCIe Root Complex Integrated Endpoint Sep 3 23:23:53.117966 kernel: pci 0000:00:04.0: BAR 0 [mem 0x80114000-0x80117fff] Sep 3 23:23:53.118162 kernel: pci 0000:00:04.0: PME# supported from D0 D1 D2 D3hot D3cold Sep 3 23:23:53.118380 kernel: pci 0000:00:05.0: [1d0f:ec20] type 00 class 0x020000 PCIe Root Complex Integrated Endpoint Sep 3 23:23:53.118724 kernel: pci 0000:00:05.0: BAR 0 [mem 0x80110000-0x80113fff] Sep 3 23:23:53.118922 kernel: pci 0000:00:05.0: BAR 2 [mem 0x80000000-0x800fffff pref] Sep 3 23:23:53.119114 kernel: pci 0000:00:05.0: BAR 4 [mem 0x80100000-0x8010ffff] Sep 3 23:23:53.119307 kernel: pci 0000:00:05.0: PME# supported from D0 D1 D2 D3hot D3cold Sep 3 23:23:53.119590 kernel: pci 0000:00:05.0: BAR 2 [mem 0x80000000-0x800fffff pref]: assigned Sep 3 23:23:53.119797 kernel: pci 0000:00:05.0: BAR 4 [mem 0x80100000-0x8010ffff]: assigned Sep 3 23:23:53.120004 kernel: pci 0000:00:04.0: BAR 0 [mem 0x80110000-0x80113fff]: assigned Sep 3 23:23:53.121074 kernel: pci 0000:00:05.0: BAR 0 [mem 0x80114000-0x80117fff]: assigned Sep 3 23:23:53.121277 kernel: pci 0000:00:01.0: BAR 0 [mem 0x80118000-0x80118fff]: assigned Sep 3 23:23:53.123084 kernel: pci_bus 0000:00: resource 4 [mem 0x80000000-0xffffffff window] Sep 3 23:23:53.123263 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Sep 3 23:23:53.123525 kernel: pci_bus 0000:00: resource 6 [mem 0x400000000000-0x407fffffffff window] Sep 3 23:23:53.123562 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Sep 3 23:23:53.123581 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Sep 3 23:23:53.123599 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Sep 3 23:23:53.123617 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Sep 3 23:23:53.123634 kernel: iommu: Default domain type: Translated Sep 3 23:23:53.123652 kernel: iommu: DMA domain TLB invalidation policy: strict mode Sep 3 23:23:53.123669 kernel: efivars: Registered efivars operations Sep 3 23:23:53.123687 kernel: vgaarb: loaded Sep 3 23:23:53.123704 kernel: clocksource: Switched to clocksource arch_sys_counter Sep 3 23:23:53.123721 kernel: VFS: Disk quotas dquot_6.6.0 Sep 3 23:23:53.123743 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Sep 3 23:23:53.123761 kernel: pnp: PnP ACPI init Sep 3 23:23:53.123964 kernel: system 00:00: [mem 0x20000000-0x2fffffff] could not be reserved Sep 3 23:23:53.123991 kernel: pnp: PnP ACPI: found 1 devices Sep 3 23:23:53.124010 kernel: NET: Registered PF_INET protocol family Sep 3 23:23:53.124029 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Sep 3 23:23:53.124048 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Sep 3 23:23:53.124065 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Sep 3 23:23:53.124089 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Sep 3 23:23:53.124107 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Sep 3 23:23:53.124125 kernel: TCP: Hash tables configured (established 32768 bind 32768) Sep 3 23:23:53.124143 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 3 23:23:53.124160 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 3 23:23:53.124178 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Sep 3 23:23:53.124195 kernel: PCI: CLS 0 bytes, default 64 Sep 3 23:23:53.124213 kernel: kvm [1]: HYP mode not available Sep 3 23:23:53.124230 kernel: Initialise system trusted keyrings Sep 3 23:23:53.124252 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Sep 3 23:23:53.124270 kernel: Key type asymmetric registered Sep 3 23:23:53.124287 kernel: Asymmetric key parser 'x509' registered Sep 3 23:23:53.124305 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Sep 3 23:23:53.124322 kernel: io scheduler mq-deadline registered Sep 3 23:23:53.124340 kernel: io scheduler kyber registered Sep 3 23:23:53.124357 kernel: io scheduler bfq registered Sep 3 23:23:53.124633 kernel: pl061_gpio ARMH0061:00: PL061 GPIO chip registered Sep 3 23:23:53.124668 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Sep 3 23:23:53.124687 kernel: ACPI: button: Power Button [PWRB] Sep 3 23:23:53.124704 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1 Sep 3 23:23:53.124722 kernel: ACPI: button: Sleep Button [SLPB] Sep 3 23:23:53.124740 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Sep 3 23:23:53.124759 kernel: ACPI: \_SB_.PCI0.GSI2: Enabled at IRQ 37 Sep 3 23:23:53.124964 kernel: serial 0000:00:01.0: enabling device (0010 -> 0012) Sep 3 23:23:53.124990 kernel: printk: legacy console [ttyS0] disabled Sep 3 23:23:53.125010 kernel: 0000:00:01.0: ttyS0 at MMIO 0x80118000 (irq = 14, base_baud = 115200) is a 16550A Sep 3 23:23:53.125033 kernel: printk: legacy console [ttyS0] enabled Sep 3 23:23:53.125051 kernel: printk: legacy bootconsole [uart0] disabled Sep 3 23:23:53.125069 kernel: thunder_xcv, ver 1.0 Sep 3 23:23:53.125086 kernel: thunder_bgx, ver 1.0 Sep 3 23:23:53.125103 kernel: nicpf, ver 1.0 Sep 3 23:23:53.125121 kernel: nicvf, ver 1.0 Sep 3 23:23:53.125323 kernel: rtc-efi rtc-efi.0: registered as rtc0 Sep 3 23:23:53.128245 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-09-03T23:23:52 UTC (1756941832) Sep 3 23:23:53.128297 kernel: hid: raw HID events driver (C) Jiri Kosina Sep 3 23:23:53.128317 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 3 (0,80000003) counters available Sep 3 23:23:53.128336 kernel: NET: Registered PF_INET6 protocol family Sep 3 23:23:53.128353 kernel: watchdog: NMI not fully supported Sep 3 23:23:53.128371 kernel: watchdog: Hard watchdog permanently disabled Sep 3 23:23:53.128388 kernel: Segment Routing with IPv6 Sep 3 23:23:53.129513 kernel: In-situ OAM (IOAM) with IPv6 Sep 3 23:23:53.129536 kernel: NET: Registered PF_PACKET protocol family Sep 3 23:23:53.129554 kernel: Key type dns_resolver registered Sep 3 23:23:53.129580 kernel: registered taskstats version 1 Sep 3 23:23:53.129598 kernel: Loading compiled-in X.509 certificates Sep 3 23:23:53.129617 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.44-flatcar: 08fc774dab168e64ce30c382a4517d40e72c4744' Sep 3 23:23:53.129634 kernel: Demotion targets for Node 0: null Sep 3 23:23:53.129652 kernel: Key type .fscrypt registered Sep 3 23:23:53.129669 kernel: Key type fscrypt-provisioning registered Sep 3 23:23:53.129686 kernel: ima: No TPM chip found, activating TPM-bypass! Sep 3 23:23:53.129704 kernel: ima: Allocated hash algorithm: sha1 Sep 3 23:23:53.129721 kernel: ima: No architecture policies found Sep 3 23:23:53.129742 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Sep 3 23:23:53.129760 kernel: clk: Disabling unused clocks Sep 3 23:23:53.129778 kernel: PM: genpd: Disabling unused power domains Sep 3 23:23:53.129795 kernel: Warning: unable to open an initial console. Sep 3 23:23:53.129813 kernel: Freeing unused kernel memory: 38976K Sep 3 23:23:53.129832 kernel: Run /init as init process Sep 3 23:23:53.129849 kernel: with arguments: Sep 3 23:23:53.129867 kernel: /init Sep 3 23:23:53.129884 kernel: with environment: Sep 3 23:23:53.129901 kernel: HOME=/ Sep 3 23:23:53.129922 kernel: TERM=linux Sep 3 23:23:53.129940 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Sep 3 23:23:53.129960 systemd[1]: Successfully made /usr/ read-only. Sep 3 23:23:53.129985 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Sep 3 23:23:53.130005 systemd[1]: Detected virtualization amazon. Sep 3 23:23:53.130024 systemd[1]: Detected architecture arm64. Sep 3 23:23:53.130043 systemd[1]: Running in initrd. Sep 3 23:23:53.130066 systemd[1]: No hostname configured, using default hostname. Sep 3 23:23:53.130087 systemd[1]: Hostname set to . Sep 3 23:23:53.130105 systemd[1]: Initializing machine ID from VM UUID. Sep 3 23:23:53.130125 systemd[1]: Queued start job for default target initrd.target. Sep 3 23:23:53.130144 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 3 23:23:53.130163 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 3 23:23:53.130184 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Sep 3 23:23:53.130204 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 3 23:23:53.130228 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Sep 3 23:23:53.130249 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Sep 3 23:23:53.130271 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Sep 3 23:23:53.130290 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Sep 3 23:23:53.130310 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 3 23:23:53.130329 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 3 23:23:53.130348 systemd[1]: Reached target paths.target - Path Units. Sep 3 23:23:53.130372 systemd[1]: Reached target slices.target - Slice Units. Sep 3 23:23:53.130391 systemd[1]: Reached target swap.target - Swaps. Sep 3 23:23:53.132537 systemd[1]: Reached target timers.target - Timer Units. Sep 3 23:23:53.132560 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Sep 3 23:23:53.132579 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 3 23:23:53.132599 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Sep 3 23:23:53.132618 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Sep 3 23:23:53.132638 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 3 23:23:53.132667 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 3 23:23:53.132687 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 3 23:23:53.132706 systemd[1]: Reached target sockets.target - Socket Units. Sep 3 23:23:53.132725 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Sep 3 23:23:53.132745 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 3 23:23:53.132765 systemd[1]: Finished network-cleanup.service - Network Cleanup. Sep 3 23:23:53.132785 systemd[1]: systemd-battery-check.service - Check battery level during early boot was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/class/power_supply). Sep 3 23:23:53.132805 systemd[1]: Starting systemd-fsck-usr.service... Sep 3 23:23:53.132823 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 3 23:23:53.132847 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 3 23:23:53.132866 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 3 23:23:53.132885 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Sep 3 23:23:53.132905 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 3 23:23:53.132928 systemd[1]: Finished systemd-fsck-usr.service. Sep 3 23:23:53.132948 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 3 23:23:53.133023 systemd-journald[258]: Collecting audit messages is disabled. Sep 3 23:23:53.133065 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Sep 3 23:23:53.133089 kernel: Bridge firewalling registered Sep 3 23:23:53.133124 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 3 23:23:53.133145 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 3 23:23:53.133165 systemd-journald[258]: Journal started Sep 3 23:23:53.133204 systemd-journald[258]: Runtime Journal (/run/log/journal/ec298d5d1de283526a1cafab505dab68) is 8M, max 75.3M, 67.3M free. Sep 3 23:23:53.080141 systemd-modules-load[259]: Inserted module 'overlay' Sep 3 23:23:53.117024 systemd-modules-load[259]: Inserted module 'br_netfilter' Sep 3 23:23:53.140323 systemd[1]: Started systemd-journald.service - Journal Service. Sep 3 23:23:53.148847 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 3 23:23:53.155792 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 3 23:23:53.172536 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 3 23:23:53.184808 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 3 23:23:53.193531 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 3 23:23:53.205518 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 3 23:23:53.232349 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 3 23:23:53.234241 systemd-tmpfiles[282]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Sep 3 23:23:53.249337 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 3 23:23:53.259973 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 3 23:23:53.284508 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 3 23:23:53.290038 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Sep 3 23:23:53.330251 dracut-cmdline[298]: Using kernel command line parameters: rd.driver.pre=btrfs SYSTEMD_SULOGIN_FORCE=1 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=cb633bb0c889435b58a5c40c9c9bc9d5899ece5018569c9fa08f911265d3f18e Sep 3 23:23:53.372797 systemd-resolved[296]: Positive Trust Anchors: Sep 3 23:23:53.372831 systemd-resolved[296]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 3 23:23:53.372895 systemd-resolved[296]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Sep 3 23:23:53.486438 kernel: SCSI subsystem initialized Sep 3 23:23:53.494442 kernel: Loading iSCSI transport class v2.0-870. Sep 3 23:23:53.506435 kernel: iscsi: registered transport (tcp) Sep 3 23:23:53.528438 kernel: iscsi: registered transport (qla4xxx) Sep 3 23:23:53.528524 kernel: QLogic iSCSI HBA Driver Sep 3 23:23:53.561567 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Sep 3 23:23:53.603986 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Sep 3 23:23:53.612386 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 3 23:23:53.635552 kernel: random: crng init done Sep 3 23:23:53.636015 systemd-resolved[296]: Defaulting to hostname 'linux'. Sep 3 23:23:53.639942 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 3 23:23:53.647468 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 3 23:23:53.709484 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Sep 3 23:23:53.715249 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Sep 3 23:23:53.803444 kernel: raid6: neonx8 gen() 6484 MB/s Sep 3 23:23:53.820435 kernel: raid6: neonx4 gen() 6566 MB/s Sep 3 23:23:53.837431 kernel: raid6: neonx2 gen() 5450 MB/s Sep 3 23:23:53.854432 kernel: raid6: neonx1 gen() 3953 MB/s Sep 3 23:23:53.871433 kernel: raid6: int64x8 gen() 3651 MB/s Sep 3 23:23:53.888431 kernel: raid6: int64x4 gen() 3697 MB/s Sep 3 23:23:53.905434 kernel: raid6: int64x2 gen() 3585 MB/s Sep 3 23:23:53.923377 kernel: raid6: int64x1 gen() 2758 MB/s Sep 3 23:23:53.923434 kernel: raid6: using algorithm neonx4 gen() 6566 MB/s Sep 3 23:23:53.941412 kernel: raid6: .... xor() 4861 MB/s, rmw enabled Sep 3 23:23:53.941448 kernel: raid6: using neon recovery algorithm Sep 3 23:23:53.950350 kernel: xor: measuring software checksum speed Sep 3 23:23:53.950422 kernel: 8regs : 12848 MB/sec Sep 3 23:23:53.952774 kernel: 32regs : 12046 MB/sec Sep 3 23:23:53.952806 kernel: arm64_neon : 8900 MB/sec Sep 3 23:23:53.952830 kernel: xor: using function: 8regs (12848 MB/sec) Sep 3 23:23:54.047445 kernel: Btrfs loaded, zoned=no, fsverity=no Sep 3 23:23:54.059307 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Sep 3 23:23:54.065868 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 3 23:23:54.131930 systemd-udevd[506]: Using default interface naming scheme 'v255'. Sep 3 23:23:54.143154 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 3 23:23:54.153679 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Sep 3 23:23:54.194783 dracut-pre-trigger[511]: rd.md=0: removing MD RAID activation Sep 3 23:23:54.238623 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Sep 3 23:23:54.245368 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 3 23:23:54.373229 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 3 23:23:54.380906 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Sep 3 23:23:54.544649 kernel: ACPI: \_SB_.PCI0.GSI0: Enabled at IRQ 35 Sep 3 23:23:54.544720 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Sep 3 23:23:54.544747 kernel: nvme nvme0: pci function 0000:00:04.0 Sep 3 23:23:54.549926 kernel: ena 0000:00:05.0: enabling device (0010 -> 0012) Sep 3 23:23:54.558453 kernel: nvme nvme0: 2/0/0 default/read/poll queues Sep 3 23:23:54.562092 kernel: ena 0000:00:05.0: ENA device version: 0.10 Sep 3 23:23:54.562470 kernel: ena 0000:00:05.0: ENA controller version: 0.0.1 implementation version 1 Sep 3 23:23:54.570437 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Sep 3 23:23:54.570506 kernel: GPT:9289727 != 16777215 Sep 3 23:23:54.570531 kernel: ena 0000:00:05.0: Elastic Network Adapter (ENA) found at mem 80114000, mac addr 06:62:17:f7:1c:d1 Sep 3 23:23:54.570856 kernel: GPT:Alternate GPT header not at the end of the disk. Sep 3 23:23:54.573440 kernel: GPT:9289727 != 16777215 Sep 3 23:23:54.576451 kernel: GPT: Use GNU Parted to correct GPT errors. Sep 3 23:23:54.579317 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Sep 3 23:23:54.579683 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 3 23:23:54.582065 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 3 23:23:54.587738 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Sep 3 23:23:54.598467 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 3 23:23:54.609210 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Sep 3 23:23:54.612341 (udev-worker)[565]: Network interface NamePolicy= disabled on kernel command line. Sep 3 23:23:54.643425 kernel: nvme nvme0: using unchecked data buffer Sep 3 23:23:54.666454 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 3 23:23:54.796027 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Amazon Elastic Block Store USR-A. Sep 3 23:23:54.807050 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Amazon Elastic Block Store USR-A. Sep 3 23:23:54.836584 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Amazon Elastic Block Store ROOT. Sep 3 23:23:54.863135 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Amazon Elastic Block Store EFI-SYSTEM. Sep 3 23:23:54.871435 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Sep 3 23:23:54.914947 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Sep 3 23:23:54.934138 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Sep 3 23:23:54.936923 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 3 23:23:54.944765 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 3 23:23:54.949252 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Sep 3 23:23:54.955950 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Sep 3 23:23:54.985543 disk-uuid[687]: Primary Header is updated. Sep 3 23:23:54.985543 disk-uuid[687]: Secondary Entries is updated. Sep 3 23:23:54.985543 disk-uuid[687]: Secondary Header is updated. Sep 3 23:23:54.994444 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Sep 3 23:23:55.010860 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Sep 3 23:23:55.027441 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Sep 3 23:23:56.026718 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Sep 3 23:23:56.028772 disk-uuid[689]: The operation has completed successfully. Sep 3 23:23:56.209275 systemd[1]: disk-uuid.service: Deactivated successfully. Sep 3 23:23:56.211450 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Sep 3 23:23:56.295820 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Sep 3 23:23:56.320663 sh[954]: Success Sep 3 23:23:56.348892 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Sep 3 23:23:56.349009 kernel: device-mapper: uevent: version 1.0.3 Sep 3 23:23:56.349039 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Sep 3 23:23:56.364446 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 23:23:56.473112 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Sep 3 23:23:56.484705 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Sep 3 23:23:56.495101 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Sep 3 23:23:56.529432 kernel: BTRFS: device fsid e8b97e78-d30f-4a41-b431-d82f3afef949 devid 1 transid 39 /dev/mapper/usr (254:0) scanned by mount (977) Sep 3 23:23:56.533741 kernel: BTRFS info (device dm-0): first mount of filesystem e8b97e78-d30f-4a41-b431-d82f3afef949 Sep 3 23:23:56.533802 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Sep 3 23:23:56.667020 kernel: BTRFS info (device dm-0): enabling ssd optimizations Sep 3 23:23:56.667091 kernel: BTRFS info (device dm-0): disabling log replay at mount time Sep 3 23:23:56.667118 kernel: BTRFS info (device dm-0): enabling free space tree Sep 3 23:23:56.682343 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Sep 3 23:23:56.686824 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Sep 3 23:23:56.691896 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Sep 3 23:23:56.697182 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Sep 3 23:23:56.700917 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Sep 3 23:23:56.755473 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (1009) Sep 3 23:23:56.760975 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem f1885725-917a-44ef-9d71-3c4c588cc4f4 Sep 3 23:23:56.761046 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Sep 3 23:23:56.769635 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Sep 3 23:23:56.769718 kernel: BTRFS info (device nvme0n1p6): enabling free space tree Sep 3 23:23:56.778440 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem f1885725-917a-44ef-9d71-3c4c588cc4f4 Sep 3 23:23:56.780648 systemd[1]: Finished ignition-setup.service - Ignition (setup). Sep 3 23:23:56.786943 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Sep 3 23:23:56.880995 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 3 23:23:56.889375 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 3 23:23:56.965597 systemd-networkd[1147]: lo: Link UP Sep 3 23:23:56.965619 systemd-networkd[1147]: lo: Gained carrier Sep 3 23:23:56.971265 systemd-networkd[1147]: Enumeration completed Sep 3 23:23:56.973136 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 3 23:23:56.975938 systemd-networkd[1147]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 3 23:23:56.975958 systemd-networkd[1147]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 3 23:23:56.982829 systemd[1]: Reached target network.target - Network. Sep 3 23:23:56.990886 systemd-networkd[1147]: eth0: Link UP Sep 3 23:23:56.990899 systemd-networkd[1147]: eth0: Gained carrier Sep 3 23:23:56.990922 systemd-networkd[1147]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 3 23:23:57.027487 systemd-networkd[1147]: eth0: DHCPv4 address 172.31.17.118/20, gateway 172.31.16.1 acquired from 172.31.16.1 Sep 3 23:23:57.275938 ignition[1068]: Ignition 2.21.0 Sep 3 23:23:57.275968 ignition[1068]: Stage: fetch-offline Sep 3 23:23:57.279392 ignition[1068]: no configs at "/usr/lib/ignition/base.d" Sep 3 23:23:57.279448 ignition[1068]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 3 23:23:57.281850 ignition[1068]: Ignition finished successfully Sep 3 23:23:57.285501 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Sep 3 23:23:57.295598 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Sep 3 23:23:57.336630 ignition[1159]: Ignition 2.21.0 Sep 3 23:23:57.336658 ignition[1159]: Stage: fetch Sep 3 23:23:57.337172 ignition[1159]: no configs at "/usr/lib/ignition/base.d" Sep 3 23:23:57.337196 ignition[1159]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 3 23:23:57.337495 ignition[1159]: PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 3 23:23:57.357173 ignition[1159]: PUT result: OK Sep 3 23:23:57.362226 ignition[1159]: parsed url from cmdline: "" Sep 3 23:23:57.362242 ignition[1159]: no config URL provided Sep 3 23:23:57.362257 ignition[1159]: reading system config file "/usr/lib/ignition/user.ign" Sep 3 23:23:57.362280 ignition[1159]: no config at "/usr/lib/ignition/user.ign" Sep 3 23:23:57.362326 ignition[1159]: PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 3 23:23:57.365044 ignition[1159]: PUT result: OK Sep 3 23:23:57.365160 ignition[1159]: GET http://169.254.169.254/2019-10-01/user-data: attempt #1 Sep 3 23:23:57.376077 ignition[1159]: GET result: OK Sep 3 23:23:57.376392 ignition[1159]: parsing config with SHA512: d88e23aec145ffd9f3be87fe5d1348d5078ca177828098d61eddf47f865ee117bb93e842a521e7464dae32e488617ca3879acb1002ad71a8d0eb00afcec7893b Sep 3 23:23:57.390694 unknown[1159]: fetched base config from "system" Sep 3 23:23:57.391032 ignition[1159]: fetch: fetch complete Sep 3 23:23:57.390717 unknown[1159]: fetched base config from "system" Sep 3 23:23:57.391043 ignition[1159]: fetch: fetch passed Sep 3 23:23:57.390730 unknown[1159]: fetched user config from "aws" Sep 3 23:23:57.391125 ignition[1159]: Ignition finished successfully Sep 3 23:23:57.398043 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Sep 3 23:23:57.404910 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Sep 3 23:23:57.449521 ignition[1165]: Ignition 2.21.0 Sep 3 23:23:57.449546 ignition[1165]: Stage: kargs Sep 3 23:23:57.450071 ignition[1165]: no configs at "/usr/lib/ignition/base.d" Sep 3 23:23:57.450095 ignition[1165]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 3 23:23:57.450254 ignition[1165]: PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 3 23:23:57.454653 ignition[1165]: PUT result: OK Sep 3 23:23:57.466475 ignition[1165]: kargs: kargs passed Sep 3 23:23:57.466583 ignition[1165]: Ignition finished successfully Sep 3 23:23:57.471846 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Sep 3 23:23:57.478867 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Sep 3 23:23:57.510982 ignition[1172]: Ignition 2.21.0 Sep 3 23:23:57.511015 ignition[1172]: Stage: disks Sep 3 23:23:57.511614 ignition[1172]: no configs at "/usr/lib/ignition/base.d" Sep 3 23:23:57.511639 ignition[1172]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 3 23:23:57.511789 ignition[1172]: PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 3 23:23:57.513616 ignition[1172]: PUT result: OK Sep 3 23:23:57.523803 ignition[1172]: disks: disks passed Sep 3 23:23:57.523895 ignition[1172]: Ignition finished successfully Sep 3 23:23:57.530593 systemd[1]: Finished ignition-disks.service - Ignition (disks). Sep 3 23:23:57.535069 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Sep 3 23:23:57.537501 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 3 23:23:57.541100 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 3 23:23:57.543330 systemd[1]: Reached target sysinit.target - System Initialization. Sep 3 23:23:57.546175 systemd[1]: Reached target basic.target - Basic System. Sep 3 23:23:57.559250 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Sep 3 23:23:57.623645 systemd-fsck[1180]: ROOT: clean, 15/553520 files, 52789/553472 blocks Sep 3 23:23:57.630302 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Sep 3 23:23:57.632930 systemd[1]: Mounting sysroot.mount - /sysroot... Sep 3 23:23:57.768437 kernel: EXT4-fs (nvme0n1p9): mounted filesystem d953e3b7-a0cb-45f7-b3a7-216a9a578dda r/w with ordered data mode. Quota mode: none. Sep 3 23:23:57.769546 systemd[1]: Mounted sysroot.mount - /sysroot. Sep 3 23:23:57.773538 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Sep 3 23:23:57.780010 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 3 23:23:57.788175 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Sep 3 23:23:57.793078 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Sep 3 23:23:57.793173 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Sep 3 23:23:57.793246 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Sep 3 23:23:57.819670 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Sep 3 23:23:57.825506 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Sep 3 23:23:57.835464 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (1199) Sep 3 23:23:57.839334 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem f1885725-917a-44ef-9d71-3c4c588cc4f4 Sep 3 23:23:57.839382 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Sep 3 23:23:57.847941 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Sep 3 23:23:57.848025 kernel: BTRFS info (device nvme0n1p6): enabling free space tree Sep 3 23:23:57.850669 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 3 23:23:58.308422 initrd-setup-root[1223]: cut: /sysroot/etc/passwd: No such file or directory Sep 3 23:23:58.318325 initrd-setup-root[1230]: cut: /sysroot/etc/group: No such file or directory Sep 3 23:23:58.326434 initrd-setup-root[1237]: cut: /sysroot/etc/shadow: No such file or directory Sep 3 23:23:58.335446 initrd-setup-root[1244]: cut: /sysroot/etc/gshadow: No such file or directory Sep 3 23:23:58.645714 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Sep 3 23:23:58.654864 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Sep 3 23:23:58.660321 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Sep 3 23:23:58.674540 systemd-networkd[1147]: eth0: Gained IPv6LL Sep 3 23:23:58.690102 systemd[1]: sysroot-oem.mount: Deactivated successfully. Sep 3 23:23:58.694443 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem f1885725-917a-44ef-9d71-3c4c588cc4f4 Sep 3 23:23:58.725664 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Sep 3 23:23:58.744689 ignition[1312]: INFO : Ignition 2.21.0 Sep 3 23:23:58.746771 ignition[1312]: INFO : Stage: mount Sep 3 23:23:58.746771 ignition[1312]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 3 23:23:58.746771 ignition[1312]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 3 23:23:58.746771 ignition[1312]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 3 23:23:58.757307 ignition[1312]: INFO : PUT result: OK Sep 3 23:23:58.765584 ignition[1312]: INFO : mount: mount passed Sep 3 23:23:58.767343 ignition[1312]: INFO : Ignition finished successfully Sep 3 23:23:58.778456 systemd[1]: Finished ignition-mount.service - Ignition (mount). Sep 3 23:23:58.783540 systemd[1]: Starting ignition-files.service - Ignition (files)... Sep 3 23:23:58.810613 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 3 23:23:58.848434 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (1324) Sep 3 23:23:58.852975 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem f1885725-917a-44ef-9d71-3c4c588cc4f4 Sep 3 23:23:58.853023 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Sep 3 23:23:58.860244 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Sep 3 23:23:58.860308 kernel: BTRFS info (device nvme0n1p6): enabling free space tree Sep 3 23:23:58.864452 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 3 23:23:58.917133 ignition[1341]: INFO : Ignition 2.21.0 Sep 3 23:23:58.917133 ignition[1341]: INFO : Stage: files Sep 3 23:23:58.925681 ignition[1341]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 3 23:23:58.925681 ignition[1341]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 3 23:23:58.925681 ignition[1341]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 3 23:23:58.925681 ignition[1341]: INFO : PUT result: OK Sep 3 23:23:58.940163 ignition[1341]: DEBUG : files: compiled without relabeling support, skipping Sep 3 23:23:58.942859 ignition[1341]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Sep 3 23:23:58.942859 ignition[1341]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Sep 3 23:23:58.965011 ignition[1341]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Sep 3 23:23:58.972611 ignition[1341]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Sep 3 23:23:58.975954 unknown[1341]: wrote ssh authorized keys file for user: core Sep 3 23:23:58.978539 ignition[1341]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Sep 3 23:23:58.986081 ignition[1341]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Sep 3 23:23:58.989884 ignition[1341]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Sep 3 23:23:58.989884 ignition[1341]: INFO : files: op(4): [started] processing unit "etcd-member.service" Sep 3 23:23:58.989884 ignition[1341]: 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" Sep 3 23:23:59.001264 ignition[1341]: 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" Sep 3 23:23:59.001264 ignition[1341]: INFO : files: op(4): [finished] processing unit "etcd-member.service" Sep 3 23:23:59.001264 ignition[1341]: INFO : files: op(6): [started] setting preset to enabled for "etcd-member.service" Sep 3 23:23:59.001264 ignition[1341]: INFO : files: op(6): [finished] setting preset to enabled for "etcd-member.service" Sep 3 23:23:59.001264 ignition[1341]: INFO : files: createResultFile: createFiles: op(7): [started] writing file "/sysroot/etc/.ignition-result.json" Sep 3 23:23:59.001264 ignition[1341]: INFO : files: createResultFile: createFiles: op(7): [finished] writing file "/sysroot/etc/.ignition-result.json" Sep 3 23:23:59.001264 ignition[1341]: INFO : files: files passed Sep 3 23:23:59.001264 ignition[1341]: INFO : Ignition finished successfully Sep 3 23:23:59.027389 systemd[1]: Finished ignition-files.service - Ignition (files). Sep 3 23:23:59.033091 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Sep 3 23:23:59.040880 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Sep 3 23:23:59.061462 systemd[1]: ignition-quench.service: Deactivated successfully. Sep 3 23:23:59.062816 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Sep 3 23:23:59.082879 initrd-setup-root-after-ignition[1370]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 3 23:23:59.082879 initrd-setup-root-after-ignition[1370]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Sep 3 23:23:59.091619 initrd-setup-root-after-ignition[1374]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 3 23:23:59.096933 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 3 23:23:59.102732 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Sep 3 23:23:59.108800 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Sep 3 23:23:59.184068 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Sep 3 23:23:59.184278 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Sep 3 23:23:59.187848 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Sep 3 23:23:59.194270 systemd[1]: Reached target initrd.target - Initrd Default Target. Sep 3 23:23:59.196782 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Sep 3 23:23:59.198894 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Sep 3 23:23:59.255801 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 3 23:23:59.263262 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Sep 3 23:23:59.307373 systemd[1]: initrd-cleanup.service: Deactivated successfully. Sep 3 23:23:59.308116 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Sep 3 23:23:59.317376 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Sep 3 23:23:59.322360 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 3 23:23:59.325228 systemd[1]: Stopped target timers.target - Timer Units. Sep 3 23:23:59.327477 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Sep 3 23:23:59.327610 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 3 23:23:59.335217 systemd[1]: Stopped target initrd.target - Initrd Default Target. Sep 3 23:23:59.339195 systemd[1]: Stopped target basic.target - Basic System. Sep 3 23:23:59.341777 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Sep 3 23:23:59.346588 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Sep 3 23:23:59.355121 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Sep 3 23:23:59.359267 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Sep 3 23:23:59.363773 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Sep 3 23:23:59.366965 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Sep 3 23:23:59.371822 systemd[1]: Stopped target sysinit.target - System Initialization. Sep 3 23:23:59.374751 systemd[1]: Stopped target local-fs.target - Local File Systems. Sep 3 23:23:59.378985 systemd[1]: Stopped target swap.target - Swaps. Sep 3 23:23:59.380934 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Sep 3 23:23:59.381052 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Sep 3 23:23:59.388174 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Sep 3 23:23:59.395173 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 3 23:23:59.399325 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Sep 3 23:23:59.404815 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 3 23:23:59.407627 systemd[1]: dracut-initqueue.service: Deactivated successfully. Sep 3 23:23:59.407743 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Sep 3 23:23:59.415799 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Sep 3 23:23:59.415898 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 3 23:23:59.423257 systemd[1]: ignition-files.service: Deactivated successfully. Sep 3 23:23:59.423380 systemd[1]: Stopped ignition-files.service - Ignition (files). Sep 3 23:23:59.436862 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Sep 3 23:23:59.448727 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Sep 3 23:23:59.449057 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Sep 3 23:23:59.459469 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Sep 3 23:23:59.462389 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Sep 3 23:23:59.462561 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Sep 3 23:23:59.472725 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Sep 3 23:23:59.472857 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Sep 3 23:23:59.507327 ignition[1395]: INFO : Ignition 2.21.0 Sep 3 23:23:59.507327 ignition[1395]: INFO : Stage: umount Sep 3 23:23:59.513549 ignition[1395]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 3 23:23:59.513549 ignition[1395]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 3 23:23:59.513549 ignition[1395]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 3 23:23:59.513549 ignition[1395]: INFO : PUT result: OK Sep 3 23:23:59.526304 ignition[1395]: INFO : umount: umount passed Sep 3 23:23:59.528565 ignition[1395]: INFO : Ignition finished successfully Sep 3 23:23:59.536422 systemd[1]: sysroot-boot.mount: Deactivated successfully. Sep 3 23:23:59.538218 systemd[1]: ignition-mount.service: Deactivated successfully. Sep 3 23:23:59.538771 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Sep 3 23:23:59.550421 systemd[1]: sysroot-boot.service: Deactivated successfully. Sep 3 23:23:59.550647 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Sep 3 23:23:59.553982 systemd[1]: ignition-disks.service: Deactivated successfully. Sep 3 23:23:59.554187 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Sep 3 23:23:59.560037 systemd[1]: ignition-kargs.service: Deactivated successfully. Sep 3 23:23:59.560158 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Sep 3 23:23:59.562924 systemd[1]: ignition-fetch.service: Deactivated successfully. Sep 3 23:23:59.563040 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Sep 3 23:23:59.567016 systemd[1]: Stopped target network.target - Network. Sep 3 23:23:59.573512 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Sep 3 23:23:59.573640 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Sep 3 23:23:59.581202 systemd[1]: Stopped target paths.target - Path Units. Sep 3 23:23:59.584784 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Sep 3 23:23:59.590979 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 3 23:23:59.593831 systemd[1]: Stopped target slices.target - Slice Units. Sep 3 23:23:59.596882 systemd[1]: Stopped target sockets.target - Socket Units. Sep 3 23:23:59.603028 systemd[1]: iscsid.socket: Deactivated successfully. Sep 3 23:23:59.603112 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Sep 3 23:23:59.606117 systemd[1]: iscsiuio.socket: Deactivated successfully. Sep 3 23:23:59.606184 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 3 23:23:59.610478 systemd[1]: ignition-setup.service: Deactivated successfully. Sep 3 23:23:59.610594 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Sep 3 23:23:59.614614 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Sep 3 23:23:59.614699 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Sep 3 23:23:59.617266 systemd[1]: initrd-setup-root.service: Deactivated successfully. Sep 3 23:23:59.617358 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Sep 3 23:23:59.621770 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Sep 3 23:23:59.627112 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Sep 3 23:23:59.652961 systemd[1]: systemd-resolved.service: Deactivated successfully. Sep 3 23:23:59.653168 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Sep 3 23:23:59.677119 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Sep 3 23:23:59.678058 systemd[1]: systemd-networkd.service: Deactivated successfully. Sep 3 23:23:59.678292 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Sep 3 23:23:59.690252 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully. Sep 3 23:23:59.691671 systemd[1]: Stopped target network-pre.target - Preparation for Network. Sep 3 23:23:59.697329 systemd[1]: systemd-networkd.socket: Deactivated successfully. Sep 3 23:23:59.697429 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Sep 3 23:23:59.707440 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Sep 3 23:23:59.709912 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Sep 3 23:23:59.710028 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 3 23:23:59.723690 systemd[1]: systemd-sysctl.service: Deactivated successfully. Sep 3 23:23:59.724340 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Sep 3 23:23:59.732644 systemd[1]: systemd-modules-load.service: Deactivated successfully. Sep 3 23:23:59.732890 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Sep 3 23:23:59.739718 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Sep 3 23:23:59.739922 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 3 23:23:59.752652 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 3 23:23:59.774362 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Sep 3 23:23:59.775610 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Sep 3 23:23:59.776445 systemd[1]: systemd-udevd.service: Deactivated successfully. Sep 3 23:23:59.778713 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 3 23:23:59.790745 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Sep 3 23:23:59.790854 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Sep 3 23:23:59.791500 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Sep 3 23:23:59.791574 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Sep 3 23:23:59.791781 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Sep 3 23:23:59.791865 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Sep 3 23:23:59.792904 systemd[1]: dracut-cmdline.service: Deactivated successfully. Sep 3 23:23:59.792991 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Sep 3 23:23:59.793935 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 3 23:23:59.794012 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 3 23:23:59.806836 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Sep 3 23:23:59.822853 systemd[1]: systemd-network-generator.service: Deactivated successfully. Sep 3 23:23:59.822978 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Sep 3 23:23:59.828580 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Sep 3 23:23:59.828679 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 3 23:23:59.844774 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 3 23:23:59.844884 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 3 23:23:59.851943 systemd[1]: run-credentials-systemd\x2dnetwork\x2dgenerator.service.mount: Deactivated successfully. Sep 3 23:23:59.852049 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup\x2ddev.service.mount: Deactivated successfully. Sep 3 23:23:59.852135 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Sep 3 23:23:59.853717 systemd[1]: network-cleanup.service: Deactivated successfully. Sep 3 23:23:59.855441 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Sep 3 23:23:59.858634 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Sep 3 23:23:59.858849 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Sep 3 23:23:59.863648 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Sep 3 23:23:59.868999 systemd[1]: Starting initrd-switch-root.service - Switch Root... Sep 3 23:23:59.920673 systemd[1]: Switching root. Sep 3 23:23:59.985113 systemd-journald[258]: Journal stopped Sep 3 23:24:02.492278 systemd-journald[258]: Received SIGTERM from PID 1 (systemd). Sep 3 23:24:02.493431 kernel: SELinux: policy capability network_peer_controls=1 Sep 3 23:24:02.493505 kernel: SELinux: policy capability open_perms=1 Sep 3 23:24:02.493538 kernel: SELinux: policy capability extended_socket_class=1 Sep 3 23:24:02.493567 kernel: SELinux: policy capability always_check_network=0 Sep 3 23:24:02.493605 kernel: SELinux: policy capability cgroup_seclabel=1 Sep 3 23:24:02.493642 kernel: SELinux: policy capability nnp_nosuid_transition=1 Sep 3 23:24:02.493672 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Sep 3 23:24:02.493703 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Sep 3 23:24:02.493731 kernel: SELinux: policy capability userspace_initial_context=0 Sep 3 23:24:02.493759 kernel: audit: type=1403 audit(1756941840.344:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Sep 3 23:24:02.493797 systemd[1]: Successfully loaded SELinux policy in 68.896ms. Sep 3 23:24:02.493842 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 24.534ms. Sep 3 23:24:02.496550 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Sep 3 23:24:02.496588 systemd[1]: Detected virtualization amazon. Sep 3 23:24:02.496633 systemd[1]: Detected architecture arm64. Sep 3 23:24:02.496662 systemd[1]: Detected first boot. Sep 3 23:24:02.496693 systemd[1]: Initializing machine ID from VM UUID. Sep 3 23:24:02.496722 zram_generator::config[1440]: No configuration found. Sep 3 23:24:02.496756 kernel: NET: Registered PF_VSOCK protocol family Sep 3 23:24:02.496786 systemd[1]: Populated /etc with preset unit settings. Sep 3 23:24:02.496815 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Sep 3 23:24:02.496846 systemd[1]: initrd-switch-root.service: Deactivated successfully. Sep 3 23:24:02.496881 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Sep 3 23:24:02.496909 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Sep 3 23:24:02.496941 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Sep 3 23:24:02.496974 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Sep 3 23:24:02.497002 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Sep 3 23:24:02.497034 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Sep 3 23:24:02.497064 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Sep 3 23:24:02.497094 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Sep 3 23:24:02.497122 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Sep 3 23:24:02.497155 systemd[1]: Created slice user.slice - User and Session Slice. Sep 3 23:24:02.497185 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 3 23:24:02.497213 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 3 23:24:02.497246 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Sep 3 23:24:02.497287 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Sep 3 23:24:02.497316 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Sep 3 23:24:02.497346 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 3 23:24:02.497378 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Sep 3 23:24:02.503497 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 3 23:24:02.503558 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 3 23:24:02.503588 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Sep 3 23:24:02.503617 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Sep 3 23:24:02.503648 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Sep 3 23:24:02.503679 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Sep 3 23:24:02.503708 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 3 23:24:02.503739 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 3 23:24:02.503769 systemd[1]: Reached target slices.target - Slice Units. Sep 3 23:24:02.503804 systemd[1]: Reached target swap.target - Swaps. Sep 3 23:24:02.503832 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Sep 3 23:24:02.503859 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 3 23:24:02.503887 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Sep 3 23:24:02.503918 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 3 23:24:02.503949 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 3 23:24:02.503979 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 3 23:24:02.504009 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Sep 3 23:24:02.504038 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Sep 3 23:24:02.504073 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Sep 3 23:24:02.504104 systemd[1]: Mounting media.mount - External Media Directory... Sep 3 23:24:02.504134 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Sep 3 23:24:02.504163 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Sep 3 23:24:02.504192 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Sep 3 23:24:02.504223 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). Sep 3 23:24:02.504254 systemd[1]: Reached target machines.target - Containers. Sep 3 23:24:02.504284 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Sep 3 23:24:02.504317 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 3 23:24:02.504349 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 3 23:24:02.504378 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Sep 3 23:24:02.504469 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 3 23:24:02.504504 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 3 23:24:02.504533 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 3 23:24:02.504564 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Sep 3 23:24:02.504594 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 3 23:24:02.504622 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Sep 3 23:24:02.504658 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Sep 3 23:24:02.504689 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Sep 3 23:24:02.504717 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Sep 3 23:24:02.504744 systemd[1]: Stopped systemd-fsck-usr.service. Sep 3 23:24:02.504778 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Sep 3 23:24:02.504806 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 3 23:24:02.504834 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 3 23:24:02.504862 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Sep 3 23:24:02.504896 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Sep 3 23:24:02.504925 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Sep 3 23:24:02.504954 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 3 23:24:02.504985 systemd[1]: verity-setup.service: Deactivated successfully. Sep 3 23:24:02.505014 systemd[1]: Stopped verity-setup.service. Sep 3 23:24:02.512015 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Sep 3 23:24:02.512076 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Sep 3 23:24:02.512116 systemd[1]: Mounted media.mount - External Media Directory. Sep 3 23:24:02.512146 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Sep 3 23:24:02.512175 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Sep 3 23:24:02.512205 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Sep 3 23:24:02.512241 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 3 23:24:02.512270 systemd[1]: modprobe@configfs.service: Deactivated successfully. Sep 3 23:24:02.512302 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Sep 3 23:24:02.512332 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 3 23:24:02.512361 kernel: loop: module loaded Sep 3 23:24:02.512431 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 3 23:24:02.512470 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 3 23:24:02.512500 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 3 23:24:02.512536 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 3 23:24:02.512565 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Sep 3 23:24:02.512593 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Sep 3 23:24:02.512624 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Sep 3 23:24:02.512653 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 3 23:24:02.512683 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Sep 3 23:24:02.512711 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Sep 3 23:24:02.512743 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 3 23:24:02.512773 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Sep 3 23:24:02.512807 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 3 23:24:02.512844 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Sep 3 23:24:02.512875 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 3 23:24:02.512903 kernel: fuse: init (API version 7.41) Sep 3 23:24:02.512933 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Sep 3 23:24:02.512966 systemd[1]: modprobe@fuse.service: Deactivated successfully. Sep 3 23:24:02.512995 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Sep 3 23:24:02.513024 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 3 23:24:02.513062 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 3 23:24:02.513092 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Sep 3 23:24:02.513123 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Sep 3 23:24:02.513153 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Sep 3 23:24:02.513182 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 3 23:24:02.513218 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 3 23:24:02.513247 kernel: ACPI: bus type drm_connector registered Sep 3 23:24:02.513276 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 3 23:24:02.513305 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 3 23:24:02.518503 systemd-journald[1518]: Collecting audit messages is disabled. Sep 3 23:24:02.518605 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Sep 3 23:24:02.518638 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Sep 3 23:24:02.518667 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Sep 3 23:24:02.518704 systemd-journald[1518]: Journal started Sep 3 23:24:02.518750 systemd-journald[1518]: Runtime Journal (/run/log/journal/ec298d5d1de283526a1cafab505dab68) is 8M, max 75.3M, 67.3M free. Sep 3 23:24:01.660954 systemd[1]: Queued start job for default target multi-user.target. Sep 3 23:24:01.678106 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. Sep 3 23:24:01.678935 systemd[1]: systemd-journald.service: Deactivated successfully. Sep 3 23:24:02.545623 systemd[1]: Started systemd-journald.service - Journal Service. Sep 3 23:24:02.545702 kernel: loop0: detected capacity change from 0 to 107312 Sep 3 23:24:02.548254 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Sep 3 23:24:02.553506 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 3 23:24:02.586504 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Sep 3 23:24:02.604767 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Sep 3 23:24:02.610937 systemd[1]: Starting systemd-sysusers.service - Create System Users... Sep 3 23:24:02.651971 systemd-journald[1518]: Time spent on flushing to /var/log/journal/ec298d5d1de283526a1cafab505dab68 is 79.369ms for 918 entries. Sep 3 23:24:02.651971 systemd-journald[1518]: System Journal (/var/log/journal/ec298d5d1de283526a1cafab505dab68) is 8M, max 195.6M, 187.6M free. Sep 3 23:24:02.749565 systemd-journald[1518]: Received client request to flush runtime journal. Sep 3 23:24:02.749646 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Sep 3 23:24:02.749681 kernel: loop1: detected capacity change from 0 to 138376 Sep 3 23:24:02.676124 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 3 23:24:02.683109 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Sep 3 23:24:02.689704 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Sep 3 23:24:02.711954 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Sep 3 23:24:02.759499 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Sep 3 23:24:02.764067 systemd[1]: Finished systemd-sysusers.service - Create System Users. Sep 3 23:24:02.774779 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 3 23:24:02.830187 systemd-tmpfiles[1592]: ACLs are not supported, ignoring. Sep 3 23:24:02.830234 systemd-tmpfiles[1592]: ACLs are not supported, ignoring. Sep 3 23:24:02.857328 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 3 23:24:02.863508 kernel: loop2: detected capacity change from 0 to 61240 Sep 3 23:24:02.905435 kernel: loop3: detected capacity change from 0 to 107312 Sep 3 23:24:02.920450 kernel: loop4: detected capacity change from 0 to 138376 Sep 3 23:24:02.950453 kernel: loop5: detected capacity change from 0 to 61240 Sep 3 23:24:02.981204 (sd-merge)[1597]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-ami'. Sep 3 23:24:02.983015 (sd-merge)[1597]: Merged extensions into '/usr'. Sep 3 23:24:02.988553 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Sep 3 23:24:03.001910 systemd[1]: Starting ensure-sysext.service... Sep 3 23:24:03.011044 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 3 23:24:03.079854 systemd[1]: Reload requested from client PID 1599 ('systemctl') (unit ensure-sysext.service)... Sep 3 23:24:03.079893 systemd[1]: Reloading... Sep 3 23:24:03.086308 systemd-tmpfiles[1600]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Sep 3 23:24:03.086374 systemd-tmpfiles[1600]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Sep 3 23:24:03.087976 systemd-tmpfiles[1600]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Sep 3 23:24:03.088551 systemd-tmpfiles[1600]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Sep 3 23:24:03.094377 systemd-tmpfiles[1600]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Sep 3 23:24:03.095738 systemd-tmpfiles[1600]: ACLs are not supported, ignoring. Sep 3 23:24:03.095879 systemd-tmpfiles[1600]: ACLs are not supported, ignoring. Sep 3 23:24:03.116342 systemd-tmpfiles[1600]: Detected autofs mount point /boot during canonicalization of boot. Sep 3 23:24:03.117288 systemd-tmpfiles[1600]: Skipping /boot Sep 3 23:24:03.179471 systemd-tmpfiles[1600]: Detected autofs mount point /boot during canonicalization of boot. Sep 3 23:24:03.179500 systemd-tmpfiles[1600]: Skipping /boot Sep 3 23:24:03.309468 zram_generator::config[1640]: No configuration found. Sep 3 23:24:03.553113 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. Sep 3 23:24:03.803385 systemd[1]: Reloading finished in 722 ms. Sep 3 23:24:03.828821 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 3 23:24:03.882684 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 3 23:24:03.893921 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Sep 3 23:24:03.907664 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Sep 3 23:24:03.920952 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 3 23:24:03.929041 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Sep 3 23:24:03.939009 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Sep 3 23:24:03.960572 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 3 23:24:03.968923 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 3 23:24:03.975552 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 3 23:24:04.009877 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 3 23:24:04.018854 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 3 23:24:04.024258 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 3 23:24:04.024569 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Sep 3 23:24:04.027907 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 3 23:24:04.029509 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 3 23:24:04.046088 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 3 23:24:04.061892 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 3 23:24:04.065659 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 3 23:24:04.065917 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Sep 3 23:24:04.070878 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Sep 3 23:24:04.075698 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Sep 3 23:24:04.082468 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Sep 3 23:24:04.102062 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 3 23:24:04.105162 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 3 23:24:04.107879 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 3 23:24:04.108647 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Sep 3 23:24:04.108992 systemd[1]: Reached target time-set.target - System Time Set. Sep 3 23:24:04.123349 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 3 23:24:04.123785 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 3 23:24:04.127360 systemd[1]: Finished ensure-sysext.service. Sep 3 23:24:04.130068 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 3 23:24:04.130645 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 3 23:24:04.140103 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 3 23:24:04.179262 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 3 23:24:04.181508 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 3 23:24:04.184781 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 3 23:24:04.195591 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 3 23:24:04.196008 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 3 23:24:04.222218 augenrules[1721]: No rules Sep 3 23:24:04.223380 systemd-udevd[1693]: Using default interface naming scheme 'v255'. Sep 3 23:24:04.229080 systemd[1]: audit-rules.service: Deactivated successfully. Sep 3 23:24:04.230464 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 3 23:24:04.270493 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Sep 3 23:24:04.273914 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). Sep 3 23:24:04.290527 systemd[1]: Started systemd-userdbd.service - User Database Manager. Sep 3 23:24:04.318086 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 3 23:24:04.326648 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 3 23:24:04.361947 ldconfig[1536]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Sep 3 23:24:04.384586 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Sep 3 23:24:04.404587 systemd[1]: Starting systemd-update-done.service - Update is Completed... Sep 3 23:24:04.530058 systemd[1]: Finished systemd-update-done.service - Update is Completed. Sep 3 23:24:04.578246 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Sep 3 23:24:04.609845 (udev-worker)[1733]: Network interface NamePolicy= disabled on kernel command line. Sep 3 23:24:04.635591 systemd-resolved[1685]: Positive Trust Anchors: Sep 3 23:24:04.635633 systemd-resolved[1685]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 3 23:24:04.635698 systemd-resolved[1685]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Sep 3 23:24:04.652569 systemd-resolved[1685]: Defaulting to hostname 'linux'. Sep 3 23:24:04.656472 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 3 23:24:04.659042 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 3 23:24:04.661632 systemd[1]: Reached target sysinit.target - System Initialization. Sep 3 23:24:04.664679 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Sep 3 23:24:04.667374 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Sep 3 23:24:04.670326 systemd[1]: Started logrotate.timer - Daily rotation of log files. Sep 3 23:24:04.672852 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Sep 3 23:24:04.675609 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Sep 3 23:24:04.679506 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Sep 3 23:24:04.679558 systemd[1]: Reached target paths.target - Path Units. Sep 3 23:24:04.681584 systemd[1]: Reached target timers.target - Timer Units. Sep 3 23:24:04.686676 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Sep 3 23:24:04.692451 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 3 23:24:04.702157 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Sep 3 23:24:04.705286 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Sep 3 23:24:04.708042 systemd[1]: Reached target ssh-access.target - SSH Access Available. Sep 3 23:24:04.715310 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Sep 3 23:24:04.719271 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Sep 3 23:24:04.724505 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 3 23:24:04.727589 systemd[1]: Reached target sockets.target - Socket Units. Sep 3 23:24:04.729757 systemd[1]: Reached target basic.target - Basic System. Sep 3 23:24:04.731937 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Sep 3 23:24:04.731989 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Sep 3 23:24:04.735127 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Sep 3 23:24:04.743195 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Sep 3 23:24:04.748783 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Sep 3 23:24:04.758759 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Sep 3 23:24:04.765105 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Sep 3 23:24:04.767377 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). Sep 3 23:24:04.772900 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Sep 3 23:24:04.781232 systemd[1]: Started ntpd.service - Network Time Service. Sep 3 23:24:04.837638 systemd[1]: Starting setup-oem.service - Setup OEM... Sep 3 23:24:04.845636 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Sep 3 23:24:04.855991 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Sep 3 23:24:04.888720 systemd[1]: Starting systemd-logind.service - User Login Management... Sep 3 23:24:04.892585 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Sep 3 23:24:04.893482 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Sep 3 23:24:04.895767 systemd[1]: Starting update-engine.service - Update Engine... Sep 3 23:24:04.900620 jq[1784]: false Sep 3 23:24:04.902743 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Sep 3 23:24:04.908641 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Sep 3 23:24:04.913192 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Sep 3 23:24:04.913635 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Sep 3 23:24:04.958001 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Sep 3 23:24:04.960547 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Sep 3 23:24:05.033022 jq[1799]: true Sep 3 23:24:05.061641 jq[1850]: true Sep 3 23:24:05.094541 dbus-daemon[1782]: [system] SELinux support is enabled Sep 3 23:24:05.097882 systemd[1]: Started dbus.service - D-Bus System Message Bus. Sep 3 23:24:05.110038 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). Sep 3 23:24:05.110671 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Sep 3 23:24:05.113557 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). Sep 3 23:24:05.113594 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Sep 3 23:24:05.145124 systemd[1]: Finished setup-oem.service - Setup OEM. Sep 3 23:24:05.190191 update_engine[1798]: I20250903 23:24:05.189348 1798 main.cc:92] Flatcar Update Engine starting Sep 3 23:24:05.200647 systemd[1]: Started update-engine.service - Update Engine. Sep 3 23:24:05.205145 update_engine[1798]: I20250903 23:24:05.202960 1798 update_check_scheduler.cc:74] Next update check in 2m12s Sep 3 23:24:05.213431 bash[1886]: Updated "/home/core/.ssh/authorized_keys" Sep 3 23:24:05.208364 systemd[1]: Started locksmithd.service - Cluster reboot manager. Sep 3 23:24:05.215500 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Sep 3 23:24:05.229552 systemd[1]: Starting sshkeys.service... Sep 3 23:24:05.268626 extend-filesystems[1785]: Found /dev/nvme0n1p6 Sep 3 23:24:05.274006 systemd[1]: motdgen.service: Deactivated successfully. Sep 3 23:24:05.280254 extend-filesystems[1785]: Found /dev/nvme0n1p9 Sep 3 23:24:05.278500 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Sep 3 23:24:05.297588 extend-filesystems[1785]: Checking size of /dev/nvme0n1p9 Sep 3 23:24:05.330724 extend-filesystems[1785]: Resized partition /dev/nvme0n1p9 Sep 3 23:24:05.335425 coreos-metadata[1781]: Sep 03 23:24:05.330 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Sep 3 23:24:05.340872 extend-filesystems[1919]: resize2fs 1.47.2 (1-Jan-2025) Sep 3 23:24:05.360491 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 553472 to 1489915 blocks Sep 3 23:24:05.378768 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Sep 3 23:24:05.389622 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Sep 3 23:24:05.455993 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 1489915 Sep 3 23:24:05.485789 extend-filesystems[1919]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Sep 3 23:24:05.485789 extend-filesystems[1919]: old_desc_blocks = 1, new_desc_blocks = 1 Sep 3 23:24:05.485789 extend-filesystems[1919]: The filesystem on /dev/nvme0n1p9 is now 1489915 (4k) blocks long. Sep 3 23:24:05.507852 extend-filesystems[1785]: Resized filesystem in /dev/nvme0n1p9 Sep 3 23:24:05.492046 systemd[1]: extend-filesystems.service: Deactivated successfully. Sep 3 23:24:05.492528 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Sep 3 23:24:05.557842 ntpd[1787]: ntpd 4.2.8p17@1.4004-o Wed Sep 3 21:32:01 UTC 2025 (1): Starting Sep 3 23:24:05.560879 ntpd[1787]: 3 Sep 23:24:05 ntpd[1787]: ntpd 4.2.8p17@1.4004-o Wed Sep 3 21:32:01 UTC 2025 (1): Starting Sep 3 23:24:05.560879 ntpd[1787]: 3 Sep 23:24:05 ntpd[1787]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Sep 3 23:24:05.560879 ntpd[1787]: 3 Sep 23:24:05 ntpd[1787]: ---------------------------------------------------- Sep 3 23:24:05.560879 ntpd[1787]: 3 Sep 23:24:05 ntpd[1787]: ntp-4 is maintained by Network Time Foundation, Sep 3 23:24:05.560879 ntpd[1787]: 3 Sep 23:24:05 ntpd[1787]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Sep 3 23:24:05.560879 ntpd[1787]: 3 Sep 23:24:05 ntpd[1787]: corporation. Support and training for ntp-4 are Sep 3 23:24:05.560879 ntpd[1787]: 3 Sep 23:24:05 ntpd[1787]: available at https://www.nwtime.org/support Sep 3 23:24:05.560879 ntpd[1787]: 3 Sep 23:24:05 ntpd[1787]: ---------------------------------------------------- Sep 3 23:24:05.557898 ntpd[1787]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Sep 3 23:24:05.557916 ntpd[1787]: ---------------------------------------------------- Sep 3 23:24:05.557933 ntpd[1787]: ntp-4 is maintained by Network Time Foundation, Sep 3 23:24:05.557951 ntpd[1787]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Sep 3 23:24:05.557967 ntpd[1787]: corporation. Support and training for ntp-4 are Sep 3 23:24:05.557983 ntpd[1787]: available at https://www.nwtime.org/support Sep 3 23:24:05.557999 ntpd[1787]: ---------------------------------------------------- Sep 3 23:24:05.583140 ntpd[1787]: proto: precision = 0.096 usec (-23) Sep 3 23:24:05.597576 ntpd[1787]: 3 Sep 23:24:05 ntpd[1787]: proto: precision = 0.096 usec (-23) Sep 3 23:24:05.597576 ntpd[1787]: 3 Sep 23:24:05 ntpd[1787]: basedate set to 2025-08-22 Sep 3 23:24:05.597576 ntpd[1787]: 3 Sep 23:24:05 ntpd[1787]: gps base set to 2025-08-24 (week 2381) Sep 3 23:24:05.594224 ntpd[1787]: basedate set to 2025-08-22 Sep 3 23:24:05.594251 ntpd[1787]: gps base set to 2025-08-24 (week 2381) Sep 3 23:24:05.601318 ntpd[1787]: Listen and drop on 0 v6wildcard [::]:123 Sep 3 23:24:05.604433 ntpd[1787]: 3 Sep 23:24:05 ntpd[1787]: Listen and drop on 0 v6wildcard [::]:123 Sep 3 23:24:05.604433 ntpd[1787]: 3 Sep 23:24:05 ntpd[1787]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Sep 3 23:24:05.604433 ntpd[1787]: 3 Sep 23:24:05 ntpd[1787]: Listen normally on 2 lo 127.0.0.1:123 Sep 3 23:24:05.604433 ntpd[1787]: 3 Sep 23:24:05 ntpd[1787]: Listen normally on 3 lo [::1]:123 Sep 3 23:24:05.604433 ntpd[1787]: 3 Sep 23:24:05 ntpd[1787]: Listening on routing socket on fd #20 for interface updates Sep 3 23:24:05.603531 ntpd[1787]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Sep 3 23:24:05.603778 ntpd[1787]: Listen normally on 2 lo 127.0.0.1:123 Sep 3 23:24:05.603843 ntpd[1787]: Listen normally on 3 lo [::1]:123 Sep 3 23:24:05.603910 ntpd[1787]: Listening on routing socket on fd #20 for interface updates Sep 3 23:24:05.617548 ntpd[1787]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 3 23:24:05.619939 ntpd[1787]: 3 Sep 23:24:05 ntpd[1787]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 3 23:24:05.619939 ntpd[1787]: 3 Sep 23:24:05 ntpd[1787]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 3 23:24:05.619504 ntpd[1787]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 3 23:24:05.631992 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Sep 3 23:24:05.640661 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Sep 3 23:24:05.689506 locksmithd[1888]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Sep 3 23:24:05.698363 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Sep 3 23:24:05.728447 systemd-networkd[1735]: lo: Link UP Sep 3 23:24:05.728527 systemd-networkd[1735]: lo: Gained carrier Sep 3 23:24:05.735373 systemd-networkd[1735]: Enumeration completed Sep 3 23:24:05.735597 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 3 23:24:05.738608 systemd[1]: Reached target network.target - Network. Sep 3 23:24:05.745768 systemd-networkd[1735]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 3 23:24:05.746592 systemd-networkd[1735]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 3 23:24:05.748092 systemd[1]: Starting containerd.service - containerd container runtime... Sep 3 23:24:05.753744 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Sep 3 23:24:05.764017 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Sep 3 23:24:05.768707 systemd-networkd[1735]: eth0: Link UP Sep 3 23:24:05.769027 systemd-networkd[1735]: eth0: Gained carrier Sep 3 23:24:05.769063 systemd-networkd[1735]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 3 23:24:05.786741 dbus-daemon[1782]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.5' (uid=244 pid=1735 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Sep 3 23:24:05.793636 systemd-networkd[1735]: eth0: DHCPv4 address 172.31.17.118/20, gateway 172.31.16.1 acquired from 172.31.16.1 Sep 3 23:24:05.799558 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Sep 3 23:24:05.827077 coreos-metadata[1921]: Sep 03 23:24:05.827 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Sep 3 23:24:05.850091 coreos-metadata[1921]: Sep 03 23:24:05.849 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys: Attempt #1 Sep 3 23:24:05.853193 coreos-metadata[1921]: Sep 03 23:24:05.852 INFO Fetch successful Sep 3 23:24:05.853193 coreos-metadata[1921]: Sep 03 23:24:05.852 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys/0/openssh-key: Attempt #1 Sep 3 23:24:05.863335 coreos-metadata[1921]: Sep 03 23:24:05.861 INFO Fetch successful Sep 3 23:24:05.858043 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Sep 3 23:24:05.870528 unknown[1921]: wrote ssh authorized keys file for user: core Sep 3 23:24:05.896718 (ntainerd)[1952]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 3 23:24:05.927590 systemd-logind[1791]: New seat seat0. Sep 3 23:24:05.933502 systemd[1]: Started systemd-logind.service - User Login Management. Sep 3 23:24:05.955858 update-ssh-keys[1955]: Updated "/home/core/.ssh/authorized_keys" Sep 3 23:24:05.959218 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Sep 3 23:24:05.974555 systemd[1]: Finished sshkeys.service. Sep 3 23:24:06.309893 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Sep 3 23:24:06.316929 dbus-daemon[1782]: [system] Successfully activated service 'org.freedesktop.hostname1' Sep 3 23:24:06.322607 dbus-daemon[1782]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.7' (uid=0 pid=1948 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Sep 3 23:24:06.342587 systemd[1]: Starting polkit.service - Authorization Manager... Sep 3 23:24:06.442421 coreos-metadata[1781]: Sep 03 23:24:06.440 INFO Putting http://169.254.169.254/latest/api/token: Attempt #2 Sep 3 23:24:06.442915 coreos-metadata[1781]: Sep 03 23:24:06.442 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-id: Attempt #1 Sep 3 23:24:06.448975 coreos-metadata[1781]: Sep 03 23:24:06.444 INFO Fetch successful Sep 3 23:24:06.448975 coreos-metadata[1781]: Sep 03 23:24:06.444 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-type: Attempt #1 Sep 3 23:24:06.448975 coreos-metadata[1781]: Sep 03 23:24:06.445 INFO Fetch successful Sep 3 23:24:06.448975 coreos-metadata[1781]: Sep 03 23:24:06.445 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/local-ipv4: Attempt #1 Sep 3 23:24:06.448975 coreos-metadata[1781]: Sep 03 23:24:06.446 INFO Fetch successful Sep 3 23:24:06.448975 coreos-metadata[1781]: Sep 03 23:24:06.446 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-ipv4: Attempt #1 Sep 3 23:24:06.448975 coreos-metadata[1781]: Sep 03 23:24:06.447 INFO Fetch successful Sep 3 23:24:06.448975 coreos-metadata[1781]: Sep 03 23:24:06.447 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/ipv6: Attempt #1 Sep 3 23:24:06.448975 coreos-metadata[1781]: Sep 03 23:24:06.448 INFO Fetch failed with 404: resource not found Sep 3 23:24:06.448975 coreos-metadata[1781]: Sep 03 23:24:06.448 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone: Attempt #1 Sep 3 23:24:06.449760 coreos-metadata[1781]: Sep 03 23:24:06.449 INFO Fetch successful Sep 3 23:24:06.450453 coreos-metadata[1781]: Sep 03 23:24:06.450 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone-id: Attempt #1 Sep 3 23:24:06.451427 coreos-metadata[1781]: Sep 03 23:24:06.451 INFO Fetch successful Sep 3 23:24:06.451961 coreos-metadata[1781]: Sep 03 23:24:06.451 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/hostname: Attempt #1 Sep 3 23:24:06.453579 coreos-metadata[1781]: Sep 03 23:24:06.453 INFO Fetch successful Sep 3 23:24:06.453687 coreos-metadata[1781]: Sep 03 23:24:06.453 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-hostname: Attempt #1 Sep 3 23:24:06.454470 coreos-metadata[1781]: Sep 03 23:24:06.454 INFO Fetch successful Sep 3 23:24:06.454558 coreos-metadata[1781]: Sep 03 23:24:06.454 INFO Fetching http://169.254.169.254/2021-01-03/dynamic/instance-identity/document: Attempt #1 Sep 3 23:24:06.458508 coreos-metadata[1781]: Sep 03 23:24:06.457 INFO Fetch successful Sep 3 23:24:06.480480 systemd-logind[1791]: Watching system buttons on /dev/input/event0 (Power Button) Sep 3 23:24:06.484710 containerd[1952]: time="2025-09-03T23:24:06Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Sep 3 23:24:06.495742 containerd[1952]: time="2025-09-03T23:24:06.495658845Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 Sep 3 23:24:06.516365 systemd-logind[1791]: Watching system buttons on /dev/input/event1 (Sleep Button) Sep 3 23:24:06.519024 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 3 23:24:06.555064 containerd[1952]: time="2025-09-03T23:24:06.554991993Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="15.588Āµs" Sep 3 23:24:06.555064 containerd[1952]: time="2025-09-03T23:24:06.555051657Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Sep 3 23:24:06.555246 containerd[1952]: time="2025-09-03T23:24:06.555091929Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Sep 3 23:24:06.557058 containerd[1952]: time="2025-09-03T23:24:06.555388041Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Sep 3 23:24:06.557058 containerd[1952]: time="2025-09-03T23:24:06.556521669Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Sep 3 23:24:06.557058 containerd[1952]: time="2025-09-03T23:24:06.556590885Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 3 23:24:06.557058 containerd[1952]: time="2025-09-03T23:24:06.556749465Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 3 23:24:06.557058 containerd[1952]: time="2025-09-03T23:24:06.556776357Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 3 23:24:06.562435 containerd[1952]: time="2025-09-03T23:24:06.561726801Z" level=info msg="skip loading plugin" 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" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 3 23:24:06.562435 containerd[1952]: time="2025-09-03T23:24:06.561799773Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 3 23:24:06.562435 containerd[1952]: time="2025-09-03T23:24:06.561835881Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 3 23:24:06.562435 containerd[1952]: time="2025-09-03T23:24:06.561859185Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Sep 3 23:24:06.562435 containerd[1952]: time="2025-09-03T23:24:06.562084629Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Sep 3 23:24:06.562739 containerd[1952]: time="2025-09-03T23:24:06.562562277Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 3 23:24:06.562739 containerd[1952]: time="2025-09-03T23:24:06.562641993Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 3 23:24:06.562739 containerd[1952]: time="2025-09-03T23:24:06.562668309Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Sep 3 23:24:06.565160 containerd[1952]: time="2025-09-03T23:24:06.564308385Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Sep 3 23:24:06.567777 containerd[1952]: time="2025-09-03T23:24:06.567709581Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Sep 3 23:24:06.567955 containerd[1952]: time="2025-09-03T23:24:06.567913173Z" level=info msg="metadata content store policy set" policy=shared Sep 3 23:24:06.577723 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Sep 3 23:24:06.581373 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Sep 3 23:24:06.587497 containerd[1952]: time="2025-09-03T23:24:06.584569437Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Sep 3 23:24:06.587497 containerd[1952]: time="2025-09-03T23:24:06.584691105Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Sep 3 23:24:06.587497 containerd[1952]: time="2025-09-03T23:24:06.584862561Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Sep 3 23:24:06.587497 containerd[1952]: time="2025-09-03T23:24:06.585229101Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Sep 3 23:24:06.587497 containerd[1952]: time="2025-09-03T23:24:06.585490053Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Sep 3 23:24:06.587497 containerd[1952]: time="2025-09-03T23:24:06.585521289Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Sep 3 23:24:06.587497 containerd[1952]: time="2025-09-03T23:24:06.585556149Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Sep 3 23:24:06.587497 containerd[1952]: time="2025-09-03T23:24:06.585585909Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Sep 3 23:24:06.587497 containerd[1952]: time="2025-09-03T23:24:06.585916149Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Sep 3 23:24:06.587497 containerd[1952]: time="2025-09-03T23:24:06.585954237Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Sep 3 23:24:06.587497 containerd[1952]: time="2025-09-03T23:24:06.586196265Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Sep 3 23:24:06.587497 containerd[1952]: time="2025-09-03T23:24:06.586233897Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Sep 3 23:24:06.587497 containerd[1952]: time="2025-09-03T23:24:06.586540281Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Sep 3 23:24:06.587497 containerd[1952]: time="2025-09-03T23:24:06.586595757Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Sep 3 23:24:06.588135 containerd[1952]: time="2025-09-03T23:24:06.586634913Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Sep 3 23:24:06.588135 containerd[1952]: time="2025-09-03T23:24:06.586667457Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Sep 3 23:24:06.588135 containerd[1952]: time="2025-09-03T23:24:06.586696485Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Sep 3 23:24:06.588135 containerd[1952]: time="2025-09-03T23:24:06.586729761Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Sep 3 23:24:06.588135 containerd[1952]: time="2025-09-03T23:24:06.586758573Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Sep 3 23:24:06.588135 containerd[1952]: time="2025-09-03T23:24:06.586786893Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Sep 3 23:24:06.588135 containerd[1952]: time="2025-09-03T23:24:06.586818021Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Sep 3 23:24:06.588135 containerd[1952]: time="2025-09-03T23:24:06.586845825Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Sep 3 23:24:06.588135 containerd[1952]: time="2025-09-03T23:24:06.586895169Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Sep 3 23:24:06.588135 containerd[1952]: time="2025-09-03T23:24:06.587280489Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Sep 3 23:24:06.588135 containerd[1952]: time="2025-09-03T23:24:06.587315637Z" level=info msg="Start snapshots syncer" Sep 3 23:24:06.591622 containerd[1952]: time="2025-09-03T23:24:06.588495657Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Sep 3 23:24:06.591622 containerd[1952]: time="2025-09-03T23:24:06.589874829Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"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\"}" Sep 3 23:24:06.591913 containerd[1952]: time="2025-09-03T23:24:06.589984533Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Sep 3 23:24:06.591913 containerd[1952]: time="2025-09-03T23:24:06.591228969Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Sep 3 23:24:06.591913 containerd[1952]: time="2025-09-03T23:24:06.591837933Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Sep 3 23:24:06.591913 containerd[1952]: time="2025-09-03T23:24:06.591897189Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Sep 3 23:24:06.592098 containerd[1952]: time="2025-09-03T23:24:06.591925389Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Sep 3 23:24:06.592098 containerd[1952]: time="2025-09-03T23:24:06.591951225Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Sep 3 23:24:06.592098 containerd[1952]: time="2025-09-03T23:24:06.591988293Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Sep 3 23:24:06.592098 containerd[1952]: time="2025-09-03T23:24:06.592022829Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Sep 3 23:24:06.592098 containerd[1952]: time="2025-09-03T23:24:06.592050957Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Sep 3 23:24:06.592302 containerd[1952]: time="2025-09-03T23:24:06.592107765Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Sep 3 23:24:06.592302 containerd[1952]: time="2025-09-03T23:24:06.592135713Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Sep 3 23:24:06.592302 containerd[1952]: time="2025-09-03T23:24:06.592164069Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Sep 3 23:24:06.593626 containerd[1952]: time="2025-09-03T23:24:06.593470810Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 3 23:24:06.593690 containerd[1952]: time="2025-09-03T23:24:06.593641042Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 3 23:24:06.593690 containerd[1952]: time="2025-09-03T23:24:06.593667598Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 3 23:24:06.593804 containerd[1952]: time="2025-09-03T23:24:06.593691658Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 3 23:24:06.593804 containerd[1952]: time="2025-09-03T23:24:06.593713906Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Sep 3 23:24:06.593804 containerd[1952]: time="2025-09-03T23:24:06.593738722Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Sep 3 23:24:06.593804 containerd[1952]: time="2025-09-03T23:24:06.593764618Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Sep 3 23:24:06.593961 containerd[1952]: time="2025-09-03T23:24:06.593930842Z" level=info msg="runtime interface created" Sep 3 23:24:06.593961 containerd[1952]: time="2025-09-03T23:24:06.593948098Z" level=info msg="created NRI interface" Sep 3 23:24:06.594049 containerd[1952]: time="2025-09-03T23:24:06.593970490Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Sep 3 23:24:06.594049 containerd[1952]: time="2025-09-03T23:24:06.594000802Z" level=info msg="Connect containerd service" Sep 3 23:24:06.594131 containerd[1952]: time="2025-09-03T23:24:06.594078454Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 3 23:24:06.597689 containerd[1952]: time="2025-09-03T23:24:06.597623434Z" 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" Sep 3 23:24:06.803710 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 3 23:24:07.047512 containerd[1952]: time="2025-09-03T23:24:07.047065400Z" level=info msg="Start subscribing containerd event" Sep 3 23:24:07.047512 containerd[1952]: time="2025-09-03T23:24:07.047465156Z" level=info msg="Start recovering state" Sep 3 23:24:07.047850 containerd[1952]: time="2025-09-03T23:24:07.047810288Z" level=info msg="Start event monitor" Sep 3 23:24:07.048265 containerd[1952]: time="2025-09-03T23:24:07.048223640Z" level=info msg="Start cni network conf syncer for default" Sep 3 23:24:07.048328 containerd[1952]: time="2025-09-03T23:24:07.048259952Z" level=info msg="Start streaming server" Sep 3 23:24:07.048328 containerd[1952]: time="2025-09-03T23:24:07.048282284Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Sep 3 23:24:07.048328 containerd[1952]: time="2025-09-03T23:24:07.048298964Z" level=info msg="runtime interface starting up..." Sep 3 23:24:07.048328 containerd[1952]: time="2025-09-03T23:24:07.048314360Z" level=info msg="starting plugins..." Sep 3 23:24:07.049569 containerd[1952]: time="2025-09-03T23:24:07.048347828Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Sep 3 23:24:07.051771 containerd[1952]: time="2025-09-03T23:24:07.051710576Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 3 23:24:07.051901 containerd[1952]: time="2025-09-03T23:24:07.051833816Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 3 23:24:07.053798 containerd[1952]: time="2025-09-03T23:24:07.053741600Z" level=info msg="containerd successfully booted in 0.582796s" Sep 3 23:24:07.061135 systemd[1]: Started containerd.service - containerd container runtime. Sep 3 23:24:07.237917 polkitd[1976]: Started polkitd version 126 Sep 3 23:24:07.249558 polkitd[1976]: Loading rules from directory /etc/polkit-1/rules.d Sep 3 23:24:07.250362 polkitd[1976]: Loading rules from directory /run/polkit-1/rules.d Sep 3 23:24:07.250649 polkitd[1976]: Error opening rules directory: Error opening directory ā€œ/run/polkit-1/rules.dā€: No such file or directory (g-file-error-quark, 4) Sep 3 23:24:07.251459 polkitd[1976]: Loading rules from directory /usr/local/share/polkit-1/rules.d Sep 3 23:24:07.251596 polkitd[1976]: Error opening rules directory: Error opening directory ā€œ/usr/local/share/polkit-1/rules.dā€: No such file or directory (g-file-error-quark, 4) Sep 3 23:24:07.251808 polkitd[1976]: Loading rules from directory /usr/share/polkit-1/rules.d Sep 3 23:24:07.252861 polkitd[1976]: Finished loading, compiling and executing 2 rules Sep 3 23:24:07.253427 systemd[1]: Started polkit.service - Authorization Manager. Sep 3 23:24:07.257682 dbus-daemon[1782]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Sep 3 23:24:07.258627 polkitd[1976]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Sep 3 23:24:07.275220 systemd-hostnamed[1948]: Hostname set to (transient) Sep 3 23:24:07.275960 systemd-resolved[1685]: System hostname changed to 'ip-172-31-17-118'. Sep 3 23:24:07.314583 systemd-networkd[1735]: eth0: Gained IPv6LL Sep 3 23:24:07.321996 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Sep 3 23:24:07.325633 systemd[1]: Reached target network-online.target - Network is Online. Sep 3 23:24:07.332947 systemd[1]: Started amazon-ssm-agent.service - amazon-ssm-agent. Sep 3 23:24:07.338912 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... Sep 3 23:24:07.344070 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Sep 3 23:24:07.368834 (-wrapper)[2099]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS Sep 3 23:24:07.415031 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Sep 3 23:24:07.497434 amazon-ssm-agent[2098]: Initializing new seelog logger Sep 3 23:24:07.497434 amazon-ssm-agent[2098]: New Seelog Logger Creation Complete Sep 3 23:24:07.497434 amazon-ssm-agent[2098]: 2025/09/03 23:24:07 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Sep 3 23:24:07.497434 amazon-ssm-agent[2098]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Sep 3 23:24:07.498883 amazon-ssm-agent[2098]: 2025/09/03 23:24:07 processing appconfig overrides Sep 3 23:24:07.501073 amazon-ssm-agent[2098]: 2025/09/03 23:24:07 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Sep 3 23:24:07.502445 amazon-ssm-agent[2098]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Sep 3 23:24:07.502445 amazon-ssm-agent[2098]: 2025/09/03 23:24:07 processing appconfig overrides Sep 3 23:24:07.502445 amazon-ssm-agent[2098]: 2025/09/03 23:24:07 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Sep 3 23:24:07.502445 amazon-ssm-agent[2098]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Sep 3 23:24:07.502710 amazon-ssm-agent[2098]: 2025/09/03 23:24:07 processing appconfig overrides Sep 3 23:24:07.503895 amazon-ssm-agent[2098]: 2025-09-03 23:24:07.4996 INFO Proxy environment variables: Sep 3 23:24:07.514875 amazon-ssm-agent[2098]: 2025/09/03 23:24:07 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Sep 3 23:24:07.515780 amazon-ssm-agent[2098]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Sep 3 23:24:07.515780 amazon-ssm-agent[2098]: 2025/09/03 23:24:07 processing appconfig overrides Sep 3 23:24:07.608748 amazon-ssm-agent[2098]: 2025-09-03 23:24:07.5009 INFO no_proxy: Sep 3 23:24:07.612368 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Sep 3 23:24:07.689050 ntpd[1787]: giving up resolving host metadata.google.internal: Name or service not known (-2) Sep 3 23:24:07.689552 ntpd[1787]: 3 Sep 23:24:07 ntpd[1787]: giving up resolving host metadata.google.internal: Name or service not known (-2) Sep 3 23:24:07.709209 amazon-ssm-agent[2098]: 2025-09-03 23:24:07.5009 INFO https_proxy: Sep 3 23:24:07.740842 systemd[1]: Starting docker.service - Docker Application Container Engine... Sep 3 23:24:07.763928 (dockerd)[2124]: 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 Sep 3 23:24:07.807512 amazon-ssm-agent[2098]: 2025-09-03 23:24:07.5009 INFO http_proxy: Sep 3 23:24:07.906312 amazon-ssm-agent[2098]: 2025-09-03 23:24:07.5013 INFO Checking if agent identity type OnPrem can be assumed Sep 3 23:24:08.005515 amazon-ssm-agent[2098]: 2025-09-03 23:24:07.5014 INFO Checking if agent identity type EC2 can be assumed Sep 3 23:24:08.104093 amazon-ssm-agent[2098]: 2025-09-03 23:24:07.6098 INFO Agent will take identity from EC2 Sep 3 23:24:08.143973 amazon-ssm-agent[2098]: 2025/09/03 23:24:08 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Sep 3 23:24:08.144136 amazon-ssm-agent[2098]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Sep 3 23:24:08.144371 amazon-ssm-agent[2098]: 2025/09/03 23:24:08 processing appconfig overrides Sep 3 23:24:08.180828 amazon-ssm-agent[2098]: 2025-09-03 23:24:07.6210 INFO [amazon-ssm-agent] amazon-ssm-agent - v3.3.0.0 Sep 3 23:24:08.180828 amazon-ssm-agent[2098]: 2025-09-03 23:24:07.6211 INFO [amazon-ssm-agent] OS: linux, Arch: arm64 Sep 3 23:24:08.180828 amazon-ssm-agent[2098]: 2025-09-03 23:24:07.6211 INFO [amazon-ssm-agent] Starting Core Agent Sep 3 23:24:08.180828 amazon-ssm-agent[2098]: 2025-09-03 23:24:07.6211 INFO [amazon-ssm-agent] Registrar detected. Attempting registration Sep 3 23:24:08.180828 amazon-ssm-agent[2098]: 2025-09-03 23:24:07.6211 INFO [Registrar] Starting registrar module Sep 3 23:24:08.180828 amazon-ssm-agent[2098]: 2025-09-03 23:24:07.6228 INFO [EC2Identity] Checking disk for registration info Sep 3 23:24:08.180828 amazon-ssm-agent[2098]: 2025-09-03 23:24:07.6229 INFO [EC2Identity] No registration info found for ec2 instance, attempting registration Sep 3 23:24:08.180828 amazon-ssm-agent[2098]: 2025-09-03 23:24:07.6229 INFO [EC2Identity] Generating registration keypair Sep 3 23:24:08.180828 amazon-ssm-agent[2098]: 2025-09-03 23:24:08.0960 INFO [EC2Identity] Checking write access before registering Sep 3 23:24:08.180828 amazon-ssm-agent[2098]: 2025-09-03 23:24:08.0967 INFO [EC2Identity] Registering EC2 instance with Systems Manager Sep 3 23:24:08.180828 amazon-ssm-agent[2098]: 2025-09-03 23:24:08.1436 INFO [EC2Identity] EC2 registration was successful. Sep 3 23:24:08.180828 amazon-ssm-agent[2098]: 2025-09-03 23:24:08.1436 INFO [amazon-ssm-agent] Registration attempted. Resuming core agent startup. Sep 3 23:24:08.180828 amazon-ssm-agent[2098]: 2025-09-03 23:24:08.1437 INFO [CredentialRefresher] credentialRefresher has started Sep 3 23:24:08.180828 amazon-ssm-agent[2098]: 2025-09-03 23:24:08.1438 INFO [CredentialRefresher] Starting credentials refresher loop Sep 3 23:24:08.180828 amazon-ssm-agent[2098]: 2025-09-03 23:24:08.1792 INFO EC2RoleProvider Successfully connected with instance profile role credentials Sep 3 23:24:08.180828 amazon-ssm-agent[2098]: 2025-09-03 23:24:08.1800 INFO [CredentialRefresher] Credentials ready Sep 3 23:24:08.203189 amazon-ssm-agent[2098]: 2025-09-03 23:24:08.1806 INFO [CredentialRefresher] Next credential rotation will be in 29.999975653699998 minutes Sep 3 23:24:08.444257 dockerd[2124]: time="2025-09-03T23:24:08.444122687Z" level=info msg="Starting up" Sep 3 23:24:08.447815 dockerd[2124]: time="2025-09-03T23:24:08.447588623Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Sep 3 23:24:08.512149 systemd[1]: var-lib-docker-check\x2doverlayfs\x2dsupport1971612338-merged.mount: Deactivated successfully. Sep 3 23:24:08.543609 dockerd[2124]: time="2025-09-03T23:24:08.543542459Z" level=info msg="Loading containers: start." Sep 3 23:24:08.562774 kernel: Initializing XFRM netlink socket Sep 3 23:24:08.674582 sshd_keygen[1865]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Sep 3 23:24:08.726059 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Sep 3 23:24:08.732320 systemd[1]: Starting issuegen.service - Generate /run/issue... Sep 3 23:24:08.737054 systemd[1]: Started sshd@0-172.31.17.118:22-139.178.89.65:55588.service - OpenSSH per-connection server daemon (139.178.89.65:55588). Sep 3 23:24:08.765636 systemd[1]: issuegen.service: Deactivated successfully. Sep 3 23:24:08.766840 systemd[1]: Finished issuegen.service - Generate /run/issue. Sep 3 23:24:08.776906 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Sep 3 23:24:08.825525 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Sep 3 23:24:08.834906 systemd[1]: Started getty@tty1.service - Getty on tty1. Sep 3 23:24:08.842191 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Sep 3 23:24:08.846065 systemd[1]: Reached target getty.target - Login Prompts. Sep 3 23:24:09.014977 (udev-worker)[1758]: Network interface NamePolicy= disabled on kernel command line. Sep 3 23:24:09.060192 sshd[2195]: Accepted publickey for core from 139.178.89.65 port 55588 ssh2: RSA SHA256:8eQAyPE99YHHVtDm+V4mP5sHyPbVNBHa6xDGC+ww79Y Sep 3 23:24:09.062276 sshd-session[2195]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 3 23:24:09.083070 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Sep 3 23:24:09.089845 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Sep 3 23:24:09.110051 systemd-networkd[1735]: docker0: Link UP Sep 3 23:24:09.122184 systemd-logind[1791]: New session 1 of user core. Sep 3 23:24:09.126513 dockerd[2124]: time="2025-09-03T23:24:09.125084374Z" level=info msg="Loading containers: done." Sep 3 23:24:09.142370 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Sep 3 23:24:09.154933 systemd[1]: Starting user@500.service - User Manager for UID 500... Sep 3 23:24:09.186617 (systemd)[2315]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Sep 3 23:24:09.188184 dockerd[2124]: time="2025-09-03T23:24:09.185245522Z" 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 Sep 3 23:24:09.188184 dockerd[2124]: time="2025-09-03T23:24:09.187370866Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1 Sep 3 23:24:09.188184 dockerd[2124]: time="2025-09-03T23:24:09.187672414Z" level=info msg="Initializing buildkit" Sep 3 23:24:09.195618 systemd-logind[1791]: New session c1 of user core. Sep 3 23:24:09.244620 amazon-ssm-agent[2098]: 2025-09-03 23:24:09.2308 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker is not running, starting worker process Sep 3 23:24:09.278330 dockerd[2124]: time="2025-09-03T23:24:09.277838243Z" level=info msg="Completed buildkit initialization" Sep 3 23:24:09.311926 dockerd[2124]: time="2025-09-03T23:24:09.311496959Z" level=info msg="Daemon has completed initialization" Sep 3 23:24:09.311926 dockerd[2124]: time="2025-09-03T23:24:09.311652563Z" level=info msg="API listen on /run/docker.sock" Sep 3 23:24:09.312451 systemd[1]: Started docker.service - Docker Application Container Engine. Sep 3 23:24:09.323957 etcd-wrapper[2108]: Error response from daemon: No such container: etcd-member Sep 3 23:24:09.350431 amazon-ssm-agent[2098]: 2025-09-03 23:24:09.2443 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker (pid:2329) started Sep 3 23:24:09.386179 etcd-wrapper[2346]: Error response from daemon: No such container: etcd-member Sep 3 23:24:09.447550 amazon-ssm-agent[2098]: 2025-09-03 23:24:09.2443 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] Monitor long running worker health every 60 seconds Sep 3 23:24:09.507177 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck960849877-merged.mount: Deactivated successfully. Sep 3 23:24:09.512320 etcd-wrapper[2368]: Unable to find image 'quay.io/coreos/etcd:v3.5.16' locally Sep 3 23:24:09.617664 systemd[2315]: Queued start job for default target default.target. Sep 3 23:24:09.637759 systemd[2315]: Created slice app.slice - User Application Slice. Sep 3 23:24:09.637995 systemd[2315]: Reached target paths.target - Paths. Sep 3 23:24:09.638078 systemd[2315]: Reached target timers.target - Timers. Sep 3 23:24:09.640548 systemd[2315]: Starting dbus.socket - D-Bus User Message Bus Socket... Sep 3 23:24:09.680859 systemd[2315]: Listening on dbus.socket - D-Bus User Message Bus Socket. Sep 3 23:24:09.681086 systemd[2315]: Reached target sockets.target - Sockets. Sep 3 23:24:09.681184 systemd[2315]: Reached target basic.target - Basic System. Sep 3 23:24:09.681270 systemd[2315]: Reached target default.target - Main User Target. Sep 3 23:24:09.681312 systemd[1]: Started user@500.service - User Manager for UID 500. Sep 3 23:24:09.681329 systemd[2315]: Startup finished in 468ms. Sep 3 23:24:09.692735 systemd[1]: Started session-1.scope - Session 1 of User core. Sep 3 23:24:09.853883 systemd[1]: Started sshd@1-172.31.17.118:22-139.178.89.65:59676.service - OpenSSH per-connection server daemon (139.178.89.65:59676). Sep 3 23:24:10.059246 sshd[2386]: Accepted publickey for core from 139.178.89.65 port 59676 ssh2: RSA SHA256:8eQAyPE99YHHVtDm+V4mP5sHyPbVNBHa6xDGC+ww79Y Sep 3 23:24:10.061952 sshd-session[2386]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 3 23:24:10.071488 systemd-logind[1791]: New session 2 of user core. Sep 3 23:24:10.080711 systemd[1]: Started session-2.scope - Session 2 of User core. Sep 3 23:24:10.205936 sshd[2388]: Connection closed by 139.178.89.65 port 59676 Sep 3 23:24:10.206684 sshd-session[2386]: pam_unix(sshd:session): session closed for user core Sep 3 23:24:10.215244 systemd[1]: sshd@1-172.31.17.118:22-139.178.89.65:59676.service: Deactivated successfully. Sep 3 23:24:10.218201 systemd[1]: session-2.scope: Deactivated successfully. Sep 3 23:24:10.219984 systemd-logind[1791]: Session 2 logged out. Waiting for processes to exit. Sep 3 23:24:10.223054 systemd-logind[1791]: Removed session 2. Sep 3 23:24:10.246885 systemd[1]: Started sshd@2-172.31.17.118:22-139.178.89.65:59688.service - OpenSSH per-connection server daemon (139.178.89.65:59688). Sep 3 23:24:10.468055 sshd[2394]: Accepted publickey for core from 139.178.89.65 port 59688 ssh2: RSA SHA256:8eQAyPE99YHHVtDm+V4mP5sHyPbVNBHa6xDGC+ww79Y Sep 3 23:24:10.471367 sshd-session[2394]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 3 23:24:10.479744 systemd-logind[1791]: New session 3 of user core. Sep 3 23:24:10.488661 systemd[1]: Started session-3.scope - Session 3 of User core. Sep 3 23:24:10.584863 etcd-wrapper[2368]: v3.5.16: Pulling from coreos/etcd Sep 3 23:24:10.620764 sshd[2396]: Connection closed by 139.178.89.65 port 59688 Sep 3 23:24:10.621723 sshd-session[2394]: pam_unix(sshd:session): session closed for user core Sep 3 23:24:10.629500 systemd-logind[1791]: Session 3 logged out. Waiting for processes to exit. Sep 3 23:24:10.630370 systemd[1]: sshd@2-172.31.17.118:22-139.178.89.65:59688.service: Deactivated successfully. Sep 3 23:24:10.634103 systemd[1]: session-3.scope: Deactivated successfully. Sep 3 23:24:10.637362 systemd-logind[1791]: Removed session 3. Sep 3 23:24:10.828128 etcd-wrapper[2368]: d10f96ed9607: Pulling fs layer Sep 3 23:24:10.828128 etcd-wrapper[2368]: 2ae710cd8bfe: Pulling fs layer Sep 3 23:24:10.828128 etcd-wrapper[2368]: d462aa345367: Pulling fs layer Sep 3 23:24:10.828128 etcd-wrapper[2368]: 0f8b424aa0b9: Pulling fs layer Sep 3 23:24:10.828128 etcd-wrapper[2368]: d557676654e5: Pulling fs layer Sep 3 23:24:10.828128 etcd-wrapper[2368]: c8022d07192e: Pulling fs layer Sep 3 23:24:10.828128 etcd-wrapper[2368]: d858cbc252ad: Pulling fs layer Sep 3 23:24:10.828128 etcd-wrapper[2368]: 1069fc2daed1: Pulling fs layer Sep 3 23:24:10.828128 etcd-wrapper[2368]: b40161cd83fc: Pulling fs layer Sep 3 23:24:10.828128 etcd-wrapper[2368]: 5318d93a3a65: Pulling fs layer Sep 3 23:24:10.828128 etcd-wrapper[2368]: 307c1adadb60: Pulling fs layer Sep 3 23:24:10.828128 etcd-wrapper[2368]: f9b3c65df792: Pulling fs layer Sep 3 23:24:10.828128 etcd-wrapper[2368]: 5709b4a82c35: Pulling fs layer Sep 3 23:24:10.828128 etcd-wrapper[2368]: d5372e382b07: Pulling fs layer Sep 3 23:24:10.828128 etcd-wrapper[2368]: 9c3b5253dddc: Pulling fs layer Sep 3 23:24:10.828128 etcd-wrapper[2368]: 7a57323f7551: Pulling fs layer Sep 3 23:24:10.829812 etcd-wrapper[2368]: 5318d93a3a65: Waiting Sep 3 23:24:10.829812 etcd-wrapper[2368]: 307c1adadb60: Waiting Sep 3 23:24:10.829812 etcd-wrapper[2368]: f9b3c65df792: Waiting Sep 3 23:24:10.829812 etcd-wrapper[2368]: 5709b4a82c35: Waiting Sep 3 23:24:10.829812 etcd-wrapper[2368]: d5372e382b07: Waiting Sep 3 23:24:10.829812 etcd-wrapper[2368]: 9c3b5253dddc: Waiting Sep 3 23:24:10.829812 etcd-wrapper[2368]: 7a57323f7551: Waiting Sep 3 23:24:10.829812 etcd-wrapper[2368]: 0f8b424aa0b9: Waiting Sep 3 23:24:10.829812 etcd-wrapper[2368]: d557676654e5: Waiting Sep 3 23:24:10.829812 etcd-wrapper[2368]: c8022d07192e: Waiting Sep 3 23:24:10.829812 etcd-wrapper[2368]: d858cbc252ad: Waiting Sep 3 23:24:10.829812 etcd-wrapper[2368]: 1069fc2daed1: Waiting Sep 3 23:24:10.830387 etcd-wrapper[2368]: b40161cd83fc: Waiting Sep 3 23:24:11.072000 etcd-wrapper[2368]: d10f96ed9607: Verifying Checksum Sep 3 23:24:11.099464 etcd-wrapper[2368]: 2ae710cd8bfe: Verifying Checksum Sep 3 23:24:11.099464 etcd-wrapper[2368]: 2ae710cd8bfe: Download complete Sep 3 23:24:11.128012 etcd-wrapper[2368]: d462aa345367: Verifying Checksum Sep 3 23:24:11.128012 etcd-wrapper[2368]: d462aa345367: Download complete Sep 3 23:24:11.128305 etcd-wrapper[2368]: d10f96ed9607: Pull complete Sep 3 23:24:11.157632 systemd[1]: var-lib-docker-overlay2-949ec8d224b070cfde749fdc5211afea4e316f278e0efc847f52e2bd6ef52e22-merged.mount: Deactivated successfully. Sep 3 23:24:11.181927 etcd-wrapper[2368]: 2ae710cd8bfe: Pull complete Sep 3 23:24:11.338346 etcd-wrapper[2368]: d557676654e5: Verifying Checksum Sep 3 23:24:11.338637 etcd-wrapper[2368]: d557676654e5: Download complete Sep 3 23:24:11.431971 etcd-wrapper[2368]: c8022d07192e: Verifying Checksum Sep 3 23:24:11.431971 etcd-wrapper[2368]: c8022d07192e: Download complete Sep 3 23:24:11.434159 etcd-wrapper[2368]: 0f8b424aa0b9: Verifying Checksum Sep 3 23:24:11.434297 etcd-wrapper[2368]: 0f8b424aa0b9: Download complete Sep 3 23:24:11.576855 ntpd[1787]: Listen normally on 4 eth0 172.31.17.118:123 Sep 3 23:24:11.577665 ntpd[1787]: 3 Sep 23:24:11 ntpd[1787]: Listen normally on 4 eth0 172.31.17.118:123 Sep 3 23:24:11.577665 ntpd[1787]: 3 Sep 23:24:11 ntpd[1787]: Listen normally on 5 eth0 [fe80::462:17ff:fef7:1cd1%2]:123 Sep 3 23:24:11.577485 ntpd[1787]: Listen normally on 5 eth0 [fe80::462:17ff:fef7:1cd1%2]:123 Sep 3 23:24:11.599757 etcd-wrapper[2368]: d858cbc252ad: Verifying Checksum Sep 3 23:24:11.600320 etcd-wrapper[2368]: d858cbc252ad: Download complete Sep 3 23:24:11.683379 etcd-wrapper[2368]: 1069fc2daed1: Verifying Checksum Sep 3 23:24:11.683379 etcd-wrapper[2368]: 1069fc2daed1: Download complete Sep 3 23:24:11.708695 etcd-wrapper[2368]: b40161cd83fc: Verifying Checksum Sep 3 23:24:11.708832 etcd-wrapper[2368]: b40161cd83fc: Download complete Sep 3 23:24:11.840430 etcd-wrapper[2368]: 5318d93a3a65: Verifying Checksum Sep 3 23:24:11.840430 etcd-wrapper[2368]: 5318d93a3a65: Download complete Sep 3 23:24:11.935685 etcd-wrapper[2368]: 307c1adadb60: Verifying Checksum Sep 3 23:24:11.935685 etcd-wrapper[2368]: 307c1adadb60: Download complete Sep 3 23:24:11.964323 systemd[1]: var-lib-docker-overlay2-21890da78013489387e03df85f32cef8aa689d8ed34a91cc963880e30c448fd9-merged.mount: Deactivated successfully. Sep 3 23:24:12.070748 etcd-wrapper[2368]: f9b3c65df792: Verifying Checksum Sep 3 23:24:12.070748 etcd-wrapper[2368]: f9b3c65df792: Download complete Sep 3 23:24:12.072376 etcd-wrapper[2368]: d462aa345367: Pull complete Sep 3 23:24:12.133377 etcd-wrapper[2368]: 0f8b424aa0b9: Pull complete Sep 3 23:24:12.147081 systemd[1]: var-lib-docker-overlay2-9a8d1b249e7cd5be734f4ac9183137329633480761703090903bbead829e0d7a-merged.mount: Deactivated successfully. Sep 3 23:24:12.177293 systemd[1]: var-lib-docker-overlay2-d141a5fcead9dd024c055b99b886de77b6326c9ade7a5f1f498f9174386651b9-merged.mount: Deactivated successfully. Sep 3 23:24:12.189801 etcd-wrapper[2368]: 5709b4a82c35: Verifying Checksum Sep 3 23:24:12.189801 etcd-wrapper[2368]: 5709b4a82c35: Download complete Sep 3 23:24:12.203364 etcd-wrapper[2368]: d557676654e5: Pull complete Sep 3 23:24:12.230192 systemd[1]: var-lib-docker-overlay2-debe115316eda6181b877acdb7fae2790d6b35ce8a9403561be68ce92e963195-merged.mount: Deactivated successfully. Sep 3 23:24:12.251906 etcd-wrapper[2368]: c8022d07192e: Pull complete Sep 3 23:24:12.308169 etcd-wrapper[2368]: d5372e382b07: Verifying Checksum Sep 3 23:24:12.308169 etcd-wrapper[2368]: d5372e382b07: Download complete Sep 3 23:24:12.310531 etcd-wrapper[2368]: d858cbc252ad: Pull complete Sep 3 23:24:12.331748 etcd-wrapper[2368]: 9c3b5253dddc: Verifying Checksum Sep 3 23:24:12.331748 etcd-wrapper[2368]: 9c3b5253dddc: Download complete Sep 3 23:24:12.351809 etcd-wrapper[2368]: 1069fc2daed1: Pull complete Sep 3 23:24:12.394969 etcd-wrapper[2368]: b40161cd83fc: Pull complete Sep 3 23:24:12.439936 etcd-wrapper[2368]: 7a57323f7551: Download complete Sep 3 23:24:12.452462 etcd-wrapper[2368]: 5318d93a3a65: Pull complete Sep 3 23:24:12.503251 etcd-wrapper[2368]: 307c1adadb60: Pull complete Sep 3 23:24:12.804045 etcd-wrapper[2368]: f9b3c65df792: Pull complete Sep 3 23:24:13.041323 etcd-wrapper[2368]: 5709b4a82c35: Pull complete Sep 3 23:24:13.247851 systemd[1]: var-lib-docker-overlay2-5302024e0c2e986e1e6d53ed67a0a7e0c3fba27b31ae91d89aafc7a50d07d4fa-merged.mount: Deactivated successfully. Sep 3 23:24:13.291206 etcd-wrapper[2368]: d5372e382b07: Pull complete Sep 3 23:24:13.320384 systemd[1]: var-lib-docker-overlay2-d251373bb969f6bca0cd25b4ccf3ebf631abaf0a6d010c99b8aec8c02e7dc57c-merged.mount: Deactivated successfully. Sep 3 23:24:13.333091 etcd-wrapper[2368]: 9c3b5253dddc: Pull complete Sep 3 23:24:13.374224 etcd-wrapper[2368]: 7a57323f7551: Pull complete Sep 3 23:24:13.403636 etcd-wrapper[2368]: Digest: sha256:d967d98a12dc220a1a290794711dba7eba04b8ce465e12b02383d1bfbb33e159 Sep 3 23:24:13.411335 etcd-wrapper[2368]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.16 Sep 3 23:24:13.510959 containerd[1952]: time="2025-09-03T23:24:13.510732952Z" level=info msg="connecting to shim 15012d5cc6058fcb93da74e492f79d3850a8bf8f7ba51401e89d0f1307898e29" address="unix:///run/containerd/s/6a0e590c3cf5c4d04609bc3d9726514d2b064f37fe1f7a3932701fcb16a06814" namespace=moby protocol=ttrpc version=3 Sep 3 23:24:13.562721 systemd[1]: Started docker-15012d5cc6058fcb93da74e492f79d3850a8bf8f7ba51401e89d0f1307898e29.scope - libcontainer container 15012d5cc6058fcb93da74e492f79d3850a8bf8f7ba51401e89d0f1307898e29. Sep 3 23:24:13.696481 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:13.695914Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Sep 3 23:24:13.696920 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:13.696114Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"ec298d5d1de283526a1cafab505dab68"} Sep 3 23:24:13.696920 etcd-wrapper[2368]: {"level":"warn","ts":"2025-09-03T23:24:13.696579Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Sep 3 23:24:13.696920 etcd-wrapper[2368]: {"level":"warn","ts":"2025-09-03T23:24:13.696601Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.16"} Sep 3 23:24:13.696920 etcd-wrapper[2368]: {"level":"warn","ts":"2025-09-03T23:24:13.696615Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Sep 3 23:24:13.696920 etcd-wrapper[2368]: {"level":"warn","ts":"2025-09-03T23:24:13.696627Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Sep 3 23:24:13.698731 etcd-wrapper[2368]: {"level":"warn","ts":"2025-09-03T23:24:13.696992Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Sep 3 23:24:13.698731 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:13.697049Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["/usr/local/bin/etcd","--listen-client-urls=http://0.0.0.0:2379","--advertise-client-urls=http://172.31.17.118:2379"]} Sep 3 23:24:13.698731 etcd-wrapper[2368]: {"level":"warn","ts":"2025-09-03T23:24:13.697157Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Sep 3 23:24:13.698731 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:13.697179Z","caller":"embed/etcd.go:128","msg":"configuring peer listeners","listen-peer-urls":["http://localhost:2380"]} Sep 3 23:24:13.698731 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:13.697907Z","caller":"embed/etcd.go:136","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Sep 3 23:24:13.699064 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:13.698145Z","caller":"embed/etcd.go:311","msg":"starting an etcd server","etcd-version":"3.5.16","git-sha":"f20bbad","go-version":"go1.22.7","go-os":"linux","go-arch":"arm64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"ec298d5d1de283526a1cafab505dab68","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,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["http://localhost:2380"],"listen-peer-urls":["http://localhost:2380"],"advertise-client-urls":["http://172.31.17.118:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"ec298d5d1de283526a1cafab505dab68=http://localhost:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":false,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} Sep 3 23:24:13.703412 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:13.702916Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.818268ms"} Sep 3 23:24:13.710222 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:13.709822Z","caller":"etcdserver/raft.go:505","msg":"starting local member","local-member-id":"8e9e05c52164694d","cluster-id":"cdf818194e3a8c32"} Sep 3 23:24:13.710704 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:13.710460Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=()"} Sep 3 23:24:13.710704 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:13.710512Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 0"} Sep 3 23:24:13.711097 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:13.710534Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8e9e05c52164694d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} Sep 3 23:24:13.711097 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:13.710753Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 1"} Sep 3 23:24:13.711097 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:13.710816Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Sep 3 23:24:13.718059 etcd-wrapper[2368]: {"level":"warn","ts":"2025-09-03T23:24:13.717756Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} Sep 3 23:24:13.720605 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:13.720239Z","caller":"mvcc/kvstore.go:423","msg":"kvstore restored","current-rev":1} Sep 3 23:24:13.722780 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:13.722440Z","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"} Sep 3 23:24:13.725059 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:13.724549Z","caller":"etcdserver/server.go:873","msg":"starting etcd server","local-member-id":"8e9e05c52164694d","local-server-version":"3.5.16","cluster-version":"to_be_decided"} Sep 3 23:24:13.725522 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:13.725121Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Sep 3 23:24:13.726455 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:13.726096Z","caller":"etcdserver/server.go:757","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8e9e05c52164694d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} Sep 3 23:24:13.727154 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:13.726818Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} Sep 3 23:24:13.727154 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:13.726943Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} Sep 3 23:24:13.727497 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:13.727127Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} Sep 3 23:24:13.728423 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:13.727914Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Sep 3 23:24:13.731428 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:13.729143Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","added-peer-id":"8e9e05c52164694d","added-peer-peer-urls":["http://localhost:2380"]} Sep 3 23:24:13.732652 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:13.732118Z","caller":"embed/etcd.go:600","msg":"serving peer traffic","address":"127.0.0.1:2380"} Sep 3 23:24:13.732652 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:13.732157Z","caller":"embed/etcd.go:572","msg":"cmux::serve","address":"127.0.0.1:2380"} Sep 3 23:24:13.732652 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:13.732106Z","caller":"embed/etcd.go:280","msg":"now serving peer/client/metrics","local-member-id":"8e9e05c52164694d","initial-advertise-peer-urls":["http://localhost:2380"],"listen-peer-urls":["http://localhost:2380"],"advertise-client-urls":["http://172.31.17.118:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} Sep 3 23:24:14.112161 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:14.111572Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d is starting a new election at term 1"} Sep 3 23:24:14.112161 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:14.111624Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became pre-candidate at term 1"} Sep 3 23:24:14.112161 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:14.111677Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgPreVoteResp from 8e9e05c52164694d at term 1"} Sep 3 23:24:14.112161 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:14.111701Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became candidate at term 2"} Sep 3 23:24:14.112161 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:14.111716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgVoteResp from 8e9e05c52164694d at term 2"} Sep 3 23:24:14.112161 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:14.111736Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became leader at term 2"} Sep 3 23:24:14.112161 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:14.111753Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8e9e05c52164694d elected leader 8e9e05c52164694d at term 2"} Sep 3 23:24:14.113652 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:14.113265Z","caller":"etcdserver/server.go:2651","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} Sep 3 23:24:14.114776 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:14.114345Z","caller":"etcdserver/server.go:2140","msg":"published local member to cluster through raft","local-member-id":"8e9e05c52164694d","local-member-attributes":"{Name:ec298d5d1de283526a1cafab505dab68 ClientURLs:[http://172.31.17.118:2379]}","request-path":"/0/members/8e9e05c52164694d/attributes","cluster-id":"cdf818194e3a8c32","publish-timeout":"7s"} Sep 3 23:24:14.115361 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:14.114795Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} Sep 3 23:24:14.115692 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:14.115269Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","cluster-version":"3.5"} Sep 3 23:24:14.117340 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:14.115837Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Sep 3 23:24:14.117340 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:14.115852Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Sep 3 23:24:14.117340 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:14.115888Z","caller":"etcdserver/server.go:2675","msg":"cluster version is updated","cluster-version":"3.5"} Sep 3 23:24:14.117340 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:14.115330Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} Sep 3 23:24:14.117340 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:14.116023Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} Sep 3 23:24:14.117340 etcd-wrapper[2368]: {"level":"info","ts":"2025-09-03T23:24:14.116634Z","caller":"embed/serve.go:187","msg":"serving client traffic insecurely; this is strongly discouraged!","traffic":"grpc+http","address":"[::]:2379"} Sep 3 23:24:14.117465 systemd[1]: Started etcd-member.service - etcd (System Application Container). Sep 3 23:24:14.118606 systemd[1]: Reached target multi-user.target - Multi-User System. Sep 3 23:24:14.118965 systemd[1]: Startup finished in 3.640s (kernel) + 7.655s (initrd) + 13.843s (userspace) = 25.139s. Sep 3 23:24:14.149320 systemd[1]: var-lib-docker-overlay2-3091ed84555475f883f7c54d35ffc0840b2f2ed1d206216405137261c8d862c3-merged.mount: Deactivated successfully. Sep 3 23:24:20.660838 systemd[1]: Started sshd@3-172.31.17.118:22-139.178.89.65:43078.service - OpenSSH per-connection server daemon (139.178.89.65:43078). Sep 3 23:24:20.852646 sshd[2541]: Accepted publickey for core from 139.178.89.65 port 43078 ssh2: RSA SHA256:8eQAyPE99YHHVtDm+V4mP5sHyPbVNBHa6xDGC+ww79Y Sep 3 23:24:20.855172 sshd-session[2541]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 3 23:24:20.865384 systemd-logind[1791]: New session 4 of user core. Sep 3 23:24:20.875688 systemd[1]: Started session-4.scope - Session 4 of User core. Sep 3 23:24:20.999591 sshd[2543]: Connection closed by 139.178.89.65 port 43078 Sep 3 23:24:20.999587 sshd-session[2541]: pam_unix(sshd:session): session closed for user core Sep 3 23:24:21.005469 systemd[1]: sshd@3-172.31.17.118:22-139.178.89.65:43078.service: Deactivated successfully. Sep 3 23:24:21.008699 systemd[1]: session-4.scope: Deactivated successfully. Sep 3 23:24:21.013063 systemd-logind[1791]: Session 4 logged out. Waiting for processes to exit. Sep 3 23:24:21.014941 systemd-logind[1791]: Removed session 4. Sep 3 23:24:21.039370 systemd[1]: Started sshd@4-172.31.17.118:22-139.178.89.65:43086.service - OpenSSH per-connection server daemon (139.178.89.65:43086). Sep 3 23:24:21.241307 sshd[2549]: Accepted publickey for core from 139.178.89.65 port 43086 ssh2: RSA SHA256:8eQAyPE99YHHVtDm+V4mP5sHyPbVNBHa6xDGC+ww79Y Sep 3 23:24:21.243865 sshd-session[2549]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 3 23:24:21.253489 systemd-logind[1791]: New session 5 of user core. Sep 3 23:24:21.260685 systemd[1]: Started session-5.scope - Session 5 of User core. Sep 3 23:24:21.379336 sshd[2551]: Connection closed by 139.178.89.65 port 43086 Sep 3 23:24:21.380136 sshd-session[2549]: pam_unix(sshd:session): session closed for user core Sep 3 23:24:21.386616 systemd[1]: sshd@4-172.31.17.118:22-139.178.89.65:43086.service: Deactivated successfully. Sep 3 23:24:21.391447 systemd[1]: session-5.scope: Deactivated successfully. Sep 3 23:24:21.393589 systemd-logind[1791]: Session 5 logged out. Waiting for processes to exit. Sep 3 23:24:21.396188 systemd-logind[1791]: Removed session 5. Sep 3 23:24:21.419114 systemd[1]: Started sshd@5-172.31.17.118:22-139.178.89.65:43090.service - OpenSSH per-connection server daemon (139.178.89.65:43090). Sep 3 23:24:21.625736 sshd[2557]: Accepted publickey for core from 139.178.89.65 port 43090 ssh2: RSA SHA256:8eQAyPE99YHHVtDm+V4mP5sHyPbVNBHa6xDGC+ww79Y Sep 3 23:24:21.628187 sshd-session[2557]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 3 23:24:21.636229 systemd-logind[1791]: New session 6 of user core. Sep 3 23:24:21.645684 systemd[1]: Started session-6.scope - Session 6 of User core. Sep 3 23:24:21.768320 sshd[2559]: Connection closed by 139.178.89.65 port 43090 Sep 3 23:24:21.769145 sshd-session[2557]: pam_unix(sshd:session): session closed for user core Sep 3 23:24:21.776272 systemd[1]: sshd@5-172.31.17.118:22-139.178.89.65:43090.service: Deactivated successfully. Sep 3 23:24:21.780029 systemd[1]: session-6.scope: Deactivated successfully. Sep 3 23:24:21.782143 systemd-logind[1791]: Session 6 logged out. Waiting for processes to exit. Sep 3 23:24:21.785444 systemd-logind[1791]: Removed session 6. Sep 3 23:24:21.805679 systemd[1]: Started sshd@6-172.31.17.118:22-139.178.89.65:43102.service - OpenSSH per-connection server daemon (139.178.89.65:43102). Sep 3 23:24:21.999352 sshd[2565]: Accepted publickey for core from 139.178.89.65 port 43102 ssh2: RSA SHA256:8eQAyPE99YHHVtDm+V4mP5sHyPbVNBHa6xDGC+ww79Y Sep 3 23:24:22.002166 sshd-session[2565]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 3 23:24:22.011496 systemd-logind[1791]: New session 7 of user core. Sep 3 23:24:22.019673 systemd[1]: Started session-7.scope - Session 7 of User core. Sep 3 23:24:22.140010 sshd[2567]: Connection closed by 139.178.89.65 port 43102 Sep 3 23:24:22.139081 sshd-session[2565]: pam_unix(sshd:session): session closed for user core Sep 3 23:24:22.145917 systemd-logind[1791]: Session 7 logged out. Waiting for processes to exit. Sep 3 23:24:22.147301 systemd[1]: sshd@6-172.31.17.118:22-139.178.89.65:43102.service: Deactivated successfully. Sep 3 23:24:22.150306 systemd[1]: session-7.scope: Deactivated successfully. Sep 3 23:24:22.153898 systemd-logind[1791]: Removed session 7. Sep 3 23:24:22.175071 systemd[1]: Started sshd@7-172.31.17.118:22-139.178.89.65:43104.service - OpenSSH per-connection server daemon (139.178.89.65:43104). Sep 3 23:24:22.370663 sshd[2575]: Accepted publickey for core from 139.178.89.65 port 43104 ssh2: RSA SHA256:8eQAyPE99YHHVtDm+V4mP5sHyPbVNBHa6xDGC+ww79Y Sep 3 23:24:22.373124 sshd-session[2575]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 3 23:24:22.382499 systemd-logind[1791]: New session 8 of user core. Sep 3 23:24:22.390684 systemd[1]: Started session-8.scope - Session 8 of User core. Sep 3 23:24:22.744466 sshd[2577]: Connection closed by 139.178.89.65 port 43104 Sep 3 23:24:22.743281 sshd-session[2575]: pam_unix(sshd:session): session closed for user core Sep 3 23:24:22.750153 systemd[1]: sshd@7-172.31.17.118:22-139.178.89.65:43104.service: Deactivated successfully. Sep 3 23:24:22.753121 systemd[1]: session-8.scope: Deactivated successfully. Sep 3 23:24:22.754950 systemd-logind[1791]: Session 8 logged out. Waiting for processes to exit. Sep 3 23:24:22.758053 systemd-logind[1791]: Removed session 8. Sep 3 23:24:37.311064 systemd[1]: systemd-hostnamed.service: Deactivated successfully. Sep 3 23:24:49.992462 update_engine[1798]: I20250903 23:24:49.992138 1798 update_attempter.cc:509] Updating boot flags... Sep 3 23:26:17.050609 update_engine[1798]: I20250903 23:26:17.050523 1798 prefs.cc:52] certificate-report-to-send-update not present in /var/lib/update_engine/prefs Sep 3 23:26:17.050609 update_engine[1798]: I20250903 23:26:17.050598 1798 prefs.cc:52] certificate-report-to-send-download not present in /var/lib/update_engine/prefs Sep 3 23:26:17.051314 update_engine[1798]: I20250903 23:26:17.050992 1798 prefs.cc:52] aleph-version not present in /var/lib/update_engine/prefs Sep 3 23:26:17.051928 update_engine[1798]: I20250903 23:26:17.051867 1798 omaha_request_params.cc:62] Current group set to beta Sep 3 23:26:17.052838 update_engine[1798]: I20250903 23:26:17.052053 1798 update_attempter.cc:499] Already updated boot flags. Skipping. Sep 3 23:26:17.052838 update_engine[1798]: I20250903 23:26:17.052085 1798 update_attempter.cc:643] Scheduling an action processor start. Sep 3 23:26:17.052838 update_engine[1798]: I20250903 23:26:17.052122 1798 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Sep 3 23:26:17.052838 update_engine[1798]: I20250903 23:26:17.052177 1798 prefs.cc:52] previous-version not present in /var/lib/update_engine/prefs Sep 3 23:26:17.052838 update_engine[1798]: I20250903 23:26:17.052284 1798 omaha_request_action.cc:271] Posting an Omaha request to disabled Sep 3 23:26:17.052838 update_engine[1798]: I20250903 23:26:17.052304 1798 omaha_request_action.cc:272] Request: Sep 3 23:26:17.052838 update_engine[1798]: Sep 3 23:26:17.052838 update_engine[1798]: Sep 3 23:26:17.052838 update_engine[1798]: Sep 3 23:26:17.052838 update_engine[1798]: Sep 3 23:26:17.052838 update_engine[1798]: Sep 3 23:26:17.052838 update_engine[1798]: Sep 3 23:26:17.052838 update_engine[1798]: Sep 3 23:26:17.052838 update_engine[1798]: Sep 3 23:26:17.052838 update_engine[1798]: I20250903 23:26:17.052320 1798 libcurl_http_fetcher.cc:47] Starting/Resuming transfer Sep 3 23:26:17.054176 locksmithd[1888]: LastCheckedTime=0 Progress=0 CurrentOperation="UPDATE_STATUS_CHECKING_FOR_UPDATE" NewVersion=0.0.0 NewSize=0 Sep 3 23:26:17.056497 update_engine[1798]: I20250903 23:26:17.056430 1798 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP Sep 3 23:26:17.057174 update_engine[1798]: I20250903 23:26:17.057111 1798 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. Sep 3 23:26:17.090789 update_engine[1798]: E20250903 23:26:17.090701 1798 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled Sep 3 23:26:17.090933 update_engine[1798]: I20250903 23:26:17.090838 1798 libcurl_http_fetcher.cc:283] No HTTP response, retry 1 Sep 3 23:26:26.986592 update_engine[1798]: I20250903 23:26:26.986495 1798 libcurl_http_fetcher.cc:47] Starting/Resuming transfer Sep 3 23:26:26.987185 update_engine[1798]: I20250903 23:26:26.986858 1798 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP Sep 3 23:26:26.987285 update_engine[1798]: I20250903 23:26:26.987231 1798 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. Sep 3 23:26:27.008688 update_engine[1798]: E20250903 23:26:27.008620 1798 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled Sep 3 23:26:27.008796 update_engine[1798]: I20250903 23:26:27.008704 1798 libcurl_http_fetcher.cc:283] No HTTP response, retry 2 Sep 3 23:26:36.982819 update_engine[1798]: I20250903 23:26:36.982723 1798 libcurl_http_fetcher.cc:47] Starting/Resuming transfer Sep 3 23:26:36.983333 update_engine[1798]: I20250903 23:26:36.983083 1798 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP Sep 3 23:26:36.983651 update_engine[1798]: I20250903 23:26:36.983577 1798 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. Sep 3 23:26:36.984715 update_engine[1798]: E20250903 23:26:36.984661 1798 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled Sep 3 23:26:36.984794 update_engine[1798]: I20250903 23:26:36.984743 1798 libcurl_http_fetcher.cc:283] No HTTP response, retry 3 Sep 3 23:26:46.989538 update_engine[1798]: I20250903 23:26:46.989444 1798 libcurl_http_fetcher.cc:47] Starting/Resuming transfer Sep 3 23:26:46.990134 update_engine[1798]: I20250903 23:26:46.989800 1798 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP Sep 3 23:26:46.990234 update_engine[1798]: I20250903 23:26:46.990183 1798 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. Sep 3 23:26:46.991568 update_engine[1798]: E20250903 23:26:46.991514 1798 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled Sep 3 23:26:46.991661 update_engine[1798]: I20250903 23:26:46.991588 1798 libcurl_http_fetcher.cc:297] Transfer resulted in an error (0), 0 bytes downloaded Sep 3 23:26:46.991661 update_engine[1798]: I20250903 23:26:46.991608 1798 omaha_request_action.cc:617] Omaha request response: Sep 3 23:26:46.991768 update_engine[1798]: E20250903 23:26:46.991722 1798 omaha_request_action.cc:636] Omaha request network transfer failed. Sep 3 23:26:46.991768 update_engine[1798]: I20250903 23:26:46.991755 1798 action_processor.cc:68] ActionProcessor::ActionComplete: OmahaRequestAction action failed. Aborting processing. Sep 3 23:26:46.991863 update_engine[1798]: I20250903 23:26:46.991770 1798 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Sep 3 23:26:46.991863 update_engine[1798]: I20250903 23:26:46.991783 1798 update_attempter.cc:306] Processing Done. Sep 3 23:26:46.991863 update_engine[1798]: E20250903 23:26:46.991809 1798 update_attempter.cc:619] Update failed. Sep 3 23:26:46.991863 update_engine[1798]: I20250903 23:26:46.991823 1798 utils.cc:600] Converting error code 2000 to kActionCodeOmahaErrorInHTTPResponse Sep 3 23:26:46.991863 update_engine[1798]: I20250903 23:26:46.991837 1798 payload_state.cc:97] Updating payload state for error code: 37 (kActionCodeOmahaErrorInHTTPResponse) Sep 3 23:26:46.991863 update_engine[1798]: I20250903 23:26:46.991851 1798 payload_state.cc:103] Ignoring failures until we get a valid Omaha response. Sep 3 23:26:46.992158 update_engine[1798]: I20250903 23:26:46.991958 1798 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Sep 3 23:26:46.992158 update_engine[1798]: I20250903 23:26:46.991999 1798 omaha_request_action.cc:271] Posting an Omaha request to disabled Sep 3 23:26:46.992158 update_engine[1798]: I20250903 23:26:46.992015 1798 omaha_request_action.cc:272] Request: Sep 3 23:26:46.992158 update_engine[1798]: Sep 3 23:26:46.992158 update_engine[1798]: Sep 3 23:26:46.992158 update_engine[1798]: Sep 3 23:26:46.992158 update_engine[1798]: Sep 3 23:26:46.992158 update_engine[1798]: Sep 3 23:26:46.992158 update_engine[1798]: Sep 3 23:26:46.992158 update_engine[1798]: I20250903 23:26:46.992030 1798 libcurl_http_fetcher.cc:47] Starting/Resuming transfer Sep 3 23:26:46.992598 update_engine[1798]: I20250903 23:26:46.992287 1798 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP Sep 3 23:26:46.993070 update_engine[1798]: I20250903 23:26:46.992643 1798 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. Sep 3 23:26:46.993174 locksmithd[1888]: LastCheckedTime=0 Progress=0 CurrentOperation="UPDATE_STATUS_REPORTING_ERROR_EVENT" NewVersion=0.0.0 NewSize=0 Sep 3 23:26:46.993671 update_engine[1798]: E20250903 23:26:46.993638 1798 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled Sep 3 23:26:46.993733 update_engine[1798]: I20250903 23:26:46.993716 1798 libcurl_http_fetcher.cc:297] Transfer resulted in an error (0), 0 bytes downloaded Sep 3 23:26:46.993786 update_engine[1798]: I20250903 23:26:46.993734 1798 omaha_request_action.cc:617] Omaha request response: Sep 3 23:26:46.993786 update_engine[1798]: I20250903 23:26:46.993750 1798 action_processor.cc:65] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Sep 3 23:26:46.993786 update_engine[1798]: I20250903 23:26:46.993764 1798 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Sep 3 23:26:46.993786 update_engine[1798]: I20250903 23:26:46.993777 1798 update_attempter.cc:306] Processing Done. Sep 3 23:26:46.994208 update_engine[1798]: I20250903 23:26:46.993793 1798 update_attempter.cc:310] Error event sent. Sep 3 23:26:46.994208 update_engine[1798]: I20250903 23:26:46.993816 1798 update_check_scheduler.cc:74] Next update check in 49m55s Sep 3 23:26:46.994579 locksmithd[1888]: LastCheckedTime=0 Progress=0 CurrentOperation="UPDATE_STATUS_IDLE" NewVersion=0.0.0 NewSize=0