Oct 2 19:28:47.758652 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]
Oct 2 19:28:47.758671 kernel: Linux version 5.15.132-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 11.3.1_p20221209 p3) 11.3.1 20221209, GNU ld (Gentoo 2.39 p5) 2.39.0) #1 SMP PREEMPT Mon Oct 2 17:55:37 -00 2023
Oct 2 19:28:47.758679 kernel: efi: EFI v2.70 by EDK II
Oct 2 19:28:47.758685 kernel: efi: SMBIOS 3.0=0xd9260000 ACPI 2.0=0xd9240000 MEMATTR=0xda32b018 RNG=0xd9220018 MEMRESERVE=0xd9521c18
Oct 2 19:28:47.758690 kernel: random: crng init done
Oct 2 19:28:47.758695 kernel: ACPI: Early table checksum verification disabled
Oct 2 19:28:47.758701 kernel: ACPI: RSDP 0x00000000D9240000 000024 (v02 BOCHS )
Oct 2 19:28:47.758708 kernel: ACPI: XSDT 0x00000000D9230000 000064 (v01 BOCHS BXPC 00000001 01000013)
Oct 2 19:28:47.758714 kernel: ACPI: FACP 0x00000000D91E0000 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001)
Oct 2 19:28:47.758719 kernel: ACPI: DSDT 0x00000000D91F0000 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001)
Oct 2 19:28:47.758724 kernel: ACPI: APIC 0x00000000D91D0000 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001)
Oct 2 19:28:47.758729 kernel: ACPI: PPTT 0x00000000D91C0000 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001)
Oct 2 19:28:47.758735 kernel: ACPI: GTDT 0x00000000D91B0000 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001)
Oct 2 19:28:47.758740 kernel: ACPI: MCFG 0x00000000D91A0000 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)
Oct 2 19:28:47.758748 kernel: ACPI: SPCR 0x00000000D9190000 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001)
Oct 2 19:28:47.758753 kernel: ACPI: DBG2 0x00000000D9180000 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001)
Oct 2 19:28:47.758759 kernel: ACPI: IORT 0x00000000D9170000 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001)
Oct 2 19:28:47.758765 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600
Oct 2 19:28:47.758770 kernel: NUMA: Failed to initialise from firmware
Oct 2 19:28:47.758776 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff]
Oct 2 19:28:47.758782 kernel: NUMA: NODE_DATA [mem 0xdcb0a900-0xdcb0ffff]
Oct 2 19:28:47.758787 kernel: Zone ranges:
Oct 2 19:28:47.758793 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff]
Oct 2 19:28:47.758800 kernel: DMA32 empty
Oct 2 19:28:47.758805 kernel: Normal empty
Oct 2 19:28:47.758811 kernel: Movable zone start for each node
Oct 2 19:28:47.758816 kernel: Early memory node ranges
Oct 2 19:28:47.758822 kernel: node 0: [mem 0x0000000040000000-0x00000000d924ffff]
Oct 2 19:28:47.758828 kernel: node 0: [mem 0x00000000d9250000-0x00000000d951ffff]
Oct 2 19:28:47.758833 kernel: node 0: [mem 0x00000000d9520000-0x00000000dc7fffff]
Oct 2 19:28:47.758839 kernel: node 0: [mem 0x00000000dc800000-0x00000000dc88ffff]
Oct 2 19:28:47.758845 kernel: node 0: [mem 0x00000000dc890000-0x00000000dc89ffff]
Oct 2 19:28:47.758863 kernel: node 0: [mem 0x00000000dc8a0000-0x00000000dc9bffff]
Oct 2 19:28:47.758869 kernel: node 0: [mem 0x00000000dc9c0000-0x00000000dcffffff]
Oct 2 19:28:47.758875 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff]
Oct 2 19:28:47.758882 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges
Oct 2 19:28:47.758888 kernel: psci: probing for conduit method from ACPI.
Oct 2 19:28:47.758893 kernel: psci: PSCIv1.1 detected in firmware.
Oct 2 19:28:47.758899 kernel: psci: Using standard PSCI v0.2 function IDs
Oct 2 19:28:47.758905 kernel: psci: Trusted OS migration not required
Oct 2 19:28:47.758913 kernel: psci: SMC Calling Convention v1.1
Oct 2 19:28:47.758919 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)
Oct 2 19:28:47.758927 kernel: ACPI: SRAT not present
Oct 2 19:28:47.758933 kernel: percpu: Embedded 29 pages/cpu s79960 r8192 d30632 u118784
Oct 2 19:28:47.758939 kernel: pcpu-alloc: s79960 r8192 d30632 u118784 alloc=29*4096
Oct 2 19:28:47.758945 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3
Oct 2 19:28:47.758951 kernel: Detected PIPT I-cache on CPU0
Oct 2 19:28:47.758957 kernel: CPU features: detected: GIC system register CPU interface
Oct 2 19:28:47.758963 kernel: CPU features: detected: Hardware dirty bit management
Oct 2 19:28:47.758969 kernel: CPU features: detected: Spectre-v4
Oct 2 19:28:47.758975 kernel: CPU features: detected: Spectre-BHB
Oct 2 19:28:47.758983 kernel: CPU features: kernel page table isolation forced ON by KASLR
Oct 2 19:28:47.758989 kernel: CPU features: detected: Kernel page table isolation (KPTI)
Oct 2 19:28:47.758995 kernel: CPU features: detected: ARM erratum 1418040
Oct 2 19:28:47.759001 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024
Oct 2 19:28:47.759007 kernel: Policy zone: DMA
Oct 2 19:28:47.759014 kernel: Kernel command line: BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected acpi=force verity.usrhash=684fe6a2259d7fb96810743ab87aaaa03d9f185b113bd6990a64d1079e5672ca
Oct 2 19:28:47.759020 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space.
Oct 2 19:28:47.759026 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
Oct 2 19:28:47.759032 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
Oct 2 19:28:47.759038 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off
Oct 2 19:28:47.759044 kernel: Memory: 2459276K/2572288K available (9792K kernel code, 2092K rwdata, 7548K rodata, 34560K init, 779K bss, 113012K reserved, 0K cma-reserved)
Oct 2 19:28:47.759052 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
Oct 2 19:28:47.759058 kernel: trace event string verifier disabled
Oct 2 19:28:47.759064 kernel: rcu: Preemptible hierarchical RCU implementation.
Oct 2 19:28:47.759070 kernel: rcu: RCU event tracing is enabled.
Oct 2 19:28:47.759077 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4.
Oct 2 19:28:47.759083 kernel: Trampoline variant of Tasks RCU enabled.
Oct 2 19:28:47.759089 kernel: Tracing variant of Tasks RCU enabled.
Oct 2 19:28:47.759095 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.
Oct 2 19:28:47.759101 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4
Oct 2 19:28:47.759107 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
Oct 2 19:28:47.759113 kernel: GICv3: 256 SPIs implemented
Oct 2 19:28:47.759121 kernel: GICv3: 0 Extended SPIs implemented
Oct 2 19:28:47.759127 kernel: GICv3: Distributor has no Range Selector support
Oct 2 19:28:47.759133 kernel: Root IRQ handler: gic_handle_irq
Oct 2 19:28:47.759138 kernel: GICv3: 16 PPIs implemented
Oct 2 19:28:47.759144 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000
Oct 2 19:28:47.759150 kernel: ACPI: SRAT not present
Oct 2 19:28:47.759156 kernel: ITS [mem 0x08080000-0x0809ffff]
Oct 2 19:28:47.759162 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1)
Oct 2 19:28:47.759173 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1)
Oct 2 19:28:47.759181 kernel: GICv3: using LPI property table @0x00000000400d0000
Oct 2 19:28:47.759187 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000
Oct 2 19:28:47.759193 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040
Oct 2 19:28:47.759200 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt).
Oct 2 19:28:47.759207 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns
Oct 2 19:28:47.759213 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns
Oct 2 19:28:47.759219 kernel: arm-pv: using stolen time PV
Oct 2 19:28:47.759225 kernel: Console: colour dummy device 80x25
Oct 2 19:28:47.759231 kernel: ACPI: Core revision 20210730
Oct 2 19:28:47.759238 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000)
Oct 2 19:28:47.759245 kernel: pid_max: default: 32768 minimum: 301
Oct 2 19:28:47.759251 kernel: LSM: Security Framework initializing
Oct 2 19:28:47.759257 kernel: SELinux: Initializing.
Oct 2 19:28:47.759264 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
Oct 2 19:28:47.759271 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
Oct 2 19:28:47.759277 kernel: rcu: Hierarchical SRCU implementation.
Oct 2 19:28:47.759283 kernel: Platform MSI: ITS@0x8080000 domain created
Oct 2 19:28:47.759289 kernel: PCI/MSI: ITS@0x8080000 domain created
Oct 2 19:28:47.759295 kernel: Remapping and enabling EFI services.
Oct 2 19:28:47.759301 kernel: smp: Bringing up secondary CPUs ...
Oct 2 19:28:47.759307 kernel: Detected PIPT I-cache on CPU1
Oct 2 19:28:47.759314 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000
Oct 2 19:28:47.759321 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000
Oct 2 19:28:47.759327 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040
Oct 2 19:28:47.759334 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1]
Oct 2 19:28:47.759340 kernel: Detected PIPT I-cache on CPU2
Oct 2 19:28:47.759346 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000
Oct 2 19:28:47.759353 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000
Oct 2 19:28:47.759359 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040
Oct 2 19:28:47.759365 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1]
Oct 2 19:28:47.759371 kernel: Detected PIPT I-cache on CPU3
Oct 2 19:28:47.759378 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000
Oct 2 19:28:47.759400 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000
Oct 2 19:28:47.759406 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040
Oct 2 19:28:47.759412 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1]
Oct 2 19:28:47.759419 kernel: smp: Brought up 1 node, 4 CPUs
Oct 2 19:28:47.759429 kernel: SMP: Total of 4 processors activated.
Oct 2 19:28:47.759437 kernel: CPU features: detected: 32-bit EL0 Support
Oct 2 19:28:47.759447 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence
Oct 2 19:28:47.759453 kernel: CPU features: detected: Common not Private translations
Oct 2 19:28:47.759460 kernel: CPU features: detected: CRC32 instructions
Oct 2 19:28:47.759466 kernel: CPU features: detected: RCpc load-acquire (LDAPR)
Oct 2 19:28:47.759473 kernel: CPU features: detected: LSE atomic instructions
Oct 2 19:28:47.759481 kernel: CPU features: detected: Privileged Access Never
Oct 2 19:28:47.759490 kernel: CPU features: detected: RAS Extension Support
Oct 2 19:28:47.759497 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS)
Oct 2 19:28:47.759504 kernel: CPU: All CPU(s) started at EL1
Oct 2 19:28:47.759510 kernel: alternatives: patching kernel code
Oct 2 19:28:47.759518 kernel: devtmpfs: initialized
Oct 2 19:28:47.759525 kernel: KASLR enabled
Oct 2 19:28:47.759531 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
Oct 2 19:28:47.759538 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
Oct 2 19:28:47.759544 kernel: pinctrl core: initialized pinctrl subsystem
Oct 2 19:28:47.759551 kernel: SMBIOS 3.0.0 present.
Oct 2 19:28:47.759558 kernel: DMI: QEMU KVM Virtual Machine, BIOS 0.0.0 02/06/2015
Oct 2 19:28:47.759564 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family
Oct 2 19:28:47.759571 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations
Oct 2 19:28:47.759577 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
Oct 2 19:28:47.759585 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
Oct 2 19:28:47.759592 kernel: audit: initializing netlink subsys (disabled)
Oct 2 19:28:47.759598 kernel: audit: type=2000 audit(0.034:1): state=initialized audit_enabled=0 res=1
Oct 2 19:28:47.759605 kernel: thermal_sys: Registered thermal governor 'step_wise'
Oct 2 19:28:47.759611 kernel: cpuidle: using governor menu
Oct 2 19:28:47.759618 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
Oct 2 19:28:47.759624 kernel: ASID allocator initialised with 32768 entries
Oct 2 19:28:47.759631 kernel: ACPI: bus type PCI registered
Oct 2 19:28:47.759637 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
Oct 2 19:28:47.759645 kernel: Serial: AMBA PL011 UART driver
Oct 2 19:28:47.759652 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages
Oct 2 19:28:47.759658 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages
Oct 2 19:28:47.759665 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
Oct 2 19:28:47.759672 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages
Oct 2 19:28:47.759678 kernel: cryptd: max_cpu_qlen set to 1000
Oct 2 19:28:47.759685 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng)
Oct 2 19:28:47.759692 kernel: ACPI: Added _OSI(Module Device)
Oct 2 19:28:47.759698 kernel: ACPI: Added _OSI(Processor Device)
Oct 2 19:28:47.759706 kernel: ACPI: Added _OSI(3.0 _SCP Extensions)
Oct 2 19:28:47.759712 kernel: ACPI: Added _OSI(Processor Aggregator Device)
Oct 2 19:28:47.759719 kernel: ACPI: Added _OSI(Linux-Dell-Video)
Oct 2 19:28:47.759725 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio)
Oct 2 19:28:47.759732 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics)
Oct 2 19:28:47.759739 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded
Oct 2 19:28:47.759745 kernel: ACPI: Interpreter enabled
Oct 2 19:28:47.759752 kernel: ACPI: Using GIC for interrupt routing
Oct 2 19:28:47.759758 kernel: ACPI: MCFG table detected, 1 entries
Oct 2 19:28:47.759766 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA
Oct 2 19:28:47.759773 kernel: printk: console [ttyAMA0] enabled
Oct 2 19:28:47.759779 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
Oct 2 19:28:47.759944 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]
Oct 2 19:28:47.760010 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR]
Oct 2 19:28:47.760069 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability]
Oct 2 19:28:47.760126 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00
Oct 2 19:28:47.760198 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]
Oct 2 19:28:47.760212 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window]
Oct 2 19:28:47.760220 kernel: PCI host bridge to bus 0000:00
Oct 2 19:28:47.760297 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window]
Oct 2 19:28:47.760355 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window]
Oct 2 19:28:47.760408 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window]
Oct 2 19:28:47.760460 kernel: pci_bus 0000:00: root bus resource [bus 00-ff]
Oct 2 19:28:47.760536 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000
Oct 2 19:28:47.760605 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00
Oct 2 19:28:47.760694 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f]
Oct 2 19:28:47.760757 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff]
Oct 2 19:28:47.760817 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref]
Oct 2 19:28:47.760888 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref]
Oct 2 19:28:47.760949 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff]
Oct 2 19:28:47.761013 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f]
Oct 2 19:28:47.761067 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window]
Oct 2 19:28:47.761121 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window]
Oct 2 19:28:47.761182 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window]
Oct 2 19:28:47.761192 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35
Oct 2 19:28:47.761199 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36
Oct 2 19:28:47.761205 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37
Oct 2 19:28:47.761214 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38
Oct 2 19:28:47.761220 kernel: iommu: Default domain type: Translated
Oct 2 19:28:47.761227 kernel: iommu: DMA domain TLB invalidation policy: strict mode
Oct 2 19:28:47.761234 kernel: vgaarb: loaded
Oct 2 19:28:47.761241 kernel: pps_core: LinuxPPS API ver. 1 registered
Oct 2 19:28:47.761247 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
Oct 2 19:28:47.761254 kernel: PTP clock support registered
Oct 2 19:28:47.761260 kernel: Registered efivars operations
Oct 2 19:28:47.761267 kernel: clocksource: Switched to clocksource arch_sys_counter
Oct 2 19:28:47.761273 kernel: VFS: Disk quotas dquot_6.6.0
Oct 2 19:28:47.761282 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
Oct 2 19:28:47.761288 kernel: pnp: PnP ACPI init
Oct 2 19:28:47.761355 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved
Oct 2 19:28:47.761365 kernel: pnp: PnP ACPI: found 1 devices
Oct 2 19:28:47.761371 kernel: NET: Registered PF_INET protocol family
Oct 2 19:28:47.761378 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)
Oct 2 19:28:47.761385 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)
Oct 2 19:28:47.761392 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
Oct 2 19:28:47.761400 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)
Oct 2 19:28:47.761407 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear)
Oct 2 19:28:47.761413 kernel: TCP: Hash tables configured (established 32768 bind 32768)
Oct 2 19:28:47.761420 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear)
Oct 2 19:28:47.761427 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear)
Oct 2 19:28:47.761433 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family
Oct 2 19:28:47.761440 kernel: PCI: CLS 0 bytes, default 64
Oct 2 19:28:47.761446 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available
Oct 2 19:28:47.761454 kernel: kvm [1]: HYP mode not available
Oct 2 19:28:47.761461 kernel: Initialise system trusted keyrings
Oct 2 19:28:47.761467 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0
Oct 2 19:28:47.761474 kernel: Key type asymmetric registered
Oct 2 19:28:47.761481 kernel: Asymmetric key parser 'x509' registered
Oct 2 19:28:47.761487 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
Oct 2 19:28:47.761494 kernel: io scheduler mq-deadline registered
Oct 2 19:28:47.761501 kernel: io scheduler kyber registered
Oct 2 19:28:47.761507 kernel: io scheduler bfq registered
Oct 2 19:28:47.761514 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0
Oct 2 19:28:47.761522 kernel: ACPI: button: Power Button [PWRB]
Oct 2 19:28:47.761529 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36
Oct 2 19:28:47.761590 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007)
Oct 2 19:28:47.761599 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
Oct 2 19:28:47.761606 kernel: thunder_xcv, ver 1.0
Oct 2 19:28:47.761612 kernel: thunder_bgx, ver 1.0
Oct 2 19:28:47.761619 kernel: nicpf, ver 1.0
Oct 2 19:28:47.761625 kernel: nicvf, ver 1.0
Oct 2 19:28:47.761696 kernel: rtc-efi rtc-efi.0: registered as rtc0
Oct 2 19:28:47.761755 kernel: rtc-efi rtc-efi.0: setting system clock to 2023-10-02T19:28:47 UTC (1696274927)
Oct 2 19:28:47.761764 kernel: hid: raw HID events driver (C) Jiri Kosina
Oct 2 19:28:47.761771 kernel: NET: Registered PF_INET6 protocol family
Oct 2 19:28:47.761777 kernel: Segment Routing with IPv6
Oct 2 19:28:47.761784 kernel: In-situ OAM (IOAM) with IPv6
Oct 2 19:28:47.761790 kernel: NET: Registered PF_PACKET protocol family
Oct 2 19:28:47.761797 kernel: Key type dns_resolver registered
Oct 2 19:28:47.761803 kernel: registered taskstats version 1
Oct 2 19:28:47.761811 kernel: Loading compiled-in X.509 certificates
Oct 2 19:28:47.761818 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.15.132-flatcar: 3a2a38edc68cb70dc60ec0223a6460557b3bb28d'
Oct 2 19:28:47.761825 kernel: Key type .fscrypt registered
Oct 2 19:28:47.761831 kernel: Key type fscrypt-provisioning registered
Oct 2 19:28:47.761838 kernel: ima: No TPM chip found, activating TPM-bypass!
Oct 2 19:28:47.761844 kernel: ima: Allocated hash algorithm: sha1
Oct 2 19:28:47.761859 kernel: ima: No architecture policies found
Oct 2 19:28:47.761865 kernel: Freeing unused kernel memory: 34560K
Oct 2 19:28:47.761872 kernel: Run /init as init process
Oct 2 19:28:47.761880 kernel: with arguments:
Oct 2 19:28:47.761887 kernel: /init
Oct 2 19:28:47.761893 kernel: with environment:
Oct 2 19:28:47.761900 kernel: HOME=/
Oct 2 19:28:47.761906 kernel: TERM=linux
Oct 2 19:28:47.761912 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a
Oct 2 19:28:47.761921 systemd[1]: systemd 252 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL -ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE -TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified)
Oct 2 19:28:47.761931 systemd[1]: Detected virtualization kvm.
Oct 2 19:28:47.761938 systemd[1]: Detected architecture arm64.
Oct 2 19:28:47.761945 systemd[1]: Running in initrd.
Oct 2 19:28:47.761952 systemd[1]: No hostname configured, using default hostname.
Oct 2 19:28:47.761959 systemd[1]: Hostname set to <localhost>.
Oct 2 19:28:47.761966 systemd[1]: Initializing machine ID from VM UUID.
Oct 2 19:28:47.761973 systemd[1]: Queued start job for default target initrd.target.
Oct 2 19:28:47.761980 systemd[1]: Started systemd-ask-password-console.path.
Oct 2 19:28:47.761988 systemd[1]: Reached target cryptsetup.target.
Oct 2 19:28:47.761995 systemd[1]: Reached target paths.target.
Oct 2 19:28:47.762002 systemd[1]: Reached target slices.target.
Oct 2 19:28:47.762009 systemd[1]: Reached target swap.target.
Oct 2 19:28:47.762016 systemd[1]: Reached target timers.target.
Oct 2 19:28:47.762024 systemd[1]: Listening on iscsid.socket.
Oct 2 19:28:47.762031 systemd[1]: Listening on iscsiuio.socket.
Oct 2 19:28:47.762038 systemd[1]: Listening on systemd-journald-audit.socket.
Oct 2 19:28:47.762046 systemd[1]: Listening on systemd-journald-dev-log.socket.
Oct 2 19:28:47.762053 systemd[1]: Listening on systemd-journald.socket.
Oct 2 19:28:47.762061 systemd[1]: Listening on systemd-networkd.socket.
Oct 2 19:28:47.762068 systemd[1]: Listening on systemd-udevd-control.socket.
Oct 2 19:28:47.762075 systemd[1]: Listening on systemd-udevd-kernel.socket.
Oct 2 19:28:47.762082 systemd[1]: Reached target sockets.target.
Oct 2 19:28:47.762089 systemd[1]: Starting kmod-static-nodes.service...
Oct 2 19:28:47.762096 systemd[1]: Finished network-cleanup.service.
Oct 2 19:28:47.762103 systemd[1]: Starting systemd-fsck-usr.service...
Oct 2 19:28:47.762111 systemd[1]: Starting systemd-journald.service...
Oct 2 19:28:47.762118 systemd[1]: Starting systemd-modules-load.service...
Oct 2 19:28:47.762125 systemd[1]: Starting systemd-resolved.service...
Oct 2 19:28:47.762132 systemd[1]: Starting systemd-vconsole-setup.service...
Oct 2 19:28:47.762139 systemd[1]: Finished kmod-static-nodes.service.
Oct 2 19:28:47.762146 systemd[1]: Finished systemd-fsck-usr.service.
Oct 2 19:28:47.762153 systemd[1]: Starting systemd-tmpfiles-setup-dev.service...
Oct 2 19:28:47.762160 systemd[1]: Finished systemd-vconsole-setup.service.
Oct 2 19:28:47.762167 kernel: audit: type=1130 audit(1696274927.760:2): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:47.762184 systemd-journald[290]: Journal started
Oct 2 19:28:47.762226 systemd-journald[290]: Runtime Journal (/run/log/journal/a019ee78b5ef4cfeb43f9b59e6621afb) is 6.0M, max 48.7M, 42.6M free.
Oct 2 19:28:47.760000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:47.752251 systemd-modules-load[291]: Inserted module 'overlay'
Oct 2 19:28:47.767481 systemd[1]: Starting dracut-cmdline-ask.service...
Oct 2 19:28:47.767517 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this.
Oct 2 19:28:47.771979 systemd[1]: Started systemd-journald.service.
Oct 2 19:28:47.772013 kernel: audit: type=1130 audit(1696274927.769:3): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:47.769000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:47.771043 systemd[1]: Finished systemd-tmpfiles-setup-dev.service.
Oct 2 19:28:47.778232 kernel: audit: type=1130 audit(1696274927.774:4): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:47.778252 kernel: Bridge firewalling registered
Oct 2 19:28:47.774000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:47.778615 systemd-modules-load[291]: Inserted module 'br_netfilter'
Oct 2 19:28:47.780092 systemd-resolved[292]: Positive Trust Anchors:
Oct 2 19:28:47.780105 systemd-resolved[292]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
Oct 2 19:28:47.780132 systemd-resolved[292]: 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 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test
Oct 2 19:28:47.784439 systemd-resolved[292]: Defaulting to hostname 'linux'.
Oct 2 19:28:47.790837 kernel: SCSI subsystem initialized
Oct 2 19:28:47.785298 systemd[1]: Started systemd-resolved.service.
Oct 2 19:28:47.789000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:47.790058 systemd[1]: Reached target nss-lookup.target.
Oct 2 19:28:47.796915 kernel: audit: type=1130 audit(1696274927.789:5): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:47.796934 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
Oct 2 19:28:47.796944 kernel: device-mapper: uevent: version 1.0.3
Oct 2 19:28:47.794904 systemd[1]: Finished dracut-cmdline-ask.service.
Oct 2 19:28:47.802431 kernel: device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com
Oct 2 19:28:47.802453 kernel: audit: type=1130 audit(1696274927.798:6): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:47.798000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:47.802522 systemd[1]: Starting dracut-cmdline.service...
Oct 2 19:28:47.803971 systemd-modules-load[291]: Inserted module 'dm_multipath'
Oct 2 19:28:47.804805 systemd[1]: Finished systemd-modules-load.service.
Oct 2 19:28:47.805000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:47.806520 systemd[1]: Starting systemd-sysctl.service...
Oct 2 19:28:47.810618 kernel: audit: type=1130 audit(1696274927.805:7): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:47.816316 systemd[1]: Finished systemd-sysctl.service.
Oct 2 19:28:47.816000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:47.820489 dracut-cmdline[307]: dracut-dracut-053
Oct 2 19:28:47.821362 kernel: audit: type=1130 audit(1696274927.816:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:47.821384 dracut-cmdline[307]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected acpi=force verity.usrhash=684fe6a2259d7fb96810743ab87aaaa03d9f185b113bd6990a64d1079e5672ca
Oct 2 19:28:47.888890 kernel: Loading iSCSI transport class v2.0-870.
Oct 2 19:28:47.897893 kernel: iscsi: registered transport (tcp)
Oct 2 19:28:47.911892 kernel: iscsi: registered transport (qla4xxx)
Oct 2 19:28:47.911945 kernel: QLogic iSCSI HBA Driver
Oct 2 19:28:47.956861 systemd[1]: Finished dracut-cmdline.service.
Oct 2 19:28:47.956000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:47.958544 systemd[1]: Starting dracut-pre-udev.service...
Oct 2 19:28:47.962066 kernel: audit: type=1130 audit(1696274927.956:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:48.005887 kernel: raid6: neonx8 gen() 13766 MB/s
Oct 2 19:28:48.022879 kernel: raid6: neonx8 xor() 10771 MB/s
Oct 2 19:28:48.039873 kernel: raid6: neonx4 gen() 13447 MB/s
Oct 2 19:28:48.056877 kernel: raid6: neonx4 xor() 11216 MB/s
Oct 2 19:28:48.073874 kernel: raid6: neonx2 gen() 12896 MB/s
Oct 2 19:28:48.090882 kernel: raid6: neonx2 xor() 9880 MB/s
Oct 2 19:28:48.107876 kernel: raid6: neonx1 gen() 10470 MB/s
Oct 2 19:28:48.124871 kernel: raid6: neonx1 xor() 8671 MB/s
Oct 2 19:28:48.141878 kernel: raid6: int64x8 gen() 6243 MB/s
Oct 2 19:28:48.158872 kernel: raid6: int64x8 xor() 3504 MB/s
Oct 2 19:28:48.175874 kernel: raid6: int64x4 gen() 7237 MB/s
Oct 2 19:28:48.192874 kernel: raid6: int64x4 xor() 3848 MB/s
Oct 2 19:28:48.209878 kernel: raid6: int64x2 gen() 6146 MB/s
Oct 2 19:28:48.226886 kernel: raid6: int64x2 xor() 3243 MB/s
Oct 2 19:28:48.243880 kernel: raid6: int64x1 gen() 5003 MB/s
Oct 2 19:28:48.261036 kernel: raid6: int64x1 xor() 2642 MB/s
Oct 2 19:28:48.261054 kernel: raid6: using algorithm neonx8 gen() 13766 MB/s
Oct 2 19:28:48.261063 kernel: raid6: .... xor() 10771 MB/s, rmw enabled
Oct 2 19:28:48.262214 kernel: raid6: using neon recovery algorithm
Oct 2 19:28:48.272877 kernel: xor: measuring software checksum speed
Oct 2 19:28:48.273872 kernel: 8regs : 17293 MB/sec
Oct 2 19:28:48.274865 kernel: 32regs : 20744 MB/sec
Oct 2 19:28:48.276488 kernel: arm64_neon : 27816 MB/sec
Oct 2 19:28:48.276499 kernel: xor: using function: arm64_neon (27816 MB/sec)
Oct 2 19:28:48.338878 kernel: Btrfs loaded, crc32c=crc32c-generic, zoned=no, fsverity=no
Oct 2 19:28:48.352314 systemd[1]: Finished dracut-pre-udev.service.
Oct 2 19:28:48.352000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-udev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:48.354374 systemd[1]: Starting systemd-udevd.service...
Oct 2 19:28:48.360621 kernel: audit: type=1130 audit(1696274928.352:10): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-udev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:48.352000 audit: BPF prog-id=7 op=LOAD
Oct 2 19:28:48.353000 audit: BPF prog-id=8 op=LOAD
Oct 2 19:28:48.370492 systemd-udevd[490]: Using default interface naming scheme 'v252'.
Oct 2 19:28:48.373865 systemd[1]: Started systemd-udevd.service.
Oct 2 19:28:48.372000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:48.378152 systemd[1]: Starting dracut-pre-trigger.service...
Oct 2 19:28:48.397581 dracut-pre-trigger[498]: rd.md=0: removing MD RAID activation
Oct 2 19:28:48.434404 systemd[1]: Finished dracut-pre-trigger.service.
Oct 2 19:28:48.434000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:48.437235 systemd[1]: Starting systemd-udev-trigger.service...
Oct 2 19:28:48.482227 systemd[1]: Finished systemd-udev-trigger.service.
Oct 2 19:28:48.482000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:48.529237 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB)
Oct 2 19:28:48.531866 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9
Oct 2 19:28:48.541893 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device.
Oct 2 19:28:48.545854 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device.
Oct 2 19:28:48.548602 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by (udev-worker) (552)
Oct 2 19:28:48.555154 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device.
Oct 2 19:28:48.556162 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device.
Oct 2 19:28:48.560369 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device.
Oct 2 19:28:48.562140 systemd[1]: Starting disk-uuid.service...
Oct 2 19:28:48.574465 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9
Oct 2 19:28:49.584878 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9
Oct 2 19:28:49.584938 disk-uuid[568]: The operation has completed successfully.
Oct 2 19:28:49.627371 systemd[1]: disk-uuid.service: Deactivated successfully.
Oct 2 19:28:49.627000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=disk-uuid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:49.627000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=disk-uuid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:49.627468 systemd[1]: Finished disk-uuid.service.
Oct 2 19:28:49.629183 systemd[1]: Starting verity-setup.service...
Oct 2 19:28:49.647214 kernel: device-mapper: verity: sha256 using implementation "sha256-ce"
Oct 2 19:28:49.670135 systemd[1]: Found device dev-mapper-usr.device.
Oct 2 19:28:49.672371 systemd[1]: Mounting sysusr-usr.mount...
Oct 2 19:28:49.675000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=verity-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:49.675215 systemd[1]: Finished verity-setup.service.
Oct 2 19:28:49.722872 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: norecovery. Quota mode: none.
Oct 2 19:28:49.723214 systemd[1]: Mounted sysusr-usr.mount.
Oct 2 19:28:49.724061 systemd[1]: afterburn-network-kargs.service was skipped because no trigger condition checks were met.
Oct 2 19:28:49.724785 systemd[1]: Starting ignition-setup.service...
Oct 2 19:28:49.727315 systemd[1]: Starting parse-ip-for-networkd.service...
Oct 2 19:28:49.736336 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm
Oct 2 19:28:49.736376 kernel: BTRFS info (device vda6): using free space tree
Oct 2 19:28:49.737061 kernel: BTRFS info (device vda6): has skinny extents
Oct 2 19:28:49.750863 systemd[1]: mnt-oem.mount: Deactivated successfully.
Oct 2 19:28:49.759111 systemd[1]: Finished ignition-setup.service.
Oct 2 19:28:49.760881 systemd[1]: Starting ignition-fetch-offline.service...
Oct 2 19:28:49.759000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:49.849931 systemd[1]: Finished parse-ip-for-networkd.service.
Oct 2 19:28:49.850000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=parse-ip-for-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:49.851000 audit: BPF prog-id=9 op=LOAD
Oct 2 19:28:49.853131 systemd[1]: Starting systemd-networkd.service...
Oct 2 19:28:49.867888 ignition[658]: Ignition 2.14.0
Oct 2 19:28:49.867899 ignition[658]: Stage: fetch-offline
Oct 2 19:28:49.867943 ignition[658]: no configs at "/usr/lib/ignition/base.d"
Oct 2 19:28:49.867952 ignition[658]: no config dir at "/usr/lib/ignition/base.platform.d/qemu"
Oct 2 19:28:49.868126 ignition[658]: parsed url from cmdline: ""
Oct 2 19:28:49.868129 ignition[658]: no config URL provided
Oct 2 19:28:49.868134 ignition[658]: reading system config file "/usr/lib/ignition/user.ign"
Oct 2 19:28:49.868141 ignition[658]: no config at "/usr/lib/ignition/user.ign"
Oct 2 19:28:49.868167 ignition[658]: op(1): [started] loading QEMU firmware config module
Oct 2 19:28:49.868172 ignition[658]: op(1): executing: "modprobe" "qemu_fw_cfg"
Oct 2 19:28:49.872339 ignition[658]: op(1): [finished] loading QEMU firmware config module
Oct 2 19:28:49.878806 ignition[658]: parsing config with SHA512: 43e237bb11463bfa780b5888fb1638f1e5335ba1f09bce6c9d5d531e8c376dcac4b12a13e41c536736ac551284a72ad3b56c9035c49bb8a294c5c6659c7f3025
Oct 2 19:28:49.886024 systemd-networkd[745]: lo: Link UP
Oct 2 19:28:49.886033 systemd-networkd[745]: lo: Gained carrier
Oct 2 19:28:49.886402 systemd-networkd[745]: Enumeration completed
Oct 2 19:28:49.886585 systemd-networkd[745]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
Oct 2 19:28:49.889000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:49.887607 systemd-networkd[745]: eth0: Link UP
Oct 2 19:28:49.887611 systemd-networkd[745]: eth0: Gained carrier
Oct 2 19:28:49.891286 ignition[658]: fetch-offline: fetch-offline passed
Oct 2 19:28:49.887991 systemd[1]: Started systemd-networkd.service.
Oct 2 19:28:49.891431 ignition[658]: Ignition finished successfully
Oct 2 19:28:49.895000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch-offline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:49.889480 systemd[1]: Reached target network.target.
Oct 2 19:28:49.891106 unknown[658]: fetched base config from "system"
Oct 2 19:28:49.891114 unknown[658]: fetched user config from "qemu"
Oct 2 19:28:49.892082 systemd[1]: Starting iscsiuio.service...
Oct 2 19:28:49.894181 systemd[1]: Finished ignition-fetch-offline.service.
Oct 2 19:28:49.895636 systemd[1]: ignition-fetch.service was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json).
Oct 2 19:28:49.896403 systemd[1]: Starting ignition-kargs.service...
Oct 2 19:28:49.903000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=iscsiuio comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:49.902223 systemd[1]: Started iscsiuio.service.
Oct 2 19:28:49.903990 systemd[1]: Starting iscsid.service...
Oct 2 19:28:49.907387 ignition[751]: Ignition 2.14.0
Oct 2 19:28:49.907393 ignition[751]: Stage: kargs
Oct 2 19:28:49.911402 iscsid[759]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi
Oct 2 19:28:49.911402 iscsid[759]: iscsid: Warning: InitiatorName file /etc/iscsi/initiatorname.iscsi does not exist or does not contain a properly formatted InitiatorName. If using software iscsi (iscsi_tcp or ib_iser) or partial offload (bnx2i or cxgbi iscsi), you may not be able to log
Oct 2 19:28:49.911402 iscsid[759]: into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.<reversed domain name>[:identifier].
Oct 2 19:28:49.911402 iscsid[759]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6.
Oct 2 19:28:49.911402 iscsid[759]: If using hardware iscsi like qla4xxx this message can be ignored.
Oct 2 19:28:49.911402 iscsid[759]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi
Oct 2 19:28:49.911402 iscsid[759]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf
Oct 2 19:28:49.912000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=iscsid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:49.917000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-kargs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:49.907490 ignition[751]: no configs at "/usr/lib/ignition/base.d"
Oct 2 19:28:49.911600 systemd[1]: Started iscsid.service.
Oct 2 19:28:49.907499 ignition[751]: no config dir at "/usr/lib/ignition/base.platform.d/qemu"
Oct 2 19:28:49.913772 systemd[1]: Finished ignition-kargs.service.
Oct 2 19:28:49.908080 ignition[751]: kargs: kargs passed
Oct 2 19:28:49.916491 systemd-networkd[745]: eth0: DHCPv4 address 10.0.0.5/16, gateway 10.0.0.1 acquired from 10.0.0.1
Oct 2 19:28:49.908122 ignition[751]: Ignition finished successfully
Oct 2 19:28:49.931000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:49.918901 systemd[1]: Starting dracut-initqueue.service...
Oct 2 19:28:49.933000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-disks comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:49.929900 ignition[761]: Ignition 2.14.0
Oct 2 19:28:49.921610 systemd[1]: Starting ignition-disks.service...
Oct 2 19:28:49.929907 ignition[761]: Stage: disks
Oct 2 19:28:49.930978 systemd[1]: Finished dracut-initqueue.service.
Oct 2 19:28:49.930008 ignition[761]: no configs at "/usr/lib/ignition/base.d"
Oct 2 19:28:49.933085 systemd[1]: Finished ignition-disks.service.
Oct 2 19:28:49.930017 ignition[761]: no config dir at "/usr/lib/ignition/base.platform.d/qemu"
Oct 2 19:28:49.934490 systemd[1]: Reached target initrd-root-device.target.
Oct 2 19:28:49.930600 ignition[761]: disks: disks passed
Oct 2 19:28:49.935797 systemd[1]: Reached target local-fs-pre.target.
Oct 2 19:28:49.930638 ignition[761]: Ignition finished successfully
Oct 2 19:28:49.937036 systemd[1]: Reached target local-fs.target.
Oct 2 19:28:49.938410 systemd[1]: Reached target remote-fs-pre.target.
Oct 2 19:28:49.939671 systemd[1]: Reached target remote-cryptsetup.target.
Oct 2 19:28:49.941211 systemd[1]: Reached target remote-fs.target.
Oct 2 19:28:49.942653 systemd[1]: Reached target sysinit.target.
Oct 2 19:28:49.944132 systemd[1]: Reached target basic.target.
Oct 2 19:28:49.946685 systemd[1]: Starting dracut-pre-mount.service...
Oct 2 19:28:49.955688 systemd[1]: Finished dracut-pre-mount.service.
Oct 2 19:28:49.956000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:49.957397 systemd[1]: Starting systemd-fsck-root.service...
Oct 2 19:28:49.968592 systemd-resolved[292]: Detected conflict on linux IN A 10.0.0.5
Oct 2 19:28:49.968605 systemd-resolved[292]: Hostname conflict, changing published hostname from 'linux' to 'linux5'.
Oct 2 19:28:49.971548 systemd-fsck[781]: ROOT: clean, 603/553520 files, 56011/553472 blocks
Oct 2 19:28:49.975709 systemd[1]: Finished systemd-fsck-root.service.
Oct 2 19:28:49.976000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:49.977528 systemd[1]: Mounting sysroot.mount...
Oct 2 19:28:49.986873 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none.
Oct 2 19:28:49.987373 systemd[1]: Mounted sysroot.mount.
Oct 2 19:28:49.988238 systemd[1]: Reached target initrd-root-fs.target.
Oct 2 19:28:49.991221 systemd[1]: Mounting sysroot-usr.mount...
Oct 2 19:28:49.992141 systemd[1]: flatcar-metadata-hostname.service was skipped because no trigger condition checks were met.
Oct 2 19:28:49.992190 systemd[1]: ignition-remount-sysroot.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot).
Oct 2 19:28:49.992214 systemd[1]: Reached target ignition-diskful.target.
Oct 2 19:28:49.994870 systemd[1]: Mounted sysroot-usr.mount.
Oct 2 19:28:49.996461 systemd[1]: Starting initrd-setup-root.service...
Oct 2 19:28:50.002872 initrd-setup-root[791]: cut: /sysroot/etc/passwd: No such file or directory
Oct 2 19:28:50.008343 initrd-setup-root[799]: cut: /sysroot/etc/group: No such file or directory
Oct 2 19:28:50.013056 initrd-setup-root[807]: cut: /sysroot/etc/shadow: No such file or directory
Oct 2 19:28:50.018501 initrd-setup-root[815]: cut: /sysroot/etc/gshadow: No such file or directory
Oct 2 19:28:50.051742 systemd[1]: Finished initrd-setup-root.service.
Oct 2 19:28:50.052000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.053613 systemd[1]: Starting ignition-mount.service...
Oct 2 19:28:50.055408 systemd[1]: Starting sysroot-boot.service...
Oct 2 19:28:50.062318 bash[832]: umount: /sysroot/usr/share/oem: not mounted.
Oct 2 19:28:50.074334 ignition[834]: INFO : Ignition 2.14.0
Oct 2 19:28:50.075384 ignition[834]: INFO : Stage: mount
Oct 2 19:28:50.076261 ignition[834]: INFO : no configs at "/usr/lib/ignition/base.d"
Oct 2 19:28:50.077329 ignition[834]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu"
Oct 2 19:28:50.079303 systemd[1]: Finished sysroot-boot.service.
Oct 2 19:28:50.080000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.081105 ignition[834]: INFO : mount: mount passed
Oct 2 19:28:50.081975 ignition[834]: INFO : Ignition finished successfully
Oct 2 19:28:50.083544 systemd[1]: Finished ignition-mount.service.
Oct 2 19:28:50.084000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.681906 systemd[1]: Mounting sysroot-usr-share-oem.mount...
Oct 2 19:28:50.688868 kernel: BTRFS: device label OEM devid 1 transid 13 /dev/vda6 scanned by mount (842)
Oct 2 19:28:50.691081 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm
Oct 2 19:28:50.691101 kernel: BTRFS info (device vda6): using free space tree
Oct 2 19:28:50.691110 kernel: BTRFS info (device vda6): has skinny extents
Oct 2 19:28:50.694839 systemd[1]: Mounted sysroot-usr-share-oem.mount.
Oct 2 19:28:50.696504 systemd[1]: Starting ignition-files.service...
Oct 2 19:28:50.713621 ignition[862]: INFO : Ignition 2.14.0
Oct 2 19:28:50.713621 ignition[862]: INFO : Stage: files
Oct 2 19:28:50.715383 ignition[862]: INFO : no configs at "/usr/lib/ignition/base.d"
Oct 2 19:28:50.715383 ignition[862]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu"
Oct 2 19:28:50.715383 ignition[862]: DEBUG : files: compiled without relabeling support, skipping
Oct 2 19:28:50.723852 ignition[862]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core"
Oct 2 19:28:50.723852 ignition[862]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core"
Oct 2 19:28:50.727682 ignition[862]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core"
Oct 2 19:28:50.729032 ignition[862]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core"
Oct 2 19:28:50.730474 unknown[862]: wrote ssh authorized keys file for user: core
Oct 2 19:28:50.731663 ignition[862]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core"
Oct 2 19:28:50.731663 ignition[862]: INFO : files: op(3): [started] processing unit "etcd-member.service"
Oct 2 19:28:50.731663 ignition[862]: INFO : files: op(3): op(4): [started] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf"
Oct 2 19:28:50.736549 ignition[862]: INFO : files: op(3): op(4): [finished] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf"
Oct 2 19:28:50.736549 ignition[862]: INFO : files: op(3): [finished] processing unit "etcd-member.service"
Oct 2 19:28:50.736549 ignition[862]: INFO : files: op(5): [started] processing unit "coreos-metadata.service"
Oct 2 19:28:50.736549 ignition[862]: INFO : files: op(5): op(6): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service"
Oct 2 19:28:50.736549 ignition[862]: INFO : files: op(5): op(6): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service"
Oct 2 19:28:50.736549 ignition[862]: INFO : files: op(5): [finished] processing unit "coreos-metadata.service"
Oct 2 19:28:50.736549 ignition[862]: INFO : files: op(7): [started] setting preset to enabled for "etcd-member.service"
Oct 2 19:28:50.736549 ignition[862]: INFO : files: op(7): [finished] setting preset to enabled for "etcd-member.service"
Oct 2 19:28:50.736549 ignition[862]: INFO : files: op(8): [started] setting preset to disabled for "coreos-metadata.service"
Oct 2 19:28:50.736549 ignition[862]: INFO : files: op(8): op(9): [started] removing enablement symlink(s) for "coreos-metadata.service"
Oct 2 19:28:50.777264 ignition[862]: INFO : files: op(8): op(9): [finished] removing enablement symlink(s) for "coreos-metadata.service"
Oct 2 19:28:50.778771 ignition[862]: INFO : files: op(8): [finished] setting preset to disabled for "coreos-metadata.service"
Oct 2 19:28:50.778771 ignition[862]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json"
Oct 2 19:28:50.778771 ignition[862]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json"
Oct 2 19:28:50.778771 ignition[862]: INFO : files: files passed
Oct 2 19:28:50.778771 ignition[862]: INFO : Ignition finished successfully
Oct 2 19:28:50.780000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.778909 systemd[1]: Finished ignition-files.service.
Oct 2 19:28:50.781623 systemd[1]: Starting initrd-setup-root-after-ignition.service...
Oct 2 19:28:50.788000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.788000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.783199 systemd[1]: torcx-profile-populate.service was skipped because of an unmet condition check (ConditionPathExists=/sysroot/etc/torcx/next-profile).
Oct 2 19:28:50.792164 initrd-setup-root-after-ignition[886]: grep: /sysroot/usr/share/oem/oem-release: No such file or directory
Oct 2 19:28:50.783934 systemd[1]: Starting ignition-quench.service...
Oct 2 19:28:50.793000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.795260 initrd-setup-root-after-ignition[888]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory
Oct 2 19:28:50.788041 systemd[1]: ignition-quench.service: Deactivated successfully.
Oct 2 19:28:50.788126 systemd[1]: Finished ignition-quench.service.
Oct 2 19:28:50.792796 systemd[1]: Finished initrd-setup-root-after-ignition.service.
Oct 2 19:28:50.794580 systemd[1]: Reached target ignition-complete.target.
Oct 2 19:28:50.796707 systemd[1]: Starting initrd-parse-etc.service...
Oct 2 19:28:50.812222 systemd[1]: initrd-parse-etc.service: Deactivated successfully.
Oct 2 19:28:50.812317 systemd[1]: Finished initrd-parse-etc.service.
Oct 2 19:28:50.813000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.813000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.814051 systemd[1]: Reached target initrd-fs.target.
Oct 2 19:28:50.815432 systemd[1]: Reached target initrd.target.
Oct 2 19:28:50.816737 systemd[1]: dracut-mount.service was skipped because no trigger condition checks were met.
Oct 2 19:28:50.817544 systemd[1]: Starting dracut-pre-pivot.service...
Oct 2 19:28:50.829822 systemd[1]: Finished dracut-pre-pivot.service.
Oct 2 19:28:50.829000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.831495 systemd[1]: Starting initrd-cleanup.service...
Oct 2 19:28:50.840856 systemd[1]: Stopped target nss-lookup.target.
Oct 2 19:28:50.841739 systemd[1]: Stopped target remote-cryptsetup.target.
Oct 2 19:28:50.843208 systemd[1]: Stopped target timers.target.
Oct 2 19:28:50.844560 systemd[1]: dracut-pre-pivot.service: Deactivated successfully.
Oct 2 19:28:50.845000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.844669 systemd[1]: Stopped dracut-pre-pivot.service.
Oct 2 19:28:50.845978 systemd[1]: Stopped target initrd.target.
Oct 2 19:28:50.847428 systemd[1]: Stopped target basic.target.
Oct 2 19:28:50.848680 systemd[1]: Stopped target ignition-complete.target.
Oct 2 19:28:50.850015 systemd[1]: Stopped target ignition-diskful.target.
Oct 2 19:28:50.851355 systemd[1]: Stopped target initrd-root-device.target.
Oct 2 19:28:50.852784 systemd[1]: Stopped target remote-fs.target.
Oct 2 19:28:50.854176 systemd[1]: Stopped target remote-fs-pre.target.
Oct 2 19:28:50.855612 systemd[1]: Stopped target sysinit.target.
Oct 2 19:28:50.856875 systemd[1]: Stopped target local-fs.target.
Oct 2 19:28:50.858228 systemd[1]: Stopped target local-fs-pre.target.
Oct 2 19:28:50.859520 systemd[1]: Stopped target swap.target.
Oct 2 19:28:50.861000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.860719 systemd[1]: dracut-pre-mount.service: Deactivated successfully.
Oct 2 19:28:50.860829 systemd[1]: Stopped dracut-pre-mount.service.
Oct 2 19:28:50.864000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.862183 systemd[1]: Stopped target cryptsetup.target.
Oct 2 19:28:50.866000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch-offline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.863389 systemd[1]: dracut-initqueue.service: Deactivated successfully.
Oct 2 19:28:50.863490 systemd[1]: Stopped dracut-initqueue.service.
Oct 2 19:28:50.864975 systemd[1]: ignition-fetch-offline.service: Deactivated successfully.
Oct 2 19:28:50.865074 systemd[1]: Stopped ignition-fetch-offline.service.
Oct 2 19:28:50.866422 systemd[1]: Stopped target paths.target.
Oct 2 19:28:50.867618 systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
Oct 2 19:28:50.873912 systemd[1]: Stopped systemd-ask-password-console.path.
Oct 2 19:28:50.874843 systemd[1]: Stopped target slices.target.
Oct 2 19:28:50.876266 systemd[1]: Stopped target sockets.target.
Oct 2 19:28:50.877531 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully.
Oct 2 19:28:50.878000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.877641 systemd[1]: Stopped initrd-setup-root-after-ignition.service.
Oct 2 19:28:50.879000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.879003 systemd[1]: ignition-files.service: Deactivated successfully.
Oct 2 19:28:50.879096 systemd[1]: Stopped ignition-files.service.
Oct 2 19:28:50.883671 iscsid[759]: iscsid shutting down.
Oct 2 19:28:50.881519 systemd[1]: Stopping ignition-mount.service...
Oct 2 19:28:50.883186 systemd[1]: Stopping iscsid.service...
Oct 2 19:28:50.884887 systemd[1]: Stopping sysroot-boot.service...
Oct 2 19:28:50.887000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.886073 systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
Oct 2 19:28:50.888000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.886212 systemd[1]: Stopped systemd-udev-trigger.service.
Oct 2 19:28:50.887505 systemd[1]: dracut-pre-trigger.service: Deactivated successfully.
Oct 2 19:28:50.891000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=iscsid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.893008 ignition[901]: INFO : Ignition 2.14.0
Oct 2 19:28:50.893008 ignition[901]: INFO : Stage: umount
Oct 2 19:28:50.893008 ignition[901]: INFO : no configs at "/usr/lib/ignition/base.d"
Oct 2 19:28:50.893008 ignition[901]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu"
Oct 2 19:28:50.893008 ignition[901]: INFO : umount: umount passed
Oct 2 19:28:50.893008 ignition[901]: INFO : Ignition finished successfully
Oct 2 19:28:50.893000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.895000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-disks comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.897000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-kargs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.899000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.887593 systemd[1]: Stopped dracut-pre-trigger.service.
Oct 2 19:28:50.890233 systemd[1]: iscsid.service: Deactivated successfully.
Oct 2 19:28:50.904000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=iscsiuio comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.890333 systemd[1]: Stopped iscsid.service.
Oct 2 19:28:50.906000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.906000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.892512 systemd[1]: ignition-mount.service: Deactivated successfully.
Oct 2 19:28:50.907000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.892583 systemd[1]: Stopped ignition-mount.service.
Oct 2 19:28:50.894169 systemd[1]: iscsid.socket: Deactivated successfully.
Oct 2 19:28:50.894240 systemd[1]: Closed iscsid.socket.
Oct 2 19:28:50.912000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.895255 systemd[1]: ignition-disks.service: Deactivated successfully.
Oct 2 19:28:50.895293 systemd[1]: Stopped ignition-disks.service.
Oct 2 19:28:50.896710 systemd[1]: ignition-kargs.service: Deactivated successfully.
Oct 2 19:28:50.896748 systemd[1]: Stopped ignition-kargs.service.
Oct 2 19:28:50.898722 systemd[1]: ignition-setup.service: Deactivated successfully.
Oct 2 19:28:50.898760 systemd[1]: Stopped ignition-setup.service.
Oct 2 19:28:50.900914 systemd[1]: Stopping iscsiuio.service...
Oct 2 19:28:50.920000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.904248 systemd[1]: sysroot-boot.mount: Deactivated successfully.
Oct 2 19:28:50.904664 systemd[1]: iscsiuio.service: Deactivated successfully.
Oct 2 19:28:50.904743 systemd[1]: Stopped iscsiuio.service.
Oct 2 19:28:50.925000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=parse-ip-for-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.905993 systemd[1]: initrd-cleanup.service: Deactivated successfully.
Oct 2 19:28:50.926000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.906063 systemd[1]: Finished initrd-cleanup.service.
Oct 2 19:28:50.928000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.907518 systemd[1]: sysroot-boot.service: Deactivated successfully.
Oct 2 19:28:50.907585 systemd[1]: Stopped sysroot-boot.service.
Oct 2 19:28:50.909425 systemd[1]: Stopped target network.target.
Oct 2 19:28:50.934000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.910226 systemd[1]: iscsiuio.socket: Deactivated successfully.
Oct 2 19:28:50.910259 systemd[1]: Closed iscsiuio.socket.
Oct 2 19:28:50.911453 systemd[1]: initrd-setup-root.service: Deactivated successfully.
Oct 2 19:28:50.911494 systemd[1]: Stopped initrd-setup-root.service.
Oct 2 19:28:50.938000 audit: BPF prog-id=6 op=UNLOAD
Oct 2 19:28:50.913023 systemd[1]: Stopping systemd-networkd.service...
Oct 2 19:28:50.939000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=network-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.914416 systemd[1]: Stopping systemd-resolved.service...
Oct 2 19:28:50.940000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.918951 systemd-networkd[745]: eth0: DHCPv6 lease lost
Oct 2 19:28:50.941000 audit: BPF prog-id=9 op=UNLOAD
Oct 2 19:28:50.920101 systemd[1]: systemd-networkd.service: Deactivated successfully.
Oct 2 19:28:50.920199 systemd[1]: Stopped systemd-networkd.service.
Oct 2 19:28:50.945000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-udev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.921805 systemd[1]: systemd-networkd.socket: Deactivated successfully.
Oct 2 19:28:50.946000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.921834 systemd[1]: Closed systemd-networkd.socket.
Oct 2 19:28:50.948000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.923668 systemd[1]: Stopping network-cleanup.service...
Oct 2 19:28:50.924483 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully.
Oct 2 19:28:50.924544 systemd[1]: Stopped parse-ip-for-networkd.service.
Oct 2 19:28:50.952000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.926169 systemd[1]: systemd-sysctl.service: Deactivated successfully.
Oct 2 19:28:50.953000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.926211 systemd[1]: Stopped systemd-sysctl.service.
Oct 2 19:28:50.955000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.928407 systemd[1]: systemd-modules-load.service: Deactivated successfully.
Oct 2 19:28:50.928447 systemd[1]: Stopped systemd-modules-load.service.
Oct 2 19:28:50.957000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-udevadm-cleanup-db comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.957000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-udevadm-cleanup-db comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:50.929430 systemd[1]: Stopping systemd-udevd.service...
Oct 2 19:28:50.933738 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully.
Oct 2 19:28:50.934207 systemd[1]: systemd-resolved.service: Deactivated successfully.
Oct 2 19:28:50.934291 systemd[1]: Stopped systemd-resolved.service.
Oct 2 19:28:50.938761 systemd[1]: network-cleanup.service: Deactivated successfully.
Oct 2 19:28:50.938907 systemd[1]: Stopped network-cleanup.service.
Oct 2 19:28:50.940280 systemd[1]: systemd-udevd.service: Deactivated successfully.
Oct 2 19:28:50.940383 systemd[1]: Stopped systemd-udevd.service.
Oct 2 19:28:50.941750 systemd[1]: systemd-udevd-control.socket: Deactivated successfully.
Oct 2 19:28:50.941785 systemd[1]: Closed systemd-udevd-control.socket.
Oct 2 19:28:50.943036 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully.
Oct 2 19:28:50.943065 systemd[1]: Closed systemd-udevd-kernel.socket.
Oct 2 19:28:50.944412 systemd[1]: dracut-pre-udev.service: Deactivated successfully.
Oct 2 19:28:50.944455 systemd[1]: Stopped dracut-pre-udev.service.
Oct 2 19:28:50.945965 systemd[1]: dracut-cmdline.service: Deactivated successfully.
Oct 2 19:28:50.946002 systemd[1]: Stopped dracut-cmdline.service.
Oct 2 19:28:50.947365 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully.
Oct 2 19:28:50.947403 systemd[1]: Stopped dracut-cmdline-ask.service.
Oct 2 19:28:50.949657 systemd[1]: Starting initrd-udevadm-cleanup-db.service...
Oct 2 19:28:50.951224 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
Oct 2 19:28:50.951278 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service.
Oct 2 19:28:50.953621 systemd[1]: kmod-static-nodes.service: Deactivated successfully.
Oct 2 19:28:50.953660 systemd[1]: Stopped kmod-static-nodes.service.
Oct 2 19:28:50.954558 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
Oct 2 19:28:50.954595 systemd[1]: Stopped systemd-vconsole-setup.service.
Oct 2 19:28:50.956964 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup\x2ddev.service.mount: Deactivated successfully.
Oct 2 19:28:50.957368 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
Oct 2 19:28:50.957443 systemd[1]: Finished initrd-udevadm-cleanup-db.service.
Oct 2 19:28:50.988202 systemd-journald[290]: Received SIGTERM from PID 1 (n/a).
Oct 2 19:28:50.958846 systemd[1]: Reached target initrd-switch-root.target.
Oct 2 19:28:50.961032 systemd[1]: Starting initrd-switch-root.service...
Oct 2 19:28:50.968595 systemd[1]: Switching root.
Oct 2 19:28:50.990403 systemd-journald[290]: Journal stopped
Oct 2 19:28:52.982895 kernel: SELinux: Class mctp_socket not defined in policy.
Oct 2 19:28:52.982993 kernel: SELinux: Class anon_inode not defined in policy.
Oct 2 19:28:52.983016 kernel: SELinux: the above unknown classes and permissions will be allowed
Oct 2 19:28:52.983026 kernel: SELinux: policy capability network_peer_controls=1
Oct 2 19:28:52.983037 kernel: SELinux: policy capability open_perms=1
Oct 2 19:28:52.983048 kernel: SELinux: policy capability extended_socket_class=1
Oct 2 19:28:52.983060 kernel: SELinux: policy capability always_check_network=0
Oct 2 19:28:52.983080 kernel: SELinux: policy capability cgroup_seclabel=1
Oct 2 19:28:52.983090 kernel: SELinux: policy capability nnp_nosuid_transition=1
Oct 2 19:28:52.983100 kernel: SELinux: policy capability genfs_seclabel_symlinks=0
Oct 2 19:28:52.983110 kernel: SELinux: policy capability ioctl_skip_cloexec=0
Oct 2 19:28:52.983121 systemd[1]: Successfully loaded SELinux policy in 35.344ms.
Oct 2 19:28:52.983143 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.888ms.
Oct 2 19:28:52.983163 systemd[1]: systemd 252 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL -ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE -TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified)
Oct 2 19:28:52.983176 systemd[1]: Detected virtualization kvm.
Oct 2 19:28:52.983188 systemd[1]: Detected architecture arm64.
Oct 2 19:28:52.983199 systemd[1]: Detected first boot.
Oct 2 19:28:52.983211 systemd[1]: Initializing machine ID from VM UUID.
Oct 2 19:28:52.983222 systemd[1]: Populated /etc with preset unit settings.
Oct 2 19:28:52.983234 systemd[1]: /usr/lib/systemd/system/locksmithd.service:8: Unit uses CPUShares=; please use CPUWeight= instead. Support for CPUShares= will be removed soon.
Oct 2 19:28:52.983245 systemd[1]: /usr/lib/systemd/system/locksmithd.service:9: Unit uses MemoryLimit=; please use MemoryMax= instead. Support for MemoryLimit= will be removed soon.
Oct 2 19:28:52.983258 systemd[1]: /run/systemd/system/docker.socket:8: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly.
Oct 2 19:28:52.983272 kernel: kauditd_printk_skb: 72 callbacks suppressed
Oct 2 19:28:52.983282 kernel: audit: type=1334 audit(1696274932.847:83): prog-id=12 op=LOAD
Oct 2 19:28:52.983291 kernel: audit: type=1334 audit(1696274932.847:84): prog-id=3 op=UNLOAD
Oct 2 19:28:52.983310 kernel: audit: type=1334 audit(1696274932.848:85): prog-id=13 op=LOAD
Oct 2 19:28:52.983320 systemd[1]: initrd-switch-root.service: Deactivated successfully.
Oct 2 19:28:52.983331 kernel: audit: type=1334 audit(1696274932.848:86): prog-id=14 op=LOAD
Oct 2 19:28:52.983340 systemd[1]: Stopped initrd-switch-root.service.
Oct 2 19:28:52.983355 kernel: audit: type=1334 audit(1696274932.848:87): prog-id=4 op=UNLOAD
Oct 2 19:28:52.983371 kernel: audit: type=1334 audit(1696274932.848:88): prog-id=5 op=UNLOAD
Oct 2 19:28:52.983387 kernel: audit: type=1131 audit(1696274932.850:89): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:52.983398 kernel: audit: type=1130 audit(1696274932.858:90): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=initrd-switch-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:52.983408 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
Oct 2 19:28:52.983419 kernel: audit: type=1131 audit(1696274932.858:91): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=initrd-switch-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:52.983430 systemd[1]: Created slice system-addon\x2dconfig.slice.
Oct 2 19:28:52.983440 kernel: audit: type=1334 audit(1696274932.866:92): prog-id=12 op=UNLOAD
Oct 2 19:28:52.983451 systemd[1]: Created slice system-addon\x2drun.slice.
Oct 2 19:28:52.983464 systemd[1]: Created slice system-getty.slice.
Oct 2 19:28:52.983475 systemd[1]: Created slice system-modprobe.slice.
Oct 2 19:28:52.983486 systemd[1]: Created slice system-serial\x2dgetty.slice.
Oct 2 19:28:52.983497 systemd[1]: Created slice system-system\x2dcloudinit.slice.
Oct 2 19:28:52.983509 systemd[1]: Created slice system-systemd\x2dfsck.slice.
Oct 2 19:28:52.983520 systemd[1]: Created slice user.slice.
Oct 2 19:28:52.983532 systemd[1]: Started systemd-ask-password-console.path.
Oct 2 19:28:52.983543 systemd[1]: Started systemd-ask-password-wall.path.
Oct 2 19:28:52.983554 systemd[1]: Set up automount boot.automount.
Oct 2 19:28:52.983565 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount.
Oct 2 19:28:52.983576 systemd[1]: Stopped target initrd-switch-root.target.
Oct 2 19:28:52.983587 systemd[1]: Stopped target initrd-fs.target.
Oct 2 19:28:52.983598 systemd[1]: Stopped target initrd-root-fs.target.
Oct 2 19:28:52.983609 systemd[1]: Reached target integritysetup.target.
Oct 2 19:28:52.983621 systemd[1]: Reached target remote-cryptsetup.target.
Oct 2 19:28:52.983633 systemd[1]: Reached target remote-fs.target.
Oct 2 19:28:52.983644 systemd[1]: Reached target slices.target.
Oct 2 19:28:52.983654 systemd[1]: Reached target swap.target.
Oct 2 19:28:52.983666 systemd[1]: Reached target torcx.target.
Oct 2 19:28:52.983676 systemd[1]: Reached target veritysetup.target.
Oct 2 19:28:52.983697 systemd[1]: Listening on systemd-coredump.socket.
Oct 2 19:28:52.983708 systemd[1]: Listening on systemd-initctl.socket.
Oct 2 19:28:52.983721 systemd[1]: Listening on systemd-networkd.socket.
Oct 2 19:28:52.983732 systemd[1]: Listening on systemd-udevd-control.socket.
Oct 2 19:28:52.983743 systemd[1]: Listening on systemd-udevd-kernel.socket.
Oct 2 19:28:52.983755 systemd[1]: Listening on systemd-userdbd.socket.
Oct 2 19:28:52.983767 systemd[1]: Mounting dev-hugepages.mount...
Oct 2 19:28:52.983780 systemd[1]: Mounting dev-mqueue.mount...
Oct 2 19:28:52.983791 systemd[1]: Mounting media.mount...
Oct 2 19:28:52.983801 systemd[1]: Mounting sys-kernel-debug.mount...
Oct 2 19:28:52.983812 systemd[1]: Mounting sys-kernel-tracing.mount...
Oct 2 19:28:52.983824 systemd[1]: Mounting tmp.mount...
Oct 2 19:28:52.983836 systemd[1]: Starting flatcar-tmpfiles.service...
Oct 2 19:28:52.983847 systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met.
Oct 2 19:28:52.983869 systemd[1]: Starting kmod-static-nodes.service...
Oct 2 19:28:52.983881 systemd[1]: Starting modprobe@configfs.service...
Oct 2 19:28:52.983891 systemd[1]: Starting modprobe@dm_mod.service...
Oct 2 19:28:52.983903 systemd[1]: Starting modprobe@drm.service...
Oct 2 19:28:52.983915 systemd[1]: Starting modprobe@efi_pstore.service...
Oct 2 19:28:52.983926 systemd[1]: Starting modprobe@fuse.service...
Oct 2 19:28:52.983939 systemd[1]: Starting modprobe@loop.service...
Oct 2 19:28:52.983951 systemd[1]: setup-nsswitch.service was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf).
Oct 2 19:28:52.983962 systemd[1]: systemd-fsck-root.service: Deactivated successfully.
Oct 2 19:28:52.983973 systemd[1]: Stopped systemd-fsck-root.service.
Oct 2 19:28:52.983984 systemd[1]: systemd-fsck-usr.service: Deactivated successfully.
Oct 2 19:28:52.984005 systemd[1]: Stopped systemd-fsck-usr.service.
Oct 2 19:28:52.984016 systemd[1]: Stopped systemd-journald.service.
Oct 2 19:28:52.984027 kernel: loop: module loaded
Oct 2 19:28:52.984039 kernel: fuse: init (API version 7.34)
Oct 2 19:28:52.984057 systemd[1]: Starting systemd-journald.service...
Oct 2 19:28:52.984068 systemd[1]: Starting systemd-modules-load.service...
Oct 2 19:28:52.984080 systemd[1]: Starting systemd-network-generator.service...
Oct 2 19:28:52.984091 systemd[1]: Starting systemd-remount-fs.service...
Oct 2 19:28:52.984102 systemd[1]: Starting systemd-udev-trigger.service...
Oct 2 19:28:52.984113 systemd[1]: verity-setup.service: Deactivated successfully.
Oct 2 19:28:52.984124 systemd[1]: Stopped verity-setup.service.
Oct 2 19:28:52.984135 systemd[1]: Mounted dev-hugepages.mount.
Oct 2 19:28:52.984152 systemd-journald[996]: Journal started
Oct 2 19:28:52.984196 systemd-journald[996]: Runtime Journal (/run/log/journal/a019ee78b5ef4cfeb43f9b59e6621afb) is 6.0M, max 48.7M, 42.6M free.
Oct 2 19:28:51.044000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1
Oct 2 19:28:51.082000 audit[1]: AVC avc: denied { bpf } for pid=1 comm="systemd" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1
Oct 2 19:28:51.082000 audit[1]: AVC avc: denied { perfmon } for pid=1 comm="systemd" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1
Oct 2 19:28:51.083000 audit: BPF prog-id=10 op=LOAD
Oct 2 19:28:51.083000 audit: BPF prog-id=10 op=UNLOAD
Oct 2 19:28:51.083000 audit: BPF prog-id=11 op=LOAD
Oct 2 19:28:51.083000 audit: BPF prog-id=11 op=UNLOAD
Oct 2 19:28:52.847000 audit: BPF prog-id=12 op=LOAD
Oct 2 19:28:52.847000 audit: BPF prog-id=3 op=UNLOAD
Oct 2 19:28:52.848000 audit: BPF prog-id=13 op=LOAD
Oct 2 19:28:52.848000 audit: BPF prog-id=14 op=LOAD
Oct 2 19:28:52.848000 audit: BPF prog-id=4 op=UNLOAD
Oct 2 19:28:52.848000 audit: BPF prog-id=5 op=UNLOAD
Oct 2 19:28:52.850000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:52.858000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=initrd-switch-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:52.858000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=initrd-switch-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:52.866000 audit: BPF prog-id=12 op=UNLOAD
Oct 2 19:28:52.956000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:52.958000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:52.960000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:52.960000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:52.961000 audit: BPF prog-id=15 op=LOAD
Oct 2 19:28:52.961000 audit: BPF prog-id=16 op=LOAD
Oct 2 19:28:52.961000 audit: BPF prog-id=17 op=LOAD
Oct 2 19:28:52.961000 audit: BPF prog-id=13 op=UNLOAD
Oct 2 19:28:52.961000 audit: BPF prog-id=14 op=UNLOAD
Oct 2 19:28:52.981000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=verity-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:52.981000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1
Oct 2 19:28:52.981000 audit[996]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=60 a0=3 a1=fffff551aa00 a2=4000 a3=1 items=0 ppid=1 pid=996 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="systemd-journal" exe="/usr/lib/systemd/systemd-journald" subj=system_u:system_r:kernel_t:s0 key=(null)
Oct 2 19:28:52.981000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald"
Oct 2 19:28:51.121569 /usr/lib/systemd/system-generators/torcx-generator[935]: time="2023-10-02T19:28:51Z" level=debug msg="common configuration parsed" base_dir=/var/lib/torcx/ conf_dir=/etc/torcx/ run_dir=/run/torcx/ store_paths="[/usr/share/torcx/store /usr/share/oem/torcx/store/3510.3.0 /usr/share/oem/torcx/store /var/lib/torcx/store/3510.3.0 /var/lib/torcx/store]"
Oct 2 19:28:52.984920 systemd[1]: Started systemd-journald.service.
Oct 2 19:28:52.846212 systemd[1]: Queued start job for default target multi-user.target.
Oct 2 19:28:51.122067 /usr/lib/systemd/system-generators/torcx-generator[935]: time="2023-10-02T19:28:51Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json
Oct 2 19:28:52.846224 systemd[1]: Unnecessary job was removed for dev-vda6.device.
Oct 2 19:28:51.122085 /usr/lib/systemd/system-generators/torcx-generator[935]: time="2023-10-02T19:28:51Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json
Oct 2 19:28:52.850580 systemd[1]: systemd-journald.service: Deactivated successfully.
Oct 2 19:28:51.122139 /usr/lib/systemd/system-generators/torcx-generator[935]: time="2023-10-02T19:28:51Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12"
Oct 2 19:28:51.122151 /usr/lib/systemd/system-generators/torcx-generator[935]: time="2023-10-02T19:28:51Z" level=debug msg="skipped missing lower profile" missing profile=oem
Oct 2 19:28:51.122183 /usr/lib/systemd/system-generators/torcx-generator[935]: time="2023-10-02T19:28:51Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory"
Oct 2 19:28:51.122205 /usr/lib/systemd/system-generators/torcx-generator[935]: time="2023-10-02T19:28:51Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)=
Oct 2 19:28:51.122426 /usr/lib/systemd/system-generators/torcx-generator[935]: time="2023-10-02T19:28:51Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack
Oct 2 19:28:51.122466 /usr/lib/systemd/system-generators/torcx-generator[935]: time="2023-10-02T19:28:51Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json
Oct 2 19:28:51.122479 /usr/lib/systemd/system-generators/torcx-generator[935]: time="2023-10-02T19:28:51Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json
Oct 2 19:28:51.122895 /usr/lib/systemd/system-generators/torcx-generator[935]: time="2023-10-02T19:28:51Z" level=debug msg="new archive/reference added to cache" format=tgz name=docker path="/usr/share/torcx/store/docker:20.10.torcx.tgz" reference=20.10
Oct 2 19:28:51.122926 /usr/lib/systemd/system-generators/torcx-generator[935]: time="2023-10-02T19:28:51Z" level=debug msg="new archive/reference added to cache" format=tgz name=docker path="/usr/share/torcx/store/docker:com.coreos.cl.torcx.tgz" reference=com.coreos.cl
Oct 2 19:28:51.122954 /usr/lib/systemd/system-generators/torcx-generator[935]: time="2023-10-02T19:28:51Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store/3510.3.0: no such file or directory" path=/usr/share/oem/torcx/store/3510.3.0
Oct 2 19:28:51.122968 /usr/lib/systemd/system-generators/torcx-generator[935]: time="2023-10-02T19:28:51Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store
Oct 2 19:28:51.122985 /usr/lib/systemd/system-generators/torcx-generator[935]: time="2023-10-02T19:28:51Z" level=info msg="store skipped" err="open /var/lib/torcx/store/3510.3.0: no such file or directory" path=/var/lib/torcx/store/3510.3.0
Oct 2 19:28:51.122999 /usr/lib/systemd/system-generators/torcx-generator[935]: time="2023-10-02T19:28:51Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store
Oct 2 19:28:52.563014 /usr/lib/systemd/system-generators/torcx-generator[935]: time="2023-10-02T19:28:52Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl
Oct 2 19:28:52.563286 /usr/lib/systemd/system-generators/torcx-generator[935]: time="2023-10-02T19:28:52Z" level=debug msg="binaries propagated" assets="[/bin/containerd /bin/containerd-shim /bin/ctr /bin/docker /bin/docker-containerd /bin/docker-containerd-shim /bin/docker-init /bin/docker-proxy /bin/docker-runc /bin/dockerd /bin/runc /bin/tini]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl
Oct 2 19:28:52.986000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:52.563379 /usr/lib/systemd/system-generators/torcx-generator[935]: time="2023-10-02T19:28:52Z" level=debug msg="networkd units propagated" assets="[/lib/systemd/network/50-docker.network /lib/systemd/network/90-docker-veth.network]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl
Oct 2 19:28:52.563533 /usr/lib/systemd/system-generators/torcx-generator[935]: time="2023-10-02T19:28:52Z" level=debug msg="systemd units propagated" assets="[/lib/systemd/system/containerd.service /lib/systemd/system/docker.service /lib/systemd/system/docker.socket /lib/systemd/system/sockets.target.wants /lib/systemd/system/multi-user.target.wants]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl
Oct 2 19:28:52.563581 /usr/lib/systemd/system-generators/torcx-generator[935]: time="2023-10-02T19:28:52Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile=
Oct 2 19:28:52.563635 /usr/lib/systemd/system-generators/torcx-generator[935]: time="2023-10-02T19:28:52Z" level=debug msg="system state sealed" content="[TORCX_LOWER_PROFILES=\"vendor\" TORCX_UPPER_PROFILE=\"\" TORCX_PROFILE_PATH=\"/run/torcx/profile.json\" TORCX_BINDIR=\"/run/torcx/bin\" TORCX_UNPACKDIR=\"/run/torcx/unpack\"]" path=/run/metadata/torcx
Oct 2 19:28:52.986967 systemd[1]: Mounted dev-mqueue.mount.
Oct 2 19:28:52.987823 systemd[1]: Mounted media.mount.
Oct 2 19:28:52.988615 systemd[1]: Mounted sys-kernel-debug.mount.
Oct 2 19:28:52.989588 systemd[1]: Mounted sys-kernel-tracing.mount.
Oct 2 19:28:52.990539 systemd[1]: Mounted tmp.mount.
Oct 2 19:28:52.991540 systemd[1]: Finished kmod-static-nodes.service.
Oct 2 19:28:52.992000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:52.992756 systemd[1]: modprobe@configfs.service: Deactivated successfully.
Oct 2 19:28:52.992947 systemd[1]: Finished modprobe@configfs.service.
Oct 2 19:28:52.992000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@configfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:52.992000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@configfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:52.994079 systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
Oct 2 19:28:52.994250 systemd[1]: Finished modprobe@dm_mod.service.
Oct 2 19:28:52.994000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@dm_mod comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:52.994000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@dm_mod comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:52.995498 systemd[1]: modprobe@drm.service: Deactivated successfully.
Oct 2 19:28:52.995671 systemd[1]: Finished modprobe@drm.service.
Oct 2 19:28:52.996000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@drm comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:52.996000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@drm comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:52.996872 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
Oct 2 19:28:52.997020 systemd[1]: Finished modprobe@efi_pstore.service.
Oct 2 19:28:52.996000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@efi_pstore comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:52.996000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@efi_pstore comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:52.998107 systemd[1]: modprobe@fuse.service: Deactivated successfully.
Oct 2 19:28:52.998277 systemd[1]: Finished modprobe@fuse.service.
Oct 2 19:28:52.998000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@fuse comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:52.998000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@fuse comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:52.999382 systemd[1]: modprobe@loop.service: Deactivated successfully.
Oct 2 19:28:52.999524 systemd[1]: Finished modprobe@loop.service.
Oct 2 19:28:53.000000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@loop comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:53.000000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@loop comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:53.000724 systemd[1]: Finished systemd-modules-load.service.
Oct 2 19:28:53.001000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:53.001904 systemd[1]: Finished systemd-network-generator.service.
Oct 2 19:28:53.001000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-network-generator comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:53.003279 systemd[1]: Finished systemd-remount-fs.service.
Oct 2 19:28:53.004000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-remount-fs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:53.004750 systemd[1]: Reached target network-pre.target.
Oct 2 19:28:53.006900 systemd[1]: Mounting sys-fs-fuse-connections.mount...
Oct 2 19:28:53.009139 systemd[1]: Mounting sys-kernel-config.mount...
Oct 2 19:28:53.009917 systemd[1]: remount-root.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/).
Oct 2 19:28:53.011678 systemd[1]: Starting systemd-hwdb-update.service...
Oct 2 19:28:53.013814 systemd[1]: Starting systemd-journal-flush.service...
Oct 2 19:28:53.014872 systemd[1]: systemd-pstore.service was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
Oct 2 19:28:53.015954 systemd[1]: Starting systemd-random-seed.service...
Oct 2 19:28:53.016918 systemd[1]: systemd-repart.service was skipped because no trigger condition checks were met.
Oct 2 19:28:53.018012 systemd[1]: Starting systemd-sysctl.service...
Oct 2 19:28:53.022401 systemd[1]: Finished flatcar-tmpfiles.service.
Oct 2 19:28:53.023550 systemd[1]: Mounted sys-fs-fuse-connections.mount.
Oct 2 19:28:53.022000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=flatcar-tmpfiles comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:53.024707 systemd[1]: Mounted sys-kernel-config.mount.
Oct 2 19:28:53.029198 systemd[1]: Starting systemd-sysusers.service...
Oct 2 19:28:53.030524 systemd[1]: Finished systemd-udev-trigger.service.
Oct 2 19:28:53.030000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:53.034882 systemd-journald[996]: Time spent on flushing to /var/log/journal/a019ee78b5ef4cfeb43f9b59e6621afb is 12.849ms for 957 entries.
Oct 2 19:28:53.034882 systemd-journald[996]: System Journal (/var/log/journal/a019ee78b5ef4cfeb43f9b59e6621afb) is 8.0M, max 195.6M, 187.6M free.
Oct 2 19:28:53.058978 systemd-journald[996]: Received client request to flush runtime journal.
Oct 2 19:28:53.045000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-random-seed comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:53.050000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:53.056000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-sysusers comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:53.034437 systemd[1]: Starting systemd-udev-settle.service...
Oct 2 19:28:53.045199 systemd[1]: Finished systemd-random-seed.service.
Oct 2 19:28:53.059334 udevadm[1034]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in.
Oct 2 19:28:53.046635 systemd[1]: Reached target first-boot-complete.target.
Oct 2 19:28:53.049928 systemd[1]: Finished systemd-sysctl.service.
Oct 2 19:28:53.056677 systemd[1]: Finished systemd-sysusers.service.
Oct 2 19:28:53.058965 systemd[1]: Starting systemd-tmpfiles-setup-dev.service...
Oct 2 19:28:53.062297 systemd[1]: Finished systemd-journal-flush.service.
Oct 2 19:28:53.062000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journal-flush comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:53.079828 systemd[1]: Finished systemd-tmpfiles-setup-dev.service.
Oct 2 19:28:53.080000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:53.440981 systemd[1]: Finished systemd-hwdb-update.service.
Oct 2 19:28:53.441000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-hwdb-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:53.441000 audit: BPF prog-id=18 op=LOAD
Oct 2 19:28:53.441000 audit: BPF prog-id=19 op=LOAD
Oct 2 19:28:53.441000 audit: BPF prog-id=7 op=UNLOAD
Oct 2 19:28:53.441000 audit: BPF prog-id=8 op=UNLOAD
Oct 2 19:28:53.443421 systemd[1]: Starting systemd-udevd.service...
Oct 2 19:28:53.464845 systemd-udevd[1039]: Using default interface naming scheme 'v252'.
Oct 2 19:28:53.477097 systemd[1]: Started systemd-udevd.service.
Oct 2 19:28:53.477000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:53.478000 audit: BPF prog-id=20 op=LOAD
Oct 2 19:28:53.481999 systemd[1]: Starting systemd-networkd.service...
Oct 2 19:28:53.490000 audit: BPF prog-id=21 op=LOAD
Oct 2 19:28:53.490000 audit: BPF prog-id=22 op=LOAD
Oct 2 19:28:53.490000 audit: BPF prog-id=23 op=LOAD
Oct 2 19:28:53.491825 systemd[1]: Starting systemd-userdbd.service...
Oct 2 19:28:53.499402 systemd[1]: Condition check resulted in dev-ttyAMA0.device being skipped.
Oct 2 19:28:53.547633 systemd[1]: Started systemd-userdbd.service.
Oct 2 19:28:53.547000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-userdbd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:53.557954 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device.
Oct 2 19:28:53.596390 systemd[1]: Finished systemd-udev-settle.service.
Oct 2 19:28:53.597000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udev-settle comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:53.598811 systemd[1]: Starting lvm2-activation-early.service...
Oct 2 19:28:53.639910 lvm[1071]: WARNING: Failed to connect to lvmetad. Falling back to device scanning.
Oct 2 19:28:53.649574 systemd-networkd[1049]: lo: Link UP
Oct 2 19:28:53.649583 systemd-networkd[1049]: lo: Gained carrier
Oct 2 19:28:53.650075 systemd-networkd[1049]: Enumeration completed
Oct 2 19:28:53.650211 systemd[1]: Started systemd-networkd.service.
Oct 2 19:28:53.650000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:53.652519 systemd[1]: Starting systemd-networkd-wait-online.service...
Oct 2 19:28:53.654072 systemd-networkd[1049]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
Oct 2 19:28:53.657974 systemd-networkd[1049]: eth0: Link UP
Oct 2 19:28:53.657986 systemd-networkd[1049]: eth0: Gained carrier
Oct 2 19:28:53.667807 systemd[1]: Finished lvm2-activation-early.service.
Oct 2 19:28:53.667000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=lvm2-activation-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:53.668986 systemd[1]: Reached target cryptsetup.target.
Oct 2 19:28:53.671052 systemd[1]: Starting lvm2-activation.service...
Oct 2 19:28:53.675789 lvm[1074]: WARNING: Failed to connect to lvmetad. Falling back to device scanning.
Oct 2 19:28:53.676993 systemd-networkd[1049]: eth0: DHCPv4 address 10.0.0.5/16, gateway 10.0.0.1 acquired from 10.0.0.1
Oct 2 19:28:53.712793 systemd[1]: Finished lvm2-activation.service.
Oct 2 19:28:53.712000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=lvm2-activation comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:53.713941 systemd[1]: Reached target local-fs-pre.target.
Oct 2 19:28:53.714782 systemd[1]: var-lib-machines.mount was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw).
Oct 2 19:28:53.714819 systemd[1]: Reached target local-fs.target.
Oct 2 19:28:53.715641 systemd[1]: Reached target machines.target.
Oct 2 19:28:53.717702 systemd[1]: Starting ldconfig.service...
Oct 2 19:28:53.718747 systemd[1]: systemd-binfmt.service was skipped because no trigger condition checks were met.
Oct 2 19:28:53.718811 systemd[1]: systemd-boot-system-token.service was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/LoaderFeatures-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f).
Oct 2 19:28:53.720574 systemd[1]: Starting systemd-boot-update.service...
Oct 2 19:28:53.722719 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service...
Oct 2 19:28:53.724901 systemd[1]: Starting systemd-machine-id-commit.service...
Oct 2 19:28:53.726796 systemd[1]: systemd-sysext.service was skipped because no trigger condition checks were met.
Oct 2 19:28:53.726871 systemd[1]: ensure-sysext.service was skipped because no trigger condition checks were met.
Oct 2 19:28:53.728023 systemd[1]: Starting systemd-tmpfiles-setup.service...
Oct 2 19:28:53.729228 systemd[1]: boot.automount: Got automount request for /boot, triggered by 1076 (bootctl)
Oct 2 19:28:53.731250 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service...
Oct 2 19:28:53.747435 systemd-tmpfiles[1079]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring.
Oct 2 19:28:53.748514 systemd-tmpfiles[1079]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring.
Oct 2 19:28:53.749549 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service.
Oct 2 19:28:53.750000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck@dev-disk-by\x2dlabel-OEM comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:53.752339 systemd-tmpfiles[1079]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring.
Oct 2 19:28:53.754657 systemd[1]: Finished systemd-machine-id-commit.service.
Oct 2 19:28:53.754000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-machine-id-commit comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:53.780809 systemd-fsck[1084]: fsck.fat 4.2 (2021-01-31)
Oct 2 19:28:53.780809 systemd-fsck[1084]: /dev/vda1: 236 files, 113463/258078 clusters
Oct 2 19:28:53.783159 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service.
Oct 2 19:28:53.783000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:53.857846 ldconfig[1075]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start.
Oct 2 19:28:53.861478 systemd[1]: Finished ldconfig.service.
Oct 2 19:28:53.861000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=ldconfig comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:53.983189 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
Oct 2 19:28:53.984643 systemd[1]: Mounting boot.mount...
Oct 2 19:28:53.992086 systemd[1]: Mounted boot.mount.
Oct 2 19:28:54.000087 systemd[1]: Finished systemd-boot-update.service.
Oct 2 19:28:54.000000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-boot-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:54.054870 systemd[1]: Finished systemd-tmpfiles-setup.service.
Oct 2 19:28:54.054000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:54.057201 systemd[1]: Starting audit-rules.service...
Oct 2 19:28:54.059102 systemd[1]: Starting clean-ca-certificates.service...
Oct 2 19:28:54.061171 systemd[1]: Starting systemd-journal-catalog-update.service...
Oct 2 19:28:54.062000 audit: BPF prog-id=24 op=LOAD
Oct 2 19:28:54.063909 systemd[1]: Starting systemd-resolved.service...
Oct 2 19:28:54.066000 audit: BPF prog-id=25 op=LOAD
Oct 2 19:28:54.067703 systemd[1]: Starting systemd-timesyncd.service...
Oct 2 19:28:54.069779 systemd[1]: Starting systemd-update-utmp.service...
Oct 2 19:28:54.071379 systemd[1]: Finished clean-ca-certificates.service.
Oct 2 19:28:54.072000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=clean-ca-certificates comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:54.073499 systemd[1]: update-ca-certificates.service was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt).
Oct 2 19:28:54.075000 audit[1099]: SYSTEM_BOOT pid=1099 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg=' comm="systemd-update-utmp" exe="/usr/lib/systemd/systemd-update-utmp" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:54.078778 systemd[1]: Finished systemd-update-utmp.service.
Oct 2 19:28:54.079000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-update-utmp comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:54.085805 systemd[1]: Finished systemd-journal-catalog-update.service.
Oct 2 19:28:54.086000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journal-catalog-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:54.088388 systemd[1]: Starting systemd-update-done.service...
Oct 2 19:28:54.097199 systemd[1]: Finished systemd-update-done.service.
Oct 2 19:28:54.098000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-update-done comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:54.119767 systemd[1]: Started systemd-timesyncd.service.
Oct 2 19:28:54.121009 systemd[1]: Reached target time-set.target.
Oct 2 19:28:54.120000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-timesyncd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:28:54.123380 systemd-timesyncd[1098]: Contacted time server 10.0.0.1:123 (10.0.0.1).
Oct 2 19:28:54.123795 systemd-timesyncd[1098]: Initial clock synchronization to Mon 2023-10-02 19:28:53.762664 UTC.
Oct 2 19:28:54.127000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1
Oct 2 19:28:54.127000 audit[1110]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffebe6e7d0 a2=420 a3=0 items=0 ppid=1088 pid=1110 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="auditctl" exe="/usr/sbin/auditctl" subj=system_u:system_r:kernel_t:s0 key=(null)
Oct 2 19:28:54.127000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573
Oct 2 19:28:54.127980 augenrules[1110]: No rules
Oct 2 19:28:54.128557 systemd[1]: Finished audit-rules.service.
Oct 2 19:28:54.130278 systemd-resolved[1092]: Positive Trust Anchors:
Oct 2 19:28:54.130289 systemd-resolved[1092]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
Oct 2 19:28:54.130316 systemd-resolved[1092]: 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 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test
Oct 2 19:28:54.149437 systemd-resolved[1092]: Defaulting to hostname 'linux'.
Oct 2 19:28:54.150954 systemd[1]: Started systemd-resolved.service.
Oct 2 19:28:54.151903 systemd[1]: Reached target network.target.
Oct 2 19:28:54.152683 systemd[1]: Reached target nss-lookup.target.
Oct 2 19:28:54.153512 systemd[1]: Reached target sysinit.target.
Oct 2 19:28:54.154381 systemd[1]: Started motdgen.path.
Oct 2 19:28:54.155121 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path.
Oct 2 19:28:54.156370 systemd[1]: Started logrotate.timer.
Oct 2 19:28:54.157204 systemd[1]: Started mdadm.timer.
Oct 2 19:28:54.157937 systemd[1]: Started systemd-tmpfiles-clean.timer.
Oct 2 19:28:54.158796 systemd[1]: update-engine-stub.timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate).
Oct 2 19:28:54.158832 systemd[1]: Reached target paths.target.
Oct 2 19:28:54.159623 systemd[1]: Reached target timers.target.
Oct 2 19:28:54.160731 systemd[1]: Listening on dbus.socket.
Oct 2 19:28:54.162631 systemd[1]: Starting docker.socket...
Oct 2 19:28:54.166305 systemd[1]: Listening on sshd.socket.
Oct 2 19:28:54.167224 systemd[1]: systemd-pcrphase-sysinit.service was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/StubPcrKernelImage-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f).
Oct 2 19:28:54.167836 systemd[1]: Listening on docker.socket.
Oct 2 19:28:54.168714 systemd[1]: Reached target sockets.target.
Oct 2 19:28:54.169526 systemd[1]: Reached target basic.target.
Oct 2 19:28:54.170339 systemd[1]: addon-config@usr-share-oem.service was skipped because no trigger condition checks were met.
Oct 2 19:28:54.170378 systemd[1]: addon-run@usr-share-oem.service was skipped because no trigger condition checks were met.
Oct 2 19:28:54.171560 systemd[1]: Starting containerd.service...
Oct 2 19:28:54.173570 systemd[1]: Starting dbus.service...
Oct 2 19:28:54.175405 systemd[1]: Starting enable-oem-cloudinit.service...
Oct 2 19:28:54.177599 systemd[1]: Starting extend-filesystems.service...
Oct 2 19:28:54.178584 systemd[1]: flatcar-setup-environment.service was skipped because of an unmet condition check (ConditionPathExists=/usr/share/oem/bin/flatcar-setup-environment).
Oct 2 19:28:54.179837 systemd[1]: Starting motdgen.service...
Oct 2 19:28:54.181908 systemd[1]: Starting ssh-key-proc-cmdline.service...
Oct 2 19:28:54.184109 systemd[1]: Starting sshd-keygen.service...
Oct 2 19:28:54.199219 jq[1119]: false
Oct 2 19:28:54.200630 systemd[1]: Starting systemd-logind.service...
Oct 2 19:28:54.201618 systemd[1]: systemd-pcrphase.service was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/StubPcrKernelImage-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f).
Oct 2 19:28:54.201721 systemd[1]: tcsd.service was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0).
Oct 2 19:28:54.202269 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details.
Oct 2 19:28:54.203103 systemd[1]: Starting update-engine.service...
Oct 2 19:28:54.205154 systemd[1]: Starting update-ssh-keys-after-ignition.service...
Oct 2 19:28:54.208232 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'.
Oct 2 19:28:54.208799 jq[1135]: true
Oct 2 19:28:54.208736 systemd[1]: Condition check resulted in enable-oem-cloudinit.service being skipped.
Oct 2 19:28:54.209119 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully.
Oct 2 19:28:54.209279 systemd[1]: Finished ssh-key-proc-cmdline.service.
Oct 2 19:28:54.217970 jq[1138]: true
Oct 2 19:28:54.231769 systemd[1]: motdgen.service: Deactivated successfully.
Oct 2 19:28:54.232022 systemd[1]: Finished motdgen.service.
Oct 2 19:28:54.234303 extend-filesystems[1120]: Found vda
Oct 2 19:28:54.235318 extend-filesystems[1120]: Found vda1
Oct 2 19:28:54.236078 extend-filesystems[1120]: Found vda2
Oct 2 19:28:54.236838 extend-filesystems[1120]: Found vda3
Oct 2 19:28:54.237607 extend-filesystems[1120]: Found usr
Oct 2 19:28:54.238502 extend-filesystems[1120]: Found vda4
Oct 2 19:28:54.239608 extend-filesystems[1120]: Found vda6
Oct 2 19:28:54.240517 extend-filesystems[1120]: Found vda7
Oct 2 19:28:54.241468 extend-filesystems[1120]: Found vda9
Oct 2 19:28:54.242321 extend-filesystems[1120]: Checking size of /dev/vda9
Oct 2 19:28:54.298681 systemd-logind[1129]: Watching system buttons on /dev/input/event0 (Power Button)
Oct 2 19:28:54.303708 systemd-logind[1129]: New seat seat0.
Oct 2 19:28:54.305182 dbus-daemon[1118]: [system] SELinux support is enabled
Oct 2 19:28:54.305346 systemd[1]: Started dbus.service.
Oct 2 19:28:54.308299 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml).
Oct 2 19:28:54.308328 systemd[1]: Reached target system-config.target.
Oct 2 19:28:54.309245 systemd[1]: user-cloudinit-proc-cmdline.service was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url).
Oct 2 19:28:54.309266 systemd[1]: Reached target user-config.target.
Oct 2 19:28:54.312121 systemd[1]: Started systemd-logind.service.
Oct 2 19:28:54.313372 extend-filesystems[1120]: Old size kept for /dev/vda9
Oct 2 19:28:54.313485 dbus-daemon[1118]: [system] Successfully activated service 'org.freedesktop.systemd1'
Oct 2 19:28:54.314782 systemd[1]: extend-filesystems.service: Deactivated successfully.
Oct 2 19:28:54.314967 systemd[1]: Finished extend-filesystems.service.
Oct 2 19:28:54.323745 bash[1160]: Updated "/home/core/.ssh/authorized_keys"
Oct 2 19:28:54.324549 systemd[1]: Finished update-ssh-keys-after-ignition.service.
Oct 2 19:28:54.347659 update_engine[1131]: I1002 19:28:54.347384 1131 main.cc:92] Flatcar Update Engine starting
Oct 2 19:28:54.350660 systemd[1]: Started update-engine.service.
Oct 2 19:28:54.350830 update_engine[1131]: I1002 19:28:54.350808 1131 update_check_scheduler.cc:74] Next update check in 4m43s
Oct 2 19:28:54.354483 systemd[1]: Started locksmithd.service.
Oct 2 19:28:54.360300 env[1139]: time="2023-10-02T19:28:54.360243280Z" level=info msg="starting containerd" revision=92b3a9d6f1b3bcc6dc74875cfdea653fe39f09c2 version=1.6.16
Oct 2 19:28:54.379722 env[1139]: time="2023-10-02T19:28:54.379640240Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1
Oct 2 19:28:54.379830 env[1139]: time="2023-10-02T19:28:54.379809880Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1
Oct 2 19:28:54.381339 env[1139]: time="2023-10-02T19:28:54.381303960Z" 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/5.15.132-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1
Oct 2 19:28:54.381339 env[1139]: time="2023-10-02T19:28:54.381337440Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1
Oct 2 19:28:54.381665 env[1139]: time="2023-10-02T19:28:54.381544360Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1
Oct 2 19:28:54.381665 env[1139]: time="2023-10-02T19:28:54.381567720Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1
Oct 2 19:28:54.381665 env[1139]: time="2023-10-02T19:28:54.381581840Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured"
Oct 2 19:28:54.381665 env[1139]: time="2023-10-02T19:28:54.381592560Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1
Oct 2 19:28:54.381776 env[1139]: time="2023-10-02T19:28:54.381666000Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1
Oct 2 19:28:54.382065 env[1139]: time="2023-10-02T19:28:54.381894280Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1
Oct 2 19:28:54.382065 env[1139]: time="2023-10-02T19:28:54.382011920Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1
Oct 2 19:28:54.382065 env[1139]: time="2023-10-02T19:28:54.382026360Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1
Oct 2 19:28:54.382162 env[1139]: time="2023-10-02T19:28:54.382079440Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured"
Oct 2 19:28:54.382162 env[1139]: time="2023-10-02T19:28:54.382091800Z" level=info msg="metadata content store policy set" policy=shared
Oct 2 19:28:54.389400 env[1139]: time="2023-10-02T19:28:54.385129280Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1
Oct 2 19:28:54.389400 env[1139]: time="2023-10-02T19:28:54.385167520Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1
Oct 2 19:28:54.389400 env[1139]: time="2023-10-02T19:28:54.385183920Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1
Oct 2 19:28:54.389400 env[1139]: time="2023-10-02T19:28:54.385216920Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1
Oct 2 19:28:54.389400 env[1139]: time="2023-10-02T19:28:54.385233080Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1
Oct 2 19:28:54.389400 env[1139]: time="2023-10-02T19:28:54.385247880Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1
Oct 2 19:28:54.389400 env[1139]: time="2023-10-02T19:28:54.385261040Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1
Oct 2 19:28:54.389400 env[1139]: time="2023-10-02T19:28:54.385593560Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1
Oct 2 19:28:54.389400 env[1139]: time="2023-10-02T19:28:54.385612240Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1
Oct 2 19:28:54.389400 env[1139]: time="2023-10-02T19:28:54.385625880Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1
Oct 2 19:28:54.389400 env[1139]: time="2023-10-02T19:28:54.385638440Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1
Oct 2 19:28:54.389400 env[1139]: time="2023-10-02T19:28:54.385651480Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1
Oct 2 19:28:54.389400 env[1139]: time="2023-10-02T19:28:54.385779680Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2
Oct 2 19:28:54.389400 env[1139]: time="2023-10-02T19:28:54.385872400Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1
Oct 2 19:28:54.388684 systemd[1]: Started containerd.service.
Oct 2 19:28:54.389787 env[1139]: time="2023-10-02T19:28:54.386107880Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1
Oct 2 19:28:54.389787 env[1139]: time="2023-10-02T19:28:54.386131080Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1
Oct 2 19:28:54.389787 env[1139]: time="2023-10-02T19:28:54.386173600Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1
Oct 2 19:28:54.389787 env[1139]: time="2023-10-02T19:28:54.386473280Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1
Oct 2 19:28:54.389787 env[1139]: time="2023-10-02T19:28:54.386490160Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1
Oct 2 19:28:54.389787 env[1139]: time="2023-10-02T19:28:54.386503000Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1
Oct 2 19:28:54.389787 env[1139]: time="2023-10-02T19:28:54.386513920Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1
Oct 2 19:28:54.389787 env[1139]: time="2023-10-02T19:28:54.386525720Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1
Oct 2 19:28:54.389787 env[1139]: time="2023-10-02T19:28:54.386538480Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1
Oct 2 19:28:54.389787 env[1139]: time="2023-10-02T19:28:54.386549680Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1
Oct 2 19:28:54.389787 env[1139]: time="2023-10-02T19:28:54.386560840Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1
Oct 2 19:28:54.389787 env[1139]: time="2023-10-02T19:28:54.386574840Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1
Oct 2 19:28:54.389787 env[1139]: time="2023-10-02T19:28:54.386700120Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1
Oct 2 19:28:54.389787 env[1139]: time="2023-10-02T19:28:54.386716360Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1
Oct 2 19:28:54.389787 env[1139]: time="2023-10-02T19:28:54.386728640Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1
Oct 2 19:28:54.390096 env[1139]: time="2023-10-02T19:28:54.386740360Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1
Oct 2 19:28:54.390096 env[1139]: time="2023-10-02T19:28:54.386754440Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="no OpenTelemetry endpoint: skip plugin" type=io.containerd.tracing.processor.v1
Oct 2 19:28:54.390096 env[1139]: time="2023-10-02T19:28:54.386765320Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1
Oct 2 19:28:54.390096 env[1139]: time="2023-10-02T19:28:54.386783280Z" level=error msg="failed to initialize a tracing processor \"otlp\"" error="no OpenTelemetry endpoint: skip plugin"
Oct 2 19:28:54.390096 env[1139]: time="2023-10-02T19:28:54.386817920Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1
Oct 2 19:28:54.390208 env[1139]: time="2023-10-02T19:28:54.387045160Z" 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:true 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}"
Oct 2 19:28:54.390208 env[1139]: time="2023-10-02T19:28:54.387100040Z" level=info msg="Connect containerd service"
Oct 2 19:28:54.390208 env[1139]: time="2023-10-02T19:28:54.387132160Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\""
Oct 2 19:28:54.390208 env[1139]: time="2023-10-02T19:28:54.387993400Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config"
Oct 2 19:28:54.390208 env[1139]: time="2023-10-02T19:28:54.388496560Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc
Oct 2 19:28:54.390208 env[1139]: time="2023-10-02T19:28:54.388540920Z" level=info msg=serving... address=/run/containerd/containerd.sock
Oct 2 19:28:54.390208 env[1139]: time="2023-10-02T19:28:54.390069480Z" level=info msg="containerd successfully booted in 0.030618s"
Oct 2 19:28:54.391991 env[1139]: time="2023-10-02T19:28:54.391944880Z" level=info msg="Start subscribing containerd event"
Oct 2 19:28:54.392052 env[1139]: time="2023-10-02T19:28:54.392006400Z" level=info msg="Start recovering state"
Oct 2 19:28:54.392079 env[1139]: time="2023-10-02T19:28:54.392066520Z" level=info msg="Start event monitor"
Oct 2 19:28:54.392112 env[1139]: time="2023-10-02T19:28:54.392097600Z" level=info msg="Start snapshots syncer"
Oct 2 19:28:54.392139 env[1139]: time="2023-10-02T19:28:54.392113480Z" level=info msg="Start cni network conf syncer for default"
Oct 2 19:28:54.392139 env[1139]: time="2023-10-02T19:28:54.392121880Z" level=info msg="Start streaming server"
Oct 2 19:28:54.410048 locksmithd[1166]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot"
Oct 2 19:28:55.351081 systemd-networkd[1049]: eth0: Gained IPv6LL
Oct 2 19:28:55.352937 systemd[1]: Finished systemd-networkd-wait-online.service.
Oct 2 19:28:55.354126 systemd[1]: Reached target network-online.target.
Oct 2 19:28:55.356208 systemd[1]: Starting coreos-metadata.service...
Oct 2 19:28:55.363907 systemd[1]: coreos-metadata.service: Deactivated successfully.
Oct 2 19:28:55.364067 systemd[1]: Finished coreos-metadata.service.
Oct 2 19:28:55.366191 systemd[1]: Starting etcd-member.service...
Oct 2 19:28:55.408549 sshd_keygen[1140]: ssh-keygen: generating new host keys: RSA ECDSA ED25519
Oct 2 19:28:55.430084 systemd[1]: Finished sshd-keygen.service.
Oct 2 19:28:55.432332 systemd[1]: Starting issuegen.service...
Oct 2 19:28:55.434777 systemd[1]: Starting docker.service...
Oct 2 19:28:55.437590 systemd[1]: issuegen.service: Deactivated successfully.
Oct 2 19:28:55.437738 systemd[1]: Finished issuegen.service.
Oct 2 19:28:55.439779 systemd[1]: Starting systemd-user-sessions.service...
Oct 2 19:28:55.446518 systemd[1]: Finished systemd-user-sessions.service.
Oct 2 19:28:55.448871 systemd[1]: Started getty@tty1.service.
Oct 2 19:28:55.451089 systemd[1]: Started serial-getty@ttyAMA0.service.
Oct 2 19:28:55.452110 systemd[1]: Reached target getty.target.
Oct 2 19:28:55.553352 env[1200]: time="2023-10-02T19:28:55.553301312Z" level=info msg="Starting up"
Oct 2 19:28:55.555750 env[1200]: time="2023-10-02T19:28:55.555723073Z" level=info msg="parsed scheme: \"unix\"" module=grpc
Oct 2 19:28:55.555750 env[1200]: time="2023-10-02T19:28:55.555745380Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
Oct 2 19:28:55.555857 env[1200]: time="2023-10-02T19:28:55.555775708Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/libcontainerd/docker-containerd.sock <nil> 0 <nil>}] <nil> <nil>}" module=grpc
Oct 2 19:28:55.555857 env[1200]: time="2023-10-02T19:28:55.555786365Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
Oct 2 19:28:55.559409 env[1200]: time="2023-10-02T19:28:55.559377372Z" level=info msg="parsed scheme: \"unix\"" module=grpc
Oct 2 19:28:55.559409 env[1200]: time="2023-10-02T19:28:55.559400061Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
Oct 2 19:28:55.559496 env[1200]: time="2023-10-02T19:28:55.559413391Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/libcontainerd/docker-containerd.sock <nil> 0 <nil>}] <nil> <nil>}" module=grpc
Oct 2 19:28:55.559496 env[1200]: time="2023-10-02T19:28:55.559423590Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
Oct 2 19:28:55.613318 env[1200]: time="2023-10-02T19:28:55.613237240Z" level=info msg="Loading containers: start."
Oct 2 19:28:55.742911 kernel: Initializing XFRM netlink socket
Oct 2 19:28:55.767301 env[1200]: time="2023-10-02T19:28:55.767255993Z" 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"
Oct 2 19:28:55.821406 systemd-networkd[1049]: docker0: Link UP
Oct 2 19:28:55.829727 env[1200]: time="2023-10-02T19:28:55.829694200Z" level=info msg="Loading containers: done."
Oct 2 19:28:55.844597 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck3413229683-merged.mount: Deactivated successfully.
Oct 2 19:28:55.846139 env[1200]: time="2023-10-02T19:28:55.846101495Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2
Oct 2 19:28:55.846576 env[1200]: time="2023-10-02T19:28:55.846552448Z" level=info msg="Docker daemon" commit=112bdf3343 graphdriver(s)=overlay2 version=20.10.23
Oct 2 19:28:55.846744 env[1200]: time="2023-10-02T19:28:55.846727275Z" level=info msg="Daemon has completed initialization"
Oct 2 19:28:55.860819 systemd[1]: Started docker.service.
Oct 2 19:28:55.868841 env[1200]: time="2023-10-02T19:28:55.868670372Z" level=info msg="API listen on /run/docker.sock"
Oct 2 19:28:55.870061 etcd-wrapper[1184]: Error response from daemon: No such container: etcd-member
Oct 2 19:28:55.890999 etcd-wrapper[1314]: Error: No such container: etcd-member
Oct 2 19:28:55.931750 etcd-wrapper[1334]: Unable to find image 'quay.io/coreos/etcd:v3.5.0-arm64' locally
Oct 2 19:28:56.642730 etcd-wrapper[1334]: v3.5.0-arm64: Pulling from coreos/etcd
Oct 2 19:28:56.642925 etcd-wrapper[1334]: 6022c6b01d76: Pulling fs layer
Oct 2 19:28:56.643005 etcd-wrapper[1334]: 1d97b1ec77fc: Pulling fs layer
Oct 2 19:28:56.643069 etcd-wrapper[1334]: 99ef4b690837: Pulling fs layer
Oct 2 19:28:56.643137 etcd-wrapper[1334]: 435b7bf0967c: Pulling fs layer
Oct 2 19:28:56.643215 etcd-wrapper[1334]: 17e4a5f7c1b5: Pulling fs layer
Oct 2 19:28:56.643280 etcd-wrapper[1334]: 5b0292999756: Pulling fs layer
Oct 2 19:28:56.643347 etcd-wrapper[1334]: 435b7bf0967c: Waiting
Oct 2 19:28:56.643409 etcd-wrapper[1334]: 17e4a5f7c1b5: Waiting
Oct 2 19:28:56.643468 etcd-wrapper[1334]: 5b0292999756: Waiting
Oct 2 19:28:56.898375 etcd-wrapper[1334]: 1d97b1ec77fc: Verifying Checksum
Oct 2 19:28:56.898375 etcd-wrapper[1334]: 1d97b1ec77fc: Download complete
Oct 2 19:28:56.944845 etcd-wrapper[1334]: 99ef4b690837: Verifying Checksum
Oct 2 19:28:56.944845 etcd-wrapper[1334]: 99ef4b690837: Download complete
Oct 2 19:28:57.092467 etcd-wrapper[1334]: 6022c6b01d76: Verifying Checksum
Oct 2 19:28:57.093095 etcd-wrapper[1334]: 6022c6b01d76: Download complete
Oct 2 19:28:57.138330 etcd-wrapper[1334]: 17e4a5f7c1b5: Verifying Checksum
Oct 2 19:28:57.138330 etcd-wrapper[1334]: 17e4a5f7c1b5: Download complete
Oct 2 19:28:57.149266 etcd-wrapper[1334]: 435b7bf0967c: Verifying Checksum
Oct 2 19:28:57.149266 etcd-wrapper[1334]: 435b7bf0967c: Download complete
Oct 2 19:28:57.268727 etcd-wrapper[1334]: 5b0292999756: Verifying Checksum
Oct 2 19:28:57.268879 etcd-wrapper[1334]: 5b0292999756: Download complete
Oct 2 19:28:57.915987 etcd-wrapper[1334]: 6022c6b01d76: Pull complete
Oct 2 19:28:58.166775 systemd[1]: var-lib-docker-overlay2-7b71df6d1634bea96485f3a37d40ece9aa29614223cedba895197140b602c3ca-merged.mount: Deactivated successfully.
Oct 2 19:28:58.425128 etcd-wrapper[1334]: 1d97b1ec77fc: Pull complete
Oct 2 19:28:58.632545 systemd[1]: var-lib-docker-overlay2-2c2df19cb3547856c90680ec292d4c3acf4c601b95ddbcd60ea4095ef814e502-merged.mount: Deactivated successfully.
Oct 2 19:28:58.669333 etcd-wrapper[1334]: 99ef4b690837: Pull complete
Oct 2 19:28:58.897214 etcd-wrapper[1334]: 435b7bf0967c: Pull complete
Oct 2 19:28:58.921543 systemd[1]: var-lib-docker-overlay2-c81780ae1e1f8ca67c437888cdd0ece7934e15077d8190d2fa2894cd3c1c3f4e-merged.mount: Deactivated successfully.
Oct 2 19:28:58.940535 systemd[1]: var-lib-docker-overlay2-160fed4d6f969219b25c04e96a579da67d08bc63f009047505d245b104e8ddb7-merged.mount: Deactivated successfully.
Oct 2 19:28:58.954989 etcd-wrapper[1334]: 17e4a5f7c1b5: Pull complete
Oct 2 19:28:58.997560 systemd[1]: var-lib-docker-overlay2-ad708dc5cceed27c0791647527f0b0d6ea4ec273d4892e03701f9c463562da68-merged.mount: Deactivated successfully.
Oct 2 19:28:59.013002 etcd-wrapper[1334]: 5b0292999756: Pull complete
Oct 2 19:28:59.021970 etcd-wrapper[1334]: Digest: sha256:96255d1ad67e7afcea46b4dc1b7e74024b9f6971193cb7316b093b3b5671efb0
Oct 2 19:28:59.025119 etcd-wrapper[1334]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.0-arm64
Oct 2 19:28:59.131189 env[1139]: time="2023-10-02T19:28:59.131114528Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1
Oct 2 19:28:59.131189 env[1139]: time="2023-10-02T19:28:59.131153627Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1
Oct 2 19:28:59.131189 env[1139]: time="2023-10-02T19:28:59.131164298Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
Oct 2 19:28:59.131798 env[1139]: time="2023-10-02T19:28:59.131744822Z" level=info msg="starting signal loop" namespace=moby path=/run/containerd/io.containerd.runtime.v2.task/moby/85baf056c93916b7f512368c90f397dfb7ffda60193d6f35fa7ee84fb3740538 pid=1425 runtime=io.containerd.runc.v2
Oct 2 19:28:59.143312 systemd[1]: Started docker-85baf056c93916b7f512368c90f397dfb7ffda60193d6f35fa7ee84fb3740538.scope.
Oct 2 19:28:59.201014 systemd-resolved[1092]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address
Oct 2 19:28:59.292269 etcd-wrapper[1334]: {"level":"info","ts":1696274939.2919724,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"}
Oct 2 19:28:59.292269 etcd-wrapper[1334]: {"level":"info","ts":1696274939.2920637,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"a019ee78b5ef4cfeb43f9b59e6621afb"}
Oct 2 19:28:59.292269 etcd-wrapper[1334]: {"level":"warn","ts":1696274939.2920868,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"}
Oct 2 19:28:59.292269 etcd-wrapper[1334]: {"level":"warn","ts":1696274939.2920952,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.0-arm64"}
Oct 2 19:28:59.292269 etcd-wrapper[1334]: {"level":"warn","ts":1696274939.2921007,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"}
Oct 2 19:28:59.292269 etcd-wrapper[1334]: {"level":"warn","ts":1696274939.292105,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"}
Oct 2 19:28:59.292269 etcd-wrapper[1334]: {"level":"warn","ts":1696274939.2921138,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_UNSUPPORTED_ARCH=arm64"}
Oct 2 19:28:59.292641 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:28:59.292Z","caller":"etcdmain/etcd.go:72","msg":"Running: ","args":["/usr/local/bin/etcd","--listen-client-urls=http://0.0.0.0:2379","--advertise-client-urls=http://10.0.0.5:2379"]}
Oct 2 19:28:59.292641 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:28:59.292Z","caller":"embed/etcd.go:131","msg":"configuring peer listeners","listen-peer-urls":["http://localhost:2380"]}
Oct 2 19:28:59.292862 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:28:59.292Z","caller":"embed/etcd.go:139","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]}
Oct 2 19:28:59.293016 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:28:59.292Z","caller":"embed/etcd.go:307","msg":"starting an etcd server","etcd-version":"3.5.0","git-sha":"946a5a6f2","go-version":"go1.16.3","go-os":"linux","go-arch":"arm64","max-cpu-set":4,"max-cpu-available":4,"member-initialized":false,"name":"a019ee78b5ef4cfeb43f9b59e6621afb","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":100000,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["http://localhost:2380"],"listen-peer-urls":["http://localhost:2380"],"advertise-client-urls":["http://10.0.0.5:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"a019ee78b5ef4cfeb43f9b59e6621afb=http://localhost:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-size-bytes":2147483648,"pre-vote":true,"initial-corrupt-check":false,"corrupt-check-time-interval":"0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
Oct 2 19:28:59.298226 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:28:59.298Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.861886ms"}
Oct 2 19:28:59.302698 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:28:59.302Z","caller":"etcdserver/raft.go:448","msg":"starting local member","local-member-id":"8e9e05c52164694d","cluster-id":"cdf818194e3a8c32"}
Oct 2 19:28:59.302814 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:28:59.302Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=()"}
Oct 2 19:28:59.302814 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:28:59.302Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 0"}
Oct 2 19:28:59.302814 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:28:59.302Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8e9e05c52164694d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
Oct 2 19:28:59.302814 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:28:59.302Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 1"}
Oct 2 19:28:59.302814 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:28:59.302Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"}
Oct 2 19:28:59.306607 etcd-wrapper[1334]: {"level":"warn","ts":"2023-10-02T19:28:59.306Z","caller":"auth/store.go:1220","msg":"simple token is not cryptographically signed"}
Oct 2 19:28:59.307556 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:28:59.307Z","caller":"mvcc/kvstore.go:415","msg":"kvstore restored","current-rev":1}
Oct 2 19:28:59.310197 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:28:59.310Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
Oct 2 19:28:59.310816 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:28:59.310Z","caller":"etcdserver/server.go:843","msg":"starting etcd server","local-member-id":"8e9e05c52164694d","local-server-version":"3.5.0","cluster-version":"to_be_decided"}
Oct 2 19:28:59.310888 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:28:59.310Z","caller":"etcdserver/server.go:728","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8e9e05c52164694d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
Oct 2 19:28:59.311811 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:28:59.311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"}
Oct 2 19:28:59.312134 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:28:59.311Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","added-peer-id":"8e9e05c52164694d","added-peer-peer-urls":["http://localhost:2380"]}
Oct 2 19:28:59.313579 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:28:59.313Z","caller":"embed/etcd.go:276","msg":"now serving peer/client/metrics","local-member-id":"8e9e05c52164694d","initial-advertise-peer-urls":["http://localhost:2380"],"listen-peer-urls":["http://localhost:2380"],"advertise-client-urls":["http://10.0.0.5:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]}
Oct 2 19:28:59.313579 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:28:59.313Z","caller":"embed/etcd.go:580","msg":"serving peer traffic","address":"127.0.0.1:2380"}
Oct 2 19:28:59.313579 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:28:59.313Z","caller":"embed/etcd.go:552","msg":"cmux::serve","address":"127.0.0.1:2380"}
Oct 2 19:28:59.921897 systemd[1]: var-lib-docker-overlay2-5a1f142fff00a656455b21409e5d538aea9955d3e02db3f627f26ab41a9b2775\x2dinit-merged.mount: Deactivated successfully.
Oct 2 19:29:00.003950 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:29:00.003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d is starting a new election at term 1"}
Oct 2 19:29:00.003950 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:29:00.003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became pre-candidate at term 1"}
Oct 2 19:29:00.003950 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:29:00.003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgPreVoteResp from 8e9e05c52164694d at term 1"}
Oct 2 19:29:00.003950 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:29:00.003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became candidate at term 2"}
Oct 2 19:29:00.003950 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:29:00.003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgVoteResp from 8e9e05c52164694d at term 2"}
Oct 2 19:29:00.003950 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:29:00.003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became leader at term 2"}
Oct 2 19:29:00.003950 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:29:00.003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8e9e05c52164694d elected leader 8e9e05c52164694d at term 2"}
Oct 2 19:29:00.003950 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:29:00.003Z","caller":"etcdserver/server.go:2476","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
Oct 2 19:29:00.004912 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:29:00.004Z","caller":"membership/cluster.go:531","msg":"set initial cluster version","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","cluster-version":"3.5"}
Oct 2 19:29:00.005066 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:29:00.004Z","caller":"etcdserver/server.go:2027","msg":"published local member to cluster through raft","local-member-id":"8e9e05c52164694d","local-member-attributes":"{Name:a019ee78b5ef4cfeb43f9b59e6621afb ClientURLs:[http://10.0.0.5:2379]}","request-path":"/0/members/8e9e05c52164694d/attributes","cluster-id":"cdf818194e3a8c32","publish-timeout":"7s"}
Oct 2 19:29:00.005066 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:29:00.004Z","caller":"embed/serve.go:98","msg":"ready to serve client requests"}
Oct 2 19:29:00.005146 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:29:00.004Z","caller":"etcdmain/main.go:47","msg":"notifying init daemon"}
Oct 2 19:29:00.005404 systemd[1]: Started etcd-member.service.
Oct 2 19:29:00.006444 systemd[1]: Reached target multi-user.target.
Oct 2 19:29:00.008556 systemd[1]: Starting systemd-update-utmp-runlevel.service...
Oct 2 19:29:00.014966 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:29:00.005Z","caller":"etcdmain/main.go:53","msg":"successfully notified init daemon"}
Oct 2 19:29:00.014966 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:29:00.007Z","caller":"embed/serve.go:140","msg":"serving client traffic insecurely; this is strongly discouraged!","address":"[::]:2379"}
Oct 2 19:29:00.015302 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:29:00.014Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
Oct 2 19:29:00.015302 etcd-wrapper[1334]: {"level":"info","ts":"2023-10-02T19:29:00.014Z","caller":"etcdserver/server.go:2500","msg":"cluster version is updated","cluster-version":"3.5"}
Oct 2 19:29:00.017854 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully.
Oct 2 19:29:00.018039 systemd[1]: Finished systemd-update-utmp-runlevel.service.
Oct 2 19:29:00.019088 systemd[1]: Startup finished in 649ms (kernel) + 3.423s (initrd) + 9.010s (userspace) = 13.083s.
Oct 2 19:29:00.595018 systemd[1]: Created slice system-sshd.slice.
Oct 2 19:29:00.596193 systemd[1]: Started sshd@0-10.0.0.5:22-10.0.0.1:58176.service.
Oct 2 19:29:00.667155 sshd[1466]: Accepted publickey for core from 10.0.0.1 port 58176 ssh2: RSA SHA256:R3OEPhWkv1tFTzpShOfiax8deu3eER597BueAu9DxLo
Oct 2 19:29:00.673324 sshd[1466]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Oct 2 19:29:00.688874 systemd[1]: Created slice user-500.slice.
Oct 2 19:29:00.690321 systemd[1]: Starting user-runtime-dir@500.service...
Oct 2 19:29:00.692258 systemd-logind[1129]: New session 1 of user core.
Oct 2 19:29:00.701063 systemd[1]: Finished user-runtime-dir@500.service.
Oct 2 19:29:00.702598 systemd[1]: Starting user@500.service...
Oct 2 19:29:00.709086 (systemd)[1469]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0)
Oct 2 19:29:00.777887 systemd[1469]: Queued start job for default target default.target.
Oct 2 19:29:00.778401 systemd[1469]: Reached target paths.target.
Oct 2 19:29:00.778420 systemd[1469]: Reached target sockets.target.
Oct 2 19:29:00.778432 systemd[1469]: Reached target timers.target.
Oct 2 19:29:00.778442 systemd[1469]: Reached target basic.target.
Oct 2 19:29:00.778484 systemd[1469]: Reached target default.target.
Oct 2 19:29:00.778512 systemd[1469]: Startup finished in 62ms.
Oct 2 19:29:00.778596 systemd[1]: Started user@500.service.
Oct 2 19:29:00.780020 systemd[1]: Started session-1.scope.
Oct 2 19:29:00.834977 systemd[1]: Started sshd@1-10.0.0.5:22-10.0.0.1:58178.service.
Oct 2 19:29:00.879270 sshd[1478]: Accepted publickey for core from 10.0.0.1 port 58178 ssh2: RSA SHA256:R3OEPhWkv1tFTzpShOfiax8deu3eER597BueAu9DxLo
Oct 2 19:29:00.880558 sshd[1478]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Oct 2 19:29:00.887404 systemd[1]: Started session-2.scope.
Oct 2 19:29:00.887912 systemd-logind[1129]: New session 2 of user core.
Oct 2 19:29:00.945175 sshd[1478]: pam_unix(sshd:session): session closed for user core
Oct 2 19:29:00.948939 systemd[1]: Started sshd@2-10.0.0.5:22-10.0.0.1:58192.service.
Oct 2 19:29:00.950649 systemd[1]: sshd@1-10.0.0.5:22-10.0.0.1:58178.service: Deactivated successfully.
Oct 2 19:29:00.951338 systemd[1]: session-2.scope: Deactivated successfully.
Oct 2 19:29:00.951946 systemd-logind[1129]: Session 2 logged out. Waiting for processes to exit.
Oct 2 19:29:00.952622 systemd-logind[1129]: Removed session 2.
Oct 2 19:29:00.984311 sshd[1483]: Accepted publickey for core from 10.0.0.1 port 58192 ssh2: RSA SHA256:R3OEPhWkv1tFTzpShOfiax8deu3eER597BueAu9DxLo
Oct 2 19:29:00.985976 sshd[1483]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Oct 2 19:29:00.989687 systemd-logind[1129]: New session 3 of user core.
Oct 2 19:29:00.990108 systemd[1]: Started session-3.scope.
Oct 2 19:29:01.040831 sshd[1483]: pam_unix(sshd:session): session closed for user core
Oct 2 19:29:01.043531 systemd[1]: sshd@2-10.0.0.5:22-10.0.0.1:58192.service: Deactivated successfully.
Oct 2 19:29:01.044127 systemd[1]: session-3.scope: Deactivated successfully.
Oct 2 19:29:01.044736 systemd-logind[1129]: Session 3 logged out. Waiting for processes to exit.
Oct 2 19:29:01.045776 systemd[1]: Started sshd@3-10.0.0.5:22-10.0.0.1:58206.service.
Oct 2 19:29:01.046615 systemd-logind[1129]: Removed session 3.
Oct 2 19:29:01.078745 sshd[1490]: Accepted publickey for core from 10.0.0.1 port 58206 ssh2: RSA SHA256:R3OEPhWkv1tFTzpShOfiax8deu3eER597BueAu9DxLo
Oct 2 19:29:01.080076 sshd[1490]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Oct 2 19:29:01.083559 systemd-logind[1129]: New session 4 of user core.
Oct 2 19:29:01.084366 systemd[1]: Started session-4.scope.
Oct 2 19:29:01.143217 sshd[1490]: pam_unix(sshd:session): session closed for user core
Oct 2 19:29:01.147309 systemd[1]: Started sshd@4-10.0.0.5:22-10.0.0.1:58210.service.
Oct 2 19:29:01.147749 systemd[1]: sshd@3-10.0.0.5:22-10.0.0.1:58206.service: Deactivated successfully.
Oct 2 19:29:01.148576 systemd[1]: session-4.scope: Deactivated successfully.
Oct 2 19:29:01.150137 systemd-logind[1129]: Session 4 logged out. Waiting for processes to exit.
Oct 2 19:29:01.151048 systemd-logind[1129]: Removed session 4.
Oct 2 19:29:01.181829 sshd[1495]: Accepted publickey for core from 10.0.0.1 port 58210 ssh2: RSA SHA256:R3OEPhWkv1tFTzpShOfiax8deu3eER597BueAu9DxLo
Oct 2 19:29:01.183470 sshd[1495]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Oct 2 19:29:01.187476 systemd-logind[1129]: New session 5 of user core.
Oct 2 19:29:01.188271 systemd[1]: Started session-5.scope.
Oct 2 19:29:01.255009 sudo[1499]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1
Oct 2 19:29:01.255205 sudo[1499]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500)
Oct 2 19:29:01.266082 dbus-daemon[1118]: avc: received setenforce notice (enforcing=1)
Oct 2 19:29:01.267807 sudo[1499]: pam_unix(sudo:session): session closed for user root
Oct 2 19:29:01.269957 sshd[1495]: pam_unix(sshd:session): session closed for user core
Oct 2 19:29:01.274292 systemd[1]: Started sshd@5-10.0.0.5:22-10.0.0.1:58222.service.
Oct 2 19:29:01.275253 systemd[1]: sshd@4-10.0.0.5:22-10.0.0.1:58210.service: Deactivated successfully.
Oct 2 19:29:01.276068 systemd[1]: session-5.scope: Deactivated successfully.
Oct 2 19:29:01.277241 systemd-logind[1129]: Session 5 logged out. Waiting for processes to exit.
Oct 2 19:29:01.278660 systemd-logind[1129]: Removed session 5.
Oct 2 19:29:01.307467 sshd[1502]: Accepted publickey for core from 10.0.0.1 port 58222 ssh2: RSA SHA256:R3OEPhWkv1tFTzpShOfiax8deu3eER597BueAu9DxLo
Oct 2 19:29:01.308776 sshd[1502]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Oct 2 19:29:01.311875 systemd-logind[1129]: New session 6 of user core.
Oct 2 19:29:01.313397 systemd[1]: Started session-6.scope.
Oct 2 19:29:01.366061 sudo[1507]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules
Oct 2 19:29:01.366547 sudo[1507]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500)
Oct 2 19:29:01.369520 sudo[1507]: pam_unix(sudo:session): session closed for user root
Oct 2 19:29:01.374359 sudo[1506]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules
Oct 2 19:29:01.374561 sudo[1506]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500)
Oct 2 19:29:01.383657 systemd[1]: Stopping audit-rules.service...
Oct 2 19:29:01.386000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1
Oct 2 19:29:01.387748 auditctl[1510]: No rules
Oct 2 19:29:01.389962 kernel: kauditd_printk_skb: 69 callbacks suppressed
Oct 2 19:29:01.390027 kernel: audit: type=1305 audit(1696274941.386:158): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1
Oct 2 19:29:01.390048 kernel: audit: type=1300 audit(1696274941.386:158): arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffdf33fd90 a2=420 a3=0 items=0 ppid=1 pid=1510 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="auditctl" exe="/usr/sbin/auditctl" subj=system_u:system_r:kernel_t:s0 key=(null)
Oct 2 19:29:01.386000 audit[1510]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffdf33fd90 a2=420 a3=0 items=0 ppid=1 pid=1510 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="auditctl" exe="/usr/sbin/auditctl" subj=system_u:system_r:kernel_t:s0 key=(null)
Oct 2 19:29:01.388186 systemd[1]: audit-rules.service: Deactivated successfully.
Oct 2 19:29:01.388362 systemd[1]: Stopped audit-rules.service.
Oct 2 19:29:01.389775 systemd[1]: Starting audit-rules.service...
Oct 2 19:29:01.386000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D44
Oct 2 19:29:01.394608 kernel: audit: type=1327 audit(1696274941.386:158): proctitle=2F7362696E2F617564697463746C002D44
Oct 2 19:29:01.394663 kernel: audit: type=1131 audit(1696274941.388:159): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:29:01.388000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:29:01.415604 augenrules[1527]: No rules
Oct 2 19:29:01.415000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:29:01.416595 systemd[1]: Finished audit-rules.service.
Oct 2 19:29:01.419562 sudo[1506]: pam_unix(sudo:session): session closed for user root
Oct 2 19:29:01.419895 kernel: audit: type=1130 audit(1696274941.415:160): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:29:01.418000 audit[1506]: USER_END pid=1506 uid=500 auid=500 ses=6 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success'
Oct 2 19:29:01.418000 audit[1506]: CRED_DISP pid=1506 uid=500 auid=500 ses=6 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success'
Oct 2 19:29:01.423969 sshd[1502]: pam_unix(sshd:session): session closed for user core
Oct 2 19:29:01.426869 kernel: audit: type=1106 audit(1696274941.418:161): pid=1506 uid=500 auid=500 ses=6 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success'
Oct 2 19:29:01.426924 kernel: audit: type=1104 audit(1696274941.418:162): pid=1506 uid=500 auid=500 ses=6 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success'
Oct 2 19:29:01.426000 audit[1502]: USER_END pid=1502 uid=0 auid=500 ses=6 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success'
Oct 2 19:29:01.427371 systemd[1]: Started sshd@6-10.0.0.5:22-10.0.0.1:58232.service.
Oct 2 19:29:01.429024 systemd[1]: sshd@5-10.0.0.5:22-10.0.0.1:58222.service: Deactivated successfully.
Oct 2 19:29:01.429714 systemd[1]: session-6.scope: Deactivated successfully.
Oct 2 19:29:01.430048 systemd-logind[1129]: Session 6 logged out. Waiting for processes to exit.
Oct 2 19:29:01.426000 audit[1502]: CRED_DISP pid=1502 uid=0 auid=500 ses=6 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success'
Oct 2 19:29:01.432213 systemd-logind[1129]: Removed session 6.
Oct 2 19:29:01.433668 kernel: audit: type=1106 audit(1696274941.426:163): pid=1502 uid=0 auid=500 ses=6 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success'
Oct 2 19:29:01.433701 kernel: audit: type=1104 audit(1696274941.426:164): pid=1502 uid=0 auid=500 ses=6 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success'
Oct 2 19:29:01.433717 kernel: audit: type=1130 audit(1696274941.426:165): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-10.0.0.5:22-10.0.0.1:58232 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:29:01.426000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-10.0.0.5:22-10.0.0.1:58232 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:29:01.426000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-10.0.0.5:22-10.0.0.1:58222 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:29:01.462000 audit[1532]: USER_ACCT pid=1532 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_access,pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success'
Oct 2 19:29:01.464707 sshd[1532]: Accepted publickey for core from 10.0.0.1 port 58232 ssh2: RSA SHA256:R3OEPhWkv1tFTzpShOfiax8deu3eER597BueAu9DxLo
Oct 2 19:29:01.464000 audit[1532]: CRED_ACQ pid=1532 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success'
Oct 2 19:29:01.464000 audit[1532]: SYSCALL arch=c00000b7 syscall=64 success=yes exit=3 a0=5 a1=ffffe16587e0 a2=3 a3=1 items=0 ppid=1 pid=1532 auid=500 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=7 comm="sshd" exe="/usr/sbin/sshd" subj=system_u:system_r:kernel_t:s0 key=(null)
Oct 2 19:29:01.464000 audit: PROCTITLE proctitle=737368643A20636F7265205B707269765D
Oct 2 19:29:01.465266 sshd[1532]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Oct 2 19:29:01.470278 systemd-logind[1129]: New session 7 of user core.
Oct 2 19:29:01.471087 systemd[1]: Started session-7.scope.
Oct 2 19:29:01.477000 audit[1532]: USER_START pid=1532 uid=0 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success'
Oct 2 19:29:01.478000 audit[1535]: CRED_ACQ pid=1535 uid=0 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success'
Oct 2 19:29:01.619314 sshd[1532]: pam_unix(sshd:session): session closed for user core
Oct 2 19:29:01.620000 audit[1532]: USER_END pid=1532 uid=0 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success'
Oct 2 19:29:01.620000 audit[1532]: CRED_DISP pid=1532 uid=0 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success'
Oct 2 19:29:01.623596 systemd[1]: sshd@6-10.0.0.5:22-10.0.0.1:58232.service: Deactivated successfully.
Oct 2 19:29:01.623000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-10.0.0.5:22-10.0.0.1:58232 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 19:29:01.624465 systemd[1]: session-7.scope: Deactivated successfully.
Oct 2 19:29:01.624998 systemd-logind[1129]: Session 7 logged out. Waiting for processes to exit.
Oct 2 19:29:01.627686 systemd-logind[1129]: Removed session 7.
Oct 2 19:29:39.970823 update_engine[1131]: I1002 19:29:39.970440 1131 update_attempter.cc:505] Updating boot flags...
Oct 2 19:33:38.011320 update_engine[1131]: I1002 19:33:38.011229 1131 prefs.cc:51] certificate-report-to-send-update not present in /var/lib/update_engine/prefs
Oct 2 19:33:38.011320 update_engine[1131]: I1002 19:33:38.011287 1131 prefs.cc:51] certificate-report-to-send-download not present in /var/lib/update_engine/prefs
Oct 2 19:33:38.011889 update_engine[1131]: I1002 19:33:38.011781 1131 prefs.cc:51] aleph-version not present in /var/lib/update_engine/prefs
Oct 2 19:33:38.012219 update_engine[1131]: I1002 19:33:38.012193 1131 omaha_request_params.cc:62] Current group set to lts
Oct 2 19:33:38.012353 update_engine[1131]: I1002 19:33:38.012331 1131 update_attempter.cc:495] Already updated boot flags. Skipping.
Oct 2 19:33:38.012353 update_engine[1131]: I1002 19:33:38.012341 1131 update_attempter.cc:638] Scheduling an action processor start.
Oct 2 19:33:38.012417 update_engine[1131]: I1002 19:33:38.012356 1131 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction
Oct 2 19:33:38.012417 update_engine[1131]: I1002 19:33:38.012382 1131 prefs.cc:51] previous-version not present in /var/lib/update_engine/prefs
Oct 2 19:33:38.012762 update_engine[1131]: I1002 19:33:38.012686 1131 omaha_request_action.cc:268] Posting an Omaha request to https://public.update.flatcar-linux.net/v1/update/
Oct 2 19:33:38.012762 update_engine[1131]: I1002 19:33:38.012701 1131 omaha_request_action.cc:269] Request: <?xml version="1.0" encoding="UTF-8"?>
Oct 2 19:33:38.012762 update_engine[1131]: <request protocol="3.0" version="update_engine-0.4.10" updaterversion="update_engine-0.4.10" installsource="scheduler" ismachine="1">
Oct 2 19:33:38.012762 update_engine[1131]: <os version="Chateau" platform="CoreOS" sp="3510.3.0_aarch64"></os>
Oct 2 19:33:38.012762 update_engine[1131]: <app appid="{e96281a6-d1af-4bde-9a0a-97b76e56dc57}" version="3510.3.0" track="lts" bootid="{b297b60f-cf24-4968-9687-972e5f607459}" oem="" oemversion="" alephversion="3510.3.0" machineid="a019ee78b5ef4cfeb43f9b59e6621afb" machinealias="" lang="en-US" board="arm64-usr" hardware_class="" delta_okay="false" >
Oct 2 19:33:38.012762 update_engine[1131]: <ping active="1"></ping>
Oct 2 19:33:38.012762 update_engine[1131]: <updatecheck></updatecheck>
Oct 2 19:33:38.012762 update_engine[1131]: <event eventtype="3" eventresult="2" previousversion="0.0.0.0"></event>
Oct 2 19:33:38.012762 update_engine[1131]: </app>
Oct 2 19:33:38.012762 update_engine[1131]: </request>
Oct 2 19:33:38.012762 update_engine[1131]: I1002 19:33:38.012706 1131 libcurl_http_fetcher.cc:47] Starting/Resuming transfer
Oct 2 19:33:38.013136 locksmithd[1166]: LastCheckedTime=0 Progress=0 CurrentOperation="UPDATE_STATUS_CHECKING_FOR_UPDATE" NewVersion=0.0.0 NewSize=0
Oct 2 19:33:38.017331 update_engine[1131]: I1002 19:33:38.017298 1131 libcurl_http_fetcher.cc:174] Setting up curl options for HTTPS
Oct 2 19:33:38.019268 update_engine[1131]: I1002 19:33:38.019243 1131 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds.
Oct 2 19:33:39.105896 update_engine[1131]: I1002 19:33:39.105829 1131 prefs.cc:51] update-server-cert-0-2 not present in /var/lib/update_engine/prefs
Oct 2 19:33:39.106216 update_engine[1131]: I1002 19:33:39.106108 1131 prefs.cc:51] update-server-cert-0-1 not present in /var/lib/update_engine/prefs
Oct 2 19:33:39.106305 update_engine[1131]: I1002 19:33:39.106272 1131 prefs.cc:51] update-server-cert-0-0 not present in /var/lib/update_engine/prefs
Oct 2 19:33:39.386169 update_engine[1131]: I1002 19:33:39.386045 1131 libcurl_http_fetcher.cc:263] HTTP response code: 200
Oct 2 19:33:39.387817 update_engine[1131]: I1002 19:33:39.387786 1131 libcurl_http_fetcher.cc:320] Transfer completed (200), 314 bytes downloaded
Oct 2 19:33:39.387817 update_engine[1131]: I1002 19:33:39.387807 1131 omaha_request_action.cc:619] Omaha request response: <?xml version="1.0" encoding="UTF-8"?>
Oct 2 19:33:39.387817 update_engine[1131]: <response protocol="3.0" server="nebraska"><daystart elapsed_seconds="0"></daystart><app appid="{e96281a6-d1af-4bde-9a0a-97b76e56dc57}" status="ok"><ping status="ok"></ping><updatecheck status="noupdate"><urls></urls></updatecheck><event status="ok"></event></app></response>
Oct 2 19:33:39.392773 update_engine[1131]: I1002 19:33:39.392746 1131 omaha_request_action.cc:409] No update.
Oct 2 19:33:39.392773 update_engine[1131]: I1002 19:33:39.392772 1131 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaRequestAction, starting OmahaResponseHandlerAction
Oct 2 19:33:39.392841 update_engine[1131]: I1002 19:33:39.392778 1131 omaha_response_handler_action.cc:36] There are no updates. Aborting.
Oct 2 19:33:39.392841 update_engine[1131]: I1002 19:33:39.392782 1131 action_processor.cc:68] ActionProcessor::ActionComplete: OmahaResponseHandlerAction action failed. Aborting processing.
Oct 2 19:33:39.392841 update_engine[1131]: I1002 19:33:39.392786 1131 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaResponseHandlerAction
Oct 2 19:33:39.392841 update_engine[1131]: I1002 19:33:39.392788 1131 update_attempter.cc:302] Processing Done.
Oct 2 19:33:39.392841 update_engine[1131]: I1002 19:33:39.392802 1131 update_attempter.cc:338] No update.
Oct 2 19:33:39.392841 update_engine[1131]: I1002 19:33:39.392814 1131 update_check_scheduler.cc:74] Next update check in 40m46s
Oct 2 19:33:39.393235 locksmithd[1166]: LastCheckedTime=1696275219 Progress=0 CurrentOperation="UPDATE_STATUS_IDLE" NewVersion=0.0.0 NewSize=0