Aug 5 22:01:11.050265 kernel: Linux version 6.6.43-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 13.2.1_p20240210 p14) 13.2.1 20240210, GNU ld (Gentoo 2.41 p5) 2.41.0) #1 SMP PREEMPT_DYNAMIC Mon Aug 5 20:36:27 -00 2024 Aug 5 22:01:11.050325 kernel: Command line: BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected verity.usrhash=4a86c72568bc3f74d57effa5e252d5620941ef6d74241fc198859d020a6392c5 Aug 5 22:01:11.050341 kernel: BIOS-provided physical RAM map: Aug 5 22:01:11.050350 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable Aug 5 22:01:11.050358 kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved Aug 5 22:01:11.050367 kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved Aug 5 22:01:11.050378 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000009cfdcfff] usable Aug 5 22:01:11.050387 kernel: BIOS-e820: [mem 0x000000009cfdd000-0x000000009cffffff] reserved Aug 5 22:01:11.050396 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Aug 5 22:01:11.050408 kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved Aug 5 22:01:11.050417 kernel: BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved Aug 5 22:01:11.050425 kernel: NX (Execute Disable) protection: active Aug 5 22:01:11.050434 kernel: APIC: Static calls initialized Aug 5 22:01:11.050443 kernel: SMBIOS 2.8 present. Aug 5 22:01:11.050454 kernel: DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.16.2-debian-1.16.2-1 04/01/2014 Aug 5 22:01:11.050467 kernel: Hypervisor detected: KVM Aug 5 22:01:11.050477 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Aug 5 22:01:11.050487 kernel: kvm-clock: using sched offset of 2689089263 cycles Aug 5 22:01:11.050498 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Aug 5 22:01:11.050508 kernel: tsc: Detected 2794.748 MHz processor Aug 5 22:01:11.050519 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Aug 5 22:01:11.050529 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Aug 5 22:01:11.050539 kernel: last_pfn = 0x9cfdd max_arch_pfn = 0x400000000 Aug 5 22:01:11.050550 kernel: MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs Aug 5 22:01:11.050563 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Aug 5 22:01:11.050573 kernel: Using GB pages for direct mapping Aug 5 22:01:11.050583 kernel: ACPI: Early table checksum verification disabled Aug 5 22:01:11.050593 kernel: ACPI: RSDP 0x00000000000F59C0 000014 (v00 BOCHS ) Aug 5 22:01:11.050603 kernel: ACPI: RSDT 0x000000009CFE1BDD 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:01:11.050613 kernel: ACPI: FACP 0x000000009CFE1A79 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:01:11.050624 kernel: ACPI: DSDT 0x000000009CFE0040 001A39 (v01 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:01:11.050634 kernel: ACPI: FACS 0x000000009CFE0000 000040 Aug 5 22:01:11.050644 kernel: ACPI: APIC 0x000000009CFE1AED 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:01:11.050657 kernel: ACPI: HPET 0x000000009CFE1B7D 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:01:11.050667 kernel: ACPI: WAET 0x000000009CFE1BB5 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:01:11.050677 kernel: ACPI: Reserving FACP table memory at [mem 0x9cfe1a79-0x9cfe1aec] Aug 5 22:01:11.050686 kernel: ACPI: Reserving DSDT table memory at [mem 0x9cfe0040-0x9cfe1a78] Aug 5 22:01:11.050697 kernel: ACPI: Reserving FACS table memory at [mem 0x9cfe0000-0x9cfe003f] Aug 5 22:01:11.050707 kernel: ACPI: Reserving APIC table memory at [mem 0x9cfe1aed-0x9cfe1b7c] Aug 5 22:01:11.050717 kernel: ACPI: Reserving HPET table memory at [mem 0x9cfe1b7d-0x9cfe1bb4] Aug 5 22:01:11.050762 kernel: ACPI: Reserving WAET table memory at [mem 0x9cfe1bb5-0x9cfe1bdc] Aug 5 22:01:11.050774 kernel: No NUMA configuration found Aug 5 22:01:11.050785 kernel: Faking a node at [mem 0x0000000000000000-0x000000009cfdcfff] Aug 5 22:01:11.050805 kernel: NODE_DATA(0) allocated [mem 0x9cfd7000-0x9cfdcfff] Aug 5 22:01:11.050814 kernel: Zone ranges: Aug 5 22:01:11.050824 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Aug 5 22:01:11.050833 kernel: DMA32 [mem 0x0000000001000000-0x000000009cfdcfff] Aug 5 22:01:11.050846 kernel: Normal empty Aug 5 22:01:11.050856 kernel: Movable zone start for each node Aug 5 22:01:11.050866 kernel: Early memory node ranges Aug 5 22:01:11.050875 kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] Aug 5 22:01:11.050884 kernel: node 0: [mem 0x0000000000100000-0x000000009cfdcfff] Aug 5 22:01:11.050894 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009cfdcfff] Aug 5 22:01:11.050903 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Aug 5 22:01:11.050912 kernel: On node 0, zone DMA: 97 pages in unavailable ranges Aug 5 22:01:11.050922 kernel: On node 0, zone DMA32: 12323 pages in unavailable ranges Aug 5 22:01:11.050967 kernel: ACPI: PM-Timer IO Port: 0x608 Aug 5 22:01:11.050987 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Aug 5 22:01:11.050998 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Aug 5 22:01:11.051007 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Aug 5 22:01:11.051016 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Aug 5 22:01:11.051026 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Aug 5 22:01:11.051036 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Aug 5 22:01:11.051046 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Aug 5 22:01:11.051056 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Aug 5 22:01:11.051072 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Aug 5 22:01:11.051082 kernel: TSC deadline timer available Aug 5 22:01:11.051093 kernel: smpboot: Allowing 4 CPUs, 0 hotplug CPUs Aug 5 22:01:11.051103 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Aug 5 22:01:11.051113 kernel: kvm-guest: KVM setup pv remote TLB flush Aug 5 22:01:11.051124 kernel: kvm-guest: setup PV sched yield Aug 5 22:01:11.051134 kernel: [mem 0x9d000000-0xfeffbfff] available for PCI devices Aug 5 22:01:11.051145 kernel: Booting paravirtualized kernel on KVM Aug 5 22:01:11.051156 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Aug 5 22:01:11.051167 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Aug 5 22:01:11.051182 kernel: percpu: Embedded 58 pages/cpu s196904 r8192 d32472 u524288 Aug 5 22:01:11.051193 kernel: pcpu-alloc: s196904 r8192 d32472 u524288 alloc=1*2097152 Aug 5 22:01:11.051238 kernel: pcpu-alloc: [0] 0 1 2 3 Aug 5 22:01:11.051250 kernel: kvm-guest: PV spinlocks enabled Aug 5 22:01:11.051261 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Aug 5 22:01:11.051273 kernel: Kernel command line: rootflags=rw mount.usrflags=ro BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected verity.usrhash=4a86c72568bc3f74d57effa5e252d5620941ef6d74241fc198859d020a6392c5 Aug 5 22:01:11.051284 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Aug 5 22:01:11.051295 kernel: random: crng init done Aug 5 22:01:11.051309 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Aug 5 22:01:11.051320 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Aug 5 22:01:11.051330 kernel: Fallback order for Node 0: 0 Aug 5 22:01:11.051341 kernel: Built 1 zonelists, mobility grouping on. Total pages: 632733 Aug 5 22:01:11.051352 kernel: Policy zone: DMA32 Aug 5 22:01:11.051362 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Aug 5 22:01:11.051373 kernel: Memory: 2428452K/2571756K available (12288K kernel code, 2302K rwdata, 22640K rodata, 49328K init, 2016K bss, 143044K reserved, 0K cma-reserved) Aug 5 22:01:11.051384 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Aug 5 22:01:11.051394 kernel: ftrace: allocating 37659 entries in 148 pages Aug 5 22:01:11.051408 kernel: ftrace: allocated 148 pages with 3 groups Aug 5 22:01:11.051419 kernel: Dynamic Preempt: voluntary Aug 5 22:01:11.051430 kernel: rcu: Preemptible hierarchical RCU implementation. Aug 5 22:01:11.051441 kernel: rcu: RCU event tracing is enabled. Aug 5 22:01:11.051452 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Aug 5 22:01:11.051463 kernel: Trampoline variant of Tasks RCU enabled. Aug 5 22:01:11.051474 kernel: Rude variant of Tasks RCU enabled. Aug 5 22:01:11.051485 kernel: Tracing variant of Tasks RCU enabled. Aug 5 22:01:11.051496 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Aug 5 22:01:11.051510 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Aug 5 22:01:11.051521 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 Aug 5 22:01:11.051531 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Aug 5 22:01:11.051541 kernel: Console: colour VGA+ 80x25 Aug 5 22:01:11.051552 kernel: printk: console [ttyS0] enabled Aug 5 22:01:11.051563 kernel: ACPI: Core revision 20230628 Aug 5 22:01:11.051574 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Aug 5 22:01:11.051584 kernel: APIC: Switch to symmetric I/O mode setup Aug 5 22:01:11.051594 kernel: x2apic enabled Aug 5 22:01:11.051608 kernel: APIC: Switched APIC routing to: physical x2apic Aug 5 22:01:11.051619 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() Aug 5 22:01:11.051630 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() Aug 5 22:01:11.051641 kernel: kvm-guest: setup PV IPIs Aug 5 22:01:11.051678 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Aug 5 22:01:11.051691 kernel: tsc: Marking TSC unstable due to TSCs unsynchronized Aug 5 22:01:11.051702 kernel: Calibrating delay loop (skipped) preset value.. 5589.49 BogoMIPS (lpj=2794748) Aug 5 22:01:11.051713 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Aug 5 22:01:11.051737 kernel: Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 Aug 5 22:01:11.051749 kernel: Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 Aug 5 22:01:11.051760 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Aug 5 22:01:11.051772 kernel: Spectre V2 : Mitigation: Retpolines Aug 5 22:01:11.051785 kernel: Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch Aug 5 22:01:11.051841 kernel: Spectre V2 : Spectre v2 / SpectreRSB : Filling RSB on VMEXIT Aug 5 22:01:11.051853 kernel: Spectre V2 : Enabling Speculation Barrier for firmware calls Aug 5 22:01:11.051864 kernel: RETBleed: Mitigation: untrained return thunk Aug 5 22:01:11.051875 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier Aug 5 22:01:11.051890 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl Aug 5 22:01:11.051902 kernel: Speculative Return Stack Overflow: IBPB-extending microcode not applied! Aug 5 22:01:11.051915 kernel: Speculative Return Stack Overflow: WARNING: See https://kernel.org/doc/html/latest/admin-guide/hw-vuln/srso.html for mitigation options. Aug 5 22:01:11.051927 kernel: Speculative Return Stack Overflow: Vulnerable: Safe RET, no microcode Aug 5 22:01:11.051953 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Aug 5 22:01:11.051965 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Aug 5 22:01:11.051976 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Aug 5 22:01:11.051987 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Aug 5 22:01:11.052002 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. Aug 5 22:01:11.052013 kernel: Freeing SMP alternatives memory: 32K Aug 5 22:01:11.052023 kernel: pid_max: default: 32768 minimum: 301 Aug 5 22:01:11.052035 kernel: LSM: initializing lsm=lockdown,capability,selinux,integrity Aug 5 22:01:11.052046 kernel: SELinux: Initializing. Aug 5 22:01:11.052058 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Aug 5 22:01:11.052096 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Aug 5 22:01:11.052108 kernel: smpboot: CPU0: AMD EPYC 7402P 24-Core Processor (family: 0x17, model: 0x31, stepping: 0x0) Aug 5 22:01:11.052123 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Aug 5 22:01:11.052134 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Aug 5 22:01:11.052145 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Aug 5 22:01:11.052157 kernel: Performance Events: Fam17h+ core perfctr, AMD PMU driver. Aug 5 22:01:11.052168 kernel: ... version: 0 Aug 5 22:01:11.052178 kernel: ... bit width: 48 Aug 5 22:01:11.052189 kernel: ... generic registers: 6 Aug 5 22:01:11.052200 kernel: ... value mask: 0000ffffffffffff Aug 5 22:01:11.052211 kernel: ... max period: 00007fffffffffff Aug 5 22:01:11.052222 kernel: ... fixed-purpose events: 0 Aug 5 22:01:11.052236 kernel: ... event mask: 000000000000003f Aug 5 22:01:11.052247 kernel: signal: max sigframe size: 1776 Aug 5 22:01:11.052258 kernel: rcu: Hierarchical SRCU implementation. Aug 5 22:01:11.052268 kernel: rcu: Max phase no-delay instances is 400. Aug 5 22:01:11.052279 kernel: smp: Bringing up secondary CPUs ... Aug 5 22:01:11.052289 kernel: smpboot: x86: Booting SMP configuration: Aug 5 22:01:11.052299 kernel: .... node #0, CPUs: #1 #2 #3 Aug 5 22:01:11.052309 kernel: smp: Brought up 1 node, 4 CPUs Aug 5 22:01:11.052319 kernel: smpboot: Max logical packages: 1 Aug 5 22:01:11.052333 kernel: smpboot: Total of 4 processors activated (22357.98 BogoMIPS) Aug 5 22:01:11.052343 kernel: devtmpfs: initialized Aug 5 22:01:11.052353 kernel: x86/mm: Memory block size: 128MB Aug 5 22:01:11.052363 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Aug 5 22:01:11.052373 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Aug 5 22:01:11.052384 kernel: pinctrl core: initialized pinctrl subsystem Aug 5 22:01:11.052394 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Aug 5 22:01:11.052404 kernel: audit: initializing netlink subsys (disabled) Aug 5 22:01:11.052415 kernel: audit: type=2000 audit(1722895270.194:1): state=initialized audit_enabled=0 res=1 Aug 5 22:01:11.052428 kernel: thermal_sys: Registered thermal governor 'step_wise' Aug 5 22:01:11.052438 kernel: thermal_sys: Registered thermal governor 'user_space' Aug 5 22:01:11.052448 kernel: cpuidle: using governor menu Aug 5 22:01:11.052458 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Aug 5 22:01:11.052469 kernel: dca service started, version 1.12.1 Aug 5 22:01:11.052479 kernel: PCI: Using configuration type 1 for base access Aug 5 22:01:11.052489 kernel: PCI: Using configuration type 1 for extended access Aug 5 22:01:11.052499 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Aug 5 22:01:11.052509 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Aug 5 22:01:11.052523 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Aug 5 22:01:11.052533 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Aug 5 22:01:11.052544 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Aug 5 22:01:11.052554 kernel: ACPI: Added _OSI(Module Device) Aug 5 22:01:11.052564 kernel: ACPI: Added _OSI(Processor Device) Aug 5 22:01:11.052574 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Aug 5 22:01:11.052584 kernel: ACPI: Added _OSI(Processor Aggregator Device) Aug 5 22:01:11.052595 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Aug 5 22:01:11.052605 kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC Aug 5 22:01:11.052619 kernel: ACPI: Interpreter enabled Aug 5 22:01:11.052629 kernel: ACPI: PM: (supports S0 S3 S5) Aug 5 22:01:11.052639 kernel: ACPI: Using IOAPIC for interrupt routing Aug 5 22:01:11.052650 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Aug 5 22:01:11.052660 kernel: PCI: Using E820 reservations for host bridge windows Aug 5 22:01:11.052671 kernel: ACPI: Enabled 2 GPEs in block 00 to 0F Aug 5 22:01:11.052681 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Aug 5 22:01:11.052949 kernel: acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Aug 5 22:01:11.052972 kernel: acpiphp: Slot [3] registered Aug 5 22:01:11.052982 kernel: acpiphp: Slot [4] registered Aug 5 22:01:11.052993 kernel: acpiphp: Slot [5] registered Aug 5 22:01:11.053002 kernel: acpiphp: Slot [6] registered Aug 5 22:01:11.053013 kernel: acpiphp: Slot [7] registered Aug 5 22:01:11.053023 kernel: acpiphp: Slot [8] registered Aug 5 22:01:11.053033 kernel: acpiphp: Slot [9] registered Aug 5 22:01:11.053043 kernel: acpiphp: Slot [10] registered Aug 5 22:01:11.053053 kernel: acpiphp: Slot [11] registered Aug 5 22:01:11.053063 kernel: acpiphp: Slot [12] registered Aug 5 22:01:11.053076 kernel: acpiphp: Slot [13] registered Aug 5 22:01:11.053087 kernel: acpiphp: Slot [14] registered Aug 5 22:01:11.053097 kernel: acpiphp: Slot [15] registered Aug 5 22:01:11.053107 kernel: acpiphp: Slot [16] registered Aug 5 22:01:11.053117 kernel: acpiphp: Slot [17] registered Aug 5 22:01:11.053126 kernel: acpiphp: Slot [18] registered Aug 5 22:01:11.053137 kernel: acpiphp: Slot [19] registered Aug 5 22:01:11.053147 kernel: acpiphp: Slot [20] registered Aug 5 22:01:11.053157 kernel: acpiphp: Slot [21] registered Aug 5 22:01:11.053171 kernel: acpiphp: Slot [22] registered Aug 5 22:01:11.053182 kernel: acpiphp: Slot [23] registered Aug 5 22:01:11.053192 kernel: acpiphp: Slot [24] registered Aug 5 22:01:11.053202 kernel: acpiphp: Slot [25] registered Aug 5 22:01:11.053213 kernel: acpiphp: Slot [26] registered Aug 5 22:01:11.053223 kernel: acpiphp: Slot [27] registered Aug 5 22:01:11.053233 kernel: acpiphp: Slot [28] registered Aug 5 22:01:11.053243 kernel: acpiphp: Slot [29] registered Aug 5 22:01:11.053253 kernel: acpiphp: Slot [30] registered Aug 5 22:01:11.053263 kernel: acpiphp: Slot [31] registered Aug 5 22:01:11.053277 kernel: PCI host bridge to bus 0000:00 Aug 5 22:01:11.053452 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Aug 5 22:01:11.053599 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Aug 5 22:01:11.053740 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Aug 5 22:01:11.053918 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xfebfffff window] Aug 5 22:01:11.054110 kernel: pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window] Aug 5 22:01:11.054251 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Aug 5 22:01:11.054438 kernel: pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 Aug 5 22:01:11.054610 kernel: pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 Aug 5 22:01:11.054781 kernel: pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 Aug 5 22:01:11.054981 kernel: pci 0000:00:01.1: reg 0x20: [io 0xc0c0-0xc0cf] Aug 5 22:01:11.055143 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] Aug 5 22:01:11.055302 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] Aug 5 22:01:11.055467 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] Aug 5 22:01:11.055625 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] Aug 5 22:01:11.055815 kernel: pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 Aug 5 22:01:11.055996 kernel: pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI Aug 5 22:01:11.056149 kernel: pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB Aug 5 22:01:11.056308 kernel: pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 Aug 5 22:01:11.056465 kernel: pci 0000:00:02.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref] Aug 5 22:01:11.056623 kernel: pci 0000:00:02.0: reg 0x18: [mem 0xfebd0000-0xfebd0fff] Aug 5 22:01:11.056776 kernel: pci 0000:00:02.0: reg 0x30: [mem 0xfebc0000-0xfebcffff pref] Aug 5 22:01:11.056962 kernel: pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Aug 5 22:01:11.057131 kernel: pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 Aug 5 22:01:11.057282 kernel: pci 0000:00:03.0: reg 0x10: [io 0xc080-0xc09f] Aug 5 22:01:11.057435 kernel: pci 0000:00:03.0: reg 0x14: [mem 0xfebd1000-0xfebd1fff] Aug 5 22:01:11.057597 kernel: pci 0000:00:03.0: reg 0x20: [mem 0xfe000000-0xfe003fff 64bit pref] Aug 5 22:01:11.057770 kernel: pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 Aug 5 22:01:11.058016 kernel: pci 0000:00:04.0: reg 0x10: [io 0xc000-0xc07f] Aug 5 22:01:11.058175 kernel: pci 0000:00:04.0: reg 0x14: [mem 0xfebd2000-0xfebd2fff] Aug 5 22:01:11.058328 kernel: pci 0000:00:04.0: reg 0x20: [mem 0xfe004000-0xfe007fff 64bit pref] Aug 5 22:01:11.058491 kernel: pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 Aug 5 22:01:11.058646 kernel: pci 0000:00:05.0: reg 0x10: [io 0xc0a0-0xc0bf] Aug 5 22:01:11.058848 kernel: pci 0000:00:05.0: reg 0x14: [mem 0xfebd3000-0xfebd3fff] Aug 5 22:01:11.059021 kernel: pci 0000:00:05.0: reg 0x20: [mem 0xfe008000-0xfe00bfff 64bit pref] Aug 5 22:01:11.059181 kernel: pci 0000:00:05.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] Aug 5 22:01:11.059197 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Aug 5 22:01:11.059208 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Aug 5 22:01:11.059219 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Aug 5 22:01:11.059231 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Aug 5 22:01:11.059243 kernel: ACPI: PCI: Interrupt link LNKS configured for IRQ 9 Aug 5 22:01:11.059256 kernel: iommu: Default domain type: Translated Aug 5 22:01:11.059272 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Aug 5 22:01:11.059282 kernel: PCI: Using ACPI for IRQ routing Aug 5 22:01:11.059293 kernel: PCI: pci_cache_line_size set to 64 bytes Aug 5 22:01:11.059304 kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] Aug 5 22:01:11.059315 kernel: e820: reserve RAM buffer [mem 0x9cfdd000-0x9fffffff] Aug 5 22:01:11.059471 kernel: pci 0000:00:02.0: vgaarb: setting as boot VGA device Aug 5 22:01:11.059627 kernel: pci 0000:00:02.0: vgaarb: bridge control possible Aug 5 22:01:11.059786 kernel: pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Aug 5 22:01:11.059818 kernel: vgaarb: loaded Aug 5 22:01:11.059830 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Aug 5 22:01:11.059841 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Aug 5 22:01:11.059852 kernel: clocksource: Switched to clocksource kvm-clock Aug 5 22:01:11.059862 kernel: VFS: Disk quotas dquot_6.6.0 Aug 5 22:01:11.059874 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Aug 5 22:01:11.059884 kernel: pnp: PnP ACPI init Aug 5 22:01:11.060068 kernel: pnp 00:02: [dma 2] Aug 5 22:01:11.060090 kernel: pnp: PnP ACPI: found 6 devices Aug 5 22:01:11.060102 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Aug 5 22:01:11.060112 kernel: NET: Registered PF_INET protocol family Aug 5 22:01:11.060123 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Aug 5 22:01:11.060134 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Aug 5 22:01:11.060145 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Aug 5 22:01:11.060156 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Aug 5 22:01:11.060167 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Aug 5 22:01:11.060177 kernel: TCP: Hash tables configured (established 32768 bind 32768) Aug 5 22:01:11.060191 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Aug 5 22:01:11.060202 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Aug 5 22:01:11.060213 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Aug 5 22:01:11.060224 kernel: NET: Registered PF_XDP protocol family Aug 5 22:01:11.060370 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Aug 5 22:01:11.060513 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Aug 5 22:01:11.060652 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Aug 5 22:01:11.060801 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xfebfffff window] Aug 5 22:01:11.060957 kernel: pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window] Aug 5 22:01:11.061113 kernel: pci 0000:00:01.0: PIIX3: Enabling Passive Release Aug 5 22:01:11.061271 kernel: pci 0000:00:00.0: Limiting direct PCI/PCI transfers Aug 5 22:01:11.061286 kernel: PCI: CLS 0 bytes, default 64 Aug 5 22:01:11.061296 kernel: Initialise system trusted keyrings Aug 5 22:01:11.061306 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Aug 5 22:01:11.061316 kernel: Key type asymmetric registered Aug 5 22:01:11.061327 kernel: Asymmetric key parser 'x509' registered Aug 5 22:01:11.061337 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Aug 5 22:01:11.061351 kernel: io scheduler mq-deadline registered Aug 5 22:01:11.061362 kernel: io scheduler kyber registered Aug 5 22:01:11.061372 kernel: io scheduler bfq registered Aug 5 22:01:11.061382 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Aug 5 22:01:11.061393 kernel: ACPI: \_SB_.LNKC: Enabled at IRQ 11 Aug 5 22:01:11.061404 kernel: ACPI: \_SB_.LNKD: Enabled at IRQ 10 Aug 5 22:01:11.061415 kernel: ACPI: \_SB_.LNKA: Enabled at IRQ 10 Aug 5 22:01:11.061424 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Aug 5 22:01:11.061435 kernel: 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Aug 5 22:01:11.061448 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Aug 5 22:01:11.061458 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Aug 5 22:01:11.061469 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Aug 5 22:01:11.061632 kernel: rtc_cmos 00:05: RTC can wake from S4 Aug 5 22:01:11.061650 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Aug 5 22:01:11.061819 kernel: rtc_cmos 00:05: registered as rtc0 Aug 5 22:01:11.061987 kernel: rtc_cmos 00:05: setting system clock to 2024-08-05T22:01:10 UTC (1722895270) Aug 5 22:01:11.062132 kernel: rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs Aug 5 22:01:11.062154 kernel: amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled Aug 5 22:01:11.062165 kernel: NET: Registered PF_INET6 protocol family Aug 5 22:01:11.062176 kernel: Segment Routing with IPv6 Aug 5 22:01:11.062187 kernel: In-situ OAM (IOAM) with IPv6 Aug 5 22:01:11.062198 kernel: NET: Registered PF_PACKET protocol family Aug 5 22:01:11.062209 kernel: Key type dns_resolver registered Aug 5 22:01:11.062220 kernel: IPI shorthand broadcast: enabled Aug 5 22:01:11.062231 kernel: sched_clock: Marking stable (1046003077, 185167578)->(1331168997, -99998342) Aug 5 22:01:11.062242 kernel: registered taskstats version 1 Aug 5 22:01:11.062256 kernel: Loading compiled-in X.509 certificates Aug 5 22:01:11.062267 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.43-flatcar: e31e857530e65c19b206dbf3ab8297cc37ac5d55' Aug 5 22:01:11.062278 kernel: Key type .fscrypt registered Aug 5 22:01:11.062288 kernel: Key type fscrypt-provisioning registered Aug 5 22:01:11.062299 kernel: ima: No TPM chip found, activating TPM-bypass! Aug 5 22:01:11.062310 kernel: ima: Allocated hash algorithm: sha1 Aug 5 22:01:11.062320 kernel: ima: No architecture policies found Aug 5 22:01:11.062331 kernel: clk: Disabling unused clocks Aug 5 22:01:11.062342 kernel: Freeing unused kernel image (initmem) memory: 49328K Aug 5 22:01:11.062356 kernel: Write protecting the kernel read-only data: 36864k Aug 5 22:01:11.062367 kernel: Freeing unused kernel image (rodata/data gap) memory: 1936K Aug 5 22:01:11.062378 kernel: Run /init as init process Aug 5 22:01:11.062388 kernel: with arguments: Aug 5 22:01:11.062398 kernel: /init Aug 5 22:01:11.062409 kernel: with environment: Aug 5 22:01:11.062420 kernel: HOME=/ Aug 5 22:01:11.062451 kernel: TERM=linux Aug 5 22:01:11.062464 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Aug 5 22:01:11.062481 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Aug 5 22:01:11.062496 systemd[1]: Detected virtualization kvm. Aug 5 22:01:11.062508 systemd[1]: Detected architecture x86-64. Aug 5 22:01:11.062520 systemd[1]: Running in initrd. Aug 5 22:01:11.062531 systemd[1]: No hostname configured, using default hostname. Aug 5 22:01:11.062543 systemd[1]: Hostname set to . Aug 5 22:01:11.062558 systemd[1]: Initializing machine ID from VM UUID. Aug 5 22:01:11.062569 systemd[1]: Queued start job for default target initrd.target. Aug 5 22:01:11.062581 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 5 22:01:11.062593 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 5 22:01:11.062606 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Aug 5 22:01:11.062618 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Aug 5 22:01:11.062630 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Aug 5 22:01:11.062643 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Aug 5 22:01:11.062660 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Aug 5 22:01:11.062672 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Aug 5 22:01:11.062684 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 5 22:01:11.062696 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Aug 5 22:01:11.062706 systemd[1]: Reached target paths.target - Path Units. Aug 5 22:01:11.062717 systemd[1]: Reached target slices.target - Slice Units. Aug 5 22:01:11.062729 systemd[1]: Reached target swap.target - Swaps. Aug 5 22:01:11.062740 systemd[1]: Reached target timers.target - Timer Units. Aug 5 22:01:11.062754 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Aug 5 22:01:11.062767 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Aug 5 22:01:11.062778 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Aug 5 22:01:11.062806 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Aug 5 22:01:11.062818 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Aug 5 22:01:11.062830 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Aug 5 22:01:11.062841 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Aug 5 22:01:11.062853 systemd[1]: Reached target sockets.target - Socket Units. Aug 5 22:01:11.062868 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Aug 5 22:01:11.062879 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Aug 5 22:01:11.062891 systemd[1]: Finished network-cleanup.service - Network Cleanup. Aug 5 22:01:11.062902 systemd[1]: Starting systemd-fsck-usr.service... Aug 5 22:01:11.062913 systemd[1]: Starting systemd-journald.service - Journal Service... Aug 5 22:01:11.062928 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Aug 5 22:01:11.063033 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 5 22:01:11.063045 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Aug 5 22:01:11.063057 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Aug 5 22:01:11.063069 systemd[1]: Finished systemd-fsck-usr.service. Aug 5 22:01:11.063111 systemd-journald[192]: Collecting audit messages is disabled. Aug 5 22:01:11.063145 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Aug 5 22:01:11.063157 systemd-journald[192]: Journal started Aug 5 22:01:11.063185 systemd-journald[192]: Runtime Journal (/run/log/journal/1edea9a2ca184478a66a1560da91f683) is 6.0M, max 48.4M, 42.3M free. Aug 5 22:01:11.043984 systemd-modules-load[193]: Inserted module 'overlay' Aug 5 22:01:11.083542 systemd[1]: Started systemd-journald.service - Journal Service. Aug 5 22:01:11.085462 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:01:11.087208 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Aug 5 22:01:11.100691 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Aug 5 22:01:11.106676 kernel: Bridge firewalling registered Aug 5 22:01:11.105639 systemd-modules-load[193]: Inserted module 'br_netfilter' Aug 5 22:01:11.105903 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 5 22:01:11.110365 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Aug 5 22:01:11.112104 systemd[1]: Starting systemd-tmpfiles-setup.service - Create Volatile Files and Directories... Aug 5 22:01:11.114186 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Aug 5 22:01:11.118604 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Aug 5 22:01:11.130830 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 5 22:01:11.134290 systemd[1]: Finished systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Aug 5 22:01:11.136447 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Aug 5 22:01:11.146038 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Aug 5 22:01:11.148362 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 5 22:01:11.154822 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Aug 5 22:01:11.177433 dracut-cmdline[232]: dracut-dracut-053 Aug 5 22:01:11.180759 dracut-cmdline[232]: Using kernel command line parameters: rd.driver.pre=btrfs rootflags=rw mount.usrflags=ro BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected verity.usrhash=4a86c72568bc3f74d57effa5e252d5620941ef6d74241fc198859d020a6392c5 Aug 5 22:01:11.190082 systemd-resolved[228]: Positive Trust Anchors: Aug 5 22:01:11.190099 systemd-resolved[228]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Aug 5 22:01:11.190130 systemd-resolved[228]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa corp home internal intranet lan local private test Aug 5 22:01:11.193001 systemd-resolved[228]: Defaulting to hostname 'linux'. Aug 5 22:01:11.194302 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Aug 5 22:01:11.201916 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Aug 5 22:01:11.287007 kernel: SCSI subsystem initialized Aug 5 22:01:11.302980 kernel: Loading iSCSI transport class v2.0-870. Aug 5 22:01:11.318979 kernel: iscsi: registered transport (tcp) Aug 5 22:01:11.348976 kernel: iscsi: registered transport (qla4xxx) Aug 5 22:01:11.349050 kernel: QLogic iSCSI HBA Driver Aug 5 22:01:11.405905 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Aug 5 22:01:11.416199 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Aug 5 22:01:11.446006 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Aug 5 22:01:11.446095 kernel: device-mapper: uevent: version 1.0.3 Aug 5 22:01:11.446116 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Aug 5 22:01:11.495969 kernel: raid6: avx2x4 gen() 28397 MB/s Aug 5 22:01:11.512966 kernel: raid6: avx2x2 gen() 30301 MB/s Aug 5 22:01:11.530134 kernel: raid6: avx2x1 gen() 22305 MB/s Aug 5 22:01:11.530206 kernel: raid6: using algorithm avx2x2 gen() 30301 MB/s Aug 5 22:01:11.548091 kernel: raid6: .... xor() 16146 MB/s, rmw enabled Aug 5 22:01:11.548170 kernel: raid6: using avx2x2 recovery algorithm Aug 5 22:01:11.575974 kernel: xor: automatically using best checksumming function avx Aug 5 22:01:11.792990 kernel: Btrfs loaded, zoned=no, fsverity=no Aug 5 22:01:11.808625 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Aug 5 22:01:11.816219 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 5 22:01:11.829911 systemd-udevd[415]: Using default interface naming scheme 'v255'. Aug 5 22:01:11.834676 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 5 22:01:11.849158 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Aug 5 22:01:11.865477 dracut-pre-trigger[423]: rd.md=0: removing MD RAID activation Aug 5 22:01:11.904152 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Aug 5 22:01:11.917236 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Aug 5 22:01:11.990653 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Aug 5 22:01:12.002206 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Aug 5 22:01:12.016036 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Aug 5 22:01:12.017995 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Aug 5 22:01:12.020313 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 5 22:01:12.020594 systemd[1]: Reached target remote-fs.target - Remote File Systems. Aug 5 22:01:12.032571 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Aug 5 22:01:12.038956 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues Aug 5 22:01:12.063519 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Aug 5 22:01:12.063702 kernel: cryptd: max_cpu_qlen set to 1000 Aug 5 22:01:12.063714 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 5 22:01:12.063725 kernel: libata version 3.00 loaded. Aug 5 22:01:12.049273 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Aug 5 22:01:12.072635 kernel: ata_piix 0000:00:01.1: version 2.13 Aug 5 22:01:12.086529 kernel: AVX2 version of gcm_enc/dec engaged. Aug 5 22:01:12.086552 kernel: AES CTR mode by8 optimization enabled Aug 5 22:01:12.086567 kernel: scsi host0: ata_piix Aug 5 22:01:12.086795 kernel: scsi host1: ata_piix Aug 5 22:01:12.086998 kernel: ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc0c0 irq 14 Aug 5 22:01:12.087022 kernel: ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc0c8 irq 15 Aug 5 22:01:12.087858 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Aug 5 22:01:12.089453 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 5 22:01:12.093392 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 5 22:01:12.100318 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Aug 5 22:01:12.107208 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by (udev-worker) (466) Aug 5 22:01:12.107233 kernel: BTRFS: device fsid d3844c60-0a2c-449a-9ee9-2a875f8d8e12 devid 1 transid 36 /dev/vda3 scanned by (udev-worker) (474) Aug 5 22:01:12.100496 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:01:12.105092 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Aug 5 22:01:12.114238 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 5 22:01:12.133742 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Aug 5 22:01:12.166321 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Aug 5 22:01:12.168000 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:01:12.180887 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Aug 5 22:01:12.187081 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Aug 5 22:01:12.188663 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Aug 5 22:01:12.210238 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Aug 5 22:01:12.212371 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 5 22:01:12.234255 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 5 22:01:12.246969 kernel: ata2: found unknown device (class 0) Aug 5 22:01:12.248966 kernel: ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Aug 5 22:01:12.251048 kernel: scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Aug 5 22:01:12.302289 kernel: sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Aug 5 22:01:12.315139 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Aug 5 22:01:12.315166 kernel: sr 1:0:0:0: Attached scsi CD-ROM sr0 Aug 5 22:01:12.357973 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 5 22:01:12.365998 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 5 22:01:13.370972 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 5 22:01:13.371548 disk-uuid[565]: The operation has completed successfully. Aug 5 22:01:13.403010 systemd[1]: disk-uuid.service: Deactivated successfully. Aug 5 22:01:13.403141 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Aug 5 22:01:13.433311 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Aug 5 22:01:13.440266 sh[579]: Success Aug 5 22:01:13.457963 kernel: device-mapper: verity: sha256 using implementation "sha256-ni" Aug 5 22:01:13.495691 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Aug 5 22:01:13.507099 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Aug 5 22:01:13.510579 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Aug 5 22:01:13.527559 kernel: BTRFS info (device dm-0): first mount of filesystem d3844c60-0a2c-449a-9ee9-2a875f8d8e12 Aug 5 22:01:13.527631 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Aug 5 22:01:13.527647 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Aug 5 22:01:13.528585 kernel: BTRFS info (device dm-0): disabling log replay at mount time Aug 5 22:01:13.529349 kernel: BTRFS info (device dm-0): using free space tree Aug 5 22:01:13.534120 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Aug 5 22:01:13.535072 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Aug 5 22:01:13.545195 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Aug 5 22:01:13.546449 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Aug 5 22:01:13.557464 kernel: BTRFS info (device vda6): first mount of filesystem b6695624-d538-4f05-9ddd-23ee987404c1 Aug 5 22:01:13.557521 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Aug 5 22:01:13.557536 kernel: BTRFS info (device vda6): using free space tree Aug 5 22:01:13.561977 kernel: BTRFS info (device vda6): auto enabling async discard Aug 5 22:01:13.572299 systemd[1]: mnt-oem.mount: Deactivated successfully. Aug 5 22:01:13.574792 kernel: BTRFS info (device vda6): last unmount of filesystem b6695624-d538-4f05-9ddd-23ee987404c1 Aug 5 22:01:13.587207 systemd[1]: Finished ignition-setup.service - Ignition (setup). Aug 5 22:01:13.594238 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Aug 5 22:01:13.729045 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Aug 5 22:01:14.133249 systemd[1]: Starting systemd-networkd.service - Network Configuration... Aug 5 22:01:14.168339 ignition[679]: Ignition 2.18.0 Aug 5 22:01:14.168355 ignition[679]: Stage: fetch-offline Aug 5 22:01:14.168404 ignition[679]: no configs at "/usr/lib/ignition/base.d" Aug 5 22:01:14.168419 ignition[679]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:01:14.168669 ignition[679]: parsed url from cmdline: "" Aug 5 22:01:14.168674 ignition[679]: no config URL provided Aug 5 22:01:14.168696 ignition[679]: reading system config file "/usr/lib/ignition/user.ign" Aug 5 22:01:14.168720 ignition[679]: no config at "/usr/lib/ignition/user.ign" Aug 5 22:01:14.168760 ignition[679]: op(1): [started] loading QEMU firmware config module Aug 5 22:01:14.168771 ignition[679]: op(1): executing: "modprobe" "qemu_fw_cfg" Aug 5 22:01:14.178880 ignition[679]: op(1): [finished] loading QEMU firmware config module Aug 5 22:01:14.180352 ignition[679]: parsing config with SHA512: 2052c0d8ff31b623cc2127a14f5a9947e3c5cbbbf45ff5b093dfe105aaa000a86efae371b40430b47e575d1ee4df247270aae8c486cf4a55c72eaf582eb9bf2f Aug 5 22:01:14.183785 unknown[679]: fetched base config from "system" Aug 5 22:01:14.183801 unknown[679]: fetched user config from "qemu" Aug 5 22:01:14.184130 ignition[679]: fetch-offline: fetch-offline passed Aug 5 22:01:14.184229 ignition[679]: Ignition finished successfully Aug 5 22:01:14.186912 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Aug 5 22:01:14.200456 systemd-networkd[761]: lo: Link UP Aug 5 22:01:14.200466 systemd-networkd[761]: lo: Gained carrier Aug 5 22:01:14.203791 systemd-networkd[761]: Enumeration completed Aug 5 22:01:14.203912 systemd[1]: Started systemd-networkd.service - Network Configuration. Aug 5 22:01:14.206837 systemd[1]: Reached target network.target - Network. Aug 5 22:01:14.206917 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Aug 5 22:01:14.210530 systemd-networkd[761]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 5 22:01:14.210539 systemd-networkd[761]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Aug 5 22:01:14.211165 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Aug 5 22:01:14.216913 systemd-networkd[761]: eth0: Link UP Aug 5 22:01:14.216918 systemd-networkd[761]: eth0: Gained carrier Aug 5 22:01:14.216927 systemd-networkd[761]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 5 22:01:14.241557 systemd-networkd[761]: eth0: DHCPv4 address 10.0.0.17/16, gateway 10.0.0.1 acquired from 10.0.0.1 Aug 5 22:01:14.247247 ignition[771]: Ignition 2.18.0 Aug 5 22:01:14.247259 ignition[771]: Stage: kargs Aug 5 22:01:14.247479 ignition[771]: no configs at "/usr/lib/ignition/base.d" Aug 5 22:01:14.247494 ignition[771]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:01:14.248337 ignition[771]: kargs: kargs passed Aug 5 22:01:14.252232 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Aug 5 22:01:14.248392 ignition[771]: Ignition finished successfully Aug 5 22:01:14.264128 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Aug 5 22:01:14.280309 ignition[781]: Ignition 2.18.0 Aug 5 22:01:14.280323 ignition[781]: Stage: disks Aug 5 22:01:14.280552 ignition[781]: no configs at "/usr/lib/ignition/base.d" Aug 5 22:01:14.280567 ignition[781]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:01:14.281455 ignition[781]: disks: disks passed Aug 5 22:01:14.281512 ignition[781]: Ignition finished successfully Aug 5 22:01:14.287367 systemd[1]: Finished ignition-disks.service - Ignition (disks). Aug 5 22:01:14.287740 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Aug 5 22:01:14.289427 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Aug 5 22:01:14.291577 systemd[1]: Reached target local-fs.target - Local File Systems. Aug 5 22:01:14.293990 systemd[1]: Reached target sysinit.target - System Initialization. Aug 5 22:01:14.295888 systemd[1]: Reached target basic.target - Basic System. Aug 5 22:01:14.314390 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Aug 5 22:01:14.343235 systemd-resolved[228]: Detected conflict on linux IN A 10.0.0.17 Aug 5 22:01:14.343264 systemd-resolved[228]: Hostname conflict, changing published hostname from 'linux' to 'linux3'. Aug 5 22:01:14.362627 systemd-fsck[792]: ROOT: clean, 14/553520 files, 52654/553472 blocks Aug 5 22:01:14.379528 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Aug 5 22:01:14.390170 systemd[1]: Mounting sysroot.mount - /sysroot... Aug 5 22:01:14.532969 kernel: EXT4-fs (vda9): mounted filesystem e865ac73-053b-4efa-9a0f-50dec3f650d9 r/w with ordered data mode. Quota mode: none. Aug 5 22:01:14.533148 systemd[1]: Mounted sysroot.mount - /sysroot. Aug 5 22:01:14.535133 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Aug 5 22:01:14.543093 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Aug 5 22:01:14.545314 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Aug 5 22:01:14.547405 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Aug 5 22:01:14.547471 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Aug 5 22:01:14.547504 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Aug 5 22:01:14.556013 kernel: BTRFS: device label OEM devid 1 transid 13 /dev/vda6 scanned by mount (800) Aug 5 22:01:14.555906 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Aug 5 22:01:14.564018 kernel: BTRFS info (device vda6): first mount of filesystem b6695624-d538-4f05-9ddd-23ee987404c1 Aug 5 22:01:14.564052 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Aug 5 22:01:14.564083 kernel: BTRFS info (device vda6): using free space tree Aug 5 22:01:14.564097 kernel: BTRFS info (device vda6): auto enabling async discard Aug 5 22:01:14.558320 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Aug 5 22:01:14.565436 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Aug 5 22:01:14.607385 initrd-setup-root[824]: cut: /sysroot/etc/passwd: No such file or directory Aug 5 22:01:14.611831 initrd-setup-root[831]: cut: /sysroot/etc/group: No such file or directory Aug 5 22:01:14.615659 initrd-setup-root[838]: cut: /sysroot/etc/shadow: No such file or directory Aug 5 22:01:14.621359 initrd-setup-root[845]: cut: /sysroot/etc/gshadow: No such file or directory Aug 5 22:01:14.913224 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Aug 5 22:01:14.930108 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Aug 5 22:01:14.932623 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Aug 5 22:01:14.939286 systemd[1]: sysroot-oem.mount: Deactivated successfully. Aug 5 22:01:14.941217 kernel: BTRFS info (device vda6): last unmount of filesystem b6695624-d538-4f05-9ddd-23ee987404c1 Aug 5 22:01:14.971894 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Aug 5 22:01:14.978285 ignition[912]: INFO : Ignition 2.18.0 Aug 5 22:01:14.978285 ignition[912]: INFO : Stage: mount Aug 5 22:01:14.980401 ignition[912]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 5 22:01:14.980401 ignition[912]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:01:14.980401 ignition[912]: INFO : mount: mount passed Aug 5 22:01:14.980401 ignition[912]: INFO : Ignition finished successfully Aug 5 22:01:14.982880 systemd[1]: Finished ignition-mount.service - Ignition (mount). Aug 5 22:01:14.994118 systemd[1]: Starting ignition-files.service - Ignition (files)... Aug 5 22:01:15.544158 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Aug 5 22:01:15.577913 systemd-networkd[761]: eth0: Gained IPv6LL Aug 5 22:01:15.581923 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 scanned by mount (927) Aug 5 22:01:15.581963 kernel: BTRFS info (device vda6): first mount of filesystem b6695624-d538-4f05-9ddd-23ee987404c1 Aug 5 22:01:15.581974 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Aug 5 22:01:15.583538 kernel: BTRFS info (device vda6): using free space tree Aug 5 22:01:15.585952 kernel: BTRFS info (device vda6): auto enabling async discard Aug 5 22:01:15.587632 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Aug 5 22:01:15.618121 ignition[944]: INFO : Ignition 2.18.0 Aug 5 22:01:15.618121 ignition[944]: INFO : Stage: files Aug 5 22:01:15.655803 ignition[944]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 5 22:01:15.655803 ignition[944]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:01:15.658459 ignition[944]: DEBUG : files: compiled without relabeling support, skipping Aug 5 22:01:15.660544 ignition[944]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Aug 5 22:01:15.660544 ignition[944]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Aug 5 22:01:15.663748 ignition[944]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Aug 5 22:01:15.663748 ignition[944]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Aug 5 22:01:15.666886 ignition[944]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Aug 5 22:01:15.666886 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Aug 5 22:01:15.666886 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Aug 5 22:01:15.666886 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing link "/sysroot/etc/extensions/docker-flatcar.raw" -> "/dev/null" Aug 5 22:01:15.666886 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing link "/sysroot/etc/extensions/docker-flatcar.raw" -> "/dev/null" Aug 5 22:01:15.666886 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing link "/sysroot/etc/extensions/containerd-flatcar.raw" -> "/dev/null" Aug 5 22:01:15.666886 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing link "/sysroot/etc/extensions/containerd-flatcar.raw" -> "/dev/null" Aug 5 22:01:15.666886 ignition[944]: INFO : files: op(6): [started] processing unit "coreos-metadata.service" Aug 5 22:01:15.664125 unknown[944]: wrote ssh authorized keys file for user: core Aug 5 22:01:15.707106 ignition[944]: INFO : files: op(6): op(7): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Aug 5 22:01:15.707106 ignition[944]: INFO : files: op(6): op(7): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Aug 5 22:01:15.707106 ignition[944]: INFO : files: op(6): [finished] processing unit "coreos-metadata.service" Aug 5 22:01:15.707106 ignition[944]: INFO : files: op(8): [started] setting preset to disabled for "coreos-metadata.service" Aug 5 22:01:15.715613 ignition[944]: INFO : files: op(8): op(9): [started] removing enablement symlink(s) for "coreos-metadata.service" Aug 5 22:01:15.720416 ignition[944]: INFO : files: op(8): op(9): [finished] removing enablement symlink(s) for "coreos-metadata.service" Aug 5 22:01:15.734070 ignition[944]: INFO : files: op(8): [finished] setting preset to disabled for "coreos-metadata.service" Aug 5 22:01:15.735637 ignition[944]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" Aug 5 22:01:15.737522 ignition[944]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" Aug 5 22:01:15.739202 ignition[944]: INFO : files: files passed Aug 5 22:01:15.739973 ignition[944]: INFO : Ignition finished successfully Aug 5 22:01:15.743063 systemd[1]: Finished ignition-files.service - Ignition (files). Aug 5 22:01:15.754168 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Aug 5 22:01:15.756409 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Aug 5 22:01:15.761080 systemd[1]: ignition-quench.service: Deactivated successfully. Aug 5 22:01:15.761256 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Aug 5 22:01:15.805208 initrd-setup-root-after-ignition[973]: grep: /sysroot/oem/oem-release: No such file or directory Aug 5 22:01:15.807518 initrd-setup-root-after-ignition[975]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Aug 5 22:01:15.809551 initrd-setup-root-after-ignition[975]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Aug 5 22:01:15.812889 initrd-setup-root-after-ignition[979]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Aug 5 22:01:15.811068 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Aug 5 22:01:15.813087 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Aug 5 22:01:15.823112 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Aug 5 22:01:15.851095 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Aug 5 22:01:15.878356 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Aug 5 22:01:15.881496 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Aug 5 22:01:15.883807 systemd[1]: Reached target initrd.target - Initrd Default Target. Aug 5 22:01:15.886225 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Aug 5 22:01:15.898077 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Aug 5 22:01:15.911684 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Aug 5 22:01:15.915700 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Aug 5 22:01:15.930380 systemd[1]: Stopped target network.target - Network. Aug 5 22:01:15.955440 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Aug 5 22:01:15.958104 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 5 22:01:15.960770 systemd[1]: Stopped target timers.target - Timer Units. Aug 5 22:01:15.962879 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Aug 5 22:01:15.964105 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Aug 5 22:01:15.987889 systemd[1]: Stopped target initrd.target - Initrd Default Target. Aug 5 22:01:15.990158 systemd[1]: Stopped target basic.target - Basic System. Aug 5 22:01:15.992203 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Aug 5 22:01:15.994668 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Aug 5 22:01:15.997308 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Aug 5 22:01:16.025052 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Aug 5 22:01:16.027388 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Aug 5 22:01:16.030166 systemd[1]: Stopped target sysinit.target - System Initialization. Aug 5 22:01:16.032570 systemd[1]: Stopped target local-fs.target - Local File Systems. Aug 5 22:01:16.034911 systemd[1]: Stopped target swap.target - Swaps. Aug 5 22:01:16.065950 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Aug 5 22:01:16.067132 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Aug 5 22:01:16.069733 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Aug 5 22:01:16.072122 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 5 22:01:16.074808 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Aug 5 22:01:16.076045 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 5 22:01:16.078741 systemd[1]: dracut-initqueue.service: Deactivated successfully. Aug 5 22:01:16.079846 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Aug 5 22:01:16.082132 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Aug 5 22:01:16.083259 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Aug 5 22:01:16.105478 systemd[1]: Stopped target paths.target - Path Units. Aug 5 22:01:16.107259 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Aug 5 22:01:16.108418 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 5 22:01:16.111202 systemd[1]: Stopped target slices.target - Slice Units. Aug 5 22:01:16.113113 systemd[1]: Stopped target sockets.target - Socket Units. Aug 5 22:01:16.115022 systemd[1]: iscsid.socket: Deactivated successfully. Aug 5 22:01:16.115946 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Aug 5 22:01:16.138305 systemd[1]: iscsiuio.socket: Deactivated successfully. Aug 5 22:01:16.139215 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Aug 5 22:01:16.141315 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Aug 5 22:01:16.142530 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Aug 5 22:01:16.145191 systemd[1]: ignition-files.service: Deactivated successfully. Aug 5 22:01:16.146239 systemd[1]: Stopped ignition-files.service - Ignition (files). Aug 5 22:01:16.162212 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Aug 5 22:01:16.164545 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Aug 5 22:01:16.165838 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Aug 5 22:01:16.170005 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Aug 5 22:01:16.170263 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Aug 5 22:01:16.183455 ignition[999]: INFO : Ignition 2.18.0 Aug 5 22:01:16.183455 ignition[999]: INFO : Stage: umount Aug 5 22:01:16.183455 ignition[999]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 5 22:01:16.183455 ignition[999]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:01:16.183455 ignition[999]: INFO : umount: umount passed Aug 5 22:01:16.183455 ignition[999]: INFO : Ignition finished successfully Aug 5 22:01:16.182627 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Aug 5 22:01:16.184532 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Aug 5 22:01:16.184724 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Aug 5 22:01:16.185017 systemd-networkd[761]: eth0: DHCPv6 lease lost Aug 5 22:01:16.190487 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Aug 5 22:01:16.190596 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Aug 5 22:01:16.195905 systemd[1]: systemd-resolved.service: Deactivated successfully. Aug 5 22:01:16.196142 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Aug 5 22:01:16.217564 systemd[1]: systemd-networkd.service: Deactivated successfully. Aug 5 22:01:16.217768 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Aug 5 22:01:16.220237 systemd[1]: ignition-mount.service: Deactivated successfully. Aug 5 22:01:16.220377 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Aug 5 22:01:16.223581 systemd[1]: initrd-cleanup.service: Deactivated successfully. Aug 5 22:01:16.223738 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Aug 5 22:01:16.227658 systemd[1]: systemd-networkd.socket: Deactivated successfully. Aug 5 22:01:16.227712 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Aug 5 22:01:16.228113 systemd[1]: ignition-disks.service: Deactivated successfully. Aug 5 22:01:16.228188 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Aug 5 22:01:16.231297 systemd[1]: ignition-kargs.service: Deactivated successfully. Aug 5 22:01:16.231356 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Aug 5 22:01:16.232598 systemd[1]: ignition-setup.service: Deactivated successfully. Aug 5 22:01:16.232672 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Aug 5 22:01:16.233399 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Aug 5 22:01:16.233457 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Aug 5 22:01:16.268130 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Aug 5 22:01:16.286837 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Aug 5 22:01:16.286949 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Aug 5 22:01:16.289288 systemd[1]: systemd-sysctl.service: Deactivated successfully. Aug 5 22:01:16.289336 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Aug 5 22:01:16.289681 systemd[1]: systemd-modules-load.service: Deactivated successfully. Aug 5 22:01:16.289725 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Aug 5 22:01:16.290606 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Aug 5 22:01:16.290663 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Aug 5 22:01:16.291316 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 5 22:01:16.340493 systemd[1]: network-cleanup.service: Deactivated successfully. Aug 5 22:01:16.340653 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Aug 5 22:01:16.369769 systemd[1]: sysroot-boot.mount: Deactivated successfully. Aug 5 22:01:16.373347 systemd[1]: systemd-udevd.service: Deactivated successfully. Aug 5 22:01:16.373591 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 5 22:01:16.375054 systemd[1]: sysroot-boot.service: Deactivated successfully. Aug 5 22:01:16.375192 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Aug 5 22:01:16.381151 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Aug 5 22:01:16.381240 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Aug 5 22:01:16.383444 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Aug 5 22:01:16.383502 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Aug 5 22:01:16.385741 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Aug 5 22:01:16.385800 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Aug 5 22:01:16.397548 systemd[1]: dracut-cmdline.service: Deactivated successfully. Aug 5 22:01:16.397628 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Aug 5 22:01:16.399798 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Aug 5 22:01:16.401881 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 5 22:01:16.404602 systemd[1]: initrd-setup-root.service: Deactivated successfully. Aug 5 22:01:16.404672 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Aug 5 22:01:16.420240 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Aug 5 22:01:16.423068 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Aug 5 22:01:16.424419 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 5 22:01:16.427516 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Aug 5 22:01:16.428605 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:01:16.432022 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Aug 5 22:01:16.433432 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Aug 5 22:01:16.436830 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Aug 5 22:01:16.451136 systemd[1]: Starting initrd-switch-root.service - Switch Root... Aug 5 22:01:16.478204 systemd[1]: Switching root. Aug 5 22:01:16.519660 systemd-journald[192]: Journal stopped Aug 5 22:01:17.388035 systemd-journald[192]: Received SIGTERM from PID 1 (systemd). Aug 5 22:01:17.388121 kernel: SELinux: policy capability network_peer_controls=1 Aug 5 22:01:17.388142 kernel: SELinux: policy capability open_perms=1 Aug 5 22:01:17.388167 kernel: SELinux: policy capability extended_socket_class=1 Aug 5 22:01:17.388188 kernel: SELinux: policy capability always_check_network=0 Aug 5 22:01:17.388208 kernel: SELinux: policy capability cgroup_seclabel=1 Aug 5 22:01:17.388238 kernel: SELinux: policy capability nnp_nosuid_transition=1 Aug 5 22:01:17.388265 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Aug 5 22:01:17.388291 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Aug 5 22:01:17.388316 kernel: audit: type=1403 audit(1722895276.613:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Aug 5 22:01:17.388346 systemd[1]: Successfully loaded SELinux policy in 45.813ms. Aug 5 22:01:17.388376 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 12.523ms. Aug 5 22:01:17.388394 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Aug 5 22:01:17.388411 systemd[1]: Detected virtualization kvm. Aug 5 22:01:17.388428 systemd[1]: Detected architecture x86-64. Aug 5 22:01:17.388444 systemd[1]: Detected first boot. Aug 5 22:01:17.388461 systemd[1]: Initializing machine ID from VM UUID. Aug 5 22:01:17.388478 zram_generator::config[1043]: No configuration found. Aug 5 22:01:17.388499 systemd[1]: Populated /etc with preset unit settings. Aug 5 22:01:17.388517 systemd[1]: initrd-switch-root.service: Deactivated successfully. Aug 5 22:01:17.388535 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Aug 5 22:01:17.388553 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Aug 5 22:01:17.388573 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Aug 5 22:01:17.388590 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Aug 5 22:01:17.388610 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Aug 5 22:01:17.388640 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Aug 5 22:01:17.388662 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Aug 5 22:01:17.388680 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Aug 5 22:01:17.388698 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Aug 5 22:01:17.388714 systemd[1]: Created slice user.slice - User and Session Slice. Aug 5 22:01:17.388731 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 5 22:01:17.388753 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 5 22:01:17.388771 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Aug 5 22:01:17.388788 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Aug 5 22:01:17.388805 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Aug 5 22:01:17.388822 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Aug 5 22:01:17.388839 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Aug 5 22:01:17.388857 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 5 22:01:17.388878 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Aug 5 22:01:17.388896 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Aug 5 22:01:17.388917 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Aug 5 22:01:17.389129 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Aug 5 22:01:17.389153 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 5 22:01:17.389172 systemd[1]: Reached target remote-fs.target - Remote File Systems. Aug 5 22:01:17.389188 systemd[1]: Reached target slices.target - Slice Units. Aug 5 22:01:17.389207 systemd[1]: Reached target swap.target - Swaps. Aug 5 22:01:17.389222 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Aug 5 22:01:17.389238 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Aug 5 22:01:17.389259 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Aug 5 22:01:17.389276 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Aug 5 22:01:17.389407 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Aug 5 22:01:17.389423 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Aug 5 22:01:17.389440 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Aug 5 22:01:17.389455 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Aug 5 22:01:17.389470 systemd[1]: Mounting media.mount - External Media Directory... Aug 5 22:01:17.389487 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Aug 5 22:01:17.389503 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Aug 5 22:01:17.389521 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Aug 5 22:01:17.389537 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Aug 5 22:01:17.389553 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). Aug 5 22:01:17.389569 systemd[1]: Reached target machines.target - Containers. Aug 5 22:01:17.389585 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Aug 5 22:01:17.389601 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 5 22:01:17.389626 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Aug 5 22:01:17.389643 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Aug 5 22:01:17.389662 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 5 22:01:17.389680 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Aug 5 22:01:17.389697 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 5 22:01:17.389713 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Aug 5 22:01:17.389730 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 5 22:01:17.389747 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Aug 5 22:01:17.389763 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Aug 5 22:01:17.389780 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Aug 5 22:01:17.389795 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Aug 5 22:01:17.389816 systemd[1]: Stopped systemd-fsck-usr.service. Aug 5 22:01:17.389833 systemd[1]: Starting systemd-journald.service - Journal Service... Aug 5 22:01:17.389849 kernel: loop: module loaded Aug 5 22:01:17.389865 kernel: fuse: init (API version 7.39) Aug 5 22:01:17.389881 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Aug 5 22:01:17.389922 systemd-journald[1105]: Collecting audit messages is disabled. Aug 5 22:01:17.390059 kernel: ACPI: bus type drm_connector registered Aug 5 22:01:17.390078 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Aug 5 22:01:17.390099 systemd-journald[1105]: Journal started Aug 5 22:01:17.390132 systemd-journald[1105]: Runtime Journal (/run/log/journal/1edea9a2ca184478a66a1560da91f683) is 6.0M, max 48.4M, 42.3M free. Aug 5 22:01:17.144141 systemd[1]: Queued start job for default target multi-user.target. Aug 5 22:01:17.167486 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Aug 5 22:01:17.168054 systemd[1]: systemd-journald.service: Deactivated successfully. Aug 5 22:01:17.395000 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Aug 5 22:01:17.402053 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Aug 5 22:01:17.404427 systemd[1]: verity-setup.service: Deactivated successfully. Aug 5 22:01:17.404475 systemd[1]: Stopped verity-setup.service. Aug 5 22:01:17.407967 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Aug 5 22:01:17.412065 systemd[1]: Started systemd-journald.service - Journal Service. Aug 5 22:01:17.413376 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Aug 5 22:01:17.414659 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Aug 5 22:01:17.416041 systemd[1]: Mounted media.mount - External Media Directory. Aug 5 22:01:17.417199 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Aug 5 22:01:17.418489 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Aug 5 22:01:17.419790 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Aug 5 22:01:17.421194 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Aug 5 22:01:17.422753 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Aug 5 22:01:17.424492 systemd[1]: modprobe@configfs.service: Deactivated successfully. Aug 5 22:01:17.424725 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Aug 5 22:01:17.426483 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 5 22:01:17.426721 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 5 22:01:17.428370 systemd[1]: modprobe@drm.service: Deactivated successfully. Aug 5 22:01:17.428586 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Aug 5 22:01:17.430189 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 5 22:01:17.430406 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 5 22:01:17.432167 systemd[1]: modprobe@fuse.service: Deactivated successfully. Aug 5 22:01:17.432392 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Aug 5 22:01:17.433976 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 5 22:01:17.434191 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 5 22:01:17.435826 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Aug 5 22:01:17.437576 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Aug 5 22:01:17.439296 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Aug 5 22:01:17.454595 systemd[1]: Reached target network-pre.target - Preparation for Network. Aug 5 22:01:17.462017 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Aug 5 22:01:17.463296 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Aug 5 22:01:17.464481 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Aug 5 22:01:17.464524 systemd[1]: Reached target local-fs.target - Local File Systems. Aug 5 22:01:17.466721 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Aug 5 22:01:17.469293 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Aug 5 22:01:17.473222 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Aug 5 22:01:17.474684 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 5 22:01:17.478212 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Aug 5 22:01:17.483114 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Aug 5 22:01:17.485676 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 5 22:01:17.487543 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Aug 5 22:01:17.488749 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Aug 5 22:01:17.494444 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Aug 5 22:01:17.502229 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Aug 5 22:01:17.507034 systemd-journald[1105]: Time spent on flushing to /var/log/journal/1edea9a2ca184478a66a1560da91f683 is 39.687ms for 918 entries. Aug 5 22:01:17.507034 systemd-journald[1105]: System Journal (/var/log/journal/1edea9a2ca184478a66a1560da91f683) is 8.0M, max 195.6M, 187.6M free. Aug 5 22:01:17.587408 systemd-journald[1105]: Received client request to flush runtime journal. Aug 5 22:01:17.506224 systemd[1]: Starting systemd-sysusers.service - Create System Users... Aug 5 22:01:17.511224 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Aug 5 22:01:17.512784 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Aug 5 22:01:17.514433 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Aug 5 22:01:17.525823 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Aug 5 22:01:17.531769 (sd-merge)[1163]: No extensions found. Aug 5 22:01:17.532560 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Aug 5 22:01:17.542362 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Aug 5 22:01:17.545113 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Aug 5 22:01:17.548478 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Aug 5 22:01:17.554105 systemd[1]: Starting ensure-sysext.service... Aug 5 22:01:17.555587 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Aug 5 22:01:17.567194 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Aug 5 22:01:17.580317 udevadm[1170]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Aug 5 22:01:17.586195 systemd[1]: Reloading requested from client PID 1168 ('systemctl') (unit ensure-sysext.service)... Aug 5 22:01:17.586207 systemd[1]: Reloading... Aug 5 22:01:17.648971 zram_generator::config[1194]: No configuration found. Aug 5 22:01:17.838734 ldconfig[1151]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Aug 5 22:01:17.861326 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Aug 5 22:01:17.861805 systemd[1]: Reloading finished in 275 ms. Aug 5 22:01:17.882875 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Aug 5 22:01:17.884775 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Aug 5 22:01:17.887004 systemd[1]: Finished systemd-sysusers.service - Create System Users. Aug 5 22:01:17.889048 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Aug 5 22:01:17.912716 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Aug 5 22:01:17.915262 systemd[1]: Starting systemd-tmpfiles-setup.service - Create Volatile Files and Directories... Aug 5 22:01:17.918631 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Aug 5 22:01:17.919203 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 5 22:01:17.924256 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 5 22:01:17.927717 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 5 22:01:17.935123 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 5 22:01:17.938099 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 5 22:01:17.938274 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Aug 5 22:01:17.939616 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 5 22:01:17.939855 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 5 22:01:17.941932 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 5 22:01:17.942248 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 5 22:01:17.944273 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 5 22:01:17.944526 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 5 22:01:17.949368 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 5 22:01:17.949530 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Aug 5 22:01:17.951018 systemd-tmpfiles[1237]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Aug 5 22:01:17.951481 systemd-tmpfiles[1237]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Aug 5 22:01:17.951781 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Aug 5 22:01:17.951957 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 5 22:01:17.953154 systemd-tmpfiles[1237]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Aug 5 22:01:17.953348 systemd-tmpfiles[1236]: ACLs are not supported, ignoring. Aug 5 22:01:17.953368 systemd-tmpfiles[1236]: ACLs are not supported, ignoring. Aug 5 22:01:17.953524 systemd-tmpfiles[1237]: ACLs are not supported, ignoring. Aug 5 22:01:17.953623 systemd-tmpfiles[1237]: ACLs are not supported, ignoring. Aug 5 22:01:17.957562 systemd-tmpfiles[1237]: Detected autofs mount point /boot during canonicalization of boot. Aug 5 22:01:17.957571 systemd-tmpfiles[1237]: Skipping /boot Aug 5 22:01:17.968301 systemd-tmpfiles[1237]: Detected autofs mount point /boot during canonicalization of boot. Aug 5 22:01:17.968310 systemd-tmpfiles[1237]: Skipping /boot Aug 5 22:01:17.968339 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 5 22:01:17.973200 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 5 22:01:17.979025 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 5 22:01:17.980516 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 5 22:01:17.980704 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Aug 5 22:01:17.982263 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 5 22:01:17.984701 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 5 22:01:17.984999 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 5 22:01:17.990257 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 5 22:01:17.990477 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 5 22:01:17.995350 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 5 22:01:17.995587 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 5 22:01:18.001476 systemd[1]: Finished systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Aug 5 22:01:18.004543 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Aug 5 22:01:18.015459 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Aug 5 22:01:18.018753 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Aug 5 22:01:18.020490 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 5 22:01:18.030265 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 5 22:01:18.033358 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Aug 5 22:01:18.038826 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 5 22:01:18.043684 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 5 22:01:18.048196 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 5 22:01:18.050194 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Aug 5 22:01:18.056628 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Aug 5 22:01:18.060861 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Aug 5 22:01:18.062992 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Aug 5 22:01:18.065530 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 5 22:01:18.065796 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 5 22:01:18.068324 systemd[1]: modprobe@drm.service: Deactivated successfully. Aug 5 22:01:18.068536 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Aug 5 22:01:18.071022 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 5 22:01:18.071247 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 5 22:01:18.074131 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 5 22:01:18.074362 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 5 22:01:18.078507 systemd[1]: Finished ensure-sysext.service. Aug 5 22:01:18.086438 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 5 22:01:18.086628 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Aug 5 22:01:18.099244 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Aug 5 22:01:18.109254 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Aug 5 22:01:18.113630 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Aug 5 22:01:18.113781 augenrules[1279]: No rules Aug 5 22:01:18.117885 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Aug 5 22:01:18.128642 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Aug 5 22:01:18.145968 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Aug 5 22:01:18.147664 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). Aug 5 22:01:18.151554 systemd[1]: Started systemd-userdbd.service - User Database Manager. Aug 5 22:01:18.170339 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Aug 5 22:01:18.174147 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 5 22:01:18.177435 systemd[1]: Starting systemd-update-done.service - Update is Completed... Aug 5 22:01:18.193865 systemd[1]: Finished systemd-update-done.service - Update is Completed. Aug 5 22:01:18.213179 systemd-udevd[1300]: Using default interface naming scheme 'v255'. Aug 5 22:01:18.229437 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 5 22:01:18.231215 systemd-resolved[1275]: Positive Trust Anchors: Aug 5 22:01:18.231234 systemd-resolved[1275]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Aug 5 22:01:18.231275 systemd-resolved[1275]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa corp home internal intranet lan local private test Aug 5 22:01:18.240817 systemd-resolved[1275]: Defaulting to hostname 'linux'. Aug 5 22:01:18.243154 systemd[1]: Starting systemd-networkd.service - Network Configuration... Aug 5 22:01:18.244669 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Aug 5 22:01:18.247831 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Aug 5 22:01:18.254460 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Aug 5 22:01:18.256374 systemd[1]: Reached target time-set.target - System Time Set. Aug 5 22:01:18.276984 kernel: BTRFS info: devid 1 device path /dev/mapper/usr changed to /dev/dm-0 scanned by (udev-worker) (1315) Aug 5 22:01:18.284312 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Aug 5 22:01:18.299959 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 36 scanned by (udev-worker) (1318) Aug 5 22:01:18.315501 systemd-networkd[1310]: lo: Link UP Aug 5 22:01:18.315517 systemd-networkd[1310]: lo: Gained carrier Aug 5 22:01:18.318800 systemd-networkd[1310]: Enumeration completed Aug 5 22:01:18.318910 systemd[1]: Started systemd-networkd.service - Network Configuration. Aug 5 22:01:18.320796 systemd[1]: Reached target network.target - Network. Aug 5 22:01:18.322438 systemd-networkd[1310]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 5 22:01:18.322449 systemd-networkd[1310]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Aug 5 22:01:18.323484 systemd-networkd[1310]: eth0: Link UP Aug 5 22:01:18.323496 systemd-networkd[1310]: eth0: Gained carrier Aug 5 22:01:18.323513 systemd-networkd[1310]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 5 22:01:18.329198 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Aug 5 22:01:18.338023 systemd-networkd[1310]: eth0: DHCPv4 address 10.0.0.17/16, gateway 10.0.0.1 acquired from 10.0.0.1 Aug 5 22:01:18.339975 systemd-timesyncd[1285]: Network configuration changed, trying to establish connection. Aug 5 22:01:19.202862 systemd-timesyncd[1285]: Contacted time server 10.0.0.1:123 (10.0.0.1). Aug 5 22:01:19.202930 systemd-timesyncd[1285]: Initial clock synchronization to Mon 2024-08-05 22:01:19.202746 UTC. Aug 5 22:01:19.203040 systemd-resolved[1275]: Clock change detected. Flushing caches. Aug 5 22:01:19.208228 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Aug 5 22:01:19.210464 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2 Aug 5 22:01:19.214026 kernel: piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 Aug 5 22:01:19.216049 kernel: ACPI: button: Power Button [PWRF] Aug 5 22:01:19.217184 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Aug 5 22:01:19.235397 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Aug 5 22:01:19.236189 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3 Aug 5 22:01:19.264970 kernel: mousedev: PS/2 mouse device common for all mice Aug 5 22:01:19.272325 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 5 22:01:19.447584 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:01:19.492460 kernel: kvm_amd: TSC scaling supported Aug 5 22:01:19.492635 kernel: kvm_amd: Nested Virtualization enabled Aug 5 22:01:19.492667 kernel: kvm_amd: Nested Paging enabled Aug 5 22:01:19.492687 kernel: kvm_amd: LBR virtualization supported Aug 5 22:01:19.493998 kernel: kvm_amd: Virtual VMLOAD VMSAVE supported Aug 5 22:01:19.495338 kernel: kvm_amd: Virtual GIF supported Aug 5 22:01:19.566993 kernel: EDAC MC: Ver: 3.0.0 Aug 5 22:01:19.600549 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Aug 5 22:01:19.618439 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Aug 5 22:01:19.640183 lvm[1349]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Aug 5 22:01:19.694869 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Aug 5 22:01:19.700143 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Aug 5 22:01:19.701852 systemd[1]: Reached target sysinit.target - System Initialization. Aug 5 22:01:19.705613 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Aug 5 22:01:19.707893 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Aug 5 22:01:19.710120 systemd[1]: Started logrotate.timer - Daily rotation of log files. Aug 5 22:01:19.711866 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Aug 5 22:01:19.713653 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Aug 5 22:01:19.715503 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Aug 5 22:01:19.715553 systemd[1]: Reached target paths.target - Path Units. Aug 5 22:01:19.716937 systemd[1]: Reached target timers.target - Timer Units. Aug 5 22:01:19.720919 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Aug 5 22:01:19.735597 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Aug 5 22:01:19.737235 systemd[1]: Reached target sockets.target - Socket Units. Aug 5 22:01:19.738440 systemd[1]: Reached target basic.target - Basic System. Aug 5 22:01:19.739552 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Aug 5 22:01:19.739596 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Aug 5 22:01:19.749355 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Aug 5 22:01:19.760750 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Aug 5 22:01:19.768175 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Aug 5 22:01:19.770618 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). Aug 5 22:01:19.772371 jq[1353]: false Aug 5 22:01:19.773826 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Aug 5 22:01:19.778403 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Aug 5 22:01:19.788867 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Aug 5 22:01:19.794181 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Aug 5 22:01:19.809499 lvm[1355]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Aug 5 22:01:19.801972 dbus-daemon[1352]: [system] SELinux support is enabled Aug 5 22:01:19.812470 extend-filesystems[1354]: Found sr0 Aug 5 22:01:19.812470 extend-filesystems[1354]: Found vda Aug 5 22:01:19.812470 extend-filesystems[1354]: Found vda1 Aug 5 22:01:19.812470 extend-filesystems[1354]: Found vda2 Aug 5 22:01:19.812470 extend-filesystems[1354]: Found vda3 Aug 5 22:01:19.812470 extend-filesystems[1354]: Found usr Aug 5 22:01:19.812470 extend-filesystems[1354]: Found vda4 Aug 5 22:01:19.812470 extend-filesystems[1354]: Found vda6 Aug 5 22:01:19.812470 extend-filesystems[1354]: Found vda7 Aug 5 22:01:19.812470 extend-filesystems[1354]: Found vda9 Aug 5 22:01:19.812470 extend-filesystems[1354]: Checking size of /dev/vda9 Aug 5 22:01:19.822258 systemd[1]: Starting systemd-logind.service - User Login Management... Aug 5 22:01:19.826968 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Aug 5 22:01:19.827606 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Aug 5 22:01:19.830404 systemd[1]: Starting update-engine.service - Update Engine... Aug 5 22:01:19.836263 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Aug 5 22:01:19.840191 systemd[1]: Started dbus.service - D-Bus System Message Bus. Aug 5 22:01:19.843409 extend-filesystems[1354]: Old size kept for /dev/vda9 Aug 5 22:01:19.850140 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Aug 5 22:01:19.850436 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Aug 5 22:01:19.850874 systemd[1]: extend-filesystems.service: Deactivated successfully. Aug 5 22:01:19.851186 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Aug 5 22:01:19.851246 jq[1371]: true Aug 5 22:01:19.853482 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Aug 5 22:01:19.855614 systemd[1]: motdgen.service: Deactivated successfully. Aug 5 22:01:19.855863 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Aug 5 22:01:19.858666 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Aug 5 22:01:19.858919 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Aug 5 22:01:19.861033 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 36 scanned by (udev-worker) (1315) Aug 5 22:01:19.884308 update_engine[1370]: I0805 22:01:19.884208 1370 main.cc:92] Flatcar Update Engine starting Aug 5 22:01:19.887703 update_engine[1370]: I0805 22:01:19.886058 1370 update_check_scheduler.cc:74] Next update check in 5m34s Aug 5 22:01:19.892514 jq[1375]: true Aug 5 22:01:19.913625 systemd-logind[1366]: Watching system buttons on /dev/input/event1 (Power Button) Aug 5 22:01:19.913658 systemd-logind[1366]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Aug 5 22:01:19.915406 systemd-logind[1366]: New seat seat0. Aug 5 22:01:19.919789 systemd[1]: Started update-engine.service - Update Engine. Aug 5 22:01:19.925910 systemd[1]: Started systemd-logind.service - User Login Management. Aug 5 22:01:19.929619 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). Aug 5 22:01:19.929838 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Aug 5 22:01:19.931776 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). Aug 5 22:01:19.931945 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Aug 5 22:01:19.944236 systemd[1]: Started locksmithd.service - Cluster reboot manager. Aug 5 22:01:19.967276 bash[1399]: Updated "/home/core/.ssh/authorized_keys" Aug 5 22:01:19.968190 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Aug 5 22:01:19.970892 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Aug 5 22:01:19.990511 locksmithd[1398]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Aug 5 22:01:20.044212 sshd_keygen[1374]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Aug 5 22:01:20.075879 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Aug 5 22:01:20.092461 systemd[1]: Starting issuegen.service - Generate /run/issue... Aug 5 22:01:20.104140 systemd[1]: issuegen.service: Deactivated successfully. Aug 5 22:01:20.104453 systemd[1]: Finished issuegen.service - Generate /run/issue. Aug 5 22:01:20.119436 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Aug 5 22:01:20.145122 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Aug 5 22:01:20.161398 systemd[1]: Started getty@tty1.service - Getty on tty1. Aug 5 22:01:20.165019 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Aug 5 22:01:20.166409 systemd[1]: Reached target getty.target - Login Prompts. Aug 5 22:01:20.779189 systemd-networkd[1310]: eth0: Gained IPv6LL Aug 5 22:01:20.782463 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Aug 5 22:01:20.784593 systemd[1]: Reached target network-online.target - Network is Online. Aug 5 22:01:20.798220 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Aug 5 22:01:20.814699 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Aug 5 22:01:20.837146 systemd[1]: coreos-metadata.service: Deactivated successfully. Aug 5 22:01:20.837388 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Aug 5 22:01:20.839550 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Aug 5 22:01:20.842061 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Aug 5 22:01:20.843837 systemd[1]: Reached target multi-user.target - Multi-User System. Aug 5 22:01:20.845371 systemd[1]: Startup finished in 1.230s (kernel) + 5.851s (initrd) + 3.413s (userspace) = 10.495s. Aug 5 22:01:29.372234 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Aug 5 22:01:29.373521 systemd[1]: Started sshd@0-10.0.0.17:22-10.0.0.1:45066.service - OpenSSH per-connection server daemon (10.0.0.1:45066). Aug 5 22:01:29.415209 sshd[1442]: Accepted publickey for core from 10.0.0.1 port 45066 ssh2: RSA SHA256:/wAyea3vP9dXQlCAyE/d+D0JDO90hh/Jr57IUMqxZQo Aug 5 22:01:29.417348 sshd[1442]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:01:29.427562 systemd-logind[1366]: New session 1 of user core. Aug 5 22:01:29.429081 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Aug 5 22:01:29.445393 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Aug 5 22:01:29.457635 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Aug 5 22:01:29.467379 systemd[1]: Starting user@500.service - User Manager for UID 500... Aug 5 22:01:29.470267 (systemd)[1446]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:01:29.582599 systemd[1446]: Queued start job for default target default.target. Aug 5 22:01:29.593400 systemd[1446]: Created slice app.slice - User Application Slice. Aug 5 22:01:29.593426 systemd[1446]: Reached target paths.target - Paths. Aug 5 22:01:29.593439 systemd[1446]: Reached target timers.target - Timers. Aug 5 22:01:29.595010 systemd[1446]: Starting dbus.socket - D-Bus User Message Bus Socket... Aug 5 22:01:29.607193 systemd[1446]: Listening on dbus.socket - D-Bus User Message Bus Socket. Aug 5 22:01:29.607366 systemd[1446]: Reached target sockets.target - Sockets. Aug 5 22:01:29.607391 systemd[1446]: Reached target basic.target - Basic System. Aug 5 22:01:29.607435 systemd[1446]: Reached target default.target - Main User Target. Aug 5 22:01:29.607479 systemd[1446]: Startup finished in 130ms. Aug 5 22:01:29.607722 systemd[1]: Started user@500.service - User Manager for UID 500. Aug 5 22:01:29.609375 systemd[1]: Started session-1.scope - Session 1 of User core. Aug 5 22:01:29.670364 systemd[1]: Started sshd@1-10.0.0.17:22-10.0.0.1:45072.service - OpenSSH per-connection server daemon (10.0.0.1:45072). Aug 5 22:01:29.707103 sshd[1457]: Accepted publickey for core from 10.0.0.1 port 45072 ssh2: RSA SHA256:/wAyea3vP9dXQlCAyE/d+D0JDO90hh/Jr57IUMqxZQo Aug 5 22:01:29.708710 sshd[1457]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:01:29.712881 systemd-logind[1366]: New session 2 of user core. Aug 5 22:01:29.721153 systemd[1]: Started session-2.scope - Session 2 of User core. Aug 5 22:01:29.777012 sshd[1457]: pam_unix(sshd:session): session closed for user core Aug 5 22:01:29.795651 systemd[1]: sshd@1-10.0.0.17:22-10.0.0.1:45072.service: Deactivated successfully. Aug 5 22:01:29.797982 systemd[1]: session-2.scope: Deactivated successfully. Aug 5 22:01:29.799415 systemd-logind[1366]: Session 2 logged out. Waiting for processes to exit. Aug 5 22:01:29.809273 systemd[1]: Started sshd@2-10.0.0.17:22-10.0.0.1:45076.service - OpenSSH per-connection server daemon (10.0.0.1:45076). Aug 5 22:01:29.810442 systemd-logind[1366]: Removed session 2. Aug 5 22:01:29.836779 sshd[1464]: Accepted publickey for core from 10.0.0.1 port 45076 ssh2: RSA SHA256:/wAyea3vP9dXQlCAyE/d+D0JDO90hh/Jr57IUMqxZQo Aug 5 22:01:29.838643 sshd[1464]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:01:29.843164 systemd-logind[1366]: New session 3 of user core. Aug 5 22:01:29.853194 systemd[1]: Started session-3.scope - Session 3 of User core. Aug 5 22:01:29.904934 sshd[1464]: pam_unix(sshd:session): session closed for user core Aug 5 22:01:29.925001 systemd[1]: sshd@2-10.0.0.17:22-10.0.0.1:45076.service: Deactivated successfully. Aug 5 22:01:29.926804 systemd[1]: session-3.scope: Deactivated successfully. Aug 5 22:01:29.928242 systemd-logind[1366]: Session 3 logged out. Waiting for processes to exit. Aug 5 22:01:29.934311 systemd[1]: Started sshd@3-10.0.0.17:22-10.0.0.1:45086.service - OpenSSH per-connection server daemon (10.0.0.1:45086). Aug 5 22:01:29.935400 systemd-logind[1366]: Removed session 3. Aug 5 22:01:29.960663 sshd[1471]: Accepted publickey for core from 10.0.0.1 port 45086 ssh2: RSA SHA256:/wAyea3vP9dXQlCAyE/d+D0JDO90hh/Jr57IUMqxZQo Aug 5 22:01:29.962802 sshd[1471]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:01:29.966739 systemd-logind[1366]: New session 4 of user core. Aug 5 22:01:29.976092 systemd[1]: Started session-4.scope - Session 4 of User core. Aug 5 22:01:30.031782 sshd[1471]: pam_unix(sshd:session): session closed for user core Aug 5 22:01:30.047928 systemd[1]: sshd@3-10.0.0.17:22-10.0.0.1:45086.service: Deactivated successfully. Aug 5 22:01:30.049490 systemd[1]: session-4.scope: Deactivated successfully. Aug 5 22:01:30.051195 systemd-logind[1366]: Session 4 logged out. Waiting for processes to exit. Aug 5 22:01:30.052274 systemd[1]: Started sshd@4-10.0.0.17:22-10.0.0.1:45100.service - OpenSSH per-connection server daemon (10.0.0.1:45100). Aug 5 22:01:30.053384 systemd-logind[1366]: Removed session 4. Aug 5 22:01:30.086196 sshd[1479]: Accepted publickey for core from 10.0.0.1 port 45100 ssh2: RSA SHA256:/wAyea3vP9dXQlCAyE/d+D0JDO90hh/Jr57IUMqxZQo Aug 5 22:01:30.087798 sshd[1479]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:01:30.092676 systemd-logind[1366]: New session 5 of user core. Aug 5 22:01:30.111160 systemd[1]: Started session-5.scope - Session 5 of User core. Aug 5 22:01:30.168775 sudo[1482]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Aug 5 22:01:30.169039 sudo[1482]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Aug 5 22:01:30.194273 sudo[1482]: pam_unix(sudo:session): session closed for user root Aug 5 22:01:30.196600 sshd[1479]: pam_unix(sshd:session): session closed for user core Aug 5 22:01:30.209805 systemd[1]: sshd@4-10.0.0.17:22-10.0.0.1:45100.service: Deactivated successfully. Aug 5 22:01:30.212444 systemd[1]: session-5.scope: Deactivated successfully. Aug 5 22:01:30.214678 systemd-logind[1366]: Session 5 logged out. Waiting for processes to exit. Aug 5 22:01:30.228390 systemd[1]: Started sshd@5-10.0.0.17:22-10.0.0.1:45114.service - OpenSSH per-connection server daemon (10.0.0.1:45114). Aug 5 22:01:30.229743 systemd-logind[1366]: Removed session 5. Aug 5 22:01:30.257822 sshd[1487]: Accepted publickey for core from 10.0.0.1 port 45114 ssh2: RSA SHA256:/wAyea3vP9dXQlCAyE/d+D0JDO90hh/Jr57IUMqxZQo Aug 5 22:01:30.260102 sshd[1487]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:01:30.264764 systemd-logind[1366]: New session 6 of user core. Aug 5 22:01:30.274135 systemd[1]: Started session-6.scope - Session 6 of User core. Aug 5 22:01:30.327782 sudo[1491]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Aug 5 22:01:30.328057 sudo[1491]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Aug 5 22:01:30.332869 sudo[1491]: pam_unix(sudo:session): session closed for user root Aug 5 22:01:30.339875 sudo[1490]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules Aug 5 22:01:30.340224 sudo[1490]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Aug 5 22:01:30.361365 systemd[1]: Stopping audit-rules.service - Load Security Auditing Rules... Aug 5 22:01:30.363060 auditctl[1494]: No rules Aug 5 22:01:30.363534 systemd[1]: audit-rules.service: Deactivated successfully. Aug 5 22:01:30.363805 systemd[1]: Stopped audit-rules.service - Load Security Auditing Rules. Aug 5 22:01:30.366536 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Aug 5 22:01:30.398093 augenrules[1512]: No rules Aug 5 22:01:30.399075 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Aug 5 22:01:30.400535 sudo[1490]: pam_unix(sudo:session): session closed for user root Aug 5 22:01:30.402649 sshd[1487]: pam_unix(sshd:session): session closed for user core Aug 5 22:01:30.418026 systemd[1]: sshd@5-10.0.0.17:22-10.0.0.1:45114.service: Deactivated successfully. Aug 5 22:01:30.419862 systemd[1]: session-6.scope: Deactivated successfully. Aug 5 22:01:30.421343 systemd-logind[1366]: Session 6 logged out. Waiting for processes to exit. Aug 5 22:01:30.432315 systemd[1]: Started sshd@6-10.0.0.17:22-10.0.0.1:45126.service - OpenSSH per-connection server daemon (10.0.0.1:45126). Aug 5 22:01:30.433440 systemd-logind[1366]: Removed session 6. Aug 5 22:01:30.464008 sshd[1520]: Accepted publickey for core from 10.0.0.1 port 45126 ssh2: RSA SHA256:/wAyea3vP9dXQlCAyE/d+D0JDO90hh/Jr57IUMqxZQo Aug 5 22:01:30.465845 sshd[1520]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:01:30.469860 systemd-logind[1366]: New session 7 of user core. Aug 5 22:01:30.479166 systemd[1]: Started session-7.scope - Session 7 of User core. Aug 5 22:01:30.529271 sshd[1520]: pam_unix(sshd:session): session closed for user core Aug 5 22:01:30.542179 systemd[1]: sshd@6-10.0.0.17:22-10.0.0.1:45126.service: Deactivated successfully. Aug 5 22:01:30.544156 systemd[1]: session-7.scope: Deactivated successfully. Aug 5 22:01:30.545538 systemd-logind[1366]: Session 7 logged out. Waiting for processes to exit. Aug 5 22:01:30.546820 systemd[1]: Started sshd@7-10.0.0.17:22-10.0.0.1:45136.service - OpenSSH per-connection server daemon (10.0.0.1:45136). Aug 5 22:01:30.547720 systemd-logind[1366]: Removed session 7. Aug 5 22:01:30.577270 sshd[1528]: Accepted publickey for core from 10.0.0.1 port 45136 ssh2: RSA SHA256:/wAyea3vP9dXQlCAyE/d+D0JDO90hh/Jr57IUMqxZQo Aug 5 22:01:30.578663 sshd[1528]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:01:30.582730 systemd-logind[1366]: New session 8 of user core. Aug 5 22:01:30.593230 systemd[1]: Started session-8.scope - Session 8 of User core. Aug 5 22:01:31.154338 sshd[1528]: pam_unix(sshd:session): session closed for user core Aug 5 22:01:31.162591 systemd[1]: sshd@7-10.0.0.17:22-10.0.0.1:45136.service: Deactivated successfully. Aug 5 22:01:31.164750 systemd[1]: session-8.scope: Deactivated successfully. Aug 5 22:01:31.166355 systemd-logind[1366]: Session 8 logged out. Waiting for processes to exit. Aug 5 22:01:31.181335 systemd[1]: Started sshd@8-10.0.0.17:22-10.0.0.1:39942.service - OpenSSH per-connection server daemon (10.0.0.1:39942). Aug 5 22:01:31.182317 systemd-logind[1366]: Removed session 8. Aug 5 22:01:31.209813 sshd[1544]: Accepted publickey for core from 10.0.0.1 port 39942 ssh2: RSA SHA256:/wAyea3vP9dXQlCAyE/d+D0JDO90hh/Jr57IUMqxZQo Aug 5 22:01:31.211806 sshd[1544]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:01:31.216282 systemd-logind[1366]: New session 9 of user core. Aug 5 22:01:31.226130 systemd[1]: Started session-9.scope - Session 9 of User core. Aug 5 22:01:57.799369 sudo[1547]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/mv docker.raw containerd.raw /etc/extensions/ Aug 5 22:01:57.802256 sudo[1547]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Aug 5 22:01:58.507337 sudo[1547]: pam_unix(sudo:session): session closed for user root Aug 5 22:01:58.517025 sshd[1544]: pam_unix(sshd:session): session closed for user core Aug 5 22:01:58.554481 systemd[1]: Started sshd@9-10.0.0.17:22-10.0.0.1:59576.service - OpenSSH per-connection server daemon (10.0.0.1:59576). Aug 5 22:01:58.555304 systemd[1]: sshd@8-10.0.0.17:22-10.0.0.1:39942.service: Deactivated successfully. Aug 5 22:01:58.566811 systemd[1]: session-9.scope: Deactivated successfully. Aug 5 22:01:58.577287 systemd[1]: session-9.scope: Consumed 20.817s CPU time. Aug 5 22:01:58.603391 systemd-logind[1366]: Session 9 logged out. Waiting for processes to exit. Aug 5 22:01:58.614894 systemd-logind[1366]: Removed session 9. Aug 5 22:01:58.640946 sshd[1603]: Accepted publickey for core from 10.0.0.1 port 59576 ssh2: RSA SHA256:/wAyea3vP9dXQlCAyE/d+D0JDO90hh/Jr57IUMqxZQo Aug 5 22:01:58.652997 sshd[1603]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:01:58.668005 systemd-logind[1366]: New session 10 of user core. Aug 5 22:01:58.687299 systemd[1]: Started session-10.scope - Session 10 of User core. Aug 5 22:01:58.764591 sudo[1608]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart systemd-sysext Aug 5 22:01:58.766041 sudo[1608]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Aug 5 22:01:58.791161 systemd[1]: ensure-sysext.service: Deactivated successfully. Aug 5 22:01:58.792214 systemd[1]: Stopped ensure-sysext.service. Aug 5 22:01:58.792341 systemd[1]: Stopping ensure-sysext.service... Aug 5 22:01:58.807325 systemd[1]: Stopping systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Aug 5 22:01:58.819291 systemd[1]: systemd-sysext.service: Deactivated successfully. Aug 5 22:01:58.822104 systemd[1]: Stopped systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Aug 5 22:01:58.846615 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Aug 5 22:01:58.860010 kernel: loop0: detected capacity change from 0 to 301320 Aug 5 22:01:58.863738 kernel: block loop0: the capability attribute has been deprecated. Aug 5 22:01:58.929008 kernel: EXT4-fs (loop0): mounted filesystem 136ca7b1-7479-40bf-9215-7c43c979c7df ro without journal. Quota mode: none. Aug 5 22:01:58.949100 kernel: EXT4-fs (loop0): unmounting filesystem 136ca7b1-7479-40bf-9215-7c43c979c7df. Aug 5 22:01:59.014818 kernel: loop1: detected capacity change from 0 to 322896 Aug 5 22:01:59.084289 kernel: EXT4-fs (loop1): mounted filesystem 7d690981-5d3c-4f74-8692-91f9ab72d235 ro without journal. Quota mode: none. Aug 5 22:01:59.108174 kernel: EXT4-fs (loop1): unmounting filesystem 7d690981-5d3c-4f74-8692-91f9ab72d235. Aug 5 22:01:59.148912 kernel: loop2: detected capacity change from 0 to 301320 Aug 5 22:01:59.199859 kernel: EXT4-fs (loop2): mounted filesystem 136ca7b1-7479-40bf-9215-7c43c979c7df ro without journal. Quota mode: none. Aug 5 22:01:59.204816 kernel: loop3: detected capacity change from 0 to 322896 Aug 5 22:01:59.233998 kernel: EXT4-fs (loop3): mounted filesystem 7d690981-5d3c-4f74-8692-91f9ab72d235 ro without journal. Quota mode: none. Aug 5 22:01:59.234822 (sd-merge)[1619]: Using extensions 'containerd', 'docker'. Aug 5 22:01:59.236001 (sd-merge)[1619]: Merged extensions into '/usr'. Aug 5 22:01:59.255562 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Aug 5 22:01:59.269386 sudo[1608]: pam_unix(sudo:session): session closed for user root Aug 5 22:01:59.273786 sshd[1603]: pam_unix(sshd:session): session closed for user core Aug 5 22:01:59.282895 systemd[1]: Starting ensure-sysext.service... Aug 5 22:01:59.327000 systemd[1]: sshd@9-10.0.0.17:22-10.0.0.1:59576.service: Deactivated successfully. Aug 5 22:01:59.329659 systemd[1]: session-10.scope: Deactivated successfully. Aug 5 22:01:59.342082 systemd-logind[1366]: Session 10 logged out. Waiting for processes to exit. Aug 5 22:01:59.372720 systemd[1]: Started sshd@10-10.0.0.17:22-10.0.0.1:59586.service - OpenSSH per-connection server daemon (10.0.0.1:59586). Aug 5 22:01:59.377169 systemd[1]: Reloading requested from client PID 1623 ('systemctl') (unit ensure-sysext.service)... Aug 5 22:01:59.377190 systemd[1]: Reloading... Aug 5 22:01:59.595603 zram_generator::config[1668]: No configuration found. Aug 5 22:02:00.380239 systemd[1]: /usr/lib/systemd/system/docker.socket:5: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Aug 5 22:02:00.488925 systemd[1]: Reloading finished in 1111 ms. Aug 5 22:02:00.581362 systemd-logind[1366]: Removed session 10. Aug 5 22:02:00.598384 systemd[1]: Stopped target sockets.target - Socket Units. Aug 5 22:02:00.598417 systemd[1]: Stopping sockets.target - Socket Units... Aug 5 22:02:00.603328 systemd[1]: Starting docker.socket - Docker Socket for the API... Aug 5 22:02:00.626175 systemd[1]: Starting containerd.service - containerd container runtime... Aug 5 22:02:00.627917 systemd[1]: Listening on docker.socket - Docker Socket for the API. Aug 5 22:02:00.628395 systemd[1]: Reached target sockets.target - Socket Units. Aug 5 22:02:00.633296 systemd[1]: Stopped target timers.target - Timer Units. Aug 5 22:02:00.633750 systemd[1]: Stopping timers.target - Timer Units... Aug 5 22:02:00.637187 systemd[1]: Reached target timers.target - Timer Units. Aug 5 22:02:00.650179 systemd[1]: Started containerd.service - containerd container runtime. Aug 5 22:02:00.675621 systemd[1]: Stopped target multi-user.target - Multi-User System. Aug 5 22:02:00.675658 systemd[1]: Stopping multi-user.target - Multi-User System... Aug 5 22:02:00.675734 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Aug 5 22:02:00.690559 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Aug 5 22:02:00.697320 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Aug 5 22:02:00.713480 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Aug 5 22:02:00.737271 jq[1707]: false Aug 5 22:02:00.745706 systemd[1]: Starting issuegen.service - Generate /run/issue... Aug 5 22:02:00.747917 sshd[1627]: Accepted publickey for core from 10.0.0.1 port 59586 ssh2: RSA SHA256:/wAyea3vP9dXQlCAyE/d+D0JDO90hh/Jr57IUMqxZQo Aug 5 22:02:00.750844 sshd[1627]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:02:00.751878 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Aug 5 22:02:00.766841 extend-filesystems[1708]: Found loop2 Aug 5 22:02:00.766841 extend-filesystems[1708]: Found loop3 Aug 5 22:02:00.766841 extend-filesystems[1708]: Found sr0 Aug 5 22:02:00.766841 extend-filesystems[1708]: Found vda Aug 5 22:02:00.766841 extend-filesystems[1708]: Found vda1 Aug 5 22:02:00.766841 extend-filesystems[1708]: Found vda2 Aug 5 22:02:00.766841 extend-filesystems[1708]: Found vda3 Aug 5 22:02:00.766841 extend-filesystems[1708]: Found usr Aug 5 22:02:00.766841 extend-filesystems[1708]: Found vda4 Aug 5 22:02:00.766841 extend-filesystems[1708]: Found vda6 Aug 5 22:02:00.766841 extend-filesystems[1708]: Found vda7 Aug 5 22:02:00.766841 extend-filesystems[1708]: Found vda9 Aug 5 22:02:00.766841 extend-filesystems[1708]: Checking size of /dev/vda9 Aug 5 22:02:00.775708 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Aug 5 22:02:00.776116 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Aug 5 22:02:00.776364 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Aug 5 22:02:00.812130 extend-filesystems[1708]: Old size kept for /dev/vda9 Aug 5 22:02:00.814785 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Aug 5 22:02:00.815055 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Aug 5 22:02:00.815693 systemd[1]: extend-filesystems.service: Deactivated successfully. Aug 5 22:02:00.815987 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Aug 5 22:02:00.816782 systemd[1]: issuegen.service: Deactivated successfully. Aug 5 22:02:00.817040 systemd[1]: Finished issuegen.service - Generate /run/issue. Aug 5 22:02:00.817704 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Aug 5 22:02:00.828486 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Aug 5 22:02:00.835009 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 36 scanned by (udev-worker) (1727) Aug 5 22:02:00.858205 systemd[1]: Finished ensure-sysext.service. Aug 5 22:02:00.875710 systemd[1]: motdgen.service: Deactivated successfully. Aug 5 22:02:00.876069 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Aug 5 22:02:00.884152 systemd[1]: coreos-metadata.service: Deactivated successfully. Aug 5 22:02:00.884435 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Aug 5 22:02:00.929979 systemd-logind[1366]: New session 11 of user core. Aug 5 22:02:00.966309 systemd[1]: Started session-11.scope - Session 11 of User core. Aug 5 22:02:00.967034 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because of an unmet condition check (ConditionFirstBoot=true). Aug 5 22:02:00.967214 systemd[1]: Reached target multi-user.target - Multi-User System. Aug 5 22:02:01.142817 containerd[1704]: time="2024-08-05T22:02:01.140674324Z" level=info msg="starting containerd" revision=1c90a442489720eec95342e1789ee8a5e1b9536f version=v1.6.9 Aug 5 22:02:01.197871 containerd[1704]: time="2024-08-05T22:02:01.197154192Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Aug 5 22:02:01.197871 containerd[1704]: time="2024-08-05T22:02:01.197407635Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:02:01.203528 containerd[1704]: time="2024-08-05T22:02:01.202001833Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.43-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Aug 5 22:02:01.203528 containerd[1704]: time="2024-08-05T22:02:01.202084290Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:02:01.203528 containerd[1704]: time="2024-08-05T22:02:01.202401864Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Aug 5 22:02:01.203528 containerd[1704]: time="2024-08-05T22:02:01.202424668Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Aug 5 22:02:01.203528 containerd[1704]: time="2024-08-05T22:02:01.202442782Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Aug 5 22:02:01.203528 containerd[1704]: time="2024-08-05T22:02:01.202456628Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Aug 5 22:02:01.203528 containerd[1704]: time="2024-08-05T22:02:01.202578601Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:02:01.203528 containerd[1704]: time="2024-08-05T22:02:01.202926011Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:02:01.207251 containerd[1704]: time="2024-08-05T22:02:01.204021314Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Aug 5 22:02:01.207251 containerd[1704]: time="2024-08-05T22:02:01.204055389Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Aug 5 22:02:01.207251 containerd[1704]: time="2024-08-05T22:02:01.204145421Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Aug 5 22:02:01.207251 containerd[1704]: time="2024-08-05T22:02:01.204164627Z" level=info msg="metadata content store policy set" policy=shared Aug 5 22:02:01.236242 containerd[1704]: time="2024-08-05T22:02:01.236060916Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Aug 5 22:02:01.236242 containerd[1704]: time="2024-08-05T22:02:01.236141810Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Aug 5 22:02:01.236242 containerd[1704]: time="2024-08-05T22:02:01.236161056Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Aug 5 22:02:01.236242 containerd[1704]: time="2024-08-05T22:02:01.236207115Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Aug 5 22:02:01.236242 containerd[1704]: time="2024-08-05T22:02:01.236232913Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Aug 5 22:02:01.236242 containerd[1704]: time="2024-08-05T22:02:01.236250417Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Aug 5 22:02:01.236242 containerd[1704]: time="2024-08-05T22:02:01.236267268Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Aug 5 22:02:01.237793 containerd[1704]: time="2024-08-05T22:02:01.236726743Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Aug 5 22:02:01.237793 containerd[1704]: time="2024-08-05T22:02:01.236746440Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1 Aug 5 22:02:01.237793 containerd[1704]: time="2024-08-05T22:02:01.236768192Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Aug 5 22:02:01.237793 containerd[1704]: time="2024-08-05T22:02:01.236783591Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Aug 5 22:02:01.237793 containerd[1704]: time="2024-08-05T22:02:01.236799160Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Aug 5 22:02:01.237793 containerd[1704]: time="2024-08-05T22:02:01.237018437Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Aug 5 22:02:01.237793 containerd[1704]: time="2024-08-05T22:02:01.237131342Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Aug 5 22:02:01.250075 containerd[1704]: time="2024-08-05T22:02:01.248133659Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Aug 5 22:02:01.250075 containerd[1704]: time="2024-08-05T22:02:01.248222548Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Aug 5 22:02:01.250075 containerd[1704]: time="2024-08-05T22:02:01.248245562Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Aug 5 22:02:01.250075 containerd[1704]: time="2024-08-05T22:02:01.248312469Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Aug 5 22:02:01.250075 containerd[1704]: time="2024-08-05T22:02:01.248331806Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Aug 5 22:02:01.250075 containerd[1704]: time="2024-08-05T22:02:01.248350501Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Aug 5 22:02:01.250075 containerd[1704]: time="2024-08-05T22:02:01.248368636Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Aug 5 22:02:01.250075 containerd[1704]: time="2024-08-05T22:02:01.248387552Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Aug 5 22:02:01.250075 containerd[1704]: time="2024-08-05T22:02:01.248407169Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Aug 5 22:02:01.250075 containerd[1704]: time="2024-08-05T22:02:01.248424923Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Aug 5 22:02:01.250075 containerd[1704]: time="2024-08-05T22:02:01.248441916Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Aug 5 22:02:01.250075 containerd[1704]: time="2024-08-05T22:02:01.248461903Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Aug 5 22:02:01.250075 containerd[1704]: time="2024-08-05T22:02:01.248840003Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Aug 5 22:02:01.250075 containerd[1704]: time="2024-08-05T22:02:01.248865902Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Aug 5 22:02:01.250075 containerd[1704]: time="2024-08-05T22:02:01.248885640Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Aug 5 22:02:01.250636 containerd[1704]: time="2024-08-05T22:02:01.248918192Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Aug 5 22:02:01.250636 containerd[1704]: time="2024-08-05T22:02:01.248940734Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="no OpenTelemetry endpoint: skip plugin" type=io.containerd.tracing.processor.v1 Aug 5 22:02:01.250636 containerd[1704]: time="2024-08-05T22:02:01.248985148Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Aug 5 22:02:01.250636 containerd[1704]: time="2024-08-05T22:02:01.249020395Z" level=error msg="failed to initialize a tracing processor \"otlp\"" error="no OpenTelemetry endpoint: skip plugin" Aug 5 22:02:01.250636 containerd[1704]: time="2024-08-05T22:02:01.249065873Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Aug 5 22:02:01.250828 containerd[1704]: time="2024-08-05T22:02:01.249323032Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:false SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.6 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false} 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}" Aug 5 22:02:01.250828 containerd[1704]: time="2024-08-05T22:02:01.249394076Z" level=info msg="Connect containerd service" Aug 5 22:02:01.250828 containerd[1704]: time="2024-08-05T22:02:01.249452708Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Aug 5 22:02:01.255229 containerd[1704]: time="2024-08-05T22:02:01.255056938Z" 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" Aug 5 22:02:01.256477 containerd[1704]: time="2024-08-05T22:02:01.255601103Z" level=info msg="Start subscribing containerd event" Aug 5 22:02:01.256477 containerd[1704]: time="2024-08-05T22:02:01.255682798Z" level=info msg="Start recovering state" Aug 5 22:02:01.256477 containerd[1704]: time="2024-08-05T22:02:01.255913567Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Aug 5 22:02:01.256477 containerd[1704]: time="2024-08-05T22:02:01.255997446Z" level=info msg=serving... address=/run/containerd/containerd.sock Aug 5 22:02:01.256477 containerd[1704]: time="2024-08-05T22:02:01.256020942Z" level=info msg="containerd successfully booted in 0.137512s" Aug 5 22:02:01.257582 containerd[1704]: time="2024-08-05T22:02:01.256980016Z" level=info msg="Start event monitor" Aug 5 22:02:01.257582 containerd[1704]: time="2024-08-05T22:02:01.257016155Z" level=info msg="Start snapshots syncer" Aug 5 22:02:01.257582 containerd[1704]: time="2024-08-05T22:02:01.257030832Z" level=info msg="Start cni network conf syncer for default" Aug 5 22:02:01.257582 containerd[1704]: time="2024-08-05T22:02:01.257060589Z" level=info msg="Start streaming server" Aug 5 22:02:01.400749 systemd[1]: Starting docker.service - Docker Application Container Engine... Aug 5 22:02:01.400933 (dockerd)[1760]: 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 Aug 5 22:02:02.789076 dockerd[1760]: time="2024-08-05T22:02:02.788564185Z" level=info msg="Starting up" Aug 5 22:02:02.825295 dockerd[1760]: time="2024-08-05T22:02:02.821575450Z" level=info msg="parsed scheme: \"unix\"" module=grpc Aug 5 22:02:02.825295 dockerd[1760]: time="2024-08-05T22:02:02.821616218Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Aug 5 22:02:02.828466 dockerd[1760]: time="2024-08-05T22:02:02.828373879Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///run/containerd/containerd.sock 0 }] }" module=grpc Aug 5 22:02:02.828466 dockerd[1760]: time="2024-08-05T22:02:02.828462919Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Aug 5 22:02:02.877763 dockerd[1760]: time="2024-08-05T22:02:02.875184198Z" level=info msg="parsed scheme: \"unix\"" module=grpc Aug 5 22:02:02.877763 dockerd[1760]: time="2024-08-05T22:02:02.875240705Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Aug 5 22:02:02.877763 dockerd[1760]: time="2024-08-05T22:02:02.875271263Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///run/containerd/containerd.sock 0 }] }" module=grpc Aug 5 22:02:02.877763 dockerd[1760]: time="2024-08-05T22:02:02.875289377Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Aug 5 22:02:03.527445 dockerd[1760]: time="2024-08-05T22:02:03.526924012Z" level=info msg="Loading containers: start." Aug 5 22:02:04.115419 kernel: Initializing XFRM netlink socket Aug 5 22:02:04.225865 dockerd[1760]: time="2024-08-05T22:02:04.224764912Z" level=info msg="Default bridge (docker0) is assigned with an IP address 172.17.0.0/16. Daemon option --bip can be used to set a preferred IP address" Aug 5 22:02:04.512237 systemd-networkd[1310]: docker0: Link UP Aug 5 22:02:04.720014 dockerd[1760]: time="2024-08-05T22:02:04.715034147Z" level=info msg="Loading containers: done." Aug 5 22:02:05.276929 dockerd[1760]: time="2024-08-05T22:02:05.275178198Z" 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 Aug 5 22:02:05.278559 dockerd[1760]: time="2024-08-05T22:02:05.277779381Z" level=info msg="Docker daemon" commit=3056208 graphdriver(s)=overlay2 version=20.10.21 Aug 5 22:02:05.278559 dockerd[1760]: time="2024-08-05T22:02:05.278153931Z" level=info msg="Daemon has completed initialization" Aug 5 22:02:05.355838 update_engine[1370]: I0805 22:02:05.352043 1370 update_attempter.cc:509] Updating boot flags... Aug 5 22:02:05.480897 systemd[1]: Started docker.service - Docker Application Container Engine. Aug 5 22:02:05.509024 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 36 scanned by (udev-worker) (1874) Aug 5 22:02:05.618937 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 36 scanned by (udev-worker) (1875) Aug 5 22:02:05.628545 dockerd[1760]: time="2024-08-05T22:02:05.628465059Z" level=info msg="API listen on /run/docker.sock" Aug 5 22:02:07.485184 systemd[1]: var-lib-docker-overlay2-e33d131663b1248b5dfb30dac22d96f935b5697bbe10b4f022f295c886f579c5\x2dinit-merged.mount: Deactivated successfully. Aug 5 22:02:07.593046 kernel: docker0: port 1(veth8472e0a) entered blocking state Aug 5 22:02:07.593184 kernel: docker0: port 1(veth8472e0a) entered disabled state Aug 5 22:02:07.593208 kernel: veth8472e0a: entered allmulticast mode Aug 5 22:02:07.594587 kernel: veth8472e0a: entered promiscuous mode Aug 5 22:02:07.594842 systemd-networkd[1310]: veth8472e0a: Link UP Aug 5 22:02:07.911485 containerd[1704]: time="2024-08-05T22:02:07.909760806Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Aug 5 22:02:07.911485 containerd[1704]: time="2024-08-05T22:02:07.909831040Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Aug 5 22:02:07.911485 containerd[1704]: time="2024-08-05T22:02:07.909844865Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 5 22:02:07.912457 containerd[1704]: time="2024-08-05T22:02:07.910448368Z" level=info msg="starting signal loop" namespace=moby path=/run/containerd/io.containerd.runtime.v2.task/moby/4f16de83cb840fb2dfaaf66ce9d41d7dac9a30d6a92eb6613b3366ab24c06eff pid=1907 runtime=io.containerd.runc.v2 Aug 5 22:02:08.332864 systemd[1]: Started docker-4f16de83cb840fb2dfaaf66ce9d41d7dac9a30d6a92eb6613b3366ab24c06eff.scope - libcontainer container 4f16de83cb840fb2dfaaf66ce9d41d7dac9a30d6a92eb6613b3366ab24c06eff. Aug 5 22:02:09.045374 kernel: eth0: renamed from vethc2f1e3f Aug 5 22:02:09.053270 kernel: docker0: port 1(veth8472e0a) entered blocking state Aug 5 22:02:09.053404 kernel: docker0: port 1(veth8472e0a) entered forwarding state Aug 5 22:02:09.053550 systemd-networkd[1310]: veth8472e0a: Gained carrier Aug 5 22:02:09.053983 systemd-networkd[1310]: docker0: Gained carrier Aug 5 22:02:09.068615 systemd-resolved[1275]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Aug 5 22:02:09.137439 systemd[1]: docker-4f16de83cb840fb2dfaaf66ce9d41d7dac9a30d6a92eb6613b3366ab24c06eff.scope: Deactivated successfully. Aug 5 22:02:09.210541 dockerd[1760]: time="2024-08-05T22:02:09.209944545Z" level=info msg="ignoring event" container=4f16de83cb840fb2dfaaf66ce9d41d7dac9a30d6a92eb6613b3366ab24c06eff module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Aug 5 22:02:09.211942 containerd[1704]: time="2024-08-05T22:02:09.210289757Z" level=info msg="shim disconnected" id=4f16de83cb840fb2dfaaf66ce9d41d7dac9a30d6a92eb6613b3366ab24c06eff Aug 5 22:02:09.211942 containerd[1704]: time="2024-08-05T22:02:09.210376592Z" level=warning msg="cleaning up after shim disconnected" id=4f16de83cb840fb2dfaaf66ce9d41d7dac9a30d6a92eb6613b3366ab24c06eff namespace=moby Aug 5 22:02:09.211942 containerd[1704]: time="2024-08-05T22:02:09.210393344Z" level=info msg="cleaning up dead shim" Aug 5 22:02:09.231906 containerd[1704]: time="2024-08-05T22:02:09.231131435Z" level=warning msg="cleanup warnings time=\"2024-08-05T22:02:09Z\" level=info msg=\"starting signal loop\" namespace=moby pid=1963 runtime=io.containerd.runc.v2\n" Aug 5 22:02:09.259081 kernel: docker0: port 1(veth8472e0a) entered disabled state Aug 5 22:02:09.259198 kernel: vethc2f1e3f: renamed from eth0 Aug 5 22:02:09.258791 systemd-networkd[1310]: veth8472e0a: Lost carrier Aug 5 22:02:09.279144 systemd-networkd[1310]: veth8472e0a: Link DOWN Aug 5 22:02:09.280991 kernel: docker0: port 1(veth8472e0a) entered disabled state Aug 5 22:02:09.288013 kernel: veth8472e0a (unregistering): left allmulticast mode Aug 5 22:02:09.288131 kernel: veth8472e0a (unregistering): left promiscuous mode Aug 5 22:02:09.288156 kernel: docker0: port 1(veth8472e0a) entered disabled state Aug 5 22:02:09.330211 systemd[1]: run-docker-netns-78f128ae0f50.mount: Deactivated successfully. Aug 5 22:02:09.336486 systemd[1]: var-lib-docker-overlay2-e33d131663b1248b5dfb30dac22d96f935b5697bbe10b4f022f295c886f579c5-merged.mount: Deactivated successfully. Aug 5 22:02:09.399850 sshd[1627]: pam_unix(sshd:session): session closed for user core Aug 5 22:02:09.412313 systemd[1]: sshd@10-10.0.0.17:22-10.0.0.1:59586.service: Deactivated successfully. Aug 5 22:02:09.414978 systemd[1]: session-11.scope: Deactivated successfully. Aug 5 22:02:09.417479 systemd-logind[1366]: Session 11 logged out. Waiting for processes to exit. Aug 5 22:02:09.419026 systemd-logind[1366]: Removed session 11. Aug 5 22:02:09.440088 systemd[1]: Started sshd@11-10.0.0.17:22-10.0.0.1:53714.service - OpenSSH per-connection server daemon (10.0.0.1:53714). Aug 5 22:02:09.505111 sshd[1981]: Accepted publickey for core from 10.0.0.1 port 53714 ssh2: RSA SHA256:/wAyea3vP9dXQlCAyE/d+D0JDO90hh/Jr57IUMqxZQo Aug 5 22:02:09.507637 sshd[1981]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:02:09.524846 systemd-logind[1366]: New session 12 of user core. Aug 5 22:02:09.539574 systemd[1]: Started session-12.scope - Session 12 of User core. Aug 5 22:02:09.697668 sshd[1981]: pam_unix(sshd:session): session closed for user core Aug 5 22:02:09.718730 systemd[1]: sshd@11-10.0.0.17:22-10.0.0.1:53714.service: Deactivated successfully. Aug 5 22:02:09.723493 systemd[1]: session-12.scope: Deactivated successfully. Aug 5 22:02:09.728591 systemd-logind[1366]: Session 12 logged out. Waiting for processes to exit. Aug 5 22:02:09.745432 systemd[1]: Started sshd@12-10.0.0.17:22-10.0.0.1:53726.service - OpenSSH per-connection server daemon (10.0.0.1:53726). Aug 5 22:02:09.748157 systemd-logind[1366]: Removed session 12. Aug 5 22:02:09.791985 sshd[1991]: Accepted publickey for core from 10.0.0.1 port 53726 ssh2: RSA SHA256:/wAyea3vP9dXQlCAyE/d+D0JDO90hh/Jr57IUMqxZQo Aug 5 22:02:09.793402 sshd[1991]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:02:09.809517 systemd-logind[1366]: New session 13 of user core. Aug 5 22:02:09.816291 systemd[1]: Started session-13.scope - Session 13 of User core. Aug 5 22:02:10.059909 systemd-networkd[1310]: docker0: Lost carrier Aug 5 22:02:10.771480 systemd-networkd[1310]: docker0: Gained IPv6LL Aug 5 22:02:18.777881 sudo[1994]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/mv docker.raw containerd.raw /etc/extensions/ Aug 5 22:02:18.778295 sudo[1994]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Aug 5 22:02:19.089578 sudo[1994]: pam_unix(sudo:session): session closed for user root Aug 5 22:02:19.091780 sshd[1991]: pam_unix(sshd:session): session closed for user core Aug 5 22:02:19.104129 systemd[1]: sshd@12-10.0.0.17:22-10.0.0.1:53726.service: Deactivated successfully. Aug 5 22:02:19.106423 systemd[1]: session-13.scope: Deactivated successfully. Aug 5 22:02:19.106667 systemd[1]: session-13.scope: Consumed 6.071s CPU time. Aug 5 22:02:19.108538 systemd-logind[1366]: Session 13 logged out. Waiting for processes to exit. Aug 5 22:02:19.110049 systemd[1]: Started sshd@13-10.0.0.17:22-10.0.0.1:42108.service - OpenSSH per-connection server daemon (10.0.0.1:42108). Aug 5 22:02:19.111443 systemd-logind[1366]: Removed session 13. Aug 5 22:02:19.147335 sshd[2051]: Accepted publickey for core from 10.0.0.1 port 42108 ssh2: RSA SHA256:/wAyea3vP9dXQlCAyE/d+D0JDO90hh/Jr57IUMqxZQo Aug 5 22:02:19.149088 sshd[2051]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:02:19.153233 systemd-logind[1366]: New session 14 of user core. Aug 5 22:02:19.163118 systemd[1]: Started session-14.scope - Session 14 of User core. Aug 5 22:02:19.217462 sudo[2055]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart systemd-sysext Aug 5 22:02:19.217788 sudo[2055]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Aug 5 22:02:19.226831 systemd[1]: ensure-sysext.service: Deactivated successfully. Aug 5 22:02:19.227107 systemd[1]: Stopped ensure-sysext.service. Aug 5 22:02:19.227183 systemd[1]: Stopping ensure-sysext.service... Aug 5 22:02:19.242332 systemd[1]: Stopping systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Aug 5 22:02:19.248619 systemd-sysext[2057]: Unmerged '/usr'. Aug 5 22:02:19.256257 systemd[1]: systemd-sysext.service: Deactivated successfully. Aug 5 22:02:19.256575 systemd[1]: Stopped systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Aug 5 22:02:19.268362 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Aug 5 22:02:19.276987 kernel: loop4: detected capacity change from 0 to 306648 Aug 5 22:02:19.284982 kernel: EXT4-fs (loop4): mounted filesystem 9fe4c3c1-ec52-4add-82d3-155769ca6681 ro without journal. Quota mode: none. Aug 5 22:02:19.287984 kernel: EXT4-fs (loop4): unmounting filesystem 9fe4c3c1-ec52-4add-82d3-155769ca6681. Aug 5 22:02:19.329093 kernel: loop5: detected capacity change from 0 to 301296 Aug 5 22:02:19.338011 kernel: EXT4-fs (loop5): mounted filesystem b09b3fc8-e465-41a1-859f-c29ed6feed28 ro without journal. Quota mode: none. Aug 5 22:02:19.341984 kernel: EXT4-fs (loop5): unmounting filesystem b09b3fc8-e465-41a1-859f-c29ed6feed28. Aug 5 22:02:19.378994 kernel: loop6: detected capacity change from 0 to 306648 Aug 5 22:02:19.385976 kernel: EXT4-fs (loop6): mounted filesystem 9fe4c3c1-ec52-4add-82d3-155769ca6681 ro without journal. Quota mode: none. Aug 5 22:02:19.388980 kernel: loop7: detected capacity change from 0 to 301296 Aug 5 22:02:19.394824 (sd-merge)[2066]: Using extensions 'containerd', 'docker'. Aug 5 22:02:19.395167 kernel: EXT4-fs (loop7): mounted filesystem b09b3fc8-e465-41a1-859f-c29ed6feed28 ro without journal. Quota mode: none. Aug 5 22:02:19.395502 (sd-merge)[2066]: Merged extensions into '/usr'. Aug 5 22:02:19.398923 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Aug 5 22:02:19.401023 sudo[2055]: pam_unix(sudo:session): session closed for user root Aug 5 22:02:19.408336 systemd[1]: Starting ensure-sysext.service... Aug 5 22:02:19.409737 sudo[2054]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart docker containerd Aug 5 22:02:19.410143 sudo[2054]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Aug 5 22:02:19.415655 systemd[1]: Reloading requested from client PID 2070 ('systemctl') (unit ensure-sysext.service)... Aug 5 22:02:19.415674 systemd[1]: Reloading... Aug 5 22:02:19.492106 zram_generator::config[2109]: No configuration found. Aug 5 22:02:20.035698 systemd[1]: /usr/lib/systemd/system/docker.socket:5: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Aug 5 22:02:20.124887 systemd[1]: Reloading finished in 708 ms. Aug 5 22:02:20.183053 systemd[1]: Stopped target sockets.target - Socket Units. Aug 5 22:02:20.183078 systemd[1]: Stopping sockets.target - Socket Units... Aug 5 22:02:20.183400 dockerd[1760]: time="2024-08-05T22:02:20.183333539Z" level=info msg="Processing signal 'terminated'" Aug 5 22:02:20.183412 systemd[1]: Stopping docker.service - Docker Application Container Engine... Aug 5 22:02:20.184354 dockerd[1760]: time="2024-08-05T22:02:20.184325648Z" level=info msg="Daemon shutdown complete" Aug 5 22:02:20.184543 systemd[1]: Stopped target timers.target - Timer Units. Aug 5 22:02:20.184560 systemd[1]: Stopping timers.target - Timer Units... Aug 5 22:02:20.184672 systemd[1]: Reached target timers.target - Timer Units. Aug 5 22:02:20.188201 systemd[1]: docker.service: Deactivated successfully. Aug 5 22:02:20.188466 systemd[1]: Stopped docker.service - Docker Application Container Engine. Aug 5 22:02:20.188508 systemd[1]: docker.service: Consumed 2.651s CPU time, 108.8M memory peak, 0B memory swap peak. Aug 5 22:02:20.189935 systemd[1]: Stopped target multi-user.target - Multi-User System. Aug 5 22:02:20.189984 systemd[1]: Stopping multi-user.target - Multi-User System... Aug 5 22:02:20.190032 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Aug 5 22:02:20.190394 systemd[1]: docker.socket: Deactivated successfully. Aug 5 22:02:20.190780 systemd[1]: Closed docker.socket - Docker Socket for the API. Aug 5 22:02:20.190818 systemd[1]: Stopping docker.socket - Docker Socket for the API... Aug 5 22:02:20.192658 systemd[1]: Starting docker.socket - Docker Socket for the API... Aug 5 22:02:20.202406 systemd[1]: Stopping containerd.service - containerd container runtime... Aug 5 22:02:20.202651 containerd[1704]: time="2024-08-05T22:02:20.202398352Z" level=info msg="Stop CRI service" Aug 5 22:02:20.204207 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Aug 5 22:02:20.205401 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Aug 5 22:02:20.206764 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Aug 5 22:02:20.212487 systemd[1]: Starting issuegen.service - Generate /run/issue... Aug 5 22:02:20.214694 jq[2148]: false Aug 5 22:02:20.216553 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Aug 5 22:02:20.218651 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Aug 5 22:02:20.219063 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Aug 5 22:02:20.219358 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Aug 5 22:02:20.222216 systemd[1]: containerd.service: Deactivated successfully. Aug 5 22:02:20.222488 systemd[1]: Stopped containerd.service - containerd container runtime. Aug 5 22:02:20.222540 systemd[1]: containerd.service: Consumed 1.096s CPU time, 81.1M memory peak, 0B memory swap peak. Aug 5 22:02:20.223195 systemd[1]: Listening on docker.socket - Docker Socket for the API. Aug 5 22:02:20.224483 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Aug 5 22:02:20.224726 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Aug 5 22:02:20.228626 systemd[1]: Finished ensure-sysext.service. Aug 5 22:02:20.229504 systemd[1]: issuegen.service: Deactivated successfully. Aug 5 22:02:20.229745 systemd[1]: Finished issuegen.service - Generate /run/issue. Aug 5 22:02:20.235850 systemd[1]: Reached target sockets.target - Socket Units. Aug 5 22:02:20.238308 systemd[1]: Starting containerd.service - containerd container runtime... Aug 5 22:02:20.239085 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Aug 5 22:02:20.239419 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Aug 5 22:02:20.243254 systemd[1]: motdgen.service: Deactivated successfully. Aug 5 22:02:20.243500 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Aug 5 22:02:20.243736 extend-filesystems[2149]: Found loop2 Aug 5 22:02:20.245156 extend-filesystems[2149]: Found loop3 Aug 5 22:02:20.245156 extend-filesystems[2149]: Found loop6 Aug 5 22:02:20.245156 extend-filesystems[2149]: Found loop7 Aug 5 22:02:20.245156 extend-filesystems[2149]: Found sr0 Aug 5 22:02:20.245156 extend-filesystems[2149]: Found vda Aug 5 22:02:20.245156 extend-filesystems[2149]: Found vda1 Aug 5 22:02:20.245156 extend-filesystems[2149]: Found vda2 Aug 5 22:02:20.245156 extend-filesystems[2149]: Found vda3 Aug 5 22:02:20.245156 extend-filesystems[2149]: Found usr Aug 5 22:02:20.245156 extend-filesystems[2149]: Found vda4 Aug 5 22:02:20.245156 extend-filesystems[2149]: Found vda6 Aug 5 22:02:20.245156 extend-filesystems[2149]: Found vda7 Aug 5 22:02:20.245156 extend-filesystems[2149]: Found vda9 Aug 5 22:02:20.245156 extend-filesystems[2149]: Checking size of /dev/vda9 Aug 5 22:02:20.264700 systemd[1]: coreos-metadata.service: Deactivated successfully. Aug 5 22:02:20.265110 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Aug 5 22:02:20.265878 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because of an unmet condition check (ConditionFirstBoot=true). Aug 5 22:02:20.288763 systemd[1]: Started containerd.service - containerd container runtime. Aug 5 22:02:20.291405 systemd[1]: Starting docker.service - Docker Application Container Engine... Aug 5 22:02:20.298731 (dockerd)[2179]: 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 Aug 5 22:02:20.313646 extend-filesystems[2149]: Old size kept for /dev/vda9 Aug 5 22:02:20.314552 systemd[1]: extend-filesystems.service: Deactivated successfully. Aug 5 22:02:20.314907 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Aug 5 22:02:20.317906 systemd[1]: Reached target multi-user.target - Multi-User System. Aug 5 22:02:20.338985 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 36 scanned by (udev-worker) (2187) Aug 5 22:02:20.401269 containerd[2178]: time="2024-08-05T22:02:20.401115245Z" level=info msg="starting containerd" revision=7c3aca7a610df76212171d200ca3811ff6096eb8 version=v1.7.13 Aug 5 22:02:20.431442 containerd[2178]: time="2024-08-05T22:02:20.431352468Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Aug 5 22:02:20.431442 containerd[2178]: time="2024-08-05T22:02:20.431446404Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:02:20.433725 containerd[2178]: time="2024-08-05T22:02:20.433684569Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.43-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Aug 5 22:02:20.433725 containerd[2178]: time="2024-08-05T22:02:20.433723362Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Aug 5 22:02:20.433807 containerd[2178]: time="2024-08-05T22:02:20.433751485Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Aug 5 22:02:20.433898 containerd[2178]: time="2024-08-05T22:02:20.433876861Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Aug 5 22:02:20.433920 containerd[2178]: time="2024-08-05T22:02:20.433898472Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Aug 5 22:02:20.433944 containerd[2178]: time="2024-08-05T22:02:20.433928449Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:02:20.434118 containerd[2178]: time="2024-08-05T22:02:20.434085634Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Aug 5 22:02:20.434118 containerd[2178]: time="2024-08-05T22:02:20.434111142Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Aug 5 22:02:20.434182 containerd[2178]: time="2024-08-05T22:02:20.434124267Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:02:20.434329 containerd[2178]: time="2024-08-05T22:02:20.434309506Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Aug 5 22:02:20.434351 containerd[2178]: time="2024-08-05T22:02:20.434327730Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Aug 5 22:02:20.434351 containerd[2178]: time="2024-08-05T22:02:20.434344832Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Aug 5 22:02:20.434393 containerd[2178]: time="2024-08-05T22:02:20.434355432Z" level=info msg="metadata content store policy set" policy=shared Aug 5 22:02:20.435215 containerd[2178]: time="2024-08-05T22:02:20.435181559Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Aug 5 22:02:20.435250 containerd[2178]: time="2024-08-05T22:02:20.435214681Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Aug 5 22:02:20.435250 containerd[2178]: time="2024-08-05T22:02:20.435231963Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Aug 5 22:02:20.435297 containerd[2178]: time="2024-08-05T22:02:20.435270505Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Aug 5 22:02:20.435297 containerd[2178]: time="2024-08-05T22:02:20.435288820Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Aug 5 22:02:20.435354 containerd[2178]: time="2024-08-05T22:02:20.435305682Z" level=info msg="NRI interface is disabled by configuration." Aug 5 22:02:20.435354 containerd[2178]: time="2024-08-05T22:02:20.435322935Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Aug 5 22:02:20.435464 containerd[2178]: time="2024-08-05T22:02:20.435434645Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Aug 5 22:02:20.435464 containerd[2178]: time="2024-08-05T22:02:20.435459482Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Aug 5 22:02:20.435536 containerd[2178]: time="2024-08-05T22:02:20.435478447Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Aug 5 22:02:20.435536 containerd[2178]: time="2024-08-05T22:02:20.435496421Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Aug 5 22:02:20.435585 containerd[2178]: time="2024-08-05T22:02:20.435537728Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Aug 5 22:02:20.435585 containerd[2178]: time="2024-08-05T22:02:20.435563167Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Aug 5 22:02:20.435585 containerd[2178]: time="2024-08-05T22:02:20.435580079Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Aug 5 22:02:20.435637 containerd[2178]: time="2024-08-05T22:02:20.435596510Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Aug 5 22:02:20.435637 containerd[2178]: time="2024-08-05T22:02:20.435615175Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Aug 5 22:02:20.435637 containerd[2178]: time="2024-08-05T22:02:20.435632808Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Aug 5 22:02:20.435699 containerd[2178]: time="2024-08-05T22:02:20.435649940Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Aug 5 22:02:20.435699 containerd[2178]: time="2024-08-05T22:02:20.435666140Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Aug 5 22:02:20.435738 containerd[2178]: time="2024-08-05T22:02:20.435708801Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Aug 5 22:02:20.436649 containerd[2178]: time="2024-08-05T22:02:20.436602274Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Aug 5 22:02:20.436689 containerd[2178]: time="2024-08-05T22:02:20.436664100Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Aug 5 22:02:20.436689 containerd[2178]: time="2024-08-05T22:02:20.436682274Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Aug 5 22:02:20.436731 containerd[2178]: time="2024-08-05T22:02:20.436718302Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Aug 5 22:02:20.437362 containerd[2178]: time="2024-08-05T22:02:20.437335013Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Aug 5 22:02:20.437506 containerd[2178]: time="2024-08-05T22:02:20.437366583Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Aug 5 22:02:20.437553 containerd[2178]: time="2024-08-05T22:02:20.437528137Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Aug 5 22:02:20.437573 containerd[2178]: time="2024-08-05T22:02:20.437552473Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Aug 5 22:02:20.437592 containerd[2178]: time="2024-08-05T22:02:20.437582249Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Aug 5 22:02:20.437618 containerd[2178]: time="2024-08-05T22:02:20.437605153Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Aug 5 22:02:20.437639 containerd[2178]: time="2024-08-05T22:02:20.437625591Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Aug 5 22:02:20.437671 containerd[2178]: time="2024-08-05T22:02:20.437640389Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Aug 5 22:02:20.437671 containerd[2178]: time="2024-08-05T22:02:20.437664273Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Aug 5 22:02:20.437718 containerd[2178]: time="2024-08-05T22:02:20.437706413Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Aug 5 22:02:20.437748 containerd[2178]: time="2024-08-05T22:02:20.437724598Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Aug 5 22:02:20.437748 containerd[2178]: time="2024-08-05T22:02:20.437738614Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Aug 5 22:02:20.437784 containerd[2178]: time="2024-08-05T22:02:20.437754564Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Aug 5 22:02:20.437784 containerd[2178]: time="2024-08-05T22:02:20.437771886Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Aug 5 22:02:20.437824 containerd[2178]: time="2024-08-05T22:02:20.437791152Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Aug 5 22:02:20.437824 containerd[2178]: time="2024-08-05T22:02:20.437806561Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Aug 5 22:02:20.437859 containerd[2178]: time="2024-08-05T22:02:20.437820968Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Aug 5 22:02:20.438247 containerd[2178]: time="2024-08-05T22:02:20.438177229Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:false SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s} 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}" Aug 5 22:02:20.438344 containerd[2178]: time="2024-08-05T22:02:20.438253814Z" level=info msg="Connect containerd service" Aug 5 22:02:20.438344 containerd[2178]: time="2024-08-05T22:02:20.438285053Z" level=info msg="using legacy CRI server" Aug 5 22:02:20.438344 containerd[2178]: time="2024-08-05T22:02:20.438293779Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Aug 5 22:02:20.438397 containerd[2178]: time="2024-08-05T22:02:20.438349674Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Aug 5 22:02:20.439190 containerd[2178]: time="2024-08-05T22:02:20.439154059Z" 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" Aug 5 22:02:20.439433 containerd[2178]: time="2024-08-05T22:02:20.439391827Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Aug 5 22:02:20.439433 containerd[2178]: time="2024-08-05T22:02:20.439422334Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="no OpenTelemetry endpoint: skip plugin" type=io.containerd.tracing.processor.v1 Aug 5 22:02:20.439487 containerd[2178]: time="2024-08-05T22:02:20.439437082Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Aug 5 22:02:20.439487 containerd[2178]: time="2024-08-05T22:02:20.439449996Z" level=info msg="skipping tracing processor initialization (no tracing plugin)" error="no OpenTelemetry endpoint: skip plugin" Aug 5 22:02:20.439920 containerd[2178]: time="2024-08-05T22:02:20.439755883Z" level=info msg="Start subscribing containerd event" Aug 5 22:02:20.440017 containerd[2178]: time="2024-08-05T22:02:20.439811818Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Aug 5 22:02:20.440017 containerd[2178]: time="2024-08-05T22:02:20.439923148Z" level=info msg="Start recovering state" Aug 5 22:02:20.440089 containerd[2178]: time="2024-08-05T22:02:20.440039777Z" level=info msg=serving... address=/run/containerd/containerd.sock Aug 5 22:02:20.440126 containerd[2178]: time="2024-08-05T22:02:20.440092136Z" level=info msg="Start event monitor" Aug 5 22:02:20.440126 containerd[2178]: time="2024-08-05T22:02:20.440122643Z" level=info msg="Start snapshots syncer" Aug 5 22:02:20.440166 containerd[2178]: time="2024-08-05T22:02:20.440138093Z" level=info msg="Start cni network conf syncer for default" Aug 5 22:02:20.440166 containerd[2178]: time="2024-08-05T22:02:20.440148703Z" level=info msg="Start streaming server" Aug 5 22:02:20.440212 containerd[2178]: time="2024-08-05T22:02:20.440177136Z" level=info msg="containerd successfully booted in 0.040914s" Aug 5 22:02:20.635080 dockerd[2179]: time="2024-08-05T22:02:20.633492286Z" level=info msg="Starting up" Aug 5 22:02:21.459554 dockerd[2179]: time="2024-08-05T22:02:21.459469273Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Aug 5 22:02:21.483070 dockerd[2179]: time="2024-08-05T22:02:21.482999254Z" level=info msg="Loading containers: start." Aug 5 22:02:21.906584 dockerd[2179]: time="2024-08-05T22:02:21.906376513Z" level=info msg="Default bridge (docker0) is assigned with an IP address 172.17.0.0/16. Daemon option --bip can be used to set a preferred IP address" Aug 5 22:02:21.984822 dockerd[2179]: time="2024-08-05T22:02:21.984724440Z" level=info msg="Loading containers: done." Aug 5 22:02:22.015134 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck2745134082-merged.mount: Deactivated successfully. Aug 5 22:02:22.017726 dockerd[2179]: time="2024-08-05T22:02:22.017651804Z" 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 Aug 5 22:02:22.017942 dockerd[2179]: time="2024-08-05T22:02:22.017914328Z" level=info msg="Docker daemon" commit=fca702d graphdriver=overlay2 version=24.0.9 Aug 5 22:02:22.018378 dockerd[2179]: time="2024-08-05T22:02:22.018319240Z" level=info msg="Daemon has completed initialization" Aug 5 22:02:22.049579 dockerd[2179]: time="2024-08-05T22:02:22.049182923Z" level=info msg="API listen on /run/docker.sock" Aug 5 22:02:22.049763 systemd[1]: Started docker.service - Docker Application Container Engine. Aug 5 22:02:22.051504 sudo[2054]: pam_unix(sudo:session): session closed for user root Aug 5 22:02:22.053860 sshd[2051]: pam_unix(sshd:session): session closed for user core Aug 5 22:02:22.070003 kernel: EXT4-fs (loop2): unmounting filesystem 136ca7b1-7479-40bf-9215-7c43c979c7df. Aug 5 22:02:22.070244 systemd-logind[1366]: Session 14 logged out. Waiting for processes to exit. Aug 5 22:02:22.074351 systemd[1]: Started sshd@14-10.0.0.17:22-10.0.0.1:43160.service - OpenSSH per-connection server daemon (10.0.0.1:43160). Aug 5 22:02:22.083052 kernel: EXT4-fs (loop3): unmounting filesystem 7d690981-5d3c-4f74-8692-91f9ab72d235. Aug 5 22:02:22.113582 sshd[2333]: Accepted publickey for core from 10.0.0.1 port 43160 ssh2: RSA SHA256:/wAyea3vP9dXQlCAyE/d+D0JDO90hh/Jr57IUMqxZQo Aug 5 22:02:22.115850 sshd[2333]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:02:22.122199 systemd-logind[1366]: New session 15 of user core. Aug 5 22:02:22.131239 systemd[1]: Started session-15.scope - Session 15 of User core. Aug 5 22:02:22.143009 systemd[1]: sshd@13-10.0.0.17:22-10.0.0.1:42108.service: Deactivated successfully. Aug 5 22:02:22.145303 systemd[1]: session-14.scope: Deactivated successfully. Aug 5 22:02:22.146434 systemd-logind[1366]: Removed session 14. Aug 5 22:02:22.242352 systemd[1]: var-lib-docker-overlay2-16a97c0edfad7dcf37b085112609b422bd00620a0adb0de3765984603b45903f\x2dinit-merged.mount: Deactivated successfully. Aug 5 22:02:22.273849 kernel: docker0: port 1(veth235837b) entered blocking state Aug 5 22:02:22.273994 kernel: docker0: port 1(veth235837b) entered disabled state Aug 5 22:02:22.274015 kernel: veth235837b: entered allmulticast mode Aug 5 22:02:22.275441 kernel: veth235837b: entered promiscuous mode Aug 5 22:02:22.275743 systemd-networkd[1310]: veth235837b: Link UP Aug 5 22:02:22.337615 containerd[2178]: time="2024-08-05T22:02:22.337400701Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Aug 5 22:02:22.337615 containerd[2178]: time="2024-08-05T22:02:22.337457387Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 5 22:02:22.337615 containerd[2178]: time="2024-08-05T22:02:22.337472395Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Aug 5 22:02:22.337615 containerd[2178]: time="2024-08-05T22:02:22.337493765Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 5 22:02:22.361080 systemd[1]: Started docker-46da792618143b22dc642fb610dbaf9779733856a823178935a4d9b30fe88a78.scope - libcontainer container 46da792618143b22dc642fb610dbaf9779733856a823178935a4d9b30fe88a78. Aug 5 22:02:22.416998 kernel: eth0: renamed from vethc3838b7 Aug 5 22:02:22.422257 kernel: docker0: port 1(veth235837b) entered blocking state Aug 5 22:02:22.422351 kernel: docker0: port 1(veth235837b) entered forwarding state Aug 5 22:02:22.422522 systemd-networkd[1310]: veth235837b: Gained carrier Aug 5 22:02:22.423060 systemd-networkd[1310]: docker0: Gained carrier Aug 5 22:02:22.435850 systemd-resolved[1275]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Aug 5 22:02:22.462516 systemd[1]: docker-46da792618143b22dc642fb610dbaf9779733856a823178935a4d9b30fe88a78.scope: Deactivated successfully. Aug 5 22:02:22.479546 containerd[2178]: time="2024-08-05T22:02:22.479460552Z" level=info msg="shim disconnected" id=46da792618143b22dc642fb610dbaf9779733856a823178935a4d9b30fe88a78 namespace=moby Aug 5 22:02:22.479689 containerd[2178]: time="2024-08-05T22:02:22.479538760Z" level=warning msg="cleaning up after shim disconnected" id=46da792618143b22dc642fb610dbaf9779733856a823178935a4d9b30fe88a78 namespace=moby Aug 5 22:02:22.479689 containerd[2178]: time="2024-08-05T22:02:22.479622897Z" level=info msg="cleaning up dead shim" namespace=moby Aug 5 22:02:22.479763 dockerd[2179]: time="2024-08-05T22:02:22.479642675Z" level=info msg="ignoring event" container=46da792618143b22dc642fb610dbaf9779733856a823178935a4d9b30fe88a78 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Aug 5 22:02:22.501173 systemd-networkd[1310]: veth235837b: Lost carrier Aug 5 22:02:22.501990 kernel: docker0: port 1(veth235837b) entered disabled state Aug 5 22:02:22.502048 kernel: vethc3838b7: renamed from eth0 Aug 5 22:02:22.629424 systemd-networkd[1310]: veth235837b: Link DOWN Aug 5 22:02:22.631675 kernel: docker0: port 1(veth235837b) entered disabled state Aug 5 22:02:22.631736 kernel: veth235837b (unregistering): left allmulticast mode Aug 5 22:02:22.631757 kernel: veth235837b (unregistering): left promiscuous mode Aug 5 22:02:22.633523 kernel: docker0: port 1(veth235837b) entered disabled state Aug 5 22:02:22.817700 sshd[2333]: pam_unix(sshd:session): session closed for user core Aug 5 22:02:22.822131 systemd[1]: sshd@14-10.0.0.17:22-10.0.0.1:43160.service: Deactivated successfully. Aug 5 22:02:22.824271 systemd[1]: session-15.scope: Deactivated successfully. Aug 5 22:02:22.825089 systemd-logind[1366]: Session 15 logged out. Waiting for processes to exit. Aug 5 22:02:22.826372 systemd-logind[1366]: Removed session 15. Aug 5 22:02:23.307351 systemd-networkd[1310]: docker0: Lost carrier