Dec 13 02:00:25.081733 kernel: Linux version 5.15.173-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-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 Thu Dec 12 23:50:37 -00 2024
Dec 13 02:00:25.081755 kernel: Command line: BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=tty1 console=ttyS0,115200n8 earlyprintk=ttyS0,115200 flatcar.first_boot=detected flatcar.oem.id=azure flatcar.autologin verity.usrhash=66bd2580285375a2ba5b0e34ba63606314bcd90aaed1de1996371bdcb032485c
Dec 13 02:00:25.081767 kernel: BIOS-provided physical RAM map:
Dec 13 02:00:25.081773 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable
Dec 13 02:00:25.081779 kernel: BIOS-e820: [mem 0x00000000000c0000-0x00000000000fffff] reserved
Dec 13 02:00:25.081785 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000003ff40fff] usable
Dec 13 02:00:25.081794 kernel: BIOS-e820: [mem 0x000000003ff41000-0x000000003ffc8fff] reserved
Dec 13 02:00:25.081800 kernel: BIOS-e820: [mem 0x000000003ffc9000-0x000000003fffafff] ACPI data
Dec 13 02:00:25.081806 kernel: BIOS-e820: [mem 0x000000003fffb000-0x000000003fffefff] ACPI NVS
Dec 13 02:00:25.081812 kernel: BIOS-e820: [mem 0x000000003ffff000-0x000000003fffffff] usable
Dec 13 02:00:25.081821 kernel: BIOS-e820: [mem 0x0000000100000000-0x00000002bfffffff] usable
Dec 13 02:00:25.081827 kernel: printk: bootconsole [earlyser0] enabled
Dec 13 02:00:25.081834 kernel: NX (Execute Disable) protection: active
Dec 13 02:00:25.081841 kernel: efi: EFI v2.70 by Microsoft
Dec 13 02:00:25.081851 kernel: efi: ACPI=0x3fffa000 ACPI 2.0=0x3fffa014 SMBIOS=0x3ff85000 SMBIOS 3.0=0x3ff83000 MEMATTR=0x3f5c8a98 RNG=0x3ffd1018 
Dec 13 02:00:25.081858 kernel: random: crng init done
Dec 13 02:00:25.081867 kernel: SMBIOS 3.1.0 present.
Dec 13 02:00:25.081874 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 03/08/2024
Dec 13 02:00:25.081884 kernel: Hypervisor detected: Microsoft Hyper-V
Dec 13 02:00:25.081890 kernel: Hyper-V: privilege flags low 0x2e7f, high 0x3b8030, hints 0x64e24, misc 0xbed7b2
Dec 13 02:00:25.081896 kernel: Hyper-V Host Build:20348-10.0-1-0.1633
Dec 13 02:00:25.081906 kernel: Hyper-V: Nested features: 0x1e0101
Dec 13 02:00:25.081914 kernel: Hyper-V: LAPIC Timer Frequency: 0x30d40
Dec 13 02:00:25.081924 kernel: Hyper-V: Using hypercall for remote TLB flush
Dec 13 02:00:25.081930 kernel: clocksource: hyperv_clocksource_tsc_page: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns
Dec 13 02:00:25.081937 kernel: tsc: Marking TSC unstable due to running on Hyper-V
Dec 13 02:00:25.081944 kernel: tsc: Detected 2593.906 MHz processor
Dec 13 02:00:25.081952 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
Dec 13 02:00:25.081960 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable
Dec 13 02:00:25.081968 kernel: last_pfn = 0x2c0000 max_arch_pfn = 0x400000000
Dec 13 02:00:25.081976 kernel: x86/PAT: Configuration [0-7]: WB  WC  UC- UC  WB  WP  UC- WT  
Dec 13 02:00:25.081983 kernel: e820: update [mem 0x40000000-0xffffffff] usable ==> reserved
Dec 13 02:00:25.081991 kernel: last_pfn = 0x40000 max_arch_pfn = 0x400000000
Dec 13 02:00:25.081999 kernel: Using GB pages for direct mapping
Dec 13 02:00:25.082010 kernel: Secure boot disabled
Dec 13 02:00:25.082020 kernel: ACPI: Early table checksum verification disabled
Dec 13 02:00:25.082027 kernel: ACPI: RSDP 0x000000003FFFA014 000024 (v02 VRTUAL)
Dec 13 02:00:25.082033 kernel: ACPI: XSDT 0x000000003FFF90E8 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
Dec 13 02:00:25.082042 kernel: ACPI: FACP 0x000000003FFF8000 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001)
Dec 13 02:00:25.082050 kernel: ACPI: DSDT 0x000000003FFD6000 01E184 (v02 MSFTVM DSDT01   00000001 MSFT 05000000)
Dec 13 02:00:25.082064 kernel: ACPI: FACS 0x000000003FFFE000 000040
Dec 13 02:00:25.082072 kernel: ACPI: OEM0 0x000000003FFF7000 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
Dec 13 02:00:25.082082 kernel: ACPI: SPCR 0x000000003FFF6000 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001)
Dec 13 02:00:25.082091 kernel: ACPI: WAET 0x000000003FFF5000 000028 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
Dec 13 02:00:25.082099 kernel: ACPI: APIC 0x000000003FFD5000 000058 (v04 VRTUAL MICROSFT 00000001 MSFT 00000001)
Dec 13 02:00:25.082106 kernel: ACPI: SRAT 0x000000003FFD4000 0002D0 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001)
Dec 13 02:00:25.082118 kernel: ACPI: BGRT 0x000000003FFD3000 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
Dec 13 02:00:25.082127 kernel: ACPI: FPDT 0x000000003FFD2000 000034 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
Dec 13 02:00:25.082135 kernel: ACPI: Reserving FACP table memory at [mem 0x3fff8000-0x3fff8113]
Dec 13 02:00:25.082143 kernel: ACPI: Reserving DSDT table memory at [mem 0x3ffd6000-0x3fff4183]
Dec 13 02:00:25.085827 kernel: ACPI: Reserving FACS table memory at [mem 0x3fffe000-0x3fffe03f]
Dec 13 02:00:25.085848 kernel: ACPI: Reserving OEM0 table memory at [mem 0x3fff7000-0x3fff7063]
Dec 13 02:00:25.085862 kernel: ACPI: Reserving SPCR table memory at [mem 0x3fff6000-0x3fff604f]
Dec 13 02:00:25.085875 kernel: ACPI: Reserving WAET table memory at [mem 0x3fff5000-0x3fff5027]
Dec 13 02:00:25.085895 kernel: ACPI: Reserving APIC table memory at [mem 0x3ffd5000-0x3ffd5057]
Dec 13 02:00:25.085908 kernel: ACPI: Reserving SRAT table memory at [mem 0x3ffd4000-0x3ffd42cf]
Dec 13 02:00:25.085921 kernel: ACPI: Reserving BGRT table memory at [mem 0x3ffd3000-0x3ffd3037]
Dec 13 02:00:25.085933 kernel: ACPI: Reserving FPDT table memory at [mem 0x3ffd2000-0x3ffd2033]
Dec 13 02:00:25.085947 kernel: SRAT: PXM 0 -> APIC 0x00 -> Node 0
Dec 13 02:00:25.085959 kernel: SRAT: PXM 0 -> APIC 0x01 -> Node 0
Dec 13 02:00:25.085972 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] hotplug
Dec 13 02:00:25.085986 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x2bfffffff] hotplug
Dec 13 02:00:25.085999 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x2c0000000-0xfdfffffff] hotplug
Dec 13 02:00:25.086014 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1000000000-0xffffffffff] hotplug
Dec 13 02:00:25.086027 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x10000000000-0x1ffffffffff] hotplug
Dec 13 02:00:25.086040 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x20000000000-0x3ffffffffff] hotplug
Dec 13 02:00:25.086054 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x40000000000-0x7ffffffffff] hotplug
Dec 13 02:00:25.086067 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x80000000000-0xfffffffffff] hotplug
Dec 13 02:00:25.086080 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000000-0x1fffffffffff] hotplug
Dec 13 02:00:25.086093 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x200000000000-0x3fffffffffff] hotplug
Dec 13 02:00:25.086107 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x400000000000-0x7fffffffffff] hotplug
Dec 13 02:00:25.086119 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x800000000000-0xffffffffffff] hotplug
Dec 13 02:00:25.086135 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1000000000000-0x1ffffffffffff] hotplug
Dec 13 02:00:25.086147 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x2000000000000-0x3ffffffffffff] hotplug
Dec 13 02:00:25.086170 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x4000000000000-0x7ffffffffffff] hotplug
Dec 13 02:00:25.086183 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x8000000000000-0xfffffffffffff] hotplug
Dec 13 02:00:25.086196 kernel: NUMA: Node 0 [mem 0x00000000-0x3fffffff] + [mem 0x100000000-0x2bfffffff] -> [mem 0x00000000-0x2bfffffff]
Dec 13 02:00:25.086209 kernel: NODE_DATA(0) allocated [mem 0x2bfffa000-0x2bfffffff]
Dec 13 02:00:25.086223 kernel: Zone ranges:
Dec 13 02:00:25.086236 kernel:   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
Dec 13 02:00:25.086249 kernel:   DMA32    [mem 0x0000000001000000-0x00000000ffffffff]
Dec 13 02:00:25.086265 kernel:   Normal   [mem 0x0000000100000000-0x00000002bfffffff]
Dec 13 02:00:25.086277 kernel: Movable zone start for each node
Dec 13 02:00:25.086290 kernel: Early memory node ranges
Dec 13 02:00:25.086303 kernel:   node   0: [mem 0x0000000000001000-0x000000000009ffff]
Dec 13 02:00:25.086317 kernel:   node   0: [mem 0x0000000000100000-0x000000003ff40fff]
Dec 13 02:00:25.086330 kernel:   node   0: [mem 0x000000003ffff000-0x000000003fffffff]
Dec 13 02:00:25.086343 kernel:   node   0: [mem 0x0000000100000000-0x00000002bfffffff]
Dec 13 02:00:25.086355 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x00000002bfffffff]
Dec 13 02:00:25.086368 kernel: On node 0, zone DMA: 1 pages in unavailable ranges
Dec 13 02:00:25.086384 kernel: On node 0, zone DMA: 96 pages in unavailable ranges
Dec 13 02:00:25.086397 kernel: On node 0, zone DMA32: 190 pages in unavailable ranges
Dec 13 02:00:25.086410 kernel: ACPI: PM-Timer IO Port: 0x408
Dec 13 02:00:25.086423 kernel: ACPI: LAPIC_NMI (acpi_id[0x01] dfl dfl lint[0x1])
Dec 13 02:00:25.086436 kernel: IOAPIC[0]: apic_id 2, version 17, address 0xfec00000, GSI 0-23
Dec 13 02:00:25.086449 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
Dec 13 02:00:25.086462 kernel: ACPI: Using ACPI (MADT) for SMP configuration information
Dec 13 02:00:25.086475 kernel: ACPI: SPCR: console: uart,io,0x3f8,115200
Dec 13 02:00:25.086488 kernel: smpboot: Allowing 2 CPUs, 0 hotplug CPUs
Dec 13 02:00:25.086504 kernel: [mem 0x40000000-0xffffffff] available for PCI devices
Dec 13 02:00:25.086517 kernel: Booting paravirtualized kernel on Hyper-V
Dec 13 02:00:25.086530 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
Dec 13 02:00:25.086543 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:512 nr_cpu_ids:2 nr_node_ids:1
Dec 13 02:00:25.086557 kernel: percpu: Embedded 56 pages/cpu s188696 r8192 d32488 u1048576
Dec 13 02:00:25.086569 kernel: pcpu-alloc: s188696 r8192 d32488 u1048576 alloc=1*2097152
Dec 13 02:00:25.086582 kernel: pcpu-alloc: [0] 0 1 
Dec 13 02:00:25.086595 kernel: Hyper-V: PV spinlocks enabled
Dec 13 02:00:25.086608 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear)
Dec 13 02:00:25.086623 kernel: Built 1 zonelists, mobility grouping on.  Total pages: 2062618
Dec 13 02:00:25.086636 kernel: Policy zone: Normal
Dec 13 02:00:25.086651 kernel: Kernel command line: rootflags=rw mount.usrflags=ro BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=tty1 console=ttyS0,115200n8 earlyprintk=ttyS0,115200 flatcar.first_boot=detected flatcar.oem.id=azure flatcar.autologin verity.usrhash=66bd2580285375a2ba5b0e34ba63606314bcd90aaed1de1996371bdcb032485c
Dec 13 02:00:25.086664 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space.
Dec 13 02:00:25.086677 kernel: Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, linear)
Dec 13 02:00:25.086689 kernel: Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
Dec 13 02:00:25.086702 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off
Dec 13 02:00:25.086715 kernel: Memory: 8079144K/8387460K available (12294K kernel code, 2275K rwdata, 13716K rodata, 47476K init, 4108K bss, 308056K reserved, 0K cma-reserved)
Dec 13 02:00:25.086731 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
Dec 13 02:00:25.086744 kernel: ftrace: allocating 34549 entries in 135 pages
Dec 13 02:00:25.086766 kernel: ftrace: allocated 135 pages with 4 groups
Dec 13 02:00:25.086783 kernel: rcu: Hierarchical RCU implementation.
Dec 13 02:00:25.086797 kernel: rcu:         RCU event tracing is enabled.
Dec 13 02:00:25.086812 kernel: rcu:         RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2.
Dec 13 02:00:25.086825 kernel:         Rude variant of Tasks RCU enabled.
Dec 13 02:00:25.086839 kernel:         Tracing variant of Tasks RCU enabled.
Dec 13 02:00:25.086853 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.
Dec 13 02:00:25.086867 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
Dec 13 02:00:25.086880 kernel: Using NULL legacy PIC
Dec 13 02:00:25.086896 kernel: NR_IRQS: 33024, nr_irqs: 440, preallocated irqs: 0
Dec 13 02:00:25.086910 kernel: Console: colour dummy device 80x25
Dec 13 02:00:25.086924 kernel: printk: console [tty1] enabled
Dec 13 02:00:25.086938 kernel: printk: console [ttyS0] enabled
Dec 13 02:00:25.086951 kernel: printk: bootconsole [earlyser0] disabled
Dec 13 02:00:25.086967 kernel: ACPI: Core revision 20210730
Dec 13 02:00:25.086981 kernel: Failed to register legacy timer interrupt
Dec 13 02:00:25.086994 kernel: APIC: Switch to symmetric I/O mode setup
Dec 13 02:00:25.087008 kernel: Hyper-V: Using IPI hypercalls
Dec 13 02:00:25.087021 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 5187.81 BogoMIPS (lpj=2593906)
Dec 13 02:00:25.087035 kernel: Last level iTLB entries: 4KB 64, 2MB 8, 4MB 8
Dec 13 02:00:25.087049 kernel: Last level dTLB entries: 4KB 64, 2MB 0, 4MB 0, 1GB 4
Dec 13 02:00:25.087062 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization
Dec 13 02:00:25.087076 kernel: Spectre V2 : Mitigation: Retpolines
Dec 13 02:00:25.087089 kernel: Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch
Dec 13 02:00:25.087105 kernel: Spectre V2 : Spectre v2 / SpectreRSB : Filling RSB on VMEXIT
Dec 13 02:00:25.087118 kernel: RETBleed: WARNING: Spectre v2 mitigation leaves CPU vulnerable to RETBleed attacks, data leaks possible!
Dec 13 02:00:25.087132 kernel: RETBleed: Vulnerable
Dec 13 02:00:25.087145 kernel: Speculative Store Bypass: Vulnerable
Dec 13 02:00:25.087166 kernel: TAA: Vulnerable: Clear CPU buffers attempted, no microcode
Dec 13 02:00:25.087177 kernel: MMIO Stale Data: Vulnerable: Clear CPU buffers attempted, no microcode
Dec 13 02:00:25.087189 kernel: GDS: Unknown: Dependent on hypervisor status
Dec 13 02:00:25.087200 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'
Dec 13 02:00:25.087209 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'
Dec 13 02:00:25.087217 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'
Dec 13 02:00:25.087227 kernel: x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'
Dec 13 02:00:25.087235 kernel: x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'
Dec 13 02:00:25.087242 kernel: x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'
Dec 13 02:00:25.087250 kernel: x86/fpu: xstate_offset[2]:  576, xstate_sizes[2]:  256
Dec 13 02:00:25.087257 kernel: x86/fpu: xstate_offset[5]:  832, xstate_sizes[5]:   64
Dec 13 02:00:25.087264 kernel: x86/fpu: xstate_offset[6]:  896, xstate_sizes[6]:  512
Dec 13 02:00:25.087271 kernel: x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024
Dec 13 02:00:25.087279 kernel: x86/fpu: Enabled xstate features 0xe7, context size is 2432 bytes, using 'compacted' format.
Dec 13 02:00:25.087286 kernel: Freeing SMP alternatives memory: 32K
Dec 13 02:00:25.087293 kernel: pid_max: default: 32768 minimum: 301
Dec 13 02:00:25.087300 kernel: LSM: Security Framework initializing
Dec 13 02:00:25.087308 kernel: SELinux:  Initializing.
Dec 13 02:00:25.087322 kernel: Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, linear)
Dec 13 02:00:25.087330 kernel: Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, linear)
Dec 13 02:00:25.087337 kernel: smpboot: CPU0: Intel(R) Xeon(R) Platinum 8272CL CPU @ 2.60GHz (family: 0x6, model: 0x55, stepping: 0x7)
Dec 13 02:00:25.087345 kernel: Performance Events: unsupported p6 CPU model 85 no PMU driver, software events only.
Dec 13 02:00:25.087352 kernel: signal: max sigframe size: 3632
Dec 13 02:00:25.087360 kernel: rcu: Hierarchical SRCU implementation.
Dec 13 02:00:25.087367 kernel: NMI watchdog: Perf NMI watchdog permanently disabled
Dec 13 02:00:25.087375 kernel: smp: Bringing up secondary CPUs ...
Dec 13 02:00:25.087382 kernel: x86: Booting SMP configuration:
Dec 13 02:00:25.087390 kernel: .... node  #0, CPUs:      #1
Dec 13 02:00:25.087399 kernel: TAA CPU bug present and SMT on, data leak possible. See https://www.kernel.org/doc/html/latest/admin-guide/hw-vuln/tsx_async_abort.html for more details.
Dec 13 02:00:25.087407 kernel: MMIO Stale Data CPU bug present and SMT on, data leak possible. See https://www.kernel.org/doc/html/latest/admin-guide/hw-vuln/processor_mmio_stale_data.html for more details.
Dec 13 02:00:25.087415 kernel: smp: Brought up 1 node, 2 CPUs
Dec 13 02:00:25.087426 kernel: smpboot: Max logical packages: 1
Dec 13 02:00:25.087433 kernel: smpboot: Total of 2 processors activated (10375.62 BogoMIPS)
Dec 13 02:00:25.087440 kernel: devtmpfs: initialized
Dec 13 02:00:25.087448 kernel: x86/mm: Memory block size: 128MB
Dec 13 02:00:25.087457 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x3fffb000-0x3fffefff] (16384 bytes)
Dec 13 02:00:25.087468 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
Dec 13 02:00:25.087476 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear)
Dec 13 02:00:25.087486 kernel: pinctrl core: initialized pinctrl subsystem
Dec 13 02:00:25.087494 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family
Dec 13 02:00:25.087508 kernel: audit: initializing netlink subsys (disabled)
Dec 13 02:00:25.087517 kernel: audit: type=2000 audit(1734055223.024:1): state=initialized audit_enabled=0 res=1
Dec 13 02:00:25.087524 kernel: thermal_sys: Registered thermal governor 'step_wise'
Dec 13 02:00:25.087535 kernel: thermal_sys: Registered thermal governor 'user_space'
Dec 13 02:00:25.087542 kernel: cpuidle: using governor menu
Dec 13 02:00:25.087555 kernel: ACPI: bus type PCI registered
Dec 13 02:00:25.087563 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
Dec 13 02:00:25.087570 kernel: dca service started, version 1.12.1
Dec 13 02:00:25.087578 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.
Dec 13 02:00:25.087585 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages
Dec 13 02:00:25.087593 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
Dec 13 02:00:25.087603 kernel: ACPI: Added _OSI(Module Device)
Dec 13 02:00:25.087611 kernel: ACPI: Added _OSI(Processor Device)
Dec 13 02:00:25.087618 kernel: ACPI: Added _OSI(3.0 _SCP Extensions)
Dec 13 02:00:25.087631 kernel: ACPI: Added _OSI(Processor Aggregator Device)
Dec 13 02:00:25.087638 kernel: ACPI: Added _OSI(Linux-Dell-Video)
Dec 13 02:00:25.087646 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio)
Dec 13 02:00:25.087656 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics)
Dec 13 02:00:25.087663 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded
Dec 13 02:00:25.087673 kernel: ACPI: Interpreter enabled
Dec 13 02:00:25.087682 kernel: ACPI: PM: (supports S0 S5)
Dec 13 02:00:25.087689 kernel: ACPI: Using IOAPIC for interrupt routing
Dec 13 02:00:25.087700 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
Dec 13 02:00:25.087709 kernel: ACPI: Enabled 1 GPEs in block 00 to 0F
Dec 13 02:00:25.087718 kernel: iommu: Default domain type: Translated 
Dec 13 02:00:25.087727 kernel: iommu: DMA domain TLB invalidation policy: lazy mode 
Dec 13 02:00:25.087735 kernel: vgaarb: loaded
Dec 13 02:00:25.087745 kernel: pps_core: LinuxPPS API ver. 1 registered
Dec 13 02:00:25.087753 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
Dec 13 02:00:25.087760 kernel: PTP clock support registered
Dec 13 02:00:25.087771 kernel: Registered efivars operations
Dec 13 02:00:25.087778 kernel: PCI: Using ACPI for IRQ routing
Dec 13 02:00:25.087788 kernel: PCI: System does not support PCI
Dec 13 02:00:25.087799 kernel: clocksource: Switched to clocksource hyperv_clocksource_tsc_page
Dec 13 02:00:25.087807 kernel: VFS: Disk quotas dquot_6.6.0
Dec 13 02:00:25.087816 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
Dec 13 02:00:25.087824 kernel: pnp: PnP ACPI init
Dec 13 02:00:25.087833 kernel: pnp: PnP ACPI: found 3 devices
Dec 13 02:00:25.087843 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
Dec 13 02:00:25.087852 kernel: NET: Registered PF_INET protocol family
Dec 13 02:00:25.087860 kernel: IP idents hash table entries: 131072 (order: 8, 1048576 bytes, linear)
Dec 13 02:00:25.087873 kernel: tcp_listen_portaddr_hash hash table entries: 4096 (order: 4, 65536 bytes, linear)
Dec 13 02:00:25.087881 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
Dec 13 02:00:25.087891 kernel: TCP established hash table entries: 65536 (order: 7, 524288 bytes, linear)
Dec 13 02:00:25.087900 kernel: TCP bind hash table entries: 65536 (order: 8, 1048576 bytes, linear)
Dec 13 02:00:25.087909 kernel: TCP: Hash tables configured (established 65536 bind 65536)
Dec 13 02:00:25.087919 kernel: UDP hash table entries: 4096 (order: 5, 131072 bytes, linear)
Dec 13 02:00:25.087926 kernel: UDP-Lite hash table entries: 4096 (order: 5, 131072 bytes, linear)
Dec 13 02:00:25.087935 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family
Dec 13 02:00:25.087944 kernel: NET: Registered PF_XDP protocol family
Dec 13 02:00:25.087953 kernel: PCI: CLS 0 bytes, default 64
Dec 13 02:00:25.087964 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
Dec 13 02:00:25.087971 kernel: software IO TLB: mapped [mem 0x000000003a8ad000-0x000000003e8ad000] (64MB)
Dec 13 02:00:25.087980 kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer
Dec 13 02:00:25.087989 kernel: Initialise system trusted keyrings
Dec 13 02:00:25.087996 kernel: workingset: timestamp_bits=39 max_order=21 bucket_order=0
Dec 13 02:00:25.088008 kernel: Key type asymmetric registered
Dec 13 02:00:25.088015 kernel: Asymmetric key parser 'x509' registered
Dec 13 02:00:25.088023 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
Dec 13 02:00:25.088035 kernel: io scheduler mq-deadline registered
Dec 13 02:00:25.088042 kernel: io scheduler kyber registered
Dec 13 02:00:25.088053 kernel: io scheduler bfq registered
Dec 13 02:00:25.088060 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00
Dec 13 02:00:25.088069 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
Dec 13 02:00:25.088078 kernel: 00:00: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
Dec 13 02:00:25.088086 kernel: 00:01: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A
Dec 13 02:00:25.088097 kernel: i8042: PNP: No PS/2 controller found.
Dec 13 02:00:25.101347 kernel: rtc_cmos 00:02: registered as rtc0
Dec 13 02:00:25.101489 kernel: rtc_cmos 00:02: setting system clock to 2024-12-13T02:00:24 UTC (1734055224)
Dec 13 02:00:25.101567 kernel: rtc_cmos 00:02: alarms up to one month, 114 bytes nvram
Dec 13 02:00:25.101582 kernel: fail to initialize ptp_kvm
Dec 13 02:00:25.101591 kernel: intel_pstate: CPU model not supported
Dec 13 02:00:25.101602 kernel: efifb: probing for efifb
Dec 13 02:00:25.101610 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k
Dec 13 02:00:25.101618 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1
Dec 13 02:00:25.101629 kernel: efifb: scrolling: redraw
Dec 13 02:00:25.101643 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0
Dec 13 02:00:25.101651 kernel: Console: switching to colour frame buffer device 128x48
Dec 13 02:00:25.101659 kernel: fb0: EFI VGA frame buffer device
Dec 13 02:00:25.101669 kernel: pstore: Registered efi as persistent store backend
Dec 13 02:00:25.101679 kernel: NET: Registered PF_INET6 protocol family
Dec 13 02:00:25.101688 kernel: Segment Routing with IPv6
Dec 13 02:00:25.101695 kernel: In-situ OAM (IOAM) with IPv6
Dec 13 02:00:25.101707 kernel: NET: Registered PF_PACKET protocol family
Dec 13 02:00:25.101715 kernel: Key type dns_resolver registered
Dec 13 02:00:25.101727 kernel: IPI shorthand broadcast: enabled
Dec 13 02:00:25.101735 kernel: sched_clock: Marking stable (834003700, 24224900)->(1222609100, -364380500)
Dec 13 02:00:25.101746 kernel: registered taskstats version 1
Dec 13 02:00:25.101755 kernel: Loading compiled-in X.509 certificates
Dec 13 02:00:25.101765 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.15.173-flatcar: d9defb0205602bee9bb670636cbe5c74194fdb5e'
Dec 13 02:00:25.101772 kernel: Key type .fscrypt registered
Dec 13 02:00:25.101784 kernel: Key type fscrypt-provisioning registered
Dec 13 02:00:25.101792 kernel: pstore: Using crash dump compression: deflate
Dec 13 02:00:25.101805 kernel: ima: No TPM chip found, activating TPM-bypass!
Dec 13 02:00:25.101812 kernel: ima: Allocated hash algorithm: sha1
Dec 13 02:00:25.101820 kernel: ima: No architecture policies found
Dec 13 02:00:25.101828 kernel: clk: Disabling unused clocks
Dec 13 02:00:25.101835 kernel: Freeing unused kernel image (initmem) memory: 47476K
Dec 13 02:00:25.101846 kernel: Write protecting the kernel read-only data: 28672k
Dec 13 02:00:25.101854 kernel: Freeing unused kernel image (text/rodata gap) memory: 2040K
Dec 13 02:00:25.101861 kernel: Freeing unused kernel image (rodata/data gap) memory: 620K
Dec 13 02:00:25.101869 kernel: Run /init as init process
Dec 13 02:00:25.101877 kernel:   with arguments:
Dec 13 02:00:25.101886 kernel:     /init
Dec 13 02:00:25.101894 kernel:   with environment:
Dec 13 02:00:25.101901 kernel:     HOME=/
Dec 13 02:00:25.101908 kernel:     TERM=linux
Dec 13 02:00:25.101916 kernel:     BOOT_IMAGE=/flatcar/vmlinuz-a
Dec 13 02:00:25.101925 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)
Dec 13 02:00:25.101936 systemd[1]: Detected virtualization microsoft.
Dec 13 02:00:25.101948 systemd[1]: Detected architecture x86-64.
Dec 13 02:00:25.101956 systemd[1]: Running in initrd.
Dec 13 02:00:25.101967 systemd[1]: No hostname configured, using default hostname.
Dec 13 02:00:25.101976 systemd[1]: Hostname set to <localhost>.
Dec 13 02:00:25.101986 systemd[1]: Initializing machine ID from random generator.
Dec 13 02:00:25.101996 systemd[1]: Queued start job for default target initrd.target.
Dec 13 02:00:25.102009 systemd[1]: Started systemd-ask-password-console.path.
Dec 13 02:00:25.102018 systemd[1]: Reached target cryptsetup.target.
Dec 13 02:00:25.102027 systemd[1]: Reached target paths.target.
Dec 13 02:00:25.102039 systemd[1]: Reached target slices.target.
Dec 13 02:00:25.102050 systemd[1]: Reached target swap.target.
Dec 13 02:00:25.102059 systemd[1]: Reached target timers.target.
Dec 13 02:00:25.102067 systemd[1]: Listening on iscsid.socket.
Dec 13 02:00:25.102075 systemd[1]: Listening on iscsiuio.socket.
Dec 13 02:00:25.102086 systemd[1]: Listening on systemd-journald-audit.socket.
Dec 13 02:00:25.102096 systemd[1]: Listening on systemd-journald-dev-log.socket.
Dec 13 02:00:25.102107 systemd[1]: Listening on systemd-journald.socket.
Dec 13 02:00:25.102117 systemd[1]: Listening on systemd-networkd.socket.
Dec 13 02:00:25.102127 systemd[1]: Listening on systemd-udevd-control.socket.
Dec 13 02:00:25.102137 systemd[1]: Listening on systemd-udevd-kernel.socket.
Dec 13 02:00:25.102145 systemd[1]: Reached target sockets.target.
Dec 13 02:00:25.102174 systemd[1]: Starting kmod-static-nodes.service...
Dec 13 02:00:25.102182 systemd[1]: Finished network-cleanup.service.
Dec 13 02:00:25.102193 systemd[1]: Starting systemd-fsck-usr.service...
Dec 13 02:00:25.102204 systemd[1]: Starting systemd-journald.service...
Dec 13 02:00:25.102215 systemd[1]: Starting systemd-modules-load.service...
Dec 13 02:00:25.102223 systemd[1]: Starting systemd-resolved.service...
Dec 13 02:00:25.102231 systemd[1]: Starting systemd-vconsole-setup.service...
Dec 13 02:00:25.102242 systemd[1]: Finished kmod-static-nodes.service.
Dec 13 02:00:25.102251 systemd[1]: Finished systemd-fsck-usr.service.
Dec 13 02:00:25.102261 kernel: audit: type=1130 audit(1734055225.089:2): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Dec 13 02:00:25.102270 systemd[1]: Finished systemd-vconsole-setup.service.
Dec 13 02:00:25.102284 systemd-journald[182]: Journal started
Dec 13 02:00:25.102337 systemd-journald[182]: Runtime Journal (/run/log/journal/582cc620dbe7448cbb6b4c2f7ac18669) is 8.0M, max 159.0M, 151.0M free.
Dec 13 02:00:25.089000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Dec 13 02:00:25.082217 systemd-modules-load[183]: Inserted module 'overlay'
Dec 13 02:00:25.114000 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'
Dec 13 02:00:25.130530 systemd[1]: Started systemd-journald.service.
Dec 13 02:00:25.130567 kernel: audit: type=1130 audit(1734055225.114:3): 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'
Dec 13 02:00:25.136000 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'
Dec 13 02:00:25.156524 kernel: audit: type=1130 audit(1734055225.136:4): 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'
Dec 13 02:00:25.156563 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this.
Dec 13 02:00:25.163006 systemd-resolved[184]: Positive Trust Anchors:
Dec 13 02:00:25.168298 kernel: Bridge firewalling registered
Dec 13 02:00:25.163024 systemd-resolved[184]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
Dec 13 02:00:25.163073 systemd-resolved[184]: 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
Dec 13 02:00:25.165822 systemd-resolved[184]: Defaulting to hostname 'linux'.
Dec 13 02:00:25.167117 systemd[1]: Starting dracut-cmdline-ask.service...
Dec 13 02:00:25.171073 systemd[1]: Starting systemd-tmpfiles-setup-dev.service...
Dec 13 02:00:25.171396 systemd[1]: Started systemd-resolved.service.
Dec 13 02:00:25.171778 systemd[1]: Reached target nss-lookup.target.
Dec 13 02:00:25.167000 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'
Dec 13 02:00:25.186166 kernel: audit: type=1130 audit(1734055225.167: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'
Dec 13 02:00:25.215100 systemd-modules-load[183]: Inserted module 'br_netfilter'
Dec 13 02:00:25.224105 systemd[1]: Finished systemd-tmpfiles-setup-dev.service.
Dec 13 02:00:25.227000 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'
Dec 13 02:00:25.242349 kernel: audit: type=1130 audit(1734055225.227:6): 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'
Dec 13 02:00:25.252000 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'
Dec 13 02:00:25.250670 systemd[1]: Finished dracut-cmdline-ask.service.
Dec 13 02:00:25.270097 kernel: audit: type=1130 audit(1734055225.252:7): 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'
Dec 13 02:00:25.254094 systemd[1]: Starting dracut-cmdline.service...
Dec 13 02:00:25.274300 kernel: SCSI subsystem initialized
Dec 13 02:00:25.274360 dracut-cmdline[201]: dracut-dracut-053
Dec 13 02:00:25.277323 dracut-cmdline[201]: Using kernel command line parameters: rd.driver.pre=btrfs rootflags=rw mount.usrflags=ro BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=tty1 console=ttyS0,115200n8 earlyprintk=ttyS0,115200 flatcar.first_boot=detected flatcar.oem.id=azure flatcar.autologin verity.usrhash=66bd2580285375a2ba5b0e34ba63606314bcd90aaed1de1996371bdcb032485c
Dec 13 02:00:25.304140 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
Dec 13 02:00:25.304189 kernel: device-mapper: uevent: version 1.0.3
Dec 13 02:00:25.310167 kernel: device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com
Dec 13 02:00:25.313738 systemd-modules-load[183]: Inserted module 'dm_multipath'
Dec 13 02:00:25.319000 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'
Dec 13 02:00:25.317035 systemd[1]: Finished systemd-modules-load.service.
Dec 13 02:00:25.333705 kernel: audit: type=1130 audit(1734055225.319:8): 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'
Dec 13 02:00:25.333922 systemd[1]: Starting systemd-sysctl.service...
Dec 13 02:00:25.347046 systemd[1]: Finished systemd-sysctl.service.
Dec 13 02:00:25.363730 kernel: audit: type=1130 audit(1734055225.349:9): 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'
Dec 13 02:00:25.349000 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'
Dec 13 02:00:25.375171 kernel: Loading iSCSI transport class v2.0-870.
Dec 13 02:00:25.393168 kernel: iscsi: registered transport (tcp)
Dec 13 02:00:25.422870 kernel: iscsi: registered transport (qla4xxx)
Dec 13 02:00:25.422926 kernel: QLogic iSCSI HBA Driver
Dec 13 02:00:25.456007 systemd[1]: Finished dracut-cmdline.service.
Dec 13 02:00:25.460000 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'
Dec 13 02:00:25.462142 systemd[1]: Starting dracut-pre-udev.service...
Dec 13 02:00:25.478314 kernel: audit: type=1130 audit(1734055225.460:10): 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'
Dec 13 02:00:25.518180 kernel: raid6: avx512x4 gen() 18446 MB/s
Dec 13 02:00:25.538171 kernel: raid6: avx512x4 xor()  8091 MB/s
Dec 13 02:00:25.558186 kernel: raid6: avx512x2 gen() 18437 MB/s
Dec 13 02:00:25.578178 kernel: raid6: avx512x2 xor() 26273 MB/s
Dec 13 02:00:25.599174 kernel: raid6: avx512x1 gen() 18388 MB/s
Dec 13 02:00:25.619172 kernel: raid6: avx512x1 xor() 25772 MB/s
Dec 13 02:00:25.639171 kernel: raid6: avx2x4   gen() 17724 MB/s
Dec 13 02:00:25.659170 kernel: raid6: avx2x4   xor()  7790 MB/s
Dec 13 02:00:25.679170 kernel: raid6: avx2x2   gen() 17991 MB/s
Dec 13 02:00:25.699166 kernel: raid6: avx2x2   xor() 22103 MB/s
Dec 13 02:00:25.719165 kernel: raid6: avx2x1   gen() 14192 MB/s
Dec 13 02:00:25.739166 kernel: raid6: avx2x1   xor() 19349 MB/s
Dec 13 02:00:25.759165 kernel: raid6: sse2x4   gen() 11680 MB/s
Dec 13 02:00:25.779164 kernel: raid6: sse2x4   xor()  7308 MB/s
Dec 13 02:00:25.799165 kernel: raid6: sse2x2   gen() 12946 MB/s
Dec 13 02:00:25.819163 kernel: raid6: sse2x2   xor()  7465 MB/s
Dec 13 02:00:25.840164 kernel: raid6: sse2x1   gen() 11625 MB/s
Dec 13 02:00:25.862983 kernel: raid6: sse2x1   xor()  5935 MB/s
Dec 13 02:00:25.863007 kernel: raid6: using algorithm avx512x4 gen() 18446 MB/s
Dec 13 02:00:25.863019 kernel: raid6: .... xor() 8091 MB/s, rmw enabled
Dec 13 02:00:25.866673 kernel: raid6: using avx512x2 recovery algorithm
Dec 13 02:00:25.885172 kernel: xor: automatically using best checksumming function   avx       
Dec 13 02:00:25.982181 kernel: Btrfs loaded, crc32c=crc32c-intel, zoned=no, fsverity=no
Dec 13 02:00:25.990188 systemd[1]: Finished dracut-pre-udev.service.
Dec 13 02:00:25.992000 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'
Dec 13 02:00:25.993000 audit: BPF prog-id=7 op=LOAD
Dec 13 02:00:25.994000 audit: BPF prog-id=8 op=LOAD
Dec 13 02:00:25.994856 systemd[1]: Starting systemd-udevd.service...
Dec 13 02:00:26.010287 systemd-udevd[384]: Using default interface naming scheme 'v252'.
Dec 13 02:00:26.017052 systemd[1]: Started systemd-udevd.service.
Dec 13 02:00:26.019000 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'
Dec 13 02:00:26.022505 systemd[1]: Starting dracut-pre-trigger.service...
Dec 13 02:00:26.040526 dracut-pre-trigger[398]: rd.md=0: removing MD RAID activation
Dec 13 02:00:26.069182 systemd[1]: Finished dracut-pre-trigger.service.
Dec 13 02:00:26.073000 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'
Dec 13 02:00:26.074791 systemd[1]: Starting systemd-udev-trigger.service...
Dec 13 02:00:26.107328 systemd[1]: Finished systemd-udev-trigger.service.
Dec 13 02:00:26.112000 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'
Dec 13 02:00:26.153168 kernel: cryptd: max_cpu_qlen set to 1000
Dec 13 02:00:26.189169 kernel: AVX2 version of gcm_enc/dec engaged.
Dec 13 02:00:26.189242 kernel: AES CTR mode by8 optimization enabled
Dec 13 02:00:26.194291 kernel: hv_vmbus: Vmbus version:5.2
Dec 13 02:00:26.211168 kernel: hv_vmbus: registering driver hyperv_keyboard
Dec 13 02:00:26.224171 kernel: hv_vmbus: registering driver hv_storvsc
Dec 13 02:00:26.224210 kernel: hid: raw HID events driver (C) Jiri Kosina
Dec 13 02:00:26.235496 kernel: input: AT Translated Set 2 keyboard as /devices/LNXSYSTM:00/LNXSYBUS:00/ACPI0004:00/VMBUS:00/d34b2567-b9b6-42b9-8778-0a4ec0b955bf/serio0/input/input0
Dec 13 02:00:26.246873 kernel: hv_vmbus: registering driver hid_hyperv
Dec 13 02:00:26.246918 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input1
Dec 13 02:00:26.252322 kernel: hid 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on 
Dec 13 02:00:26.260171 kernel: scsi host0: storvsc_host_t
Dec 13 02:00:26.260354 kernel: scsi 0:0:0:0: Direct-Access     Msft     Virtual Disk     1.0  PQ: 0 ANSI: 5
Dec 13 02:00:26.266621 kernel: hv_vmbus: registering driver hv_netvsc
Dec 13 02:00:26.274018 kernel: scsi 0:0:0:2: CD-ROM            Msft     Virtual DVD-ROM  1.0  PQ: 0 ANSI: 0
Dec 13 02:00:26.274077 kernel: scsi host1: storvsc_host_t
Dec 13 02:00:26.302899 kernel: sr 0:0:0:2: [sr0] scsi-1 drive
Dec 13 02:00:26.315270 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20
Dec 13 02:00:26.315287 kernel: sd 0:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB)
Dec 13 02:00:26.334963 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0
Dec 13 02:00:26.335140 kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks
Dec 13 02:00:26.335310 kernel: sd 0:0:0:0: [sda] Write Protect is off
Dec 13 02:00:26.335462 kernel: sd 0:0:0:0: [sda] Mode Sense: 0f 00 10 00
Dec 13 02:00:26.335612 kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA
Dec 13 02:00:26.335769 kernel:  sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9
Dec 13 02:00:26.335789 kernel: sd 0:0:0:0: [sda] Attached SCSI disk
Dec 13 02:00:26.450450 kernel: hv_netvsc 7c1e5277-09d4-7c1e-5277-09d47c1e5277 eth0: VF slot 1 added
Dec 13 02:00:26.460180 kernel: hv_vmbus: registering driver hv_pci
Dec 13 02:00:26.466171 kernel: hv_pci 885aa367-5481-4a46-b7a4-7d924f7c16ba: PCI VMBus probing: Using version 0x10004
Dec 13 02:00:26.581189 kernel: hv_pci 885aa367-5481-4a46-b7a4-7d924f7c16ba: PCI host bridge to bus 5481:00
Dec 13 02:00:26.581375 kernel: pci_bus 5481:00: root bus resource [mem 0xfe0000000-0xfe00fffff window]
Dec 13 02:00:26.581553 kernel: pci_bus 5481:00: No busn resource found for root bus, will use [bus 00-ff]
Dec 13 02:00:26.581700 kernel: pci 5481:00:02.0: [15b3:1016] type 00 class 0x020000
Dec 13 02:00:26.581866 kernel: pci 5481:00:02.0: reg 0x10: [mem 0xfe0000000-0xfe00fffff 64bit pref]
Dec 13 02:00:26.582024 kernel: pci 5481:00:02.0: enabling Extended Tags
Dec 13 02:00:26.582188 kernel: pci 5481:00:02.0: 0.000 Gb/s available PCIe bandwidth, limited by Unknown x0 link at 5481:00:02.0 (capable of 63.008 Gb/s with 8.0 GT/s PCIe x8 link)
Dec 13 02:00:26.582341 kernel: pci_bus 5481:00: busn_res: [bus 00-ff] end is updated to 00
Dec 13 02:00:26.582483 kernel: pci 5481:00:02.0: BAR 0: assigned [mem 0xfe0000000-0xfe00fffff 64bit pref]
Dec 13 02:00:26.677125 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device.
Dec 13 02:00:26.694834 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/sda6 scanned by (udev-worker) (452)
Dec 13 02:00:26.694890 kernel: mlx5_core 5481:00:02.0: firmware version: 14.30.5000
Dec 13 02:00:26.972483 kernel: mlx5_core 5481:00:02.0: MLX5E: StrdRq(0) RqSz(1024) StrdSz(256) RxCqeCmprss(0)
Dec 13 02:00:26.972676 kernel: mlx5_core 5481:00:02.0: Supported tc offload range - chains: 1, prios: 1
Dec 13 02:00:26.972841 kernel: mlx5_core 5481:00:02.0: mlx5e_tc_post_act_init:40:(pid 187): firmware level support is missing
Dec 13 02:00:26.973006 kernel: hv_netvsc 7c1e5277-09d4-7c1e-5277-09d47c1e5277 eth0: VF registering: eth1
Dec 13 02:00:26.973174 kernel: mlx5_core 5481:00:02.0 eth1: joined to eth0
Dec 13 02:00:26.711510 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device.
Dec 13 02:00:26.845810 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device.
Dec 13 02:00:26.848974 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device.
Dec 13 02:00:26.852307 systemd[1]: Starting disk-uuid.service...
Dec 13 02:00:26.922333 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device.
Dec 13 02:00:26.998180 kernel: mlx5_core 5481:00:02.0 enP21633s1: renamed from eth1
Dec 13 02:00:27.873180 kernel:  sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9
Dec 13 02:00:27.873685 disk-uuid[561]: The operation has completed successfully.
Dec 13 02:00:27.948366 systemd[1]: disk-uuid.service: Deactivated successfully.
Dec 13 02:00:27.950000 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'
Dec 13 02:00:27.950000 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'
Dec 13 02:00:27.948468 systemd[1]: Finished disk-uuid.service.
Dec 13 02:00:27.952849 systemd[1]: Starting verity-setup.service...
Dec 13 02:00:27.996176 kernel: device-mapper: verity: sha256 using implementation "sha256-avx2"
Dec 13 02:00:28.139936 systemd[1]: Found device dev-mapper-usr.device.
Dec 13 02:00:28.145839 systemd[1]: Mounting sysusr-usr.mount...
Dec 13 02:00:28.151990 systemd[1]: Finished verity-setup.service.
Dec 13 02:00:28.155000 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'
Dec 13 02:00:28.224180 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: norecovery. Quota mode: none.
Dec 13 02:00:28.224309 systemd[1]: Mounted sysusr-usr.mount.
Dec 13 02:00:28.227070 systemd[1]: afterburn-network-kargs.service was skipped because no trigger condition checks were met.
Dec 13 02:00:28.228688 systemd[1]: Starting ignition-setup.service...
Dec 13 02:00:28.238883 systemd[1]: Starting parse-ip-for-networkd.service...
Dec 13 02:00:28.259731 kernel: BTRFS info (device sda6): using crc32c (crc32c-intel) checksum algorithm
Dec 13 02:00:28.259787 kernel: BTRFS info (device sda6): using free space tree
Dec 13 02:00:28.259804 kernel: BTRFS info (device sda6): has skinny extents
Dec 13 02:00:28.306407 systemd[1]: Finished parse-ip-for-networkd.service.
Dec 13 02:00:28.309000 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'
Dec 13 02:00:28.311000 audit: BPF prog-id=9 op=LOAD
Dec 13 02:00:28.312227 systemd[1]: Starting systemd-networkd.service...
Dec 13 02:00:28.338865 systemd-networkd[806]: lo: Link UP
Dec 13 02:00:28.338876 systemd-networkd[806]: lo: Gained carrier
Dec 13 02:00:28.343957 systemd-networkd[806]: Enumeration completed
Dec 13 02:00:28.352000 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'
Dec 13 02:00:28.344051 systemd[1]: Started systemd-networkd.service.
Dec 13 02:00:28.352447 systemd[1]: Reached target network.target.
Dec 13 02:00:28.355558 systemd-networkd[806]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
Dec 13 02:00:28.361617 systemd[1]: Starting iscsiuio.service...
Dec 13 02:00:28.365862 systemd[1]: mnt-oem.mount: Deactivated successfully.
Dec 13 02:00:28.372000 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'
Dec 13 02:00:28.370733 systemd[1]: Started iscsiuio.service.
Dec 13 02:00:28.373456 systemd[1]: Starting iscsid.service...
Dec 13 02:00:28.378092 iscsid[816]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi
Dec 13 02:00:28.378092 iscsid[816]: 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 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].
Dec 13 02:00:28.378092 iscsid[816]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6.
Dec 13 02:00:28.378092 iscsid[816]: If using hardware iscsi like qla4xxx this message can be ignored.
Dec 13 02:00:28.378092 iscsid[816]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi
Dec 13 02:00:28.378092 iscsid[816]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf
Dec 13 02:00:28.383000 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'
Dec 13 02:00:28.402000 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'
Dec 13 02:00:28.378778 systemd[1]: Started iscsid.service.
Dec 13 02:00:28.384130 systemd[1]: Starting dracut-initqueue.service...
Dec 13 02:00:28.398361 systemd[1]: Finished dracut-initqueue.service.
Dec 13 02:00:28.402743 systemd[1]: Reached target remote-fs-pre.target.
Dec 13 02:00:28.407952 systemd[1]: Reached target remote-cryptsetup.target.
Dec 13 02:00:28.413587 systemd[1]: Reached target remote-fs.target.
Dec 13 02:00:28.416409 systemd[1]: Starting dracut-pre-mount.service...
Dec 13 02:00:28.439018 systemd[1]: Finished dracut-pre-mount.service.
Dec 13 02:00:28.443711 kernel: mlx5_core 5481:00:02.0 enP21633s1: Link up
Dec 13 02:00:28.443000 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'
Dec 13 02:00:28.476181 kernel: hv_netvsc 7c1e5277-09d4-7c1e-5277-09d47c1e5277 eth0: Data path switched to VF: enP21633s1
Dec 13 02:00:28.476491 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
Dec 13 02:00:28.481898 systemd-networkd[806]: enP21633s1: Link UP
Dec 13 02:00:28.482038 systemd-networkd[806]: eth0: Link UP
Dec 13 02:00:28.482364 systemd-networkd[806]: eth0: Gained carrier
Dec 13 02:00:28.490332 systemd-networkd[806]: enP21633s1: Gained carrier
Dec 13 02:00:28.525247 systemd-networkd[806]: eth0: DHCPv4 address 10.200.8.10/24, gateway 10.200.8.1 acquired from 168.63.129.16
Dec 13 02:00:28.811480 systemd[1]: Finished ignition-setup.service.
Dec 13 02:00:28.813000 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'
Dec 13 02:00:28.816182 systemd[1]: Starting ignition-fetch-offline.service...
Dec 13 02:00:30.021331 systemd-networkd[806]: eth0: Gained IPv6LL
Dec 13 02:00:33.914241 ignition[831]: Ignition 2.14.0
Dec 13 02:00:33.914256 ignition[831]: Stage: fetch-offline
Dec 13 02:00:33.914344 ignition[831]: reading system config file "/usr/lib/ignition/base.d/base.ign"
Dec 13 02:00:33.914389 ignition[831]: parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63
Dec 13 02:00:34.061336 ignition[831]: no config dir at "/usr/lib/ignition/base.platform.d/azure"
Dec 13 02:00:34.061539 ignition[831]: parsed url from cmdline: ""
Dec 13 02:00:34.061543 ignition[831]: no config URL provided
Dec 13 02:00:34.061548 ignition[831]: reading system config file "/usr/lib/ignition/user.ign"
Dec 13 02:00:34.064367 ignition[831]: no config at "/usr/lib/ignition/user.ign"
Dec 13 02:00:34.066833 systemd[1]: Finished ignition-fetch-offline.service.
Dec 13 02:00:34.095840 kernel: kauditd_printk_skb: 17 callbacks suppressed
Dec 13 02:00:34.095876 kernel: audit: type=1130 audit(1734055234.072:28): 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'
Dec 13 02:00:34.072000 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'
Dec 13 02:00:34.064380 ignition[831]: failed to fetch config: resource requires networking
Dec 13 02:00:34.073120 systemd[1]: Starting ignition-fetch.service...
Dec 13 02:00:34.065710 ignition[831]: Ignition finished successfully
Dec 13 02:00:34.094982 ignition[837]: Ignition 2.14.0
Dec 13 02:00:34.094988 ignition[837]: Stage: fetch
Dec 13 02:00:34.095092 ignition[837]: reading system config file "/usr/lib/ignition/base.d/base.ign"
Dec 13 02:00:34.095117 ignition[837]: parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63
Dec 13 02:00:34.099057 ignition[837]: no config dir at "/usr/lib/ignition/base.platform.d/azure"
Dec 13 02:00:34.099966 ignition[837]: parsed url from cmdline: ""
Dec 13 02:00:34.099971 ignition[837]: no config URL provided
Dec 13 02:00:34.099978 ignition[837]: reading system config file "/usr/lib/ignition/user.ign"
Dec 13 02:00:34.099993 ignition[837]: no config at "/usr/lib/ignition/user.ign"
Dec 13 02:00:34.100034 ignition[837]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1
Dec 13 02:00:34.174920 ignition[837]: GET result: OK
Dec 13 02:00:34.174988 ignition[837]: failed to retrieve userdata from IMDS, falling back to custom data: not a config (empty)
Dec 13 02:00:34.288096 ignition[837]: opening config device: "/dev/sr0"
Dec 13 02:00:34.288886 ignition[837]: getting drive status for "/dev/sr0"
Dec 13 02:00:34.288933 ignition[837]: drive status: OK
Dec 13 02:00:34.288970 ignition[837]: mounting config device
Dec 13 02:00:34.289017 ignition[837]: op(1): [started]  mounting "/dev/sr0" at "/tmp/ignition-azure1166143255"
Dec 13 02:00:34.317176 kernel: UDF-fs: INFO Mounting volume 'UDF Volume', timestamp 2024/12/14 00:00 (1000)
Dec 13 02:00:34.316800 ignition[837]: op(1): [finished] mounting "/dev/sr0" at "/tmp/ignition-azure1166143255"
Dec 13 02:00:34.316810 ignition[837]: checking for config drive
Dec 13 02:00:34.321374 ignition[837]: reading config
Dec 13 02:00:34.321403 ignition[837]: op(2): [started]  unmounting "/dev/sr0" at "/tmp/ignition-azure1166143255"
Dec 13 02:00:34.321479 ignition[837]: op(2): [finished] unmounting "/dev/sr0" at "/tmp/ignition-azure1166143255"
Dec 13 02:00:34.324105 systemd[1]: tmp-ignition\x2dazure1166143255.mount: Deactivated successfully.
Dec 13 02:00:34.321494 ignition[837]: config has been read from custom data
Dec 13 02:00:34.325118 ignition[837]: parsing config with SHA512: cf83e1357eefb8bdf1542850d66d8007d620e4050b5715dc83f4a921d36ce9ce47d0d13c5d85f2b0ff8318d2877eec2f63b931bd47417a81a538327af927da3e
Dec 13 02:00:34.325145 ignition[837]: not a config (empty): provider config was empty, continuing with empty cache config
Dec 13 02:00:34.336931 unknown[837]: fetched base config from "system"
Dec 13 02:00:34.336943 unknown[837]: fetched base config from "system"
Dec 13 02:00:34.340118 ignition[837]: fetch: fetch complete
Dec 13 02:00:34.340125 ignition[837]: fetch: fetch passed
Dec 13 02:00:34.342404 ignition[837]: Ignition finished successfully
Dec 13 02:00:34.352000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Dec 13 02:00:34.350047 systemd[1]: Finished ignition-fetch.service.
Dec 13 02:00:34.373467 kernel: audit: type=1130 audit(1734055234.352:29): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Dec 13 02:00:34.353615 systemd[1]: Starting ignition-kargs.service...
Dec 13 02:00:34.384362 ignition[845]: Ignition 2.14.0
Dec 13 02:00:34.384372 ignition[845]: Stage: kargs
Dec 13 02:00:34.384502 ignition[845]: reading system config file "/usr/lib/ignition/base.d/base.ign"
Dec 13 02:00:34.384534 ignition[845]: parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63
Dec 13 02:00:34.395274 ignition[845]: no config dir at "/usr/lib/ignition/base.platform.d/azure"
Dec 13 02:00:34.398633 ignition[845]: kargs: kargs passed
Dec 13 02:00:34.399000 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'
Dec 13 02:00:34.400102 systemd[1]: Finished ignition-kargs.service.
Dec 13 02:00:34.419196 kernel: audit: type=1130 audit(1734055234.399:30): 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'
Dec 13 02:00:34.398685 ignition[845]: Ignition finished successfully
Dec 13 02:00:34.401722 systemd[1]: Starting ignition-disks.service...
Dec 13 02:00:34.415927 ignition[851]: Ignition 2.14.0
Dec 13 02:00:34.415936 ignition[851]: Stage: disks
Dec 13 02:00:34.416073 ignition[851]: reading system config file "/usr/lib/ignition/base.d/base.ign"
Dec 13 02:00:34.428000 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'
Dec 13 02:00:34.426414 systemd[1]: Finished ignition-disks.service.
Dec 13 02:00:34.451405 kernel: audit: type=1130 audit(1734055234.428:31): 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'
Dec 13 02:00:34.416102 ignition[851]: parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63
Dec 13 02:00:34.429074 systemd[1]: Reached target initrd-root-device.target.
Dec 13 02:00:34.424189 ignition[851]: no config dir at "/usr/lib/ignition/base.platform.d/azure"
Dec 13 02:00:34.445359 systemd[1]: Reached target local-fs-pre.target.
Dec 13 02:00:34.425685 ignition[851]: disks: disks passed
Dec 13 02:00:34.449328 systemd[1]: Reached target local-fs.target.
Dec 13 02:00:34.425727 ignition[851]: Ignition finished successfully
Dec 13 02:00:34.451391 systemd[1]: Reached target sysinit.target.
Dec 13 02:00:34.453274 systemd[1]: Reached target basic.target.
Dec 13 02:00:34.455966 systemd[1]: Starting systemd-fsck-root.service...
Dec 13 02:00:34.512588 systemd-fsck[859]: ROOT: clean, 621/7326000 files, 481077/7359488 blocks
Dec 13 02:00:34.517793 systemd[1]: Finished systemd-fsck-root.service.
Dec 13 02:00:34.520000 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'
Dec 13 02:00:34.535514 kernel: audit: type=1130 audit(1734055234.520:32): 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'
Dec 13 02:00:34.533444 systemd[1]: Mounting sysroot.mount...
Dec 13 02:00:34.550173 kernel: EXT4-fs (sda9): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none.
Dec 13 02:00:34.550336 systemd[1]: Mounted sysroot.mount.
Dec 13 02:00:34.552413 systemd[1]: Reached target initrd-root-fs.target.
Dec 13 02:00:34.609278 systemd[1]: Mounting sysroot-usr.mount...
Dec 13 02:00:34.614900 systemd[1]: Starting flatcar-metadata-hostname.service...
Dec 13 02:00:34.620274 systemd[1]: ignition-remount-sysroot.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot).
Dec 13 02:00:34.621261 systemd[1]: Reached target ignition-diskful.target.
Dec 13 02:00:34.631058 systemd[1]: Mounted sysroot-usr.mount.
Dec 13 02:00:34.672221 systemd[1]: Mounting sysroot-usr-share-oem.mount...
Dec 13 02:00:34.678759 systemd[1]: Starting initrd-setup-root.service...
Dec 13 02:00:34.694315 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/sda6 scanned by mount (869)
Dec 13 02:00:34.694353 kernel: BTRFS info (device sda6): using crc32c (crc32c-intel) checksum algorithm
Dec 13 02:00:34.699053 initrd-setup-root[874]: cut: /sysroot/etc/passwd: No such file or directory
Dec 13 02:00:34.709838 kernel: BTRFS info (device sda6): using free space tree
Dec 13 02:00:34.709886 kernel: BTRFS info (device sda6): has skinny extents
Dec 13 02:00:34.714567 systemd[1]: Mounted sysroot-usr-share-oem.mount.
Dec 13 02:00:34.747721 initrd-setup-root[900]: cut: /sysroot/etc/group: No such file or directory
Dec 13 02:00:34.772416 initrd-setup-root[908]: cut: /sysroot/etc/shadow: No such file or directory
Dec 13 02:00:34.778757 initrd-setup-root[916]: cut: /sysroot/etc/gshadow: No such file or directory
Dec 13 02:00:35.529189 systemd[1]: Finished initrd-setup-root.service.
Dec 13 02:00:35.557887 kernel: audit: type=1130 audit(1734055235.531:33): 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'
Dec 13 02:00:35.531000 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'
Dec 13 02:00:35.535628 systemd[1]: Starting ignition-mount.service...
Dec 13 02:00:35.561346 systemd[1]: Starting sysroot-boot.service...
Dec 13 02:00:35.569140 systemd[1]: sysusr-usr-share-oem.mount: Deactivated successfully.
Dec 13 02:00:35.571790 systemd[1]: sysroot-usr-share-oem.mount: Deactivated successfully.
Dec 13 02:00:35.590750 ignition[937]: INFO     : Ignition 2.14.0
Dec 13 02:00:35.592664 ignition[937]: INFO     : Stage: mount
Dec 13 02:00:35.592664 ignition[937]: INFO     : reading system config file "/usr/lib/ignition/base.d/base.ign"
Dec 13 02:00:35.592664 ignition[937]: DEBUG    : parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63
Dec 13 02:00:35.602888 ignition[937]: INFO     : no config dir at "/usr/lib/ignition/base.platform.d/azure"
Dec 13 02:00:35.602888 ignition[937]: INFO     : mount: mount passed
Dec 13 02:00:35.602888 ignition[937]: INFO     : Ignition finished successfully
Dec 13 02:00:35.607000 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'
Dec 13 02:00:35.624000 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'
Dec 13 02:00:35.604012 systemd[1]: Finished sysroot-boot.service.
Dec 13 02:00:35.641049 kernel: audit: type=1130 audit(1734055235.607:34): 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'
Dec 13 02:00:35.641079 kernel: audit: type=1130 audit(1734055235.624:35): 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'
Dec 13 02:00:35.610092 systemd[1]: Finished ignition-mount.service.
Dec 13 02:00:36.664623 coreos-metadata[868]: Dec 13 02:00:36.664 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1
Dec 13 02:00:36.678355 coreos-metadata[868]: Dec 13 02:00:36.678 INFO Fetch successful
Dec 13 02:00:36.718053 coreos-metadata[868]: Dec 13 02:00:36.717 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1
Dec 13 02:00:36.728662 coreos-metadata[868]: Dec 13 02:00:36.728 INFO Fetch successful
Dec 13 02:00:36.743431 coreos-metadata[868]: Dec 13 02:00:36.743 INFO wrote hostname ci-3510.3.6-a-51ae78fa62 to /sysroot/etc/hostname
Dec 13 02:00:36.749000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=flatcar-metadata-hostname comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Dec 13 02:00:36.745303 systemd[1]: Finished flatcar-metadata-hostname.service.
Dec 13 02:00:36.766792 kernel: audit: type=1130 audit(1734055236.749:36): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=flatcar-metadata-hostname comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Dec 13 02:00:36.750897 systemd[1]: Starting ignition-files.service...
Dec 13 02:00:36.769902 systemd[1]: Mounting sysroot-usr-share-oem.mount...
Dec 13 02:00:36.788973 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/sda6 scanned by mount (947)
Dec 13 02:00:36.789009 kernel: BTRFS info (device sda6): using crc32c (crc32c-intel) checksum algorithm
Dec 13 02:00:36.789031 kernel: BTRFS info (device sda6): using free space tree
Dec 13 02:00:36.796514 kernel: BTRFS info (device sda6): has skinny extents
Dec 13 02:00:36.801553 systemd[1]: Mounted sysroot-usr-share-oem.mount.
Dec 13 02:00:36.815015 ignition[966]: INFO     : Ignition 2.14.0
Dec 13 02:00:36.815015 ignition[966]: INFO     : Stage: files
Dec 13 02:00:36.818602 ignition[966]: INFO     : reading system config file "/usr/lib/ignition/base.d/base.ign"
Dec 13 02:00:36.818602 ignition[966]: DEBUG    : parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63
Dec 13 02:00:36.832714 ignition[966]: INFO     : no config dir at "/usr/lib/ignition/base.platform.d/azure"
Dec 13 02:00:36.847638 ignition[966]: DEBUG    : files: compiled without relabeling support, skipping
Dec 13 02:00:36.866608 ignition[966]: INFO     : files: createFilesystemsFiles: createFiles: op(1): [started]  writing file "/sysroot/etc/systemd/system/waagent.service"
Dec 13 02:00:36.871093 ignition[966]: INFO     : files: createFilesystemsFiles: createFiles: op(1): oem config not found in "/usr/share/oem", looking on oem partition
Dec 13 02:00:36.876423 ignition[966]: INFO     : files: createFilesystemsFiles: createFiles: op(1): op(2): [started]  mounting "/dev/disk/by-label/OEM" at "/mnt/oem2812750612"
Dec 13 02:00:36.880825 ignition[966]: CRITICAL : files: createFilesystemsFiles: createFiles: op(1): op(2): [failed]   mounting "/dev/disk/by-label/OEM" at "/mnt/oem2812750612": device or resource busy
Dec 13 02:00:36.880825 ignition[966]: ERROR    : files: createFilesystemsFiles: createFiles: op(1): failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem2812750612", trying btrfs: device or resource busy
Dec 13 02:00:36.880825 ignition[966]: INFO     : files: createFilesystemsFiles: createFiles: op(1): op(3): [started]  mounting "/dev/disk/by-label/OEM" at "/mnt/oem2812750612"
Dec 13 02:00:36.908450 kernel: BTRFS info: devid 1 device path /dev/sda6 changed to /dev/disk/by-label/OEM scanned by ignition (966)
Dec 13 02:00:36.908485 ignition[966]: INFO     : files: createFilesystemsFiles: createFiles: op(1): op(3): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2812750612"
Dec 13 02:00:36.913400 ignition[966]: INFO     : files: createFilesystemsFiles: createFiles: op(1): op(4): [started]  unmounting "/mnt/oem2812750612"
Dec 13 02:00:36.913400 ignition[966]: INFO     : files: createFilesystemsFiles: createFiles: op(1): op(4): [finished] unmounting "/mnt/oem2812750612"
Dec 13 02:00:36.913400 ignition[966]: INFO     : files: createFilesystemsFiles: createFiles: op(1): [finished] writing file "/sysroot/etc/systemd/system/waagent.service"
Dec 13 02:00:36.913400 ignition[966]: INFO     : files: createFilesystemsFiles: createFiles: op(5): [started]  writing file "/sysroot/etc/systemd/system/nvidia.service"
Dec 13 02:00:36.913400 ignition[966]: INFO     : files: createFilesystemsFiles: createFiles: op(5): oem config not found in "/usr/share/oem", looking on oem partition
Dec 13 02:00:36.936240 ignition[966]: INFO     : files: createFilesystemsFiles: createFiles: op(5): op(6): [started]  mounting "/dev/disk/by-label/OEM" at "/mnt/oem2336728579"
Dec 13 02:00:36.936240 ignition[966]: CRITICAL : files: createFilesystemsFiles: createFiles: op(5): op(6): [failed]   mounting "/dev/disk/by-label/OEM" at "/mnt/oem2336728579": device or resource busy
Dec 13 02:00:36.936240 ignition[966]: ERROR    : files: createFilesystemsFiles: createFiles: op(5): failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem2336728579", trying btrfs: device or resource busy
Dec 13 02:00:36.936240 ignition[966]: INFO     : files: createFilesystemsFiles: createFiles: op(5): op(7): [started]  mounting "/dev/disk/by-label/OEM" at "/mnt/oem2336728579"
Dec 13 02:00:36.936240 ignition[966]: INFO     : files: createFilesystemsFiles: createFiles: op(5): op(7): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2336728579"
Dec 13 02:00:36.936240 ignition[966]: INFO     : files: createFilesystemsFiles: createFiles: op(5): op(8): [started]  unmounting "/mnt/oem2336728579"
Dec 13 02:00:36.936240 ignition[966]: INFO     : files: createFilesystemsFiles: createFiles: op(5): op(8): [finished] unmounting "/mnt/oem2336728579"
Dec 13 02:00:36.936240 ignition[966]: INFO     : files: createFilesystemsFiles: createFiles: op(5): [finished] writing file "/sysroot/etc/systemd/system/nvidia.service"
Dec 13 02:00:36.936240 ignition[966]: INFO     : files: op(9): [started]  processing unit "waagent.service"
Dec 13 02:00:36.936240 ignition[966]: INFO     : files: op(9): [finished] processing unit "waagent.service"
Dec 13 02:00:36.936240 ignition[966]: INFO     : files: op(a): [started]  processing unit "nvidia.service"
Dec 13 02:00:36.936240 ignition[966]: INFO     : files: op(a): [finished] processing unit "nvidia.service"
Dec 13 02:00:36.936240 ignition[966]: INFO     : files: op(b): [started]  setting preset to enabled for "waagent.service"
Dec 13 02:00:37.017681 kernel: audit: type=1130 audit(1734055236.964:37): 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'
Dec 13 02:00:36.964000 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'
Dec 13 02:00:36.913913 systemd[1]: mnt-oem2812750612.mount: Deactivated successfully.
Dec 13 02:00:37.020454 ignition[966]: INFO     : files: op(b): [finished] setting preset to enabled for "waagent.service"
Dec 13 02:00:37.020454 ignition[966]: INFO     : files: op(c): [started]  setting preset to enabled for "nvidia.service"
Dec 13 02:00:37.020454 ignition[966]: INFO     : files: op(c): [finished] setting preset to enabled for "nvidia.service"
Dec 13 02:00:37.020454 ignition[966]: INFO     : files: createResultFile: createFiles: op(d): [started]  writing file "/sysroot/etc/.ignition-result.json"
Dec 13 02:00:37.020454 ignition[966]: INFO     : files: createResultFile: createFiles: op(d): [finished] writing file "/sysroot/etc/.ignition-result.json"
Dec 13 02:00:37.020454 ignition[966]: INFO     : files: files passed
Dec 13 02:00:37.020454 ignition[966]: INFO     : Ignition finished successfully
Dec 13 02:00:36.961141 systemd[1]: Finished ignition-files.service.
Dec 13 02:00:37.049656 systemd[1]: Starting initrd-setup-root-after-ignition.service...
Dec 13 02:00:37.052695 systemd[1]: torcx-profile-populate.service was skipped because of an unmet condition check (ConditionPathExists=/sysroot/etc/torcx/next-profile).
Dec 13 02:00:37.053680 systemd[1]: Starting ignition-quench.service...
Dec 13 02:00:37.071435 systemd[1]: ignition-quench.service: Deactivated successfully.
Dec 13 02:00:37.071928 systemd[1]: Finished ignition-quench.service.
Dec 13 02:00:37.078000 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'
Dec 13 02:00:37.078000 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'
Dec 13 02:00:37.132094 initrd-setup-root-after-ignition[983]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory
Dec 13 02:00:37.140000 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'
Dec 13 02:00:37.135754 systemd[1]: Finished initrd-setup-root-after-ignition.service.
Dec 13 02:00:37.140283 systemd[1]: Reached target ignition-complete.target.
Dec 13 02:00:37.149487 systemd[1]: Starting initrd-parse-etc.service...
Dec 13 02:00:37.168058 systemd[1]: initrd-parse-etc.service: Deactivated successfully.
Dec 13 02:00:37.171287 systemd[1]: Finished initrd-parse-etc.service.
Dec 13 02:00:37.176000 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'
Dec 13 02:00:37.176000 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'
Dec 13 02:00:37.176350 systemd[1]: Reached target initrd-fs.target.
Dec 13 02:00:37.180940 systemd[1]: Reached target initrd.target.
Dec 13 02:00:37.186059 systemd[1]: dracut-mount.service was skipped because no trigger condition checks were met.
Dec 13 02:00:37.190725 systemd[1]: Starting dracut-pre-pivot.service...
Dec 13 02:00:37.202308 systemd[1]: Finished dracut-pre-pivot.service.
Dec 13 02:00:37.205000 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'
Dec 13 02:00:37.206789 systemd[1]: Starting initrd-cleanup.service...
Dec 13 02:00:37.217015 systemd[1]: Stopped target nss-lookup.target.
Dec 13 02:00:37.221455 systemd[1]: Stopped target remote-cryptsetup.target.
Dec 13 02:00:37.223447 systemd[1]: Stopped target timers.target.
Dec 13 02:00:37.227034 systemd[1]: dracut-pre-pivot.service: Deactivated successfully.
Dec 13 02:00:37.230000 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'
Dec 13 02:00:37.227144 systemd[1]: Stopped dracut-pre-pivot.service.
Dec 13 02:00:37.231200 systemd[1]: Stopped target initrd.target.
Dec 13 02:00:37.236762 systemd[1]: Stopped target basic.target.
Dec 13 02:00:37.240780 systemd[1]: Stopped target ignition-complete.target.
Dec 13 02:00:37.244763 systemd[1]: Stopped target ignition-diskful.target.
Dec 13 02:00:37.248917 systemd[1]: Stopped target initrd-root-device.target.
Dec 13 02:00:37.253480 systemd[1]: Stopped target remote-fs.target.
Dec 13 02:00:37.258256 systemd[1]: Stopped target remote-fs-pre.target.
Dec 13 02:00:37.264889 systemd[1]: Stopped target sysinit.target.
Dec 13 02:00:37.270311 systemd[1]: Stopped target local-fs.target.
Dec 13 02:00:37.273824 systemd[1]: Stopped target local-fs-pre.target.
Dec 13 02:00:37.278025 systemd[1]: Stopped target swap.target.
Dec 13 02:00:37.286000 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'
Dec 13 02:00:37.282107 systemd[1]: dracut-pre-mount.service: Deactivated successfully.
Dec 13 02:00:37.282268 systemd[1]: Stopped dracut-pre-mount.service.
Dec 13 02:00:37.294000 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'
Dec 13 02:00:37.295000 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'
Dec 13 02:00:37.295000 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'
Dec 13 02:00:37.295000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=flatcar-metadata-hostname comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Dec 13 02:00:37.286387 systemd[1]: Stopped target cryptsetup.target.
Dec 13 02:00:37.312300 iscsid[816]: iscsid shutting down.
Dec 13 02:00:37.290415 systemd[1]: dracut-initqueue.service: Deactivated successfully.
Dec 13 02:00:37.290569 systemd[1]: Stopped dracut-initqueue.service.
Dec 13 02:00:37.323589 ignition[996]: INFO     : Ignition 2.14.0
Dec 13 02:00:37.323589 ignition[996]: INFO     : Stage: umount
Dec 13 02:00:37.323589 ignition[996]: INFO     : reading system config file "/usr/lib/ignition/base.d/base.ign"
Dec 13 02:00:37.323589 ignition[996]: DEBUG    : parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63
Dec 13 02:00:37.295175 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully.
Dec 13 02:00:37.339000 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'
Dec 13 02:00:37.344555 ignition[996]: INFO     : no config dir at "/usr/lib/ignition/base.platform.d/azure"
Dec 13 02:00:37.344555 ignition[996]: INFO     : umount: umount passed
Dec 13 02:00:37.344555 ignition[996]: INFO     : Ignition finished successfully
Dec 13 02:00:37.345000 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'
Dec 13 02:00:37.356000 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'
Dec 13 02:00:37.295311 systemd[1]: Stopped initrd-setup-root-after-ignition.service.
Dec 13 02:00:37.296166 systemd[1]: ignition-files.service: Deactivated successfully.
Dec 13 02:00:37.296286 systemd[1]: Stopped ignition-files.service.
Dec 13 02:00:37.296620 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully.
Dec 13 02:00:37.296736 systemd[1]: Stopped flatcar-metadata-hostname.service.
Dec 13 02:00:37.297992 systemd[1]: Stopping ignition-mount.service...
Dec 13 02:00:37.301227 systemd[1]: Stopping iscsid.service...
Dec 13 02:00:37.317433 systemd[1]: Stopping sysroot-boot.service...
Dec 13 02:00:37.375000 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'
Dec 13 02:00:37.381000 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'
Dec 13 02:00:37.381000 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'
Dec 13 02:00:37.323939 systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
Dec 13 02:00:37.386000 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'
Dec 13 02:00:37.328291 systemd[1]: Stopped systemd-udev-trigger.service.
Dec 13 02:00:37.390000 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'
Dec 13 02:00:37.339516 systemd[1]: dracut-pre-trigger.service: Deactivated successfully.
Dec 13 02:00:37.394000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Dec 13 02:00:37.339725 systemd[1]: Stopped dracut-pre-trigger.service.
Dec 13 02:00:37.347004 systemd[1]: iscsid.service: Deactivated successfully.
Dec 13 02:00:37.347094 systemd[1]: Stopped iscsid.service.
Dec 13 02:00:37.402000 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'
Dec 13 02:00:37.370169 systemd[1]: ignition-mount.service: Deactivated successfully.
Dec 13 02:00:37.370284 systemd[1]: Stopped ignition-mount.service.
Dec 13 02:00:37.377233 systemd[1]: sysroot-boot.mount: Deactivated successfully.
Dec 13 02:00:37.378800 systemd[1]: initrd-cleanup.service: Deactivated successfully.
Dec 13 02:00:37.378894 systemd[1]: Finished initrd-cleanup.service.
Dec 13 02:00:37.382143 systemd[1]: ignition-disks.service: Deactivated successfully.
Dec 13 02:00:37.382195 systemd[1]: Stopped ignition-disks.service.
Dec 13 02:00:37.428000 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'
Dec 13 02:00:37.386345 systemd[1]: ignition-kargs.service: Deactivated successfully.
Dec 13 02:00:37.386398 systemd[1]: Stopped ignition-kargs.service.
Dec 13 02:00:37.390488 systemd[1]: ignition-fetch.service: Deactivated successfully.
Dec 13 02:00:37.390536 systemd[1]: Stopped ignition-fetch.service.
Dec 13 02:00:37.395001 systemd[1]: ignition-fetch-offline.service: Deactivated successfully.
Dec 13 02:00:37.395048 systemd[1]: Stopped ignition-fetch-offline.service.
Dec 13 02:00:37.402837 systemd[1]: Stopped target paths.target.
Dec 13 02:00:37.407002 systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
Dec 13 02:00:37.413138 systemd[1]: Stopped systemd-ask-password-console.path.
Dec 13 02:00:37.417143 systemd[1]: Stopped target slices.target.
Dec 13 02:00:37.419002 systemd[1]: Stopped target sockets.target.
Dec 13 02:00:37.420930 systemd[1]: iscsid.socket: Deactivated successfully.
Dec 13 02:00:37.420971 systemd[1]: Closed iscsid.socket.
Dec 13 02:00:37.425080 systemd[1]: ignition-setup.service: Deactivated successfully.
Dec 13 02:00:37.425131 systemd[1]: Stopped ignition-setup.service.
Dec 13 02:00:37.428969 systemd[1]: Stopping iscsiuio.service...
Dec 13 02:00:37.462755 systemd[1]: iscsiuio.service: Deactivated successfully.
Dec 13 02:00:37.464000 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'
Dec 13 02:00:37.462868 systemd[1]: Stopped iscsiuio.service.
Dec 13 02:00:37.464946 systemd[1]: Stopped target network.target.
Dec 13 02:00:37.465850 systemd[1]: iscsiuio.socket: Deactivated successfully.
Dec 13 02:00:37.465884 systemd[1]: Closed iscsiuio.socket.
Dec 13 02:00:37.466681 systemd[1]: Stopping systemd-networkd.service...
Dec 13 02:00:37.481211 systemd[1]: Stopping systemd-resolved.service...
Dec 13 02:00:37.483846 systemd[1]: sysroot-boot.service: Deactivated successfully.
Dec 13 02:00:37.483928 systemd[1]: Stopped sysroot-boot.service.
Dec 13 02:00:37.490000 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'
Dec 13 02:00:37.490986 systemd[1]: systemd-resolved.service: Deactivated successfully.
Dec 13 02:00:37.491579 systemd-networkd[806]: eth0: DHCPv6 lease lost
Dec 13 02:00:37.497000 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'
Dec 13 02:00:37.493499 systemd[1]: Stopped systemd-resolved.service.
Dec 13 02:00:37.499604 systemd[1]: systemd-networkd.service: Deactivated successfully.
Dec 13 02:00:37.501984 systemd[1]: Stopped systemd-networkd.service.
Dec 13 02:00:37.505000 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'
Dec 13 02:00:37.506274 systemd[1]: systemd-networkd.socket: Deactivated successfully.
Dec 13 02:00:37.506316 systemd[1]: Closed systemd-networkd.socket.
Dec 13 02:00:37.512459 systemd[1]: initrd-setup-root.service: Deactivated successfully.
Dec 13 02:00:37.512516 systemd[1]: Stopped initrd-setup-root.service.
Dec 13 02:00:37.518000 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'
Dec 13 02:00:37.519000 audit: BPF prog-id=6 op=UNLOAD
Dec 13 02:00:37.519000 audit: BPF prog-id=9 op=UNLOAD
Dec 13 02:00:37.519905 systemd[1]: Stopping network-cleanup.service...
Dec 13 02:00:37.524000 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'
Dec 13 02:00:37.526000 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'
Dec 13 02:00:37.528000 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'
Dec 13 02:00:37.521814 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully.
Dec 13 02:00:37.521891 systemd[1]: Stopped parse-ip-for-networkd.service.
Dec 13 02:00:37.524176 systemd[1]: systemd-sysctl.service: Deactivated successfully.
Dec 13 02:00:37.544000 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'
Dec 13 02:00:37.524237 systemd[1]: Stopped systemd-sysctl.service.
Dec 13 02:00:37.526500 systemd[1]: systemd-modules-load.service: Deactivated successfully.
Dec 13 02:00:37.526549 systemd[1]: Stopped systemd-modules-load.service.
Dec 13 02:00:37.528965 systemd[1]: Stopping systemd-udevd.service...
Dec 13 02:00:37.541416 systemd[1]: systemd-udevd.service: Deactivated successfully.
Dec 13 02:00:37.565000 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'
Dec 13 02:00:37.541534 systemd[1]: Stopped systemd-udevd.service.
Dec 13 02:00:37.546299 systemd[1]: systemd-udevd-control.socket: Deactivated successfully.
Dec 13 02:00:37.582963 kernel: hv_netvsc 7c1e5277-09d4-7c1e-5277-09d47c1e5277 eth0: Data path switched from VF: enP21633s1
Dec 13 02:00:37.575000 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'
Dec 13 02:00:37.582000 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'
Dec 13 02:00:37.546334 systemd[1]: Closed systemd-udevd-control.socket.
Dec 13 02:00:37.549826 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully.
Dec 13 02:00:37.549867 systemd[1]: Closed systemd-udevd-kernel.socket.
Dec 13 02:00:37.557944 systemd[1]: dracut-pre-udev.service: Deactivated successfully.
Dec 13 02:00:37.560260 systemd[1]: Stopped dracut-pre-udev.service.
Dec 13 02:00:37.565313 systemd[1]: dracut-cmdline.service: Deactivated successfully.
Dec 13 02:00:37.596000 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'
Dec 13 02:00:37.565361 systemd[1]: Stopped dracut-cmdline.service.
Dec 13 02:00:37.607000 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'
Dec 13 02:00:37.575684 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully.
Dec 13 02:00:37.575770 systemd[1]: Stopped dracut-cmdline-ask.service.
Dec 13 02:00:37.613000 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'
Dec 13 02:00:37.588843 systemd[1]: Starting initrd-udevadm-cleanup-db.service...
Dec 13 02:00:37.600716 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
Dec 13 02:00:37.600854 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service.
Dec 13 02:00:37.604833 systemd[1]: kmod-static-nodes.service: Deactivated successfully.
Dec 13 02:00:37.604891 systemd[1]: Stopped kmod-static-nodes.service.
Dec 13 02:00:37.630000 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'
Dec 13 02:00:37.610224 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
Dec 13 02:00:37.610294 systemd[1]: Stopped systemd-vconsole-setup.service.
Dec 13 02:00:37.628531 systemd[1]: network-cleanup.service: Deactivated successfully.
Dec 13 02:00:37.628651 systemd[1]: Stopped network-cleanup.service.
Dec 13 02:00:37.645557 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
Dec 13 02:00:37.648000 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'
Dec 13 02:00:37.648000 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'
Dec 13 02:00:37.645652 systemd[1]: Finished initrd-udevadm-cleanup-db.service.
Dec 13 02:00:37.650842 systemd[1]: Reached target initrd-switch-root.target.
Dec 13 02:00:37.653810 systemd[1]: Starting initrd-switch-root.service...
Dec 13 02:00:37.668168 systemd[1]: Switching root.
Dec 13 02:00:37.697227 systemd-journald[182]: Journal stopped
Dec 13 02:00:57.406235 systemd-journald[182]: Received SIGTERM from PID 1 (systemd).
Dec 13 02:00:57.406261 kernel: SELinux:  Class mctp_socket not defined in policy.
Dec 13 02:00:57.406274 kernel: SELinux:  Class anon_inode not defined in policy.
Dec 13 02:00:57.406283 kernel: SELinux: the above unknown classes and permissions will be allowed
Dec 13 02:00:57.406293 kernel: SELinux:  policy capability network_peer_controls=1
Dec 13 02:00:57.406303 kernel: SELinux:  policy capability open_perms=1
Dec 13 02:00:57.406315 kernel: SELinux:  policy capability extended_socket_class=1
Dec 13 02:00:57.406325 kernel: SELinux:  policy capability always_check_network=0
Dec 13 02:00:57.406335 kernel: SELinux:  policy capability cgroup_seclabel=1
Dec 13 02:00:57.406347 kernel: SELinux:  policy capability nnp_nosuid_transition=1
Dec 13 02:00:57.406355 kernel: SELinux:  policy capability genfs_seclabel_symlinks=0
Dec 13 02:00:57.406364 kernel: SELinux:  policy capability ioctl_skip_cloexec=0
Dec 13 02:00:57.406374 kernel: kauditd_printk_skb: 43 callbacks suppressed
Dec 13 02:00:57.406386 kernel: audit: type=1403 audit(1734055240.913:81): auid=4294967295 ses=4294967295 lsm=selinux res=1
Dec 13 02:00:57.406398 systemd[1]: Successfully loaded SELinux policy in 439.356ms.
Dec 13 02:00:57.406412 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 33.649ms.
Dec 13 02:00:57.406424 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)
Dec 13 02:00:57.406434 systemd[1]: Detected virtualization microsoft.
Dec 13 02:00:57.406448 systemd[1]: Detected architecture x86-64.
Dec 13 02:00:57.406458 systemd[1]: Detected first boot.
Dec 13 02:00:57.406470 systemd[1]: Hostname set to <ci-3510.3.6-a-51ae78fa62>.
Dec 13 02:00:57.406482 systemd[1]: Initializing machine ID from random generator.
Dec 13 02:00:57.406494 kernel: audit: type=1400 audit(1734055241.912:82): avc:  denied  { integrity } for  pid=1 comm="systemd" lockdown_reason="/dev/mem,kmem,port" scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=lockdown permissive=1
Dec 13 02:00:57.406507 kernel: audit: type=1400 audit(1734055241.931:83): 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
Dec 13 02:00:57.406516 kernel: audit: type=1400 audit(1734055241.931:84): 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
Dec 13 02:00:57.406529 kernel: audit: type=1334 audit(1734055241.945:85): prog-id=10 op=LOAD
Dec 13 02:00:57.406538 kernel: audit: type=1334 audit(1734055241.945:86): prog-id=10 op=UNLOAD
Dec 13 02:00:57.406550 kernel: audit: type=1334 audit(1734055241.957:87): prog-id=11 op=LOAD
Dec 13 02:00:57.406558 kernel: audit: type=1334 audit(1734055241.957:88): prog-id=11 op=UNLOAD
Dec 13 02:00:57.406569 kernel: SELinux:  Context system_u:object_r:container_file_t:s0:c1022,c1023 is not valid (left unmapped).
Dec 13 02:00:57.406579 kernel: audit: type=1400 audit(1734055243.823:89): avc:  denied  { associate } for  pid=1029 comm="torcx-generator" name="docker" dev="tmpfs" ino=2 scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 srawcon="system_u:object_r:container_file_t:s0:c1022,c1023"
Dec 13 02:00:57.406591 kernel: audit: type=1300 audit(1734055243.823:89): arch=c000003e syscall=188 success=yes exit=0 a0=c0001058d2 a1=c00002ae58 a2=c000029100 a3=32 items=0 ppid=1012 pid=1029 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="torcx-generator" exe="/usr/lib/systemd/system-generators/torcx-generator" subj=system_u:system_r:kernel_t:s0 key=(null)
Dec 13 02:00:57.406602 systemd[1]: Populated /etc with preset unit settings.
Dec 13 02:00:57.406614 systemd[1]: /usr/lib/systemd/system/locksmithd.service:8: Unit uses CPUShares=; please use CPUWeight= instead. Support for CPUShares= will be removed soon.
Dec 13 02:00:57.406627 systemd[1]: /usr/lib/systemd/system/locksmithd.service:9: Unit uses MemoryLimit=; please use MemoryMax= instead. Support for MemoryLimit= will be removed soon.
Dec 13 02:00:57.406638 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.
Dec 13 02:00:57.406650 kernel: kauditd_printk_skb: 7 callbacks suppressed
Dec 13 02:00:57.406659 kernel: audit: type=1334 audit(1734055256.824:91): prog-id=12 op=LOAD
Dec 13 02:00:57.406670 kernel: audit: type=1334 audit(1734055256.824:92): prog-id=3 op=UNLOAD
Dec 13 02:00:57.406680 kernel: audit: type=1334 audit(1734055256.828:93): prog-id=13 op=LOAD
Dec 13 02:00:57.406695 kernel: audit: type=1334 audit(1734055256.833:94): prog-id=14 op=LOAD
Dec 13 02:00:57.406707 kernel: audit: type=1334 audit(1734055256.833:95): prog-id=4 op=UNLOAD
Dec 13 02:00:57.406717 kernel: audit: type=1334 audit(1734055256.833:96): prog-id=5 op=UNLOAD
Dec 13 02:00:57.406729 kernel: audit: type=1334 audit(1734055256.842:97): prog-id=15 op=LOAD
Dec 13 02:00:57.406739 kernel: audit: type=1334 audit(1734055256.842:98): prog-id=12 op=UNLOAD
Dec 13 02:00:57.406750 kernel: audit: type=1334 audit(1734055256.847:99): prog-id=16 op=LOAD
Dec 13 02:00:57.406759 kernel: audit: type=1334 audit(1734055256.866:100): prog-id=17 op=LOAD
Dec 13 02:00:57.406771 systemd[1]: initrd-switch-root.service: Deactivated successfully.
Dec 13 02:00:57.406786 systemd[1]: Stopped initrd-switch-root.service.
Dec 13 02:00:57.406796 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
Dec 13 02:00:57.406809 systemd[1]: Created slice system-addon\x2dconfig.slice.
Dec 13 02:00:57.406820 systemd[1]: Created slice system-addon\x2drun.slice.
Dec 13 02:00:57.406831 systemd[1]: Created slice system-getty.slice.
Dec 13 02:00:57.406845 systemd[1]: Created slice system-modprobe.slice.
Dec 13 02:00:57.406864 systemd[1]: Created slice system-serial\x2dgetty.slice.
Dec 13 02:00:57.406883 systemd[1]: Created slice system-system\x2dcloudinit.slice.
Dec 13 02:00:57.406905 systemd[1]: Created slice system-systemd\x2dfsck.slice.
Dec 13 02:00:57.406922 systemd[1]: Created slice user.slice.
Dec 13 02:00:57.406944 systemd[1]: Started systemd-ask-password-console.path.
Dec 13 02:00:57.406962 systemd[1]: Started systemd-ask-password-wall.path.
Dec 13 02:00:57.406980 systemd[1]: Set up automount boot.automount.
Dec 13 02:00:57.406999 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount.
Dec 13 02:00:57.407016 systemd[1]: Stopped target initrd-switch-root.target.
Dec 13 02:00:57.407036 systemd[1]: Stopped target initrd-fs.target.
Dec 13 02:00:57.407057 systemd[1]: Stopped target initrd-root-fs.target.
Dec 13 02:00:57.407079 systemd[1]: Reached target integritysetup.target.
Dec 13 02:00:57.407097 systemd[1]: Reached target remote-cryptsetup.target.
Dec 13 02:00:57.407118 systemd[1]: Reached target remote-fs.target.
Dec 13 02:00:57.407137 systemd[1]: Reached target slices.target.
Dec 13 02:00:57.407167 systemd[1]: Reached target swap.target.
Dec 13 02:00:57.407187 systemd[1]: Reached target torcx.target.
Dec 13 02:00:57.407206 systemd[1]: Reached target veritysetup.target.
Dec 13 02:00:57.407229 systemd[1]: Listening on systemd-coredump.socket.
Dec 13 02:00:57.407247 systemd[1]: Listening on systemd-initctl.socket.
Dec 13 02:00:57.407265 systemd[1]: Listening on systemd-networkd.socket.
Dec 13 02:00:57.407287 systemd[1]: Listening on systemd-udevd-control.socket.
Dec 13 02:00:57.407305 systemd[1]: Listening on systemd-udevd-kernel.socket.
Dec 13 02:00:57.407327 systemd[1]: Listening on systemd-userdbd.socket.
Dec 13 02:00:57.407345 systemd[1]: Mounting dev-hugepages.mount...
Dec 13 02:00:57.407363 systemd[1]: Mounting dev-mqueue.mount...
Dec 13 02:00:57.407384 systemd[1]: Mounting media.mount...
Dec 13 02:00:57.407403 systemd[1]: proc-xen.mount was skipped because of an unmet condition check (ConditionVirtualization=xen).
Dec 13 02:00:57.407422 systemd[1]: Mounting sys-kernel-debug.mount...
Dec 13 02:00:57.407443 systemd[1]: Mounting sys-kernel-tracing.mount...
Dec 13 02:00:57.407464 systemd[1]: Mounting tmp.mount...
Dec 13 02:00:57.407483 systemd[1]: Starting flatcar-tmpfiles.service...
Dec 13 02:00:57.407507 systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met.
Dec 13 02:00:57.407530 systemd[1]: Starting kmod-static-nodes.service...
Dec 13 02:00:57.407548 systemd[1]: Starting modprobe@configfs.service...
Dec 13 02:00:57.407568 systemd[1]: Starting modprobe@dm_mod.service...
Dec 13 02:00:57.407587 systemd[1]: Starting modprobe@drm.service...
Dec 13 02:00:57.407605 systemd[1]: Starting modprobe@efi_pstore.service...
Dec 13 02:00:57.407624 systemd[1]: Starting modprobe@fuse.service...
Dec 13 02:00:57.407642 systemd[1]: Starting modprobe@loop.service...
Dec 13 02:00:57.407661 systemd[1]: setup-nsswitch.service was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf).
Dec 13 02:00:57.407684 systemd[1]: systemd-fsck-root.service: Deactivated successfully.
Dec 13 02:00:57.407702 systemd[1]: Stopped systemd-fsck-root.service.
Dec 13 02:00:57.407717 systemd[1]: systemd-fsck-usr.service: Deactivated successfully.
Dec 13 02:00:57.407733 systemd[1]: Stopped systemd-fsck-usr.service.
Dec 13 02:00:57.407747 kernel: loop: module loaded
Dec 13 02:00:57.407761 systemd[1]: Stopped systemd-journald.service.
Dec 13 02:00:57.407774 kernel: fuse: init (API version 7.34)
Dec 13 02:00:57.409512 systemd[1]: Starting systemd-journald.service...
Dec 13 02:00:57.409534 systemd[1]: Starting systemd-modules-load.service...
Dec 13 02:00:57.409557 systemd[1]: Starting systemd-network-generator.service...
Dec 13 02:00:57.409578 systemd[1]: Starting systemd-remount-fs.service...
Dec 13 02:00:57.409595 systemd[1]: Starting systemd-udev-trigger.service...
Dec 13 02:00:57.409610 systemd[1]: verity-setup.service: Deactivated successfully.
Dec 13 02:00:57.409627 systemd[1]: Stopped verity-setup.service.
Dec 13 02:00:57.409643 systemd[1]: xenserver-pv-version.service was skipped because of an unmet condition check (ConditionVirtualization=xen).
Dec 13 02:00:57.409661 systemd[1]: Mounted dev-hugepages.mount.
Dec 13 02:00:57.409678 systemd[1]: Mounted dev-mqueue.mount.
Dec 13 02:00:57.409697 systemd[1]: Mounted media.mount.
Dec 13 02:00:57.409711 systemd[1]: Mounted sys-kernel-debug.mount.
Dec 13 02:00:57.409726 systemd[1]: Mounted sys-kernel-tracing.mount.
Dec 13 02:00:57.409742 systemd[1]: Mounted tmp.mount.
Dec 13 02:00:57.409774 systemd[1]: Finished flatcar-tmpfiles.service.
Dec 13 02:00:57.409793 systemd-journald[1138]: Journal started
Dec 13 02:00:57.409852 systemd-journald[1138]: Runtime Journal (/run/log/journal/499051b4521c455ea2ec6215287e9455) is 8.0M, max 159.0M, 151.0M free.
Dec 13 02:00:40.913000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1
Dec 13 02:00:41.912000 audit[1]: AVC avc:  denied  { integrity } for  pid=1 comm="systemd" lockdown_reason="/dev/mem,kmem,port" scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=lockdown permissive=1
Dec 13 02:00:41.931000 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
Dec 13 02:00:41.931000 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
Dec 13 02:00:41.945000 audit: BPF prog-id=10 op=LOAD
Dec 13 02:00:41.945000 audit: BPF prog-id=10 op=UNLOAD
Dec 13 02:00:41.957000 audit: BPF prog-id=11 op=LOAD
Dec 13 02:00:41.957000 audit: BPF prog-id=11 op=UNLOAD
Dec 13 02:00:43.823000 audit[1029]: AVC avc:  denied  { associate } for  pid=1029 comm="torcx-generator" name="docker" dev="tmpfs" ino=2 scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 srawcon="system_u:object_r:container_file_t:s0:c1022,c1023"
Dec 13 02:00:43.823000 audit[1029]: SYSCALL arch=c000003e syscall=188 success=yes exit=0 a0=c0001058d2 a1=c00002ae58 a2=c000029100 a3=32 items=0 ppid=1012 pid=1029 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="torcx-generator" exe="/usr/lib/systemd/system-generators/torcx-generator" subj=system_u:system_r:kernel_t:s0 key=(null)
Dec 13 02:00:43.823000 audit: PROCTITLE proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61
Dec 13 02:00:43.831000 audit[1029]: AVC avc:  denied  { associate } for  pid=1029 comm="torcx-generator" name="bin" scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1
Dec 13 02:00:43.831000 audit[1029]: SYSCALL arch=c000003e syscall=258 success=yes exit=0 a0=ffffffffffffff9c a1=c0001059a9 a2=1ed a3=0 items=2 ppid=1012 pid=1029 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="torcx-generator" exe="/usr/lib/systemd/system-generators/torcx-generator" subj=system_u:system_r:kernel_t:s0 key=(null)
Dec 13 02:00:43.831000 audit: CWD cwd="/"
Dec 13 02:00:43.831000 audit: PATH item=0 name=(null) inode=2 dev=00:1c mode=040755 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:unlabeled_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0
Dec 13 02:00:43.831000 audit: PATH item=1 name=(null) inode=3 dev=00:1c mode=040755 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:unlabeled_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0
Dec 13 02:00:43.831000 audit: PROCTITLE proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61
Dec 13 02:00:56.824000 audit: BPF prog-id=12 op=LOAD
Dec 13 02:00:56.824000 audit: BPF prog-id=3 op=UNLOAD
Dec 13 02:00:56.828000 audit: BPF prog-id=13 op=LOAD
Dec 13 02:00:56.833000 audit: BPF prog-id=14 op=LOAD
Dec 13 02:00:56.833000 audit: BPF prog-id=4 op=UNLOAD
Dec 13 02:00:56.833000 audit: BPF prog-id=5 op=UNLOAD
Dec 13 02:00:56.842000 audit: BPF prog-id=15 op=LOAD
Dec 13 02:00:56.842000 audit: BPF prog-id=12 op=UNLOAD
Dec 13 02:00:56.847000 audit: BPF prog-id=16 op=LOAD
Dec 13 02:00:56.866000 audit: BPF prog-id=17 op=LOAD
Dec 13 02:00:56.866000 audit: BPF prog-id=13 op=UNLOAD
Dec 13 02:00:56.867000 audit: BPF prog-id=14 op=UNLOAD
Dec 13 02:00:56.872000 audit: BPF prog-id=18 op=LOAD
Dec 13 02:00:56.872000 audit: BPF prog-id=15 op=UNLOAD
Dec 13 02:00:56.876000 audit: BPF prog-id=19 op=LOAD
Dec 13 02:00:56.877000 audit: BPF prog-id=20 op=LOAD
Dec 13 02:00:56.877000 audit: BPF prog-id=16 op=UNLOAD
Dec 13 02:00:56.877000 audit: BPF prog-id=17 op=UNLOAD
Dec 13 02:00:56.877000 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'
Dec 13 02:00:56.887000 audit: BPF prog-id=18 op=UNLOAD
Dec 13 02:00:56.889000 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'
Dec 13 02:00:56.889000 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'
Dec 13 02:00:57.272000 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'
Dec 13 02:00:57.288000 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'
Dec 13 02:00:57.296000 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'
Dec 13 02:00:57.296000 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'
Dec 13 02:00:57.297000 audit: BPF prog-id=21 op=LOAD
Dec 13 02:00:57.297000 audit: BPF prog-id=22 op=LOAD
Dec 13 02:00:57.297000 audit: BPF prog-id=23 op=LOAD
Dec 13 02:00:57.297000 audit: BPF prog-id=19 op=UNLOAD
Dec 13 02:00:57.297000 audit: BPF prog-id=20 op=UNLOAD
Dec 13 02:00:57.355000 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'
Dec 13 02:00:57.401000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1
Dec 13 02:00:57.401000 audit[1138]: SYSCALL arch=c000003e syscall=46 success=yes exit=60 a0=5 a1=7fffd15ce300 a2=4000 a3=7fffd15ce39c items=0 ppid=1 pid=1138 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)
Dec 13 02:00:57.401000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald"
Dec 13 02:00:43.786683 /usr/lib/systemd/system-generators/torcx-generator[1029]: time="2024-12-13T02:00:43Z" 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.6 /usr/share/oem/torcx/store /var/lib/torcx/store/3510.3.6 /var/lib/torcx/store]"
Dec 13 02:00:56.822535 systemd[1]: Queued start job for default target multi-user.target.
Dec 13 02:00:43.787235 /usr/lib/systemd/system-generators/torcx-generator[1029]: time="2024-12-13T02:00:43Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json
Dec 13 02:00:56.877506 systemd[1]: systemd-journald.service: Deactivated successfully.
Dec 13 02:00:43.787254 /usr/lib/systemd/system-generators/torcx-generator[1029]: time="2024-12-13T02:00:43Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json
Dec 13 02:00:43.787287 /usr/lib/systemd/system-generators/torcx-generator[1029]: time="2024-12-13T02:00:43Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12"
Dec 13 02:00:43.787297 /usr/lib/systemd/system-generators/torcx-generator[1029]: time="2024-12-13T02:00:43Z" level=debug msg="skipped missing lower profile" missing profile=oem
Dec 13 02:00:43.787336 /usr/lib/systemd/system-generators/torcx-generator[1029]: time="2024-12-13T02:00:43Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory"
Dec 13 02:00:43.787349 /usr/lib/systemd/system-generators/torcx-generator[1029]: time="2024-12-13T02:00:43Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)=
Dec 13 02:00:43.787526 /usr/lib/systemd/system-generators/torcx-generator[1029]: time="2024-12-13T02:00:43Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack
Dec 13 02:00:43.787572 /usr/lib/systemd/system-generators/torcx-generator[1029]: time="2024-12-13T02:00:43Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json
Dec 13 02:00:43.787584 /usr/lib/systemd/system-generators/torcx-generator[1029]: time="2024-12-13T02:00:43Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json
Dec 13 02:00:43.812285 /usr/lib/systemd/system-generators/torcx-generator[1029]: time="2024-12-13T02:00:43Z" 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
Dec 13 02:00:43.812324 /usr/lib/systemd/system-generators/torcx-generator[1029]: time="2024-12-13T02:00:43Z" 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
Dec 13 02:00:43.812342 /usr/lib/systemd/system-generators/torcx-generator[1029]: time="2024-12-13T02:00:43Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store/3510.3.6: no such file or directory" path=/usr/share/oem/torcx/store/3510.3.6
Dec 13 02:00:43.812355 /usr/lib/systemd/system-generators/torcx-generator[1029]: time="2024-12-13T02:00:43Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store
Dec 13 02:00:43.812374 /usr/lib/systemd/system-generators/torcx-generator[1029]: time="2024-12-13T02:00:43Z" level=info msg="store skipped" err="open /var/lib/torcx/store/3510.3.6: no such file or directory" path=/var/lib/torcx/store/3510.3.6
Dec 13 02:00:43.812386 /usr/lib/systemd/system-generators/torcx-generator[1029]: time="2024-12-13T02:00:43Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store
Dec 13 02:00:55.374978 /usr/lib/systemd/system-generators/torcx-generator[1029]: time="2024-12-13T02:00:55Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl
Dec 13 02:00:55.375219 /usr/lib/systemd/system-generators/torcx-generator[1029]: time="2024-12-13T02:00:55Z" 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
Dec 13 02:00:55.375335 /usr/lib/systemd/system-generators/torcx-generator[1029]: time="2024-12-13T02:00:55Z" 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
Dec 13 02:00:55.375498 /usr/lib/systemd/system-generators/torcx-generator[1029]: time="2024-12-13T02:00:55Z" 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
Dec 13 02:00:55.375545 /usr/lib/systemd/system-generators/torcx-generator[1029]: time="2024-12-13T02:00:55Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile=
Dec 13 02:00:55.375595 /usr/lib/systemd/system-generators/torcx-generator[1029]: time="2024-12-13T02:00:55Z" 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
Dec 13 02:00:57.416810 systemd[1]: Started systemd-journald.service.
Dec 13 02:00:57.415000 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'
Dec 13 02:00:57.421000 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'
Dec 13 02:00:57.422340 systemd[1]: Finished kmod-static-nodes.service.
Dec 13 02:00:57.424000 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'
Dec 13 02:00:57.424990 systemd[1]: modprobe@configfs.service: Deactivated successfully.
Dec 13 02:00:57.425131 systemd[1]: Finished modprobe@configfs.service.
Dec 13 02:00:57.427000 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'
Dec 13 02:00:57.427000 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'
Dec 13 02:00:57.427735 systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
Dec 13 02:00:57.427881 systemd[1]: Finished modprobe@dm_mod.service.
Dec 13 02:00:57.430000 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'
Dec 13 02:00:57.430000 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'
Dec 13 02:00:57.433000 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'
Dec 13 02:00:57.433000 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'
Dec 13 02:00:57.430880 systemd[1]: modprobe@drm.service: Deactivated successfully.
Dec 13 02:00:57.431092 systemd[1]: Finished modprobe@drm.service.
Dec 13 02:00:57.433798 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
Dec 13 02:00:57.434084 systemd[1]: Finished modprobe@efi_pstore.service.
Dec 13 02:00:57.441000 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'
Dec 13 02:00:57.441000 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'
Dec 13 02:00:57.441659 systemd[1]: modprobe@fuse.service: Deactivated successfully.
Dec 13 02:00:57.441896 systemd[1]: Finished modprobe@fuse.service.
Dec 13 02:00:57.444000 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'
Dec 13 02:00:57.444000 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'
Dec 13 02:00:57.444789 systemd[1]: modprobe@loop.service: Deactivated successfully.
Dec 13 02:00:57.444966 systemd[1]: Finished modprobe@loop.service.
Dec 13 02:00:57.451000 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'
Dec 13 02:00:57.451000 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'
Dec 13 02:00:57.452083 systemd[1]: Finished systemd-modules-load.service.
Dec 13 02:00:57.455000 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'
Dec 13 02:00:57.455505 systemd[1]: Finished systemd-network-generator.service.
Dec 13 02:00:57.461000 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'
Dec 13 02:00:57.461942 systemd[1]: Finished systemd-remount-fs.service.
Dec 13 02:00:57.464000 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'
Dec 13 02:00:57.465593 systemd[1]: Reached target network-pre.target.
Dec 13 02:00:57.472484 systemd[1]: Mounting sys-fs-fuse-connections.mount...
Dec 13 02:00:57.480103 systemd[1]: Mounting sys-kernel-config.mount...
Dec 13 02:00:57.485627 systemd[1]: remount-root.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/).
Dec 13 02:00:57.497394 systemd[1]: Starting systemd-hwdb-update.service...
Dec 13 02:00:57.504034 systemd[1]: Starting systemd-journal-flush.service...
Dec 13 02:00:57.506915 systemd[1]: systemd-pstore.service was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
Dec 13 02:00:57.508093 systemd[1]: Starting systemd-random-seed.service...
Dec 13 02:00:57.511260 systemd[1]: systemd-repart.service was skipped because no trigger condition checks were met.
Dec 13 02:00:57.512964 systemd[1]: Starting systemd-sysctl.service...
Dec 13 02:00:57.518061 systemd[1]: Starting systemd-sysusers.service...
Dec 13 02:00:57.525848 systemd[1]: Finished systemd-udev-trigger.service.
Dec 13 02:00:57.528000 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'
Dec 13 02:00:57.528686 systemd[1]: Mounted sys-fs-fuse-connections.mount.
Dec 13 02:00:57.531335 systemd[1]: Mounted sys-kernel-config.mount.
Dec 13 02:00:57.534630 systemd[1]: Starting systemd-udev-settle.service...
Dec 13 02:00:57.537538 systemd[1]: Finished systemd-random-seed.service.
Dec 13 02:00:57.539000 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'
Dec 13 02:00:57.540044 systemd[1]: Reached target first-boot-complete.target.
Dec 13 02:00:57.547011 udevadm[1153]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in.
Dec 13 02:00:57.557141 systemd[1]: Finished systemd-sysctl.service.
Dec 13 02:00:57.559000 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'
Dec 13 02:00:57.566824 systemd-journald[1138]: Time spent on flushing to /var/log/journal/499051b4521c455ea2ec6215287e9455 is 19.602ms for 1148 entries.
Dec 13 02:00:57.566824 systemd-journald[1138]: System Journal (/var/log/journal/499051b4521c455ea2ec6215287e9455) is 8.0M, max 2.6G, 2.6G free.
Dec 13 02:00:57.623627 systemd-journald[1138]: Received client request to flush runtime journal.
Dec 13 02:00:57.624561 systemd[1]: Finished systemd-journal-flush.service.
Dec 13 02:00:57.627000 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'
Dec 13 02:00:58.545000 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'
Dec 13 02:00:58.542357 systemd[1]: Finished systemd-sysusers.service.
Dec 13 02:00:58.546801 systemd[1]: Starting systemd-tmpfiles-setup-dev.service...
Dec 13 02:00:58.919705 systemd[1]: Finished systemd-hwdb-update.service.
Dec 13 02:00:58.922000 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'
Dec 13 02:00:59.246000 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'
Dec 13 02:00:59.243654 systemd[1]: Finished systemd-tmpfiles-setup-dev.service.
Dec 13 02:00:59.247000 audit: BPF prog-id=24 op=LOAD
Dec 13 02:00:59.247000 audit: BPF prog-id=25 op=LOAD
Dec 13 02:00:59.247000 audit: BPF prog-id=7 op=UNLOAD
Dec 13 02:00:59.247000 audit: BPF prog-id=8 op=UNLOAD
Dec 13 02:00:59.248263 systemd[1]: Starting systemd-udevd.service...
Dec 13 02:00:59.265434 systemd-udevd[1157]: Using default interface naming scheme 'v252'.
Dec 13 02:00:59.548631 systemd[1]: Started systemd-udevd.service.
Dec 13 02:00:59.559000 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'
Dec 13 02:00:59.561000 audit: BPF prog-id=26 op=LOAD
Dec 13 02:00:59.562542 systemd[1]: Starting systemd-networkd.service...
Dec 13 02:00:59.588887 systemd[1]: Condition check resulted in dev-ttyS0.device being skipped.
Dec 13 02:00:59.745175 kernel: mousedev: PS/2 mouse device common for all mice
Dec 13 02:00:59.755000 audit[1171]: AVC avc:  denied  { confidentiality } for  pid=1171 comm="(udev-worker)" lockdown_reason="use of tracefs" scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=lockdown permissive=1
Dec 13 02:00:59.763174 kernel: hv_vmbus: registering driver hv_balloon
Dec 13 02:00:59.768214 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0
Dec 13 02:00:59.786016 kernel: hv_utils: Registering HyperV Utility Driver
Dec 13 02:00:59.786099 kernel: hv_vmbus: registering driver hv_utils
Dec 13 02:00:59.802958 kernel: hv_vmbus: registering driver hyperv_fb
Dec 13 02:00:59.803014 kernel: hv_utils: Heartbeat IC version 3.0
Dec 13 02:00:59.803040 kernel: hv_utils: Shutdown IC version 3.2
Dec 13 02:00:59.803064 kernel: hv_utils: TimeSync IC version 4.0
Dec 13 02:00:59.799000 audit: BPF prog-id=27 op=LOAD
Dec 13 02:01:00.653448 kernel: hyperv_fb: Synthvid Version major 3, minor 5
Dec 13 02:01:00.653509 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608
Dec 13 02:00:59.806000 audit: BPF prog-id=28 op=LOAD
Dec 13 02:01:00.653000 audit: BPF prog-id=29 op=LOAD
Dec 13 02:01:00.655482 systemd[1]: Starting systemd-userdbd.service...
Dec 13 02:01:00.661261 kernel: Console: switching to colour dummy device 80x25
Dec 13 02:01:00.667686 kernel: Console: switching to colour frame buffer device 128x48
Dec 13 02:00:59.755000 audit[1171]: SYSCALL arch=c000003e syscall=175 success=yes exit=0 a0=556ea819c040 a1=f884 a2=7f73e9322bc5 a3=5 items=12 ppid=1157 pid=1171 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="(udev-worker)" exe="/usr/bin/udevadm" subj=system_u:system_r:kernel_t:s0 key=(null)
Dec 13 02:00:59.755000 audit: CWD cwd="/"
Dec 13 02:00:59.755000 audit: PATH item=0 name=(null) inode=235 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0
Dec 13 02:00:59.755000 audit: PATH item=1 name=(null) inode=15640 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0
Dec 13 02:00:59.755000 audit: PATH item=2 name=(null) inode=15640 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0
Dec 13 02:00:59.755000 audit: PATH item=3 name=(null) inode=15641 dev=00:0b mode=0100640 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0
Dec 13 02:00:59.755000 audit: PATH item=4 name=(null) inode=15640 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0
Dec 13 02:00:59.755000 audit: PATH item=5 name=(null) inode=15642 dev=00:0b mode=0100440 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0
Dec 13 02:00:59.755000 audit: PATH item=6 name=(null) inode=15640 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0
Dec 13 02:00:59.755000 audit: PATH item=7 name=(null) inode=15643 dev=00:0b mode=0100640 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0
Dec 13 02:00:59.755000 audit: PATH item=8 name=(null) inode=15640 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0
Dec 13 02:00:59.755000 audit: PATH item=9 name=(null) inode=15644 dev=00:0b mode=0100640 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0
Dec 13 02:00:59.755000 audit: PATH item=10 name=(null) inode=15640 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0
Dec 13 02:00:59.755000 audit: PATH item=11 name=(null) inode=15645 dev=00:0b mode=0100440 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0
Dec 13 02:00:59.755000 audit: PROCTITLE proctitle="(udev-worker)"
Dec 13 02:01:00.724130 systemd[1]: Started systemd-userdbd.service.
Dec 13 02:01:00.726000 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'
Dec 13 02:01:00.878024 kernel: BTRFS info: devid 1 device path /dev/disk/by-label/OEM changed to /dev/sda6 scanned by (udev-worker) (1168)
Dec 13 02:01:00.933026 kernel: KVM: vmx: using Hyper-V Enlightened VMCS
Dec 13 02:01:00.943409 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device.
Dec 13 02:01:01.054430 systemd[1]: Finished systemd-udev-settle.service.
Dec 13 02:01:01.055000 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'
Dec 13 02:01:01.058230 systemd[1]: Starting lvm2-activation-early.service...
Dec 13 02:01:01.171774 systemd-networkd[1172]: lo: Link UP
Dec 13 02:01:01.171784 systemd-networkd[1172]: lo: Gained carrier
Dec 13 02:01:01.172495 systemd-networkd[1172]: Enumeration completed
Dec 13 02:01:01.172697 systemd[1]: Started systemd-networkd.service.
Dec 13 02:01:01.174000 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'
Dec 13 02:01:01.176470 systemd[1]: Starting systemd-networkd-wait-online.service...
Dec 13 02:01:01.203310 systemd-networkd[1172]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
Dec 13 02:01:01.237027 kernel: mlx5_core 5481:00:02.0 enP21633s1: Link up
Dec 13 02:01:01.260526 kernel: hv_netvsc 7c1e5277-09d4-7c1e-5277-09d47c1e5277 eth0: Data path switched to VF: enP21633s1
Dec 13 02:01:01.260401 systemd-networkd[1172]: enP21633s1: Link UP
Dec 13 02:01:01.260556 systemd-networkd[1172]: eth0: Link UP
Dec 13 02:01:01.260562 systemd-networkd[1172]: eth0: Gained carrier
Dec 13 02:01:01.265556 systemd-networkd[1172]: enP21633s1: Gained carrier
Dec 13 02:01:01.293141 systemd-networkd[1172]: eth0: DHCPv4 address 10.200.8.10/24, gateway 10.200.8.1 acquired from 168.63.129.16
Dec 13 02:01:01.668018 lvm[1234]:   WARNING: Failed to connect to lvmetad. Falling back to device scanning.
Dec 13 02:01:01.696306 systemd[1]: Finished lvm2-activation-early.service.
Dec 13 02:01:01.698000 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'
Dec 13 02:01:01.699395 systemd[1]: Reached target cryptsetup.target.
Dec 13 02:01:01.703346 systemd[1]: Starting lvm2-activation.service...
Dec 13 02:01:01.710191 lvm[1236]:   WARNING: Failed to connect to lvmetad. Falling back to device scanning.
Dec 13 02:01:01.730143 systemd[1]: Finished lvm2-activation.service.
Dec 13 02:01:01.731000 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'
Dec 13 02:01:01.732892 systemd[1]: Reached target local-fs-pre.target.
Dec 13 02:01:01.735493 systemd[1]: var-lib-machines.mount was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw).
Dec 13 02:01:01.735529 systemd[1]: Reached target local-fs.target.
Dec 13 02:01:01.738129 systemd[1]: Reached target machines.target.
Dec 13 02:01:01.741834 systemd[1]: Starting ldconfig.service...
Dec 13 02:01:01.744506 systemd[1]: systemd-binfmt.service was skipped because no trigger condition checks were met.
Dec 13 02:01:01.744625 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).
Dec 13 02:01:01.745940 systemd[1]: Starting systemd-boot-update.service...
Dec 13 02:01:01.749537 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service...
Dec 13 02:01:01.753496 systemd[1]: Starting systemd-machine-id-commit.service...
Dec 13 02:01:01.756058 systemd[1]: systemd-sysext.service was skipped because no trigger condition checks were met.
Dec 13 02:01:01.756152 systemd[1]: ensure-sysext.service was skipped because no trigger condition checks were met.
Dec 13 02:01:01.757269 systemd[1]: Starting systemd-tmpfiles-setup.service...
Dec 13 02:01:01.770515 systemd-tmpfiles[1241]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring.
Dec 13 02:01:01.805727 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
Dec 13 02:01:01.806462 systemd[1]: Finished systemd-machine-id-commit.service.
Dec 13 02:01:01.809000 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'
Dec 13 02:01:01.810686 systemd[1]: boot.automount: Got automount request for /boot, triggered by 1238 (bootctl)
Dec 13 02:01:01.811844 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service...
Dec 13 02:01:01.816116 systemd-tmpfiles[1241]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring.
Dec 13 02:01:01.829113 systemd-tmpfiles[1241]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring.
Dec 13 02:01:01.852320 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service.
Dec 13 02:01:01.851000 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'
Dec 13 02:01:02.351180 systemd-networkd[1172]: eth0: Gained IPv6LL
Dec 13 02:01:02.356937 systemd[1]: Finished systemd-networkd-wait-online.service.
Dec 13 02:01:02.359000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-networkd-wait-online comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Dec 13 02:01:03.040297 systemd-fsck[1246]: fsck.fat 4.2 (2021-01-31)
Dec 13 02:01:03.040297 systemd-fsck[1246]: /dev/sda1: 789 files, 119291/258078 clusters
Dec 13 02:01:03.042857 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service.
Dec 13 02:01:03.063453 kernel: kauditd_printk_skb: 83 callbacks suppressed
Dec 13 02:01:03.063543 kernel: audit: type=1130 audit(1734055263.045:167): 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'
Dec 13 02:01:03.045000 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'
Dec 13 02:01:03.047420 systemd[1]: Mounting boot.mount...
Dec 13 02:01:03.067243 systemd[1]: Mounted boot.mount.
Dec 13 02:01:03.082359 systemd[1]: Finished systemd-boot-update.service.
Dec 13 02:01:03.096117 kernel: audit: type=1130 audit(1734055263.084:168): 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'
Dec 13 02:01:03.084000 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'
Dec 13 02:01:03.223537 systemd[1]: Finished systemd-tmpfiles-setup.service.
Dec 13 02:01:03.226000 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'
Dec 13 02:01:03.228337 systemd[1]: Starting audit-rules.service...
Dec 13 02:01:03.239047 kernel: audit: type=1130 audit(1734055263.226:169): 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'
Dec 13 02:01:03.241551 systemd[1]: Starting clean-ca-certificates.service...
Dec 13 02:01:03.245242 systemd[1]: Starting systemd-journal-catalog-update.service...
Dec 13 02:01:03.247000 audit: BPF prog-id=30 op=LOAD
Dec 13 02:01:03.249729 systemd[1]: Starting systemd-resolved.service...
Dec 13 02:01:03.253042 kernel: audit: type=1334 audit(1734055263.247:170): prog-id=30 op=LOAD
Dec 13 02:01:03.254000 audit: BPF prog-id=31 op=LOAD
Dec 13 02:01:03.256251 systemd[1]: Starting systemd-timesyncd.service...
Dec 13 02:01:03.260027 kernel: audit: type=1334 audit(1734055263.254:171): prog-id=31 op=LOAD
Dec 13 02:01:03.262057 systemd[1]: Starting systemd-update-utmp.service...
Dec 13 02:01:03.351000 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'
Dec 13 02:01:03.349532 systemd[1]: Finished clean-ca-certificates.service.
Dec 13 02:01:03.358918 systemd[1]: update-ca-certificates.service was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt).
Dec 13 02:01:03.360527 systemd[1]: Finished systemd-update-utmp.service.
Dec 13 02:01:03.383658 kernel: audit: type=1130 audit(1734055263.351:172): 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'
Dec 13 02:01:03.383743 kernel: audit: type=1127 audit(1734055263.356:173): pid=1258 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'
Dec 13 02:01:03.356000 audit[1258]: SYSTEM_BOOT pid=1258 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'
Dec 13 02:01:03.382000 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'
Dec 13 02:01:03.395390 kernel: audit: type=1130 audit(1734055263.382:174): 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'
Dec 13 02:01:03.395581 systemd[1]: Started systemd-timesyncd.service.
Dec 13 02:01:03.396000 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'
Dec 13 02:01:03.398809 systemd[1]: Reached target time-set.target.
Dec 13 02:01:03.411830 kernel: audit: type=1130 audit(1734055263.396:175): 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'
Dec 13 02:01:03.480181 systemd-resolved[1256]: Positive Trust Anchors:
Dec 13 02:01:03.480197 systemd-resolved[1256]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
Dec 13 02:01:03.480236 systemd-resolved[1256]: 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
Dec 13 02:01:03.545606 systemd[1]: Finished systemd-journal-catalog-update.service.
Dec 13 02:01:03.547000 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'
Dec 13 02:01:03.566804 kernel: audit: type=1130 audit(1734055263.547:176): 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'
Dec 13 02:01:03.637927 systemd-resolved[1256]: Using system hostname 'ci-3510.3.6-a-51ae78fa62'.
Dec 13 02:01:03.639812 systemd[1]: Started systemd-resolved.service.
Dec 13 02:01:03.642000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Dec 13 02:01:03.643298 systemd[1]: Reached target network.target.
Dec 13 02:01:03.646969 systemd[1]: Reached target network-online.target.
Dec 13 02:01:03.649796 systemd[1]: Reached target nss-lookup.target.
Dec 13 02:01:03.671989 systemd-timesyncd[1257]: Contacted time server 85.91.1.180:123 (0.flatcar.pool.ntp.org).
Dec 13 02:01:03.672189 systemd-timesyncd[1257]: Initial clock synchronization to Fri 2024-12-13 02:01:03.672976 UTC.
Dec 13 02:01:03.756000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1
Dec 13 02:01:03.756000 audit[1273]: SYSCALL arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7ffe405a8960 a2=420 a3=0 items=0 ppid=1252 pid=1273 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)
Dec 13 02:01:03.756000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573
Dec 13 02:01:03.757777 augenrules[1273]: No rules
Dec 13 02:01:03.758566 systemd[1]: Finished audit-rules.service.
Dec 13 02:01:11.086792 ldconfig[1237]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start.
Dec 13 02:01:11.108022 systemd[1]: Finished ldconfig.service.
Dec 13 02:01:11.112419 systemd[1]: Starting systemd-update-done.service...
Dec 13 02:01:11.132735 systemd[1]: Finished systemd-update-done.service.
Dec 13 02:01:11.136017 systemd[1]: Reached target sysinit.target.
Dec 13 02:01:11.138158 systemd[1]: Started motdgen.path.
Dec 13 02:01:11.140138 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path.
Dec 13 02:01:11.143220 systemd[1]: Started logrotate.timer.
Dec 13 02:01:11.145106 systemd[1]: Started mdadm.timer.
Dec 13 02:01:11.146884 systemd[1]: Started systemd-tmpfiles-clean.timer.
Dec 13 02:01:11.149079 systemd[1]: update-engine-stub.timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate).
Dec 13 02:01:11.149129 systemd[1]: Reached target paths.target.
Dec 13 02:01:11.150971 systemd[1]: Reached target timers.target.
Dec 13 02:01:11.153308 systemd[1]: Listening on dbus.socket.
Dec 13 02:01:11.156208 systemd[1]: Starting docker.socket...
Dec 13 02:01:11.160167 systemd[1]: Listening on sshd.socket.
Dec 13 02:01:11.162328 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).
Dec 13 02:01:11.162758 systemd[1]: Listening on docker.socket.
Dec 13 02:01:11.164652 systemd[1]: Reached target sockets.target.
Dec 13 02:01:11.166864 systemd[1]: Reached target basic.target.
Dec 13 02:01:11.168739 systemd[1]: addon-config@usr-share-oem.service was skipped because no trigger condition checks were met.
Dec 13 02:01:11.168774 systemd[1]: addon-run@usr-share-oem.service was skipped because no trigger condition checks were met.
Dec 13 02:01:11.169726 systemd[1]: Starting containerd.service...
Dec 13 02:01:11.173643 systemd[1]: Starting dbus.service...
Dec 13 02:01:11.176239 systemd[1]: Starting enable-oem-cloudinit.service...
Dec 13 02:01:11.179554 systemd[1]: Starting extend-filesystems.service...
Dec 13 02:01:11.182144 systemd[1]: flatcar-setup-environment.service was skipped because of an unmet condition check (ConditionPathExists=/usr/share/oem/bin/flatcar-setup-environment).
Dec 13 02:01:11.183360 systemd[1]: Starting motdgen.service...
Dec 13 02:01:11.186573 systemd[1]: Started nvidia.service.
Dec 13 02:01:11.190550 systemd[1]: Starting ssh-key-proc-cmdline.service...
Dec 13 02:01:11.194372 systemd[1]: Starting sshd-keygen.service...
Dec 13 02:01:11.199631 systemd[1]: Starting systemd-logind.service...
Dec 13 02:01:11.205268 systemd[1]: systemd-pcrphase.service was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/StubPcrKernelImage-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f).
Dec 13 02:01:11.205355 systemd[1]: tcsd.service was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0).
Dec 13 02:01:11.205859 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details.
Dec 13 02:01:11.206726 systemd[1]: Starting update-engine.service...
Dec 13 02:01:11.212086 systemd[1]: Starting update-ssh-keys-after-ignition.service...
Dec 13 02:01:11.216561 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully.
Dec 13 02:01:11.216807 systemd[1]: Finished ssh-key-proc-cmdline.service.
Dec 13 02:01:11.228718 jq[1299]: false
Dec 13 02:01:11.229375 jq[1283]: true
Dec 13 02:01:11.230572 systemd[1]: update-ssh-keys-after-ignition.service: Skipped due to 'exec-condition'.
Dec 13 02:01:11.230795 systemd[1]: Condition check resulted in update-ssh-keys-after-ignition.service being skipped.
Dec 13 02:01:11.247568 extend-filesystems[1284]: Found sda
Dec 13 02:01:11.249888 extend-filesystems[1284]: Found sda1
Dec 13 02:01:11.249888 extend-filesystems[1284]: Found sda2
Dec 13 02:01:11.249888 extend-filesystems[1284]: Found sda3
Dec 13 02:01:11.249888 extend-filesystems[1284]: Found usr
Dec 13 02:01:11.249888 extend-filesystems[1284]: Found sda4
Dec 13 02:01:11.249888 extend-filesystems[1284]: Found sda6
Dec 13 02:01:11.249888 extend-filesystems[1284]: Found sda7
Dec 13 02:01:11.249888 extend-filesystems[1284]: Found sda9
Dec 13 02:01:11.249888 extend-filesystems[1284]: Checking size of /dev/sda9
Dec 13 02:01:11.280313 jq[1302]: true
Dec 13 02:01:11.280957 systemd[1]: motdgen.service: Deactivated successfully.
Dec 13 02:01:11.281140 systemd[1]: Finished motdgen.service.
Dec 13 02:01:11.322935 extend-filesystems[1284]: Old size kept for /dev/sda9
Dec 13 02:01:11.326938 extend-filesystems[1284]: Found sr0
Dec 13 02:01:11.328661 systemd[1]: extend-filesystems.service: Deactivated successfully.
Dec 13 02:01:11.328839 systemd[1]: Finished extend-filesystems.service.
Dec 13 02:01:11.348829 systemd-logind[1293]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)
Dec 13 02:01:11.350642 systemd-logind[1293]: New seat seat0.
Dec 13 02:01:11.386035 env[1309]: time="2024-12-13T02:01:11.385542800Z" level=info msg="starting containerd" revision=92b3a9d6f1b3bcc6dc74875cfdea653fe39f09c2 version=1.6.16
Dec 13 02:01:11.390261 systemctl[1307]: Created symlink /etc/systemd/system/multi-user.target.wants/oem-cloudinit.service → /usr/lib/systemd/system/oem-cloudinit.service.
Dec 13 02:01:11.390313 systemd[1]: Reloading.
Dec 13 02:01:11.435764 env[1309]: time="2024-12-13T02:01:11.435714074Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1
Dec 13 02:01:11.435954 env[1309]: time="2024-12-13T02:01:11.435929784Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1
Dec 13 02:01:11.447488 env[1309]: time="2024-12-13T02:01:11.447280121Z" 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.173-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1
Dec 13 02:01:11.447488 env[1309]: time="2024-12-13T02:01:11.447319223Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1
Dec 13 02:01:11.447641 env[1309]: time="2024-12-13T02:01:11.447600736Z" 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
Dec 13 02:01:11.447641 env[1309]: time="2024-12-13T02:01:11.447625737Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1
Dec 13 02:01:11.447723 env[1309]: time="2024-12-13T02:01:11.447644738Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured"
Dec 13 02:01:11.447723 env[1309]: time="2024-12-13T02:01:11.447660139Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1
Dec 13 02:01:11.447796 env[1309]: time="2024-12-13T02:01:11.447759944Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1
Dec 13 02:01:11.448068 env[1309]: time="2024-12-13T02:01:11.448040857Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1
Dec 13 02:01:11.448266 env[1309]: time="2024-12-13T02:01:11.448240067Z" 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
Dec 13 02:01:11.448323 env[1309]: time="2024-12-13T02:01:11.448269668Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1
Dec 13 02:01:11.448367 env[1309]: time="2024-12-13T02:01:11.448340971Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured"
Dec 13 02:01:11.448367 env[1309]: time="2024-12-13T02:01:11.448359072Z" level=info msg="metadata content store policy set" policy=shared
Dec 13 02:01:11.480552 env[1309]: time="2024-12-13T02:01:11.479145429Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1
Dec 13 02:01:11.480552 env[1309]: time="2024-12-13T02:01:11.479236833Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1
Dec 13 02:01:11.480552 env[1309]: time="2024-12-13T02:01:11.479276535Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1
Dec 13 02:01:11.480552 env[1309]: time="2024-12-13T02:01:11.479377040Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1
Dec 13 02:01:11.480552 env[1309]: time="2024-12-13T02:01:11.479412641Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1
Dec 13 02:01:11.480552 env[1309]: time="2024-12-13T02:01:11.479432842Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1
Dec 13 02:01:11.480552 env[1309]: time="2024-12-13T02:01:11.479450743Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1
Dec 13 02:01:11.480552 env[1309]: time="2024-12-13T02:01:11.479469744Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1
Dec 13 02:01:11.480552 env[1309]: time="2024-12-13T02:01:11.479498346Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1
Dec 13 02:01:11.480552 env[1309]: time="2024-12-13T02:01:11.479520547Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1
Dec 13 02:01:11.480552 env[1309]: time="2024-12-13T02:01:11.479540248Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1
Dec 13 02:01:11.480552 env[1309]: time="2024-12-13T02:01:11.479571449Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1
Dec 13 02:01:11.480552 env[1309]: time="2024-12-13T02:01:11.479740157Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2
Dec 13 02:01:11.480552 env[1309]: time="2024-12-13T02:01:11.479847562Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1
Dec 13 02:01:11.481179 env[1309]: time="2024-12-13T02:01:11.480301184Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1
Dec 13 02:01:11.481179 env[1309]: time="2024-12-13T02:01:11.480366487Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1
Dec 13 02:01:11.481179 env[1309]: time="2024-12-13T02:01:11.480388688Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1
Dec 13 02:01:11.486082 env[1309]: time="2024-12-13T02:01:11.481302631Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1
Dec 13 02:01:11.486082 env[1309]: time="2024-12-13T02:01:11.481339433Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1
Dec 13 02:01:11.486082 env[1309]: time="2024-12-13T02:01:11.481373334Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1
Dec 13 02:01:11.486082 env[1309]: time="2024-12-13T02:01:11.481392635Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1
Dec 13 02:01:11.486082 env[1309]: time="2024-12-13T02:01:11.481409836Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1
Dec 13 02:01:11.486082 env[1309]: time="2024-12-13T02:01:11.481426937Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1
Dec 13 02:01:11.486082 env[1309]: time="2024-12-13T02:01:11.481456338Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1
Dec 13 02:01:11.486082 env[1309]: time="2024-12-13T02:01:11.481474739Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1
Dec 13 02:01:11.486082 env[1309]: time="2024-12-13T02:01:11.481504540Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1
Dec 13 02:01:11.486082 env[1309]: time="2024-12-13T02:01:11.481721551Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1
Dec 13 02:01:11.486082 env[1309]: time="2024-12-13T02:01:11.481743952Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1
Dec 13 02:01:11.486082 env[1309]: time="2024-12-13T02:01:11.481773853Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1
Dec 13 02:01:11.486082 env[1309]: time="2024-12-13T02:01:11.481790454Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1
Dec 13 02:01:11.486082 env[1309]: time="2024-12-13T02:01:11.481810655Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="no OpenTelemetry endpoint: skip plugin" type=io.containerd.tracing.processor.v1
Dec 13 02:01:11.486649 env[1309]: time="2024-12-13T02:01:11.481827356Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1
Dec 13 02:01:11.486649 env[1309]: time="2024-12-13T02:01:11.481861857Z" level=error msg="failed to initialize a tracing processor \"otlp\"" error="no OpenTelemetry endpoint: skip plugin"
Dec 13 02:01:11.486649 env[1309]: time="2024-12-13T02:01:11.481907360Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1
Dec 13 02:01:11.486793 env[1309]: time="2024-12-13T02:01:11.482248876Z" 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}"
Dec 13 02:01:11.486793 env[1309]: time="2024-12-13T02:01:11.482378982Z" level=info msg="Connect containerd service"
Dec 13 02:01:11.486793 env[1309]: time="2024-12-13T02:01:11.482440185Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\""
Dec 13 02:01:11.486793 env[1309]: time="2024-12-13T02:01:11.483412031Z" 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"
Dec 13 02:01:11.538268 env[1309]: time="2024-12-13T02:01:11.491991337Z" level=info msg="Start subscribing containerd event"
Dec 13 02:01:11.538268 env[1309]: time="2024-12-13T02:01:11.492736172Z" level=info msg="Start recovering state"
Dec 13 02:01:11.538268 env[1309]: time="2024-12-13T02:01:11.493550410Z" level=info msg="Start event monitor"
Dec 13 02:01:11.538268 env[1309]: time="2024-12-13T02:01:11.493876226Z" level=info msg="Start snapshots syncer"
Dec 13 02:01:11.538268 env[1309]: time="2024-12-13T02:01:11.493896427Z" level=info msg="Start cni network conf syncer for default"
Dec 13 02:01:11.538268 env[1309]: time="2024-12-13T02:01:11.493909027Z" level=info msg="Start streaming server"
Dec 13 02:01:11.538268 env[1309]: time="2024-12-13T02:01:11.494601860Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc
Dec 13 02:01:11.538268 env[1309]: time="2024-12-13T02:01:11.494762768Z" level=info msg=serving... address=/run/containerd/containerd.sock
Dec 13 02:01:11.538268 env[1309]: time="2024-12-13T02:01:11.500358833Z" level=info msg="containerd successfully booted in 0.115598s"
Dec 13 02:01:11.527412 /usr/lib/systemd/system-generators/torcx-generator[1359]: time="2024-12-13T02:01:11Z" 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.6 /usr/share/oem/torcx/store /var/lib/torcx/store/3510.3.6 /var/lib/torcx/store]"
Dec 13 02:01:11.527440 /usr/lib/systemd/system-generators/torcx-generator[1359]: time="2024-12-13T02:01:11Z" level=info msg="torcx already run"
Dec 13 02:01:11.541673 dbus-daemon[1282]: [system] SELinux support is enabled
Dec 13 02:01:11.705269 systemd[1]: /usr/lib/systemd/system/locksmithd.service:8: Unit uses CPUShares=; please use CPUWeight= instead. Support for CPUShares= will be removed soon.
Dec 13 02:01:11.705291 systemd[1]: /usr/lib/systemd/system/locksmithd.service:9: Unit uses MemoryLimit=; please use MemoryMax= instead. Support for MemoryLimit= will be removed soon.
Dec 13 02:01:11.736569 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.
Dec 13 02:01:11.863991 systemd[1]: Started containerd.service.
Dec 13 02:01:11.866386 systemd[1]: Started dbus.service.
Dec 13 02:01:11.871127 systemd[1]: nvidia.service: Deactivated successfully.
Dec 13 02:01:11.877987 dbus-daemon[1282]: [system] Successfully activated service 'org.freedesktop.systemd1'
Dec 13 02:01:11.895923 systemd[1]: Started systemd-logind.service.
Dec 13 02:01:11.904204 systemd[1]: Starting oem-cloudinit.service...
Dec 13 02:01:11.906543 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).
Dec 13 02:01:11.907041 systemd[1]: Reached target system-config.target.
Dec 13 02:01:11.909555 bash[1449]: + OEMS=(aws gcp rackspace-onmetal azure cloudsigma packet vmware digitalocean openstack)
Dec 13 02:01:11.909804 bash[1452]: + grep -q -x -F azure
Dec 13 02:01:11.909977 bash[1451]: + tr ' ' '
Dec 13 02:01:11.909977 bash[1451]: '
Dec 13 02:01:11.910693 systemd[1]: user-cloudinit-proc-cmdline.service was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url).
Dec 13 02:01:11.913087 bash[1450]: + echo aws gcp rackspace-onmetal azure cloudsigma packet vmware digitalocean openstack
Dec 13 02:01:11.911161 systemd[1]: Reached target user-config.target.
Dec 13 02:01:11.989520 bash[1454]: ++ '[' azure = aws -o azure = openstack ']'
Dec 13 02:01:11.989775 bash[1454]: ++ '[' azure = gcp ']'
Dec 13 02:01:11.989775 bash[1454]: ++ echo azure
Dec 13 02:01:11.989854 bash[1453]: + /usr/bin/coreos-cloudinit --oem=azure
Dec 13 02:01:12.021858 sshd_keygen[1298]: ssh-keygen: generating new host keys: RSA ECDSA ED25519
Dec 13 02:01:12.041261 systemd[1]: Finished sshd-keygen.service.
Dec 13 02:01:12.045870 systemd[1]: Starting issuegen.service...
Dec 13 02:01:12.049418 systemd[1]: Started waagent.service.
Dec 13 02:01:12.052719 systemd[1]: issuegen.service: Deactivated successfully.
Dec 13 02:01:12.052953 systemd[1]: Finished issuegen.service.
Dec 13 02:01:12.056965 systemd[1]: Starting systemd-user-sessions.service...
Dec 13 02:01:12.064800 systemd[1]: Finished systemd-user-sessions.service.
Dec 13 02:01:12.068952 systemd[1]: Started getty@tty1.service.
Dec 13 02:01:12.072423 systemd[1]: Started serial-getty@ttyS0.service.
Dec 13 02:01:12.075131 systemd[1]: Reached target getty.target.
Dec 13 02:01:12.379298 update_engine[1297]: I1213 02:01:12.378993  1297 main.cc:92] Flatcar Update Engine starting
Dec 13 02:01:12.419289 systemd[1]: Started update-engine.service.
Dec 13 02:01:12.422642 update_engine[1297]: I1213 02:01:12.419329  1297 update_check_scheduler.cc:74] Next update check in 8m14s
Dec 13 02:01:12.425029 systemd[1]: Started locksmithd.service.
Dec 13 02:01:13.725187 locksmithd[1470]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot"
Dec 13 02:01:13.928305 bash[1453]: 2024/12/13 02:01:13 Checking availability of "waagent"
Dec 13 02:01:14.028651 bash[1453]: 2024/12/13 02:01:14 Checking availability of "waagent"
Dec 13 02:01:14.229044 bash[1453]: 2024/12/13 02:01:14 Checking availability of "waagent"
Dec 13 02:01:14.629711 bash[1453]: 2024/12/13 02:01:14 Checking availability of "waagent"
Dec 13 02:01:15.430769 bash[1453]: 2024/12/13 02:01:15 Checking availability of "waagent"
Dec 13 02:01:17.030894 bash[1453]: 2024/12/13 02:01:17 Checking availability of "waagent"
Dec 13 02:01:17.499164 login[1469]: pam_lastlog(login:session): file /var/log/lastlog is locked/read
Dec 13 02:01:17.499598 login[1468]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0)
Dec 13 02:01:17.522113 systemd[1]: Created slice user-500.slice.
Dec 13 02:01:17.524314 systemd[1]: Starting user-runtime-dir@500.service...
Dec 13 02:01:17.530188 systemd-logind[1293]: New session 1 of user core.
Dec 13 02:01:17.535849 systemd[1]: Finished user-runtime-dir@500.service.
Dec 13 02:01:17.537924 systemd[1]: Starting user@500.service...
Dec 13 02:01:17.572285 (systemd)[1480]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0)
Dec 13 02:01:17.794001 systemd[1480]: Queued start job for default target default.target.
Dec 13 02:01:17.794582 systemd[1480]: Reached target paths.target.
Dec 13 02:01:17.794611 systemd[1480]: Reached target sockets.target.
Dec 13 02:01:17.794628 systemd[1480]: Reached target timers.target.
Dec 13 02:01:17.794642 systemd[1480]: Reached target basic.target.
Dec 13 02:01:17.794759 systemd[1]: Started user@500.service.
Dec 13 02:01:17.796196 systemd[1]: Started session-1.scope.
Dec 13 02:01:17.797112 systemd[1480]: Reached target default.target.
Dec 13 02:01:17.797408 systemd[1480]: Startup finished in 217ms.
Dec 13 02:01:18.501586 login[1469]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0)
Dec 13 02:01:18.509302 systemd-logind[1293]: New session 2 of user core.
Dec 13 02:01:18.510851 systemd[1]: Started session-2.scope.
Dec 13 02:01:20.233208 bash[1453]: 2024/12/13 02:01:20 Checking availability of "waagent"
Dec 13 02:01:20.888834 waagent[1463]: 2024-12-13T02:01:20.888695Z INFO Daemon Daemon Azure Linux Agent Version:2.6.0.2
Dec 13 02:01:20.902166 waagent[1463]: 2024-12-13T02:01:20.890496Z INFO Daemon Daemon OS: flatcar 3510.3.6
Dec 13 02:01:20.902166 waagent[1463]: 2024-12-13T02:01:20.891858Z INFO Daemon Daemon Python: 3.9.16
Dec 13 02:01:20.902166 waagent[1463]: 2024-12-13T02:01:20.893092Z INFO Daemon Daemon Run daemon
Dec 13 02:01:20.902166 waagent[1463]: 2024-12-13T02:01:20.894376Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='3510.3.6'
Dec 13 02:01:20.907080 waagent[1463]: 2024-12-13T02:01:20.906949Z INFO Daemon Daemon Unable to get cloud-init enabled status from systemctl: Command '['systemctl', 'is-enabled', 'cloud-init-local.service']' returned non-zero exit status 1.
Dec 13 02:01:20.915052 waagent[1463]: 2024-12-13T02:01:20.914935Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service'
Dec 13 02:01:20.920138 waagent[1463]: 2024-12-13T02:01:20.920080Z INFO Daemon Daemon cloud-init is enabled: False
Dec 13 02:01:20.922938 waagent[1463]: 2024-12-13T02:01:20.922878Z INFO Daemon Daemon Using waagent for provisioning
Dec 13 02:01:20.926155 waagent[1463]: 2024-12-13T02:01:20.926096Z INFO Daemon Daemon Activate resource disk
Dec 13 02:01:20.928704 waagent[1463]: 2024-12-13T02:01:20.928647Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb
Dec 13 02:01:20.939078 waagent[1463]: 2024-12-13T02:01:20.939002Z INFO Daemon Daemon Found device: None
Dec 13 02:01:20.941804 waagent[1463]: 2024-12-13T02:01:20.941741Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology
Dec 13 02:01:20.946201 waagent[1463]: 2024-12-13T02:01:20.946142Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0
Dec 13 02:01:20.952448 waagent[1463]: 2024-12-13T02:01:20.952386Z INFO Daemon Daemon Clean protocol and wireserver endpoint
Dec 13 02:01:20.955608 waagent[1463]: 2024-12-13T02:01:20.955550Z INFO Daemon Daemon Running default provisioning handler
Dec 13 02:01:20.966227 waagent[1463]: 2024-12-13T02:01:20.966104Z INFO Daemon Daemon Unable to get cloud-init enabled status from systemctl: Command '['systemctl', 'is-enabled', 'cloud-init-local.service']' returned non-zero exit status 1.
Dec 13 02:01:20.974798 waagent[1463]: 2024-12-13T02:01:20.974697Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service'
Dec 13 02:01:20.988757 waagent[1463]: 2024-12-13T02:01:20.976839Z INFO Daemon Daemon cloud-init is enabled: False
Dec 13 02:01:20.988757 waagent[1463]: 2024-12-13T02:01:20.979238Z INFO Daemon Daemon Copying ovf-env.xml
Dec 13 02:01:21.000313 waagent[1463]: 2024-12-13T02:01:21.000197Z INFO Daemon Daemon Successfully mounted dvd
Dec 13 02:01:21.109317 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully.
Dec 13 02:01:21.165647 waagent[1463]: 2024-12-13T02:01:21.165036Z INFO Daemon Daemon Detect protocol endpoint
Dec 13 02:01:21.169216 waagent[1463]: 2024-12-13T02:01:21.167711Z INFO Daemon Daemon Clean protocol and wireserver endpoint
Dec 13 02:01:21.186538 waagent[1463]: 2024-12-13T02:01:21.170659Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler
Dec 13 02:01:21.186538 waagent[1463]: 2024-12-13T02:01:21.174614Z INFO Daemon Daemon Test for route to 168.63.129.16
Dec 13 02:01:21.186538 waagent[1463]: 2024-12-13T02:01:21.177460Z INFO Daemon Daemon Route to 168.63.129.16 exists
Dec 13 02:01:21.186538 waagent[1463]: 2024-12-13T02:01:21.179718Z INFO Daemon Daemon Wire server endpoint:168.63.129.16
Dec 13 02:01:21.337984 waagent[1463]: 2024-12-13T02:01:21.337902Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05
Dec 13 02:01:21.342163 waagent[1463]: 2024-12-13T02:01:21.342117Z INFO Daemon Daemon Wire protocol version:2012-11-30
Dec 13 02:01:21.344986 waagent[1463]: 2024-12-13T02:01:21.344926Z INFO Daemon Daemon Server preferred version:2015-04-05
Dec 13 02:01:21.844207 waagent[1463]: 2024-12-13T02:01:21.844048Z INFO Daemon Daemon Initializing goal state during protocol detection
Dec 13 02:01:21.855728 waagent[1463]: 2024-12-13T02:01:21.855646Z INFO Daemon Daemon Forcing an update of the goal state..
Dec 13 02:01:21.861802 waagent[1463]: 2024-12-13T02:01:21.856745Z INFO Daemon Daemon Fetching goal state [incarnation 1]
Dec 13 02:01:21.935457 waagent[1463]: 2024-12-13T02:01:21.935093Z INFO Daemon Daemon Found private key matching thumbprint 9E08183E41727E3CD405ED32F3B033586432FD63
Dec 13 02:01:21.940942 waagent[1463]: 2024-12-13T02:01:21.940852Z INFO Daemon Daemon Certificate with thumbprint AB80B715FC9616F05D26B76B658950F380D72A3C has no matching private key.
Dec 13 02:01:21.946365 waagent[1463]: 2024-12-13T02:01:21.946291Z INFO Daemon Daemon Fetch goal state completed
Dec 13 02:01:21.992220 waagent[1463]: 2024-12-13T02:01:21.992138Z INFO Daemon Daemon Fetched new vmSettings [correlation ID: dc436caf-70c4-40f8-959b-6fa29a7cc41c New eTag: 5122813921054221493]
Dec 13 02:01:21.997926 waagent[1463]: 2024-12-13T02:01:21.997860Z INFO Daemon Daemon Status Blob type 'None' is not valid, assuming BlockBlob
Dec 13 02:01:22.013836 waagent[1463]: 2024-12-13T02:01:22.013758Z INFO Daemon Daemon Starting provisioning
Dec 13 02:01:22.016741 waagent[1463]: 2024-12-13T02:01:22.016667Z INFO Daemon Daemon Handle ovf-env.xml.
Dec 13 02:01:22.019536 waagent[1463]: 2024-12-13T02:01:22.019471Z INFO Daemon Daemon Set hostname [ci-3510.3.6-a-51ae78fa62]
Dec 13 02:01:22.037561 waagent[1463]: 2024-12-13T02:01:22.037447Z INFO Daemon Daemon Publish hostname [ci-3510.3.6-a-51ae78fa62]
Dec 13 02:01:22.041454 waagent[1463]: 2024-12-13T02:01:22.041381Z INFO Daemon Daemon Examine /proc/net/route for primary interface
Dec 13 02:01:22.045319 waagent[1463]: 2024-12-13T02:01:22.045255Z INFO Daemon Daemon Primary interface is [eth0]
Dec 13 02:01:22.060342 systemd[1]: systemd-networkd-wait-online.service: Deactivated successfully.
Dec 13 02:01:22.060647 systemd[1]: Stopped systemd-networkd-wait-online.service.
Dec 13 02:01:22.060726 systemd[1]: Stopping systemd-networkd-wait-online.service...
Dec 13 02:01:22.061093 systemd[1]: Stopping systemd-networkd.service...
Dec 13 02:01:22.066062 systemd-networkd[1172]: eth0: DHCPv6 lease lost
Dec 13 02:01:22.067464 systemd[1]: systemd-networkd.service: Deactivated successfully.
Dec 13 02:01:22.067659 systemd[1]: Stopped systemd-networkd.service.
Dec 13 02:01:22.070912 systemd[1]: Starting systemd-networkd.service...
Dec 13 02:01:22.103416 systemd-networkd[1524]: enP21633s1: Link UP
Dec 13 02:01:22.103427 systemd-networkd[1524]: enP21633s1: Gained carrier
Dec 13 02:01:22.104793 systemd-networkd[1524]: eth0: Link UP
Dec 13 02:01:22.104796 systemd-networkd[1524]: eth0: Gained carrier
Dec 13 02:01:22.105194 systemd-networkd[1524]: lo: Link UP
Dec 13 02:01:22.105198 systemd-networkd[1524]: lo: Gained carrier
Dec 13 02:01:22.105452 systemd-networkd[1524]: eth0: Gained IPv6LL
Dec 13 02:01:22.106498 systemd-networkd[1524]: Enumeration completed
Dec 13 02:01:22.106604 systemd[1]: Started systemd-networkd.service.
Dec 13 02:01:22.117916 waagent[1463]: 2024-12-13T02:01:22.108550Z INFO Daemon Daemon Create user account if not exists
Dec 13 02:01:22.117916 waagent[1463]: 2024-12-13T02:01:22.112591Z INFO Daemon Daemon User core already exists, skip useradd
Dec 13 02:01:22.112315 systemd[1]: Starting systemd-networkd-wait-online.service...
Dec 13 02:01:22.119185 waagent[1463]: 2024-12-13T02:01:22.119087Z INFO Daemon Daemon Configure sudoer
Dec 13 02:01:22.124298 waagent[1463]: 2024-12-13T02:01:22.124211Z INFO Daemon Daemon Configure sshd
Dec 13 02:01:22.128244 waagent[1463]: 2024-12-13T02:01:22.128165Z INFO Daemon Daemon Deploy ssh public key.
Dec 13 02:01:22.128919 systemd-networkd[1524]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
Dec 13 02:01:22.163113 systemd-networkd[1524]: eth0: DHCPv4 address 10.200.8.10/24, gateway 10.200.8.1 acquired from 168.63.129.16
Dec 13 02:01:22.167503 systemd[1]: Finished systemd-networkd-wait-online.service.
Dec 13 02:01:23.307159 waagent[1463]: 2024-12-13T02:01:23.307036Z INFO Daemon Daemon Provisioning complete
Dec 13 02:01:23.321841 waagent[1463]: 2024-12-13T02:01:23.321752Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping
Dec 13 02:01:23.326265 waagent[1463]: 2024-12-13T02:01:23.323624Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions.
Dec 13 02:01:23.333878 waagent[1463]: 2024-12-13T02:01:23.328419Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.6.0.2 is the most current agent
Dec 13 02:01:23.617249 waagent[1533]: 2024-12-13T02:01:23.617078Z INFO ExtHandler ExtHandler Agent WALinuxAgent-2.6.0.2 is running as the goal state agent
Dec 13 02:01:23.617961 waagent[1533]: 2024-12-13T02:01:23.617896Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file
Dec 13 02:01:23.618125 waagent[1533]: 2024-12-13T02:01:23.618067Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16
Dec 13 02:01:23.630670 waagent[1533]: 2024-12-13T02:01:23.630575Z INFO ExtHandler ExtHandler Forcing an update of the goal state..
Dec 13 02:01:23.630879 waagent[1533]: 2024-12-13T02:01:23.630814Z INFO ExtHandler ExtHandler Fetching goal state [incarnation 1]
Dec 13 02:01:23.693912 waagent[1533]: 2024-12-13T02:01:23.693786Z INFO ExtHandler ExtHandler Found private key matching thumbprint 9E08183E41727E3CD405ED32F3B033586432FD63
Dec 13 02:01:23.694155 waagent[1533]: 2024-12-13T02:01:23.694093Z INFO ExtHandler ExtHandler Certificate with thumbprint AB80B715FC9616F05D26B76B658950F380D72A3C has no matching private key.
Dec 13 02:01:23.694389 waagent[1533]: 2024-12-13T02:01:23.694339Z INFO ExtHandler ExtHandler Fetch goal state completed
Dec 13 02:01:23.709042 waagent[1533]: 2024-12-13T02:01:23.708976Z INFO ExtHandler ExtHandler Fetched new vmSettings [correlation ID: 66cec8ff-a4bc-4f8e-9275-18a348c77e4a New eTag: 5122813921054221493]
Dec 13 02:01:23.712151 waagent[1533]: 2024-12-13T02:01:23.712087Z INFO ExtHandler ExtHandler Status Blob type 'None' is not valid, assuming BlockBlob
Dec 13 02:01:23.839857 waagent[1533]: 2024-12-13T02:01:23.839715Z INFO ExtHandler ExtHandler Distro: flatcar-3510.3.6; OSUtil: CoreOSUtil; AgentService: waagent; Python: 3.9.16; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.20.1;
Dec 13 02:01:23.858760 waagent[1533]: 2024-12-13T02:01:23.858670Z INFO ExtHandler ExtHandler WALinuxAgent-2.6.0.2 running as process 1533
Dec 13 02:01:23.862345 waagent[1533]: 2024-12-13T02:01:23.862277Z INFO ExtHandler ExtHandler Cgroup monitoring is not supported on ['flatcar', '3510.3.6', '', 'Flatcar Container Linux by Kinvolk']
Dec 13 02:01:23.863563 waagent[1533]: 2024-12-13T02:01:23.863505Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules
Dec 13 02:01:23.923540 waagent[1533]: 2024-12-13T02:01:23.923477Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service
Dec 13 02:01:23.923934 waagent[1533]: 2024-12-13T02:01:23.923870Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup
Dec 13 02:01:23.933989 waagent[1533]: 2024-12-13T02:01:23.933927Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now
Dec 13 02:01:23.934492 waagent[1533]: 2024-12-13T02:01:23.934432Z ERROR ExtHandler ExtHandler Unable to setup the persistent firewall rules: [Errno 30] Read-only file system: '/lib/systemd/system/waagent-network-setup.service'
Dec 13 02:01:23.935584 waagent[1533]: 2024-12-13T02:01:23.935519Z INFO ExtHandler ExtHandler Checking if log collection is allowed at this time [False]. All three conditions must be met: configuration enabled [False], cgroups enabled [False], python supported: [True]
Dec 13 02:01:23.936936 waagent[1533]: 2024-12-13T02:01:23.936877Z INFO ExtHandler ExtHandler Starting env monitor service.
Dec 13 02:01:23.937705 waagent[1533]: 2024-12-13T02:01:23.937647Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service.
Dec 13 02:01:23.937874 waagent[1533]: 2024-12-13T02:01:23.937821Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file
Dec 13 02:01:23.938376 waagent[1533]: 2024-12-13T02:01:23.938317Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread
Dec 13 02:01:23.938478 waagent[1533]: 2024-12-13T02:01:23.938420Z INFO ExtHandler ExtHandler Start Extension Telemetry service.
Dec 13 02:01:23.938775 waagent[1533]: 2024-12-13T02:01:23.938721Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file
Dec 13 02:01:23.939700 waagent[1533]: 2024-12-13T02:01:23.939639Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True
Dec 13 02:01:23.939898 waagent[1533]: 2024-12-13T02:01:23.939849Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16
Dec 13 02:01:23.940029 waagent[1533]: 2024-12-13T02:01:23.939962Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status.
Dec 13 02:01:23.940297 waagent[1533]: 2024-12-13T02:01:23.940247Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16
Dec 13 02:01:23.940721 waagent[1533]: 2024-12-13T02:01:23.940671Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread
Dec 13 02:01:23.941194 waagent[1533]: 2024-12-13T02:01:23.941137Z INFO EnvHandler ExtHandler Configure routes
Dec 13 02:01:23.941799 waagent[1533]: 2024-12-13T02:01:23.941745Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled.
Dec 13 02:01:23.942931 waagent[1533]: 2024-12-13T02:01:23.942871Z INFO EnvHandler ExtHandler Gateway:None
Dec 13 02:01:23.944576 waagent[1533]: 2024-12-13T02:01:23.944519Z INFO EnvHandler ExtHandler Routes:None
Dec 13 02:01:23.944701 waagent[1533]: 2024-12-13T02:01:23.944651Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route:
Dec 13 02:01:23.944701 waagent[1533]: Iface        Destination        Gateway         Flags        RefCnt        Use        Metric        Mask                MTU        Window        IRTT
Dec 13 02:01:23.944701 waagent[1533]: eth0        00000000        0108C80A        0003        0        0        1024        00000000        0        0        0
Dec 13 02:01:23.944701 waagent[1533]: eth0        0008C80A        00000000        0001        0        0        1024        00FFFFFF        0        0        0
Dec 13 02:01:23.944701 waagent[1533]: eth0        0108C80A        00000000        0005        0        0        1024        FFFFFFFF        0        0        0
Dec 13 02:01:23.944701 waagent[1533]: eth0        10813FA8        0108C80A        0007        0        0        1024        FFFFFFFF        0        0        0
Dec 13 02:01:23.944701 waagent[1533]: eth0        FEA9FEA9        0108C80A        0007        0        0        1024        FFFFFFFF        0        0        0
Dec 13 02:01:23.957463 waagent[1533]: 2024-12-13T02:01:23.957377Z INFO ExtHandler ExtHandler Checking for agent updates (family: Prod)
Dec 13 02:01:23.961825 waagent[1533]: 2024-12-13T02:01:23.961762Z WARNING ExtHandler ExtHandler Fetch failed: [HttpError] HTTPS is unavailable and required
Dec 13 02:01:23.962908 waagent[1533]: 2024-12-13T02:01:23.962848Z INFO ExtHandler ExtHandler [PERIODIC] Request failed using the direct channel. Error: 'NoneType' object has no attribute 'getheaders'
Dec 13 02:01:24.002714 waagent[1533]: 2024-12-13T02:01:24.002635Z INFO ExtHandler ExtHandler Default channel changed to HostGA channel.
Dec 13 02:01:24.052329 waagent[1533]: 2024-12-13T02:01:24.052250Z ERROR EnvHandler ExtHandler Failed to get the PID of the DHCP client: invalid literal for int() with base 10: 'MainPID=1524'
Dec 13 02:01:24.184110 waagent[1533]: 2024-12-13T02:01:24.183921Z INFO MonitorHandler ExtHandler Network interfaces:
Dec 13 02:01:24.184110 waagent[1533]: Executing ['ip', '-a', '-o', 'link']:
Dec 13 02:01:24.184110 waagent[1533]: 1: lo: <LOOPBACK,UP,LOWER_UP> mtu 65536 qdisc noqueue state UNKNOWN mode DEFAULT group default qlen 1000\    link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00
Dec 13 02:01:24.184110 waagent[1533]: 2: eth0: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\    link/ether 7c:1e:52:77:09:d4 brd ff:ff:ff:ff:ff:ff
Dec 13 02:01:24.184110 waagent[1533]: 3: enP21633s1: <BROADCAST,MULTICAST,SLAVE,UP,LOWER_UP> mtu 1500 qdisc mq master eth0 state UP mode DEFAULT group default qlen 1000\    link/ether 7c:1e:52:77:09:d4 brd ff:ff:ff:ff:ff:ff\    altname enP21633p0s2
Dec 13 02:01:24.184110 waagent[1533]: Executing ['ip', '-4', '-a', '-o', 'address']:
Dec 13 02:01:24.184110 waagent[1533]: 1: lo    inet 127.0.0.1/8 scope host lo\       valid_lft forever preferred_lft forever
Dec 13 02:01:24.184110 waagent[1533]: 2: eth0    inet 10.200.8.10/24 metric 1024 brd 10.200.8.255 scope global eth0\       valid_lft forever preferred_lft forever
Dec 13 02:01:24.184110 waagent[1533]: Executing ['ip', '-6', '-a', '-o', 'address']:
Dec 13 02:01:24.184110 waagent[1533]: 1: lo    inet6 ::1/128 scope host \       valid_lft forever preferred_lft forever
Dec 13 02:01:24.184110 waagent[1533]: 2: eth0    inet6 fe80::7e1e:52ff:fe77:9d4/64 scope link \       valid_lft forever preferred_lft forever
Dec 13 02:01:24.230326 waagent[1533]: 2024-12-13T02:01:24.230255Z INFO ExtHandler ExtHandler Agent WALinuxAgent-2.6.0.2 discovered update WALinuxAgent-2.12.0.2 -- exiting
Dec 13 02:01:24.336958 waagent[1463]: 2024-12-13T02:01:24.336817Z INFO Daemon Daemon Agent WALinuxAgent-2.6.0.2 launched with command '/usr/share/oem/python/bin/python -u /usr/share/oem/bin/waagent -run-exthandlers' is successfully running
Dec 13 02:01:24.342224 waagent[1463]: 2024-12-13T02:01:24.342154Z INFO Daemon Daemon Determined Agent WALinuxAgent-2.12.0.2 to be the latest agent
Dec 13 02:01:25.427353 waagent[1562]: 2024-12-13T02:01:25.427242Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.12.0.2)
Dec 13 02:01:25.428080 waagent[1562]: 2024-12-13T02:01:25.427996Z INFO ExtHandler ExtHandler OS: flatcar 3510.3.6
Dec 13 02:01:25.428235 waagent[1562]: 2024-12-13T02:01:25.428183Z INFO ExtHandler ExtHandler Python: 3.9.16
Dec 13 02:01:25.428377 waagent[1562]: 2024-12-13T02:01:25.428331Z INFO ExtHandler ExtHandler CPU Arch: x86_64
Dec 13 02:01:25.438091 waagent[1562]: 2024-12-13T02:01:25.437966Z INFO ExtHandler ExtHandler Distro: flatcar-3510.3.6; OSUtil: CoreOSUtil; AgentService: waagent; Python: 3.9.16; Arch: x86_64; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.20.1;
Dec 13 02:01:25.438480 waagent[1562]: 2024-12-13T02:01:25.438422Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file
Dec 13 02:01:25.438642 waagent[1562]: 2024-12-13T02:01:25.438593Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16
Dec 13 02:01:25.450424 waagent[1562]: 2024-12-13T02:01:25.450349Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1]
Dec 13 02:01:25.459298 waagent[1562]: 2024-12-13T02:01:25.459238Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.159
Dec 13 02:01:25.460235 waagent[1562]: 2024-12-13T02:01:25.460175Z INFO ExtHandler
Dec 13 02:01:25.460551 waagent[1562]: 2024-12-13T02:01:25.460466Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: 4e9faf22-ba05-4e40-b8df-109ecdfb044e eTag: 5122813921054221493 source: Fabric]
Dec 13 02:01:25.461480 waagent[1562]: 2024-12-13T02:01:25.461406Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them.
Dec 13 02:01:25.462803 waagent[1562]: 2024-12-13T02:01:25.462741Z INFO ExtHandler
Dec 13 02:01:25.462940 waagent[1562]: 2024-12-13T02:01:25.462889Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1]
Dec 13 02:01:25.469977 waagent[1562]: 2024-12-13T02:01:25.469922Z INFO ExtHandler ExtHandler Downloading artifacts profile blob
Dec 13 02:01:25.470412 waagent[1562]: 2024-12-13T02:01:25.470363Z WARNING ExtHandler ExtHandler Fetch failed: [HttpError] HTTPS is unavailable and required
Dec 13 02:01:25.492401 waagent[1562]: 2024-12-13T02:01:25.492297Z INFO ExtHandler ExtHandler Default channel changed to HostGAPlugin channel.
Dec 13 02:01:25.557542 waagent[1562]: 2024-12-13T02:01:25.557404Z INFO ExtHandler Downloaded certificate {'thumbprint': 'AB80B715FC9616F05D26B76B658950F380D72A3C', 'hasPrivateKey': False}
Dec 13 02:01:25.558564 waagent[1562]: 2024-12-13T02:01:25.558498Z INFO ExtHandler Downloaded certificate {'thumbprint': '9E08183E41727E3CD405ED32F3B033586432FD63', 'hasPrivateKey': True}
Dec 13 02:01:25.559540 waagent[1562]: 2024-12-13T02:01:25.559478Z INFO ExtHandler Fetch goal state completed
Dec 13 02:01:25.578982 waagent[1562]: 2024-12-13T02:01:25.578883Z INFO ExtHandler ExtHandler OpenSSL version: OpenSSL 3.0.15 3 Sep 2024 (Library: OpenSSL 3.0.15 3 Sep 2024)
Dec 13 02:01:25.590139 waagent[1562]: 2024-12-13T02:01:25.590056Z INFO ExtHandler ExtHandler WALinuxAgent-2.12.0.2 running as process 1562
Dec 13 02:01:25.593156 waagent[1562]: 2024-12-13T02:01:25.593093Z INFO ExtHandler ExtHandler [CGI] Cgroup monitoring is not supported on ['flatcar', '3510.3.6', '', 'Flatcar Container Linux by Kinvolk']
Dec 13 02:01:25.594096 waagent[1562]: 2024-12-13T02:01:25.594042Z INFO ExtHandler ExtHandler [CGI] Agent will reset the quotas in case distro: ['flatcar', '3510.3.6', '', 'Flatcar Container Linux by Kinvolk'] went from supported to unsupported
Dec 13 02:01:25.594361 waagent[1562]: 2024-12-13T02:01:25.594310Z INFO ExtHandler ExtHandler [CGI] Agent cgroups enabled: False
Dec 13 02:01:25.596282 waagent[1562]: 2024-12-13T02:01:25.596226Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules
Dec 13 02:01:25.600814 waagent[1562]: 2024-12-13T02:01:25.600761Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service
Dec 13 02:01:25.601205 waagent[1562]: 2024-12-13T02:01:25.601150Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup
Dec 13 02:01:25.608840 waagent[1562]: 2024-12-13T02:01:25.608786Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now
Dec 13 02:01:25.609281 waagent[1562]: 2024-12-13T02:01:25.609228Z ERROR ExtHandler ExtHandler Unable to setup the persistent firewall rules: [Errno 30] Read-only file system: '/lib/systemd/system/waagent-network-setup.service'
Dec 13 02:01:25.614899 waagent[1562]: 2024-12-13T02:01:25.614808Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up.
Dec 13 02:01:25.615872 waagent[1562]: 2024-12-13T02:01:25.615806Z INFO ExtHandler ExtHandler Checking if log collection is allowed at this time [False]. All three conditions must be met: 1. configuration enabled [True], 2. cgroups v1 enabled [False] OR cgroups v2 is in use and v2 resource limiting configuration enabled [False], 3. python supported: [True]
Dec 13 02:01:25.617263 waagent[1562]: 2024-12-13T02:01:25.617204Z INFO ExtHandler ExtHandler Starting env monitor service.
Dec 13 02:01:25.618208 waagent[1562]: 2024-12-13T02:01:25.618155Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file
Dec 13 02:01:25.618373 waagent[1562]: 2024-12-13T02:01:25.618324Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16
Dec 13 02:01:25.618881 waagent[1562]: 2024-12-13T02:01:25.618826Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled.
Dec 13 02:01:25.619351 waagent[1562]: 2024-12-13T02:01:25.619295Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service.
Dec 13 02:01:25.619641 waagent[1562]: 2024-12-13T02:01:25.619592Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route:
Dec 13 02:01:25.619641 waagent[1562]: Iface        Destination        Gateway         Flags        RefCnt        Use        Metric        Mask                MTU        Window        IRTT
Dec 13 02:01:25.619641 waagent[1562]: eth0        00000000        0108C80A        0003        0        0        1024        00000000        0        0        0
Dec 13 02:01:25.619641 waagent[1562]: eth0        0008C80A        00000000        0001        0        0        1024        00FFFFFF        0        0        0
Dec 13 02:01:25.619641 waagent[1562]: eth0        0108C80A        00000000        0005        0        0        1024        FFFFFFFF        0        0        0
Dec 13 02:01:25.619641 waagent[1562]: eth0        10813FA8        0108C80A        0007        0        0        1024        FFFFFFFF        0        0        0
Dec 13 02:01:25.619641 waagent[1562]: eth0        FEA9FEA9        0108C80A        0007        0        0        1024        FFFFFFFF        0        0        0
Dec 13 02:01:25.619921 waagent[1562]: 2024-12-13T02:01:25.619776Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file
Dec 13 02:01:25.619983 waagent[1562]: 2024-12-13T02:01:25.619932Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16
Dec 13 02:01:25.622805 waagent[1562]: 2024-12-13T02:01:25.622734Z INFO EnvHandler ExtHandler Configure routes
Dec 13 02:01:25.622967 waagent[1562]: 2024-12-13T02:01:25.622916Z INFO EnvHandler ExtHandler Gateway:None
Dec 13 02:01:25.623133 waagent[1562]: 2024-12-13T02:01:25.623087Z INFO EnvHandler ExtHandler Routes:None
Dec 13 02:01:25.624108 waagent[1562]: 2024-12-13T02:01:25.624050Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread
Dec 13 02:01:25.624394 waagent[1562]: 2024-12-13T02:01:25.624345Z INFO ExtHandler ExtHandler Start Extension Telemetry service.
Dec 13 02:01:25.629664 waagent[1562]: 2024-12-13T02:01:25.629549Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True
Dec 13 02:01:25.629934 waagent[1562]: 2024-12-13T02:01:25.629872Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread
Dec 13 02:01:25.636829 waagent[1562]: 2024-12-13T02:01:25.636537Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status.
Dec 13 02:01:25.648311 waagent[1562]: 2024-12-13T02:01:25.648217Z INFO MonitorHandler ExtHandler Network interfaces:
Dec 13 02:01:25.648311 waagent[1562]: Executing ['ip', '-a', '-o', 'link']:
Dec 13 02:01:25.648311 waagent[1562]: 1: lo: <LOOPBACK,UP,LOWER_UP> mtu 65536 qdisc noqueue state UNKNOWN mode DEFAULT group default qlen 1000\    link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00
Dec 13 02:01:25.648311 waagent[1562]: 2: eth0: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\    link/ether 7c:1e:52:77:09:d4 brd ff:ff:ff:ff:ff:ff
Dec 13 02:01:25.648311 waagent[1562]: 3: enP21633s1: <BROADCAST,MULTICAST,SLAVE,UP,LOWER_UP> mtu 1500 qdisc mq master eth0 state UP mode DEFAULT group default qlen 1000\    link/ether 7c:1e:52:77:09:d4 brd ff:ff:ff:ff:ff:ff\    altname enP21633p0s2
Dec 13 02:01:25.648311 waagent[1562]: Executing ['ip', '-4', '-a', '-o', 'address']:
Dec 13 02:01:25.648311 waagent[1562]: 1: lo    inet 127.0.0.1/8 scope host lo\       valid_lft forever preferred_lft forever
Dec 13 02:01:25.648311 waagent[1562]: 2: eth0    inet 10.200.8.10/24 metric 1024 brd 10.200.8.255 scope global eth0\       valid_lft forever preferred_lft forever
Dec 13 02:01:25.648311 waagent[1562]: Executing ['ip', '-6', '-a', '-o', 'address']:
Dec 13 02:01:25.648311 waagent[1562]: 1: lo    inet6 ::1/128 scope host \       valid_lft forever preferred_lft forever
Dec 13 02:01:25.648311 waagent[1562]: 2: eth0    inet6 fe80::7e1e:52ff:fe77:9d4/64 scope link \       valid_lft forever preferred_lft forever
Dec 13 02:01:25.654783 waagent[1562]: 2024-12-13T02:01:25.654727Z INFO ExtHandler ExtHandler Downloading agent manifest
Dec 13 02:01:25.692078 waagent[1562]: 2024-12-13T02:01:25.691938Z INFO ExtHandler ExtHandler
Dec 13 02:01:25.692200 waagent[1562]: 2024-12-13T02:01:25.692136Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: 0810a06b-b8aa-4412-8412-4c8548581b23 correlation 6007221f-3d00-43b9-a06f-9f8038e57e1f created: 2024-12-13T01:59:43.841446Z]
Dec 13 02:01:25.693220 waagent[1562]: 2024-12-13T02:01:25.693158Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything.
Dec 13 02:01:25.695083 waagent[1562]: 2024-12-13T02:01:25.695027Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 3 ms]
Dec 13 02:01:25.721099 waagent[1562]: 2024-12-13T02:01:25.721034Z INFO ExtHandler ExtHandler Looking for existing remote access users.
Dec 13 02:01:25.737288 waagent[1562]: 2024-12-13T02:01:25.737215Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.12.0.2 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: C7FEB7CC-03B0-45B1-80F7-A2F1BC1E5B48;DroppedPackets: 0;UpdateGSErrors: 0;AutoUpdate: 1;UpdateMode: SelfUpdate;]
Dec 13 02:01:25.831853 waagent[1562]: 2024-12-13T02:01:25.831732Z INFO EnvHandler ExtHandler Created firewall rules for the Azure Fabric:
Dec 13 02:01:25.831853 waagent[1562]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes)
Dec 13 02:01:25.831853 waagent[1562]:     pkts      bytes target     prot opt in     out     source               destination
Dec 13 02:01:25.831853 waagent[1562]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes)
Dec 13 02:01:25.831853 waagent[1562]:     pkts      bytes target     prot opt in     out     source               destination
Dec 13 02:01:25.831853 waagent[1562]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes)
Dec 13 02:01:25.831853 waagent[1562]:     pkts      bytes target     prot opt in     out     source               destination
Dec 13 02:01:25.831853 waagent[1562]:        0        0 ACCEPT     tcp  --  *      *       0.0.0.0/0            168.63.129.16        tcp dpt:53
Dec 13 02:01:25.831853 waagent[1562]:        0        0 ACCEPT     tcp  --  *      *       0.0.0.0/0            168.63.129.16        owner UID match 0
Dec 13 02:01:25.831853 waagent[1562]:        0        0 DROP       tcp  --  *      *       0.0.0.0/0            168.63.129.16        ctstate INVALID,NEW
Dec 13 02:01:25.839050 waagent[1562]: 2024-12-13T02:01:25.838925Z INFO EnvHandler ExtHandler Current Firewall rules:
Dec 13 02:01:25.839050 waagent[1562]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes)
Dec 13 02:01:25.839050 waagent[1562]:     pkts      bytes target     prot opt in     out     source               destination
Dec 13 02:01:25.839050 waagent[1562]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes)
Dec 13 02:01:25.839050 waagent[1562]:     pkts      bytes target     prot opt in     out     source               destination
Dec 13 02:01:25.839050 waagent[1562]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes)
Dec 13 02:01:25.839050 waagent[1562]:     pkts      bytes target     prot opt in     out     source               destination
Dec 13 02:01:25.839050 waagent[1562]:        0        0 ACCEPT     tcp  --  *      *       0.0.0.0/0            168.63.129.16        tcp dpt:53
Dec 13 02:01:25.839050 waagent[1562]:        0        0 ACCEPT     tcp  --  *      *       0.0.0.0/0            168.63.129.16        owner UID match 0
Dec 13 02:01:25.839050 waagent[1562]:        0        0 DROP       tcp  --  *      *       0.0.0.0/0            168.63.129.16        ctstate INVALID,NEW
Dec 13 02:01:25.839768 waagent[1562]: 2024-12-13T02:01:25.839711Z INFO EnvHandler ExtHandler Set block dev timeout: sda with timeout: 300
Dec 13 02:01:26.638786 bash[1453]: 2024/12/13 02:01:26 Checking availability of "waagent"
Dec 13 02:01:26.638786 bash[1453]: 2024/12/13 02:01:26 Fetching user-data from datasource of type "waagent"
Dec 13 02:01:26.638786 bash[1453]: 2024/12/13 02:01:26 Attempting to read from "/var/lib/waagent/CustomData"
Dec 13 02:01:26.639503 bash[1453]: 2024/12/13 02:01:26 Fetching meta-data from datasource of type "waagent"
Dec 13 02:01:26.639503 bash[1453]: 2024/12/13 02:01:26 Attempting to read from "/var/lib/waagent/SharedConfig.xml"
Dec 13 02:01:26.639503 bash[1453]: 2024/12/13 02:01:26 Merging cloud-config from meta-data and user-data
Dec 13 02:01:26.639503 bash[1453]: 2024/12/13 02:01:26 Writing file to "/etc/environment"
Dec 13 02:01:26.639759 bash[1453]: 2024/12/13 02:01:26 Wrote file to "/etc/environment"
Dec 13 02:01:26.639759 bash[1453]: 2024/12/13 02:01:26 Updated /etc/environment
Dec 13 02:01:26.639759 bash[1453]: 2024/12/13 02:01:26 Ensuring runtime unit file "etcd.service" is unmasked
Dec 13 02:01:26.639910 bash[1453]: 2024/12/13 02:01:26 Ensuring runtime unit file "etcd2.service" is unmasked
Dec 13 02:01:26.639910 bash[1453]: 2024/12/13 02:01:26 Ensuring runtime unit file "fleet.service" is unmasked
Dec 13 02:01:26.639910 bash[1453]: 2024/12/13 02:01:26 Ensuring runtime unit file "locksmithd.service" is unmasked
Dec 13 02:01:26.640685 systemd[1]: oem-cloudinit.service: Deactivated successfully.
Dec 13 02:01:26.640940 systemd[1]: Finished oem-cloudinit.service.
Dec 13 02:01:26.643307 systemd[1]: Finished enable-oem-cloudinit.service.
Dec 13 02:01:26.643774 systemd[1]: Reached target multi-user.target.
Dec 13 02:01:26.646020 systemd[1]: Starting systemd-update-utmp-runlevel.service...
Dec 13 02:01:26.652815 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully.
Dec 13 02:01:26.652987 systemd[1]: Finished systemd-update-utmp-runlevel.service.
Dec 13 02:01:26.653185 systemd[1]: Startup finished in 1.023s (firmware) + 27.166s (loader) + 996ms (kernel) + 15.385s (initrd) + 45.704s (userspace) = 1min 30.277s.
Dec 13 02:01:48.732150 kernel: hv_balloon: Max. dynamic memory size: 8192 MB
Dec 13 02:01:51.497747 systemd[1]: Created slice system-sshd.slice.
Dec 13 02:01:51.499435 systemd[1]: Started sshd@0-10.200.8.10:22-10.200.16.10:41218.service.
Dec 13 02:01:52.458624 sshd[1618]: Accepted publickey for core from 10.200.16.10 port 41218 ssh2: RSA SHA256:gXnTcda5xTHu03Chb+JqgZafruXVzN/4W1lBkFcVm+I
Dec 13 02:01:52.460258 sshd[1618]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Dec 13 02:01:52.464845 systemd-logind[1293]: New session 3 of user core.
Dec 13 02:01:52.465483 systemd[1]: Started session-3.scope.
Dec 13 02:01:53.000514 systemd[1]: Started sshd@1-10.200.8.10:22-10.200.16.10:41226.service.
Dec 13 02:01:53.622664 sshd[1623]: Accepted publickey for core from 10.200.16.10 port 41226 ssh2: RSA SHA256:gXnTcda5xTHu03Chb+JqgZafruXVzN/4W1lBkFcVm+I
Dec 13 02:01:53.624341 sshd[1623]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Dec 13 02:01:53.628956 systemd-logind[1293]: New session 4 of user core.
Dec 13 02:01:53.629623 systemd[1]: Started session-4.scope.
Dec 13 02:01:54.070476 sshd[1623]: pam_unix(sshd:session): session closed for user core
Dec 13 02:01:54.073461 systemd[1]: sshd@1-10.200.8.10:22-10.200.16.10:41226.service: Deactivated successfully.
Dec 13 02:01:54.074325 systemd[1]: session-4.scope: Deactivated successfully.
Dec 13 02:01:54.074923 systemd-logind[1293]: Session 4 logged out. Waiting for processes to exit.
Dec 13 02:01:54.075681 systemd-logind[1293]: Removed session 4.
Dec 13 02:01:54.174942 systemd[1]: Started sshd@2-10.200.8.10:22-10.200.16.10:41230.service.
Dec 13 02:01:54.797461 sshd[1629]: Accepted publickey for core from 10.200.16.10 port 41230 ssh2: RSA SHA256:gXnTcda5xTHu03Chb+JqgZafruXVzN/4W1lBkFcVm+I
Dec 13 02:01:54.798821 sshd[1629]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Dec 13 02:01:54.803491 systemd[1]: Started session-5.scope.
Dec 13 02:01:54.804104 systemd-logind[1293]: New session 5 of user core.
Dec 13 02:01:55.237583 sshd[1629]: pam_unix(sshd:session): session closed for user core
Dec 13 02:01:55.240884 systemd[1]: sshd@2-10.200.8.10:22-10.200.16.10:41230.service: Deactivated successfully.
Dec 13 02:01:55.241725 systemd[1]: session-5.scope: Deactivated successfully.
Dec 13 02:01:55.242354 systemd-logind[1293]: Session 5 logged out. Waiting for processes to exit.
Dec 13 02:01:55.243081 systemd-logind[1293]: Removed session 5.
Dec 13 02:01:55.344819 systemd[1]: Started sshd@3-10.200.8.10:22-10.200.16.10:41242.service.
Dec 13 02:01:55.967387 sshd[1635]: Accepted publickey for core from 10.200.16.10 port 41242 ssh2: RSA SHA256:gXnTcda5xTHu03Chb+JqgZafruXVzN/4W1lBkFcVm+I
Dec 13 02:01:55.968780 sshd[1635]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Dec 13 02:01:55.973525 systemd[1]: Started session-6.scope.
Dec 13 02:01:55.974382 systemd-logind[1293]: New session 6 of user core.
Dec 13 02:01:56.414156 sshd[1635]: pam_unix(sshd:session): session closed for user core
Dec 13 02:01:56.417423 systemd[1]: sshd@3-10.200.8.10:22-10.200.16.10:41242.service: Deactivated successfully.
Dec 13 02:01:56.418245 systemd[1]: session-6.scope: Deactivated successfully.
Dec 13 02:01:56.418860 systemd-logind[1293]: Session 6 logged out. Waiting for processes to exit.
Dec 13 02:01:56.419594 systemd-logind[1293]: Removed session 6.
Dec 13 02:01:56.518999 systemd[1]: Started sshd@4-10.200.8.10:22-10.200.16.10:41254.service.
Dec 13 02:01:57.141644 sshd[1641]: Accepted publickey for core from 10.200.16.10 port 41254 ssh2: RSA SHA256:gXnTcda5xTHu03Chb+JqgZafruXVzN/4W1lBkFcVm+I
Dec 13 02:01:57.143285 sshd[1641]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Dec 13 02:01:57.149095 systemd[1]: Started session-7.scope.
Dec 13 02:01:57.149825 systemd-logind[1293]: New session 7 of user core.
Dec 13 02:01:57.567498 update_engine[1297]: I1213 02:01:57.567343  1297 update_attempter.cc:509] Updating boot flags...
Dec 13 02:01:57.838536 sudo[1644]:     core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1
Dec 13 02:01:57.838838 sudo[1644]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500)
Dec 13 02:01:57.861251 dbus-daemon[1282]: \xd0\u074c\u000f\xbfU:  received setenforce notice (enforcing=423280000)
Dec 13 02:01:57.863141 sudo[1644]: pam_unix(sudo:session): session closed for user root
Dec 13 02:01:58.033838 sshd[1641]: pam_unix(sshd:session): session closed for user core
Dec 13 02:01:58.037511 systemd[1]: sshd@4-10.200.8.10:22-10.200.16.10:41254.service: Deactivated successfully.
Dec 13 02:01:58.038825 systemd-logind[1293]: Session 7 logged out. Waiting for processes to exit.
Dec 13 02:01:58.038920 systemd[1]: session-7.scope: Deactivated successfully.
Dec 13 02:01:58.040303 systemd-logind[1293]: Removed session 7.
Dec 13 02:01:58.138062 systemd[1]: Started sshd@5-10.200.8.10:22-10.200.16.10:41256.service.
Dec 13 02:01:58.761454 sshd[1687]: Accepted publickey for core from 10.200.16.10 port 41256 ssh2: RSA SHA256:gXnTcda5xTHu03Chb+JqgZafruXVzN/4W1lBkFcVm+I
Dec 13 02:01:58.763176 sshd[1687]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Dec 13 02:01:58.768774 systemd[1]: Started session-8.scope.
Dec 13 02:01:58.769382 systemd-logind[1293]: New session 8 of user core.
Dec 13 02:01:59.104883 sudo[1691]:     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
Dec 13 02:01:59.105544 sudo[1691]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500)
Dec 13 02:01:59.108437 sudo[1691]: pam_unix(sudo:session): session closed for user root
Dec 13 02:01:59.112883 sudo[1690]:     core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules
Dec 13 02:01:59.113168 sudo[1690]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500)
Dec 13 02:01:59.121672 systemd[1]: Stopping audit-rules.service...
Dec 13 02:01:59.122000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1
Dec 13 02:01:59.126303 kernel: kauditd_printk_skb: 4 callbacks suppressed
Dec 13 02:01:59.126360 kernel: audit: type=1305 audit(1734055319.122:179): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1
Dec 13 02:01:59.126549 auditctl[1694]: No rules
Dec 13 02:01:59.126972 systemd[1]: audit-rules.service: Deactivated successfully.
Dec 13 02:01:59.127141 systemd[1]: Stopped audit-rules.service.
Dec 13 02:01:59.128685 systemd[1]: Starting audit-rules.service...
Dec 13 02:01:59.122000 audit[1694]: SYSCALL arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7ffed53034f0 a2=420 a3=0 items=0 ppid=1 pid=1694 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)
Dec 13 02:01:59.150330 augenrules[1711]: No rules
Dec 13 02:01:59.150580 kernel: audit: type=1300 audit(1734055319.122:179): arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7ffed53034f0 a2=420 a3=0 items=0 ppid=1 pid=1694 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)
Dec 13 02:01:59.150627 kernel: audit: type=1327 audit(1734055319.122:179): proctitle=2F7362696E2F617564697463746C002D44
Dec 13 02:01:59.122000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D44
Dec 13 02:01:59.151277 systemd[1]: Finished audit-rules.service.
Dec 13 02:01:59.153518 sudo[1690]: pam_unix(sudo:session): session closed for user root
Dec 13 02:01:59.125000 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'
Dec 13 02:01:59.165963 kernel: audit: type=1131 audit(1734055319.125:180): 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'
Dec 13 02:01:59.149000 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'
Dec 13 02:01:59.177024 kernel: audit: type=1130 audit(1734055319.149:181): 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'
Dec 13 02:01:59.149000 audit[1690]: USER_END pid=1690 uid=500 auid=500 ses=8 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'
Dec 13 02:01:59.201063 kernel: audit: type=1106 audit(1734055319.149:182): pid=1690 uid=500 auid=500 ses=8 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'
Dec 13 02:01:59.201151 kernel: audit: type=1104 audit(1734055319.149:183): pid=1690 uid=500 auid=500 ses=8 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'
Dec 13 02:01:59.149000 audit[1690]: CRED_DISP pid=1690 uid=500 auid=500 ses=8 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'
Dec 13 02:01:59.257915 sshd[1687]: pam_unix(sshd:session): session closed for user core
Dec 13 02:01:59.258000 audit[1687]: USER_END pid=1687 uid=0 auid=500 ses=8 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.200.16.10 addr=10.200.16.10 terminal=ssh res=success'
Dec 13 02:01:59.261468 systemd-logind[1293]: Session 8 logged out. Waiting for processes to exit.
Dec 13 02:01:59.262721 systemd[1]: sshd@5-10.200.8.10:22-10.200.16.10:41256.service: Deactivated successfully.
Dec 13 02:01:59.263557 systemd[1]: session-8.scope: Deactivated successfully.
Dec 13 02:01:59.264744 systemd-logind[1293]: Removed session 8.
Dec 13 02:01:59.258000 audit[1687]: CRED_DISP pid=1687 uid=0 auid=500 ses=8 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.200.16.10 addr=10.200.16.10 terminal=ssh res=success'
Dec 13 02:01:59.293695 kernel: audit: type=1106 audit(1734055319.258:184): pid=1687 uid=0 auid=500 ses=8 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.200.16.10 addr=10.200.16.10 terminal=ssh res=success'
Dec 13 02:01:59.293809 kernel: audit: type=1104 audit(1734055319.258:185): pid=1687 uid=0 auid=500 ses=8 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.200.16.10 addr=10.200.16.10 terminal=ssh res=success'
Dec 13 02:01:59.293829 kernel: audit: type=1131 audit(1734055319.261:186): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-10.200.8.10:22-10.200.16.10:41256 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Dec 13 02:01:59.261000 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.200.8.10:22-10.200.16.10:41256 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Dec 13 02:01:59.361849 systemd[1]: Started sshd@6-10.200.8.10:22-10.200.16.10:37970.service.
Dec 13 02:01:59.361000 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.200.8.10:22-10.200.16.10:37970 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Dec 13 02:01:59.982000 audit[1717]: USER_ACCT pid=1717 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.200.16.10 addr=10.200.16.10 terminal=ssh res=success'
Dec 13 02:01:59.984227 sshd[1717]: Accepted publickey for core from 10.200.16.10 port 37970 ssh2: RSA SHA256:gXnTcda5xTHu03Chb+JqgZafruXVzN/4W1lBkFcVm+I
Dec 13 02:01:59.984000 audit[1717]: CRED_ACQ pid=1717 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.200.16.10 addr=10.200.16.10 terminal=ssh res=success'
Dec 13 02:01:59.984000 audit[1717]: SYSCALL arch=c000003e syscall=1 success=yes exit=3 a0=5 a1=7ffda1111940 a2=3 a3=0 items=0 ppid=1 pid=1717 auid=500 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=9 comm="sshd" exe="/usr/sbin/sshd" subj=system_u:system_r:kernel_t:s0 key=(null)
Dec 13 02:01:59.984000 audit: PROCTITLE proctitle=737368643A20636F7265205B707269765D
Dec 13 02:01:59.985976 sshd[1717]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Dec 13 02:01:59.991863 systemd[1]: Started session-9.scope.
Dec 13 02:01:59.992348 systemd-logind[1293]: New session 9 of user core.
Dec 13 02:01:59.995000 audit[1717]: USER_START pid=1717 uid=0 auid=500 ses=9 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.200.16.10 addr=10.200.16.10 terminal=ssh res=success'
Dec 13 02:01:59.997000 audit[1719]: CRED_ACQ pid=1719 uid=0 auid=500 ses=9 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.200.16.10 addr=10.200.16.10 terminal=ssh res=success'
Dec 13 02:02:00.327000 audit[1722]: USER_ACCT pid=1722 uid=500 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success'
Dec 13 02:02:00.327000 audit[1722]: CRED_REFR pid=1722 uid=500 auid=500 ses=9 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'
Dec 13 02:02:00.328211 sudo[1722]:     core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/tee /etc/flatcar/update.conf
Dec 13 02:02:00.328548 sudo[1722]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500)
Dec 13 02:02:00.329000 audit[1722]: USER_START pid=1722 uid=500 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success'
Dec 13 02:02:00.418000 audit[1722]: USER_END pid=1722 uid=500 auid=500 ses=9 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'
Dec 13 02:02:00.418000 audit[1722]: CRED_DISP pid=1722 uid=500 auid=500 ses=9 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'
Dec 13 02:02:00.419071 sudo[1722]: pam_unix(sudo:session): session closed for user root
Dec 13 02:02:00.422978 systemd[1]: Starting motdgen.service...
Dec 13 02:02:00.433811 systemd[1]: motdgen.service: Deactivated successfully.
Dec 13 02:02:00.433998 systemd[1]: Finished motdgen.service.
Dec 13 02:02:00.433000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=motdgen comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Dec 13 02:02:00.433000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=motdgen comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Dec 13 02:02:00.523775 sshd[1717]: pam_unix(sshd:session): session closed for user core
Dec 13 02:02:00.524000 audit[1717]: USER_END pid=1717 uid=0 auid=500 ses=9 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.200.16.10 addr=10.200.16.10 terminal=ssh res=success'
Dec 13 02:02:00.525000 audit[1717]: CRED_DISP pid=1717 uid=0 auid=500 ses=9 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.200.16.10 addr=10.200.16.10 terminal=ssh res=success'
Dec 13 02:02:00.527513 systemd[1]: sshd@6-10.200.8.10:22-10.200.16.10:37970.service: Deactivated successfully.
Dec 13 02:02:00.526000 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.200.8.10:22-10.200.16.10:37970 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Dec 13 02:02:00.528893 systemd[1]: session-9.scope: Deactivated successfully.
Dec 13 02:02:00.528940 systemd-logind[1293]: Session 9 logged out. Waiting for processes to exit.
Dec 13 02:02:00.530191 systemd-logind[1293]: Removed session 9.