Oct 2 20:22:08.545072 kernel: microcode: microcode updated early to revision 0xf4, date = 2022-07-31 Oct 2 20:22:08.545086 kernel: Linux version 5.15.132-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 Mon Oct 2 17:52:37 -00 2023 Oct 2 20:22:08.545092 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=tty0 console=ttyS1,115200n8 flatcar.first_boot=detected flatcar.oem.id=packet flatcar.autologin verity.usrhash=96b0fdb9f11bf1422adc9955c78c8182df387766badfd0b94e08fb9688739ee1 Oct 2 20:22:08.545096 kernel: BIOS-provided physical RAM map: Oct 2 20:22:08.545099 kernel: BIOS-e820: [mem 0x0000000000000000-0x00000000000997ff] usable Oct 2 20:22:08.545103 kernel: BIOS-e820: [mem 0x0000000000099800-0x000000000009ffff] reserved Oct 2 20:22:08.545108 kernel: BIOS-e820: [mem 0x00000000000e0000-0x00000000000fffff] reserved Oct 2 20:22:08.545112 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000003fffffff] usable Oct 2 20:22:08.545116 kernel: BIOS-e820: [mem 0x0000000040000000-0x00000000403fffff] reserved Oct 2 20:22:08.545120 kernel: BIOS-e820: [mem 0x0000000040400000-0x000000006dfb1fff] usable Oct 2 20:22:08.545124 kernel: BIOS-e820: [mem 0x000000006dfb2000-0x000000006dfb2fff] ACPI NVS Oct 2 20:22:08.545127 kernel: BIOS-e820: [mem 0x000000006dfb3000-0x000000006dfb3fff] reserved Oct 2 20:22:08.545131 kernel: BIOS-e820: [mem 0x000000006dfb4000-0x0000000077fc4fff] usable Oct 2 20:22:08.545135 kernel: BIOS-e820: [mem 0x0000000077fc5000-0x00000000790a7fff] reserved Oct 2 20:22:08.545141 kernel: BIOS-e820: [mem 0x00000000790a8000-0x0000000079230fff] usable Oct 2 20:22:08.545145 kernel: BIOS-e820: [mem 0x0000000079231000-0x0000000079662fff] ACPI NVS Oct 2 20:22:08.545149 kernel: BIOS-e820: [mem 0x0000000079663000-0x000000007befefff] reserved Oct 2 20:22:08.545153 kernel: BIOS-e820: [mem 0x000000007beff000-0x000000007befffff] usable Oct 2 20:22:08.545157 kernel: BIOS-e820: [mem 0x000000007bf00000-0x000000007f7fffff] reserved Oct 2 20:22:08.545161 kernel: BIOS-e820: [mem 0x00000000e0000000-0x00000000efffffff] reserved Oct 2 20:22:08.545165 kernel: BIOS-e820: [mem 0x00000000fe000000-0x00000000fe010fff] reserved Oct 2 20:22:08.545169 kernel: BIOS-e820: [mem 0x00000000fec00000-0x00000000fec00fff] reserved Oct 2 20:22:08.545173 kernel: BIOS-e820: [mem 0x00000000fee00000-0x00000000fee00fff] reserved Oct 2 20:22:08.545179 kernel: BIOS-e820: [mem 0x00000000ff000000-0x00000000ffffffff] reserved Oct 2 20:22:08.545183 kernel: BIOS-e820: [mem 0x0000000100000000-0x000000087f7fffff] usable Oct 2 20:22:08.545187 kernel: NX (Execute Disable) protection: active Oct 2 20:22:08.545191 kernel: SMBIOS 3.2.1 present. Oct 2 20:22:08.545195 kernel: DMI: Supermicro PIO-519C-MR-PH004/X11SCH-F, BIOS 1.5 11/17/2020 Oct 2 20:22:08.545199 kernel: tsc: Detected 3400.000 MHz processor Oct 2 20:22:08.545203 kernel: tsc: Detected 3399.906 MHz TSC Oct 2 20:22:08.545207 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Oct 2 20:22:08.545212 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Oct 2 20:22:08.545216 kernel: last_pfn = 0x87f800 max_arch_pfn = 0x400000000 Oct 2 20:22:08.545222 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Oct 2 20:22:08.545226 kernel: last_pfn = 0x7bf00 max_arch_pfn = 0x400000000 Oct 2 20:22:08.545230 kernel: Using GB pages for direct mapping Oct 2 20:22:08.545234 kernel: ACPI: Early table checksum verification disabled Oct 2 20:22:08.545239 kernel: ACPI: RSDP 0x00000000000F05B0 000024 (v02 SUPERM) Oct 2 20:22:08.545243 kernel: ACPI: XSDT 0x00000000795440C8 00010C (v01 SUPERM SUPERM 01072009 AMI 00010013) Oct 2 20:22:08.545247 kernel: ACPI: FACP 0x0000000079580620 000114 (v06 01072009 AMI 00010013) Oct 2 20:22:08.545253 kernel: ACPI: DSDT 0x0000000079544268 03C3B7 (v02 SUPERM SMCI--MB 01072009 INTL 20160527) Oct 2 20:22:08.545259 kernel: ACPI: FACS 0x0000000079662F80 000040 Oct 2 20:22:08.545263 kernel: ACPI: APIC 0x0000000079580738 00012C (v04 01072009 AMI 00010013) Oct 2 20:22:08.545268 kernel: ACPI: FPDT 0x0000000079580868 000044 (v01 01072009 AMI 00010013) Oct 2 20:22:08.545273 kernel: ACPI: FIDT 0x00000000795808B0 00009C (v01 SUPERM SMCI--MB 01072009 AMI 00010013) Oct 2 20:22:08.545277 kernel: ACPI: MCFG 0x0000000079580950 00003C (v01 SUPERM SMCI--MB 01072009 MSFT 00000097) Oct 2 20:22:08.545282 kernel: ACPI: SPMI 0x0000000079580990 000041 (v05 SUPERM SMCI--MB 00000000 AMI. 00000000) Oct 2 20:22:08.545287 kernel: ACPI: SSDT 0x00000000795809D8 001B1C (v02 CpuRef CpuSsdt 00003000 INTL 20160527) Oct 2 20:22:08.545292 kernel: ACPI: SSDT 0x00000000795824F8 0031C6 (v02 SaSsdt SaSsdt 00003000 INTL 20160527) Oct 2 20:22:08.545296 kernel: ACPI: SSDT 0x00000000795856C0 00232B (v02 PegSsd PegSsdt 00001000 INTL 20160527) Oct 2 20:22:08.545301 kernel: ACPI: HPET 0x00000000795879F0 000038 (v01 SUPERM SMCI--MB 00000002 01000013) Oct 2 20:22:08.545306 kernel: ACPI: SSDT 0x0000000079587A28 000FAE (v02 SUPERM Ther_Rvp 00001000 INTL 20160527) Oct 2 20:22:08.545310 kernel: ACPI: SSDT 0x00000000795889D8 0008F7 (v02 INTEL xh_mossb 00000000 INTL 20160527) Oct 2 20:22:08.545315 kernel: ACPI: UEFI 0x00000000795892D0 000042 (v01 SUPERM SMCI--MB 00000002 01000013) Oct 2 20:22:08.545319 kernel: ACPI: LPIT 0x0000000079589318 000094 (v01 SUPERM SMCI--MB 00000002 01000013) Oct 2 20:22:08.545324 kernel: ACPI: SSDT 0x00000000795893B0 0027DE (v02 SUPERM PtidDevc 00001000 INTL 20160527) Oct 2 20:22:08.545329 kernel: ACPI: SSDT 0x000000007958BB90 0014E2 (v02 SUPERM TbtTypeC 00000000 INTL 20160527) Oct 2 20:22:08.545334 kernel: ACPI: DBGP 0x000000007958D078 000034 (v01 SUPERM SMCI--MB 00000002 01000013) Oct 2 20:22:08.545338 kernel: ACPI: DBG2 0x000000007958D0B0 000054 (v00 SUPERM SMCI--MB 00000002 01000013) Oct 2 20:22:08.545343 kernel: ACPI: SSDT 0x000000007958D108 001B67 (v02 SUPERM UsbCTabl 00001000 INTL 20160527) Oct 2 20:22:08.545348 kernel: ACPI: DMAR 0x000000007958EC70 0000A8 (v01 INTEL EDK2 00000002 01000013) Oct 2 20:22:08.545352 kernel: ACPI: SSDT 0x000000007958ED18 000144 (v02 Intel ADebTabl 00001000 INTL 20160527) Oct 2 20:22:08.545357 kernel: ACPI: TPM2 0x000000007958EE60 000034 (v04 SUPERM SMCI--MB 00000001 AMI 00000000) Oct 2 20:22:08.545361 kernel: ACPI: SSDT 0x000000007958EE98 000D8F (v02 INTEL SpsNm 00000002 INTL 20160527) Oct 2 20:22:08.545367 kernel: ACPI: WSMT 0x000000007958FC28 000028 (v01 \xf4m 01072009 AMI 00010013) Oct 2 20:22:08.545372 kernel: ACPI: EINJ 0x000000007958FC50 000130 (v01 AMI AMI.EINJ 00000000 AMI. 00000000) Oct 2 20:22:08.545376 kernel: ACPI: ERST 0x000000007958FD80 000230 (v01 AMIER AMI.ERST 00000000 AMI. 00000000) Oct 2 20:22:08.545381 kernel: ACPI: BERT 0x000000007958FFB0 000030 (v01 AMI AMI.BERT 00000000 AMI. 00000000) Oct 2 20:22:08.545386 kernel: ACPI: HEST 0x000000007958FFE0 00027C (v01 AMI AMI.HEST 00000000 AMI. 00000000) Oct 2 20:22:08.545390 kernel: ACPI: SSDT 0x0000000079590260 000162 (v01 SUPERM SMCCDN 00000000 INTL 20181221) Oct 2 20:22:08.545395 kernel: ACPI: Reserving FACP table memory at [mem 0x79580620-0x79580733] Oct 2 20:22:08.545399 kernel: ACPI: Reserving DSDT table memory at [mem 0x79544268-0x7958061e] Oct 2 20:22:08.545404 kernel: ACPI: Reserving FACS table memory at [mem 0x79662f80-0x79662fbf] Oct 2 20:22:08.545409 kernel: ACPI: Reserving APIC table memory at [mem 0x79580738-0x79580863] Oct 2 20:22:08.545414 kernel: ACPI: Reserving FPDT table memory at [mem 0x79580868-0x795808ab] Oct 2 20:22:08.545419 kernel: ACPI: Reserving FIDT table memory at [mem 0x795808b0-0x7958094b] Oct 2 20:22:08.545423 kernel: ACPI: Reserving MCFG table memory at [mem 0x79580950-0x7958098b] Oct 2 20:22:08.545428 kernel: ACPI: Reserving SPMI table memory at [mem 0x79580990-0x795809d0] Oct 2 20:22:08.545432 kernel: ACPI: Reserving SSDT table memory at [mem 0x795809d8-0x795824f3] Oct 2 20:22:08.545437 kernel: ACPI: Reserving SSDT table memory at [mem 0x795824f8-0x795856bd] Oct 2 20:22:08.545441 kernel: ACPI: Reserving SSDT table memory at [mem 0x795856c0-0x795879ea] Oct 2 20:22:08.545446 kernel: ACPI: Reserving HPET table memory at [mem 0x795879f0-0x79587a27] Oct 2 20:22:08.545451 kernel: ACPI: Reserving SSDT table memory at [mem 0x79587a28-0x795889d5] Oct 2 20:22:08.545456 kernel: ACPI: Reserving SSDT table memory at [mem 0x795889d8-0x795892ce] Oct 2 20:22:08.545461 kernel: ACPI: Reserving UEFI table memory at [mem 0x795892d0-0x79589311] Oct 2 20:22:08.545465 kernel: ACPI: Reserving LPIT table memory at [mem 0x79589318-0x795893ab] Oct 2 20:22:08.545470 kernel: ACPI: Reserving SSDT table memory at [mem 0x795893b0-0x7958bb8d] Oct 2 20:22:08.545474 kernel: ACPI: Reserving SSDT table memory at [mem 0x7958bb90-0x7958d071] Oct 2 20:22:08.545479 kernel: ACPI: Reserving DBGP table memory at [mem 0x7958d078-0x7958d0ab] Oct 2 20:22:08.545483 kernel: ACPI: Reserving DBG2 table memory at [mem 0x7958d0b0-0x7958d103] Oct 2 20:22:08.545488 kernel: ACPI: Reserving SSDT table memory at [mem 0x7958d108-0x7958ec6e] Oct 2 20:22:08.545494 kernel: ACPI: Reserving DMAR table memory at [mem 0x7958ec70-0x7958ed17] Oct 2 20:22:08.545498 kernel: ACPI: Reserving SSDT table memory at [mem 0x7958ed18-0x7958ee5b] Oct 2 20:22:08.545505 kernel: ACPI: Reserving TPM2 table memory at [mem 0x7958ee60-0x7958ee93] Oct 2 20:22:08.545510 kernel: ACPI: Reserving SSDT table memory at [mem 0x7958ee98-0x7958fc26] Oct 2 20:22:08.545514 kernel: ACPI: Reserving WSMT table memory at [mem 0x7958fc28-0x7958fc4f] Oct 2 20:22:08.545519 kernel: ACPI: Reserving EINJ table memory at [mem 0x7958fc50-0x7958fd7f] Oct 2 20:22:08.545523 kernel: ACPI: Reserving ERST table memory at [mem 0x7958fd80-0x7958ffaf] Oct 2 20:22:08.545528 kernel: ACPI: Reserving BERT table memory at [mem 0x7958ffb0-0x7958ffdf] Oct 2 20:22:08.545532 kernel: ACPI: Reserving HEST table memory at [mem 0x7958ffe0-0x7959025b] Oct 2 20:22:08.545538 kernel: ACPI: Reserving SSDT table memory at [mem 0x79590260-0x795903c1] Oct 2 20:22:08.545558 kernel: No NUMA configuration found Oct 2 20:22:08.545563 kernel: Faking a node at [mem 0x0000000000000000-0x000000087f7fffff] Oct 2 20:22:08.545567 kernel: NODE_DATA(0) allocated [mem 0x87f7fa000-0x87f7fffff] Oct 2 20:22:08.545572 kernel: Zone ranges: Oct 2 20:22:08.545576 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Oct 2 20:22:08.545581 kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff] Oct 2 20:22:08.545585 kernel: Normal [mem 0x0000000100000000-0x000000087f7fffff] Oct 2 20:22:08.545590 kernel: Movable zone start for each node Oct 2 20:22:08.545595 kernel: Early memory node ranges Oct 2 20:22:08.545600 kernel: node 0: [mem 0x0000000000001000-0x0000000000098fff] Oct 2 20:22:08.545604 kernel: node 0: [mem 0x0000000000100000-0x000000003fffffff] Oct 2 20:22:08.545608 kernel: node 0: [mem 0x0000000040400000-0x000000006dfb1fff] Oct 2 20:22:08.545613 kernel: node 0: [mem 0x000000006dfb4000-0x0000000077fc4fff] Oct 2 20:22:08.545617 kernel: node 0: [mem 0x00000000790a8000-0x0000000079230fff] Oct 2 20:22:08.545622 kernel: node 0: [mem 0x000000007beff000-0x000000007befffff] Oct 2 20:22:08.545626 kernel: node 0: [mem 0x0000000100000000-0x000000087f7fffff] Oct 2 20:22:08.545632 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000087f7fffff] Oct 2 20:22:08.545639 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Oct 2 20:22:08.545644 kernel: On node 0, zone DMA: 103 pages in unavailable ranges Oct 2 20:22:08.545649 kernel: On node 0, zone DMA32: 1024 pages in unavailable ranges Oct 2 20:22:08.545654 kernel: On node 0, zone DMA32: 2 pages in unavailable ranges Oct 2 20:22:08.545659 kernel: On node 0, zone DMA32: 4323 pages in unavailable ranges Oct 2 20:22:08.545664 kernel: On node 0, zone DMA32: 11470 pages in unavailable ranges Oct 2 20:22:08.545669 kernel: On node 0, zone Normal: 16640 pages in unavailable ranges Oct 2 20:22:08.545674 kernel: On node 0, zone Normal: 2048 pages in unavailable ranges Oct 2 20:22:08.545680 kernel: ACPI: PM-Timer IO Port: 0x1808 Oct 2 20:22:08.545685 kernel: ACPI: LAPIC_NMI (acpi_id[0x01] high edge lint[0x1]) Oct 2 20:22:08.545689 kernel: ACPI: LAPIC_NMI (acpi_id[0x02] high edge lint[0x1]) Oct 2 20:22:08.545694 kernel: ACPI: LAPIC_NMI (acpi_id[0x03] high edge lint[0x1]) Oct 2 20:22:08.545699 kernel: ACPI: LAPIC_NMI (acpi_id[0x04] high edge lint[0x1]) Oct 2 20:22:08.545704 kernel: ACPI: LAPIC_NMI (acpi_id[0x05] high edge lint[0x1]) Oct 2 20:22:08.545708 kernel: ACPI: LAPIC_NMI (acpi_id[0x06] high edge lint[0x1]) Oct 2 20:22:08.545713 kernel: ACPI: LAPIC_NMI (acpi_id[0x07] high edge lint[0x1]) Oct 2 20:22:08.545718 kernel: ACPI: LAPIC_NMI (acpi_id[0x08] high edge lint[0x1]) Oct 2 20:22:08.545724 kernel: ACPI: LAPIC_NMI (acpi_id[0x09] high edge lint[0x1]) Oct 2 20:22:08.545728 kernel: ACPI: LAPIC_NMI (acpi_id[0x0a] high edge lint[0x1]) Oct 2 20:22:08.545733 kernel: ACPI: LAPIC_NMI (acpi_id[0x0b] high edge lint[0x1]) Oct 2 20:22:08.545738 kernel: ACPI: LAPIC_NMI (acpi_id[0x0c] high edge lint[0x1]) Oct 2 20:22:08.545743 kernel: ACPI: LAPIC_NMI (acpi_id[0x0d] high edge lint[0x1]) Oct 2 20:22:08.545747 kernel: ACPI: LAPIC_NMI (acpi_id[0x0e] high edge lint[0x1]) Oct 2 20:22:08.545752 kernel: ACPI: LAPIC_NMI (acpi_id[0x0f] high edge lint[0x1]) Oct 2 20:22:08.545757 kernel: ACPI: LAPIC_NMI (acpi_id[0x10] high edge lint[0x1]) Oct 2 20:22:08.545762 kernel: IOAPIC[0]: apic_id 2, version 32, address 0xfec00000, GSI 0-119 Oct 2 20:22:08.545767 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Oct 2 20:22:08.545773 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Oct 2 20:22:08.545778 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Oct 2 20:22:08.545782 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Oct 2 20:22:08.545787 kernel: TSC deadline timer available Oct 2 20:22:08.545792 kernel: smpboot: Allowing 16 CPUs, 0 hotplug CPUs Oct 2 20:22:08.545797 kernel: [mem 0x7f800000-0xdfffffff] available for PCI devices Oct 2 20:22:08.545802 kernel: Booting paravirtualized kernel on bare hardware Oct 2 20:22:08.545807 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Oct 2 20:22:08.545812 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:512 nr_cpu_ids:16 nr_node_ids:1 Oct 2 20:22:08.545817 kernel: percpu: Embedded 55 pages/cpu s185624 r8192 d31464 u262144 Oct 2 20:22:08.545822 kernel: pcpu-alloc: s185624 r8192 d31464 u262144 alloc=1*2097152 Oct 2 20:22:08.545827 kernel: pcpu-alloc: [0] 00 01 02 03 04 05 06 07 [0] 08 09 10 11 12 13 14 15 Oct 2 20:22:08.545831 kernel: Built 1 zonelists, mobility grouping on. Total pages: 8222327 Oct 2 20:22:08.545836 kernel: Policy zone: Normal Oct 2 20:22:08.545842 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=tty0 console=ttyS1,115200n8 flatcar.first_boot=detected flatcar.oem.id=packet flatcar.autologin verity.usrhash=96b0fdb9f11bf1422adc9955c78c8182df387766badfd0b94e08fb9688739ee1 Oct 2 20:22:08.545847 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Oct 2 20:22:08.545852 kernel: Dentry cache hash table entries: 4194304 (order: 13, 33554432 bytes, linear) Oct 2 20:22:08.545857 kernel: Inode-cache hash table entries: 2097152 (order: 12, 16777216 bytes, linear) Oct 2 20:22:08.545862 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 2 20:22:08.545867 kernel: Memory: 32683728K/33411988K available (12294K kernel code, 2274K rwdata, 13692K rodata, 45372K init, 4176K bss, 728000K reserved, 0K cma-reserved) Oct 2 20:22:08.545872 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=16, Nodes=1 Oct 2 20:22:08.545877 kernel: ftrace: allocating 34453 entries in 135 pages Oct 2 20:22:08.545882 kernel: ftrace: allocated 135 pages with 4 groups Oct 2 20:22:08.545886 kernel: rcu: Hierarchical RCU implementation. Oct 2 20:22:08.545891 kernel: rcu: RCU event tracing is enabled. Oct 2 20:22:08.545897 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=16. Oct 2 20:22:08.545902 kernel: Rude variant of Tasks RCU enabled. Oct 2 20:22:08.545907 kernel: Tracing variant of Tasks RCU enabled. Oct 2 20:22:08.545912 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 2 20:22:08.545917 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=16 Oct 2 20:22:08.545921 kernel: NR_IRQS: 33024, nr_irqs: 2184, preallocated irqs: 16 Oct 2 20:22:08.545926 kernel: random: crng init done Oct 2 20:22:08.545931 kernel: Console: colour dummy device 80x25 Oct 2 20:22:08.545936 kernel: printk: console [tty0] enabled Oct 2 20:22:08.545942 kernel: printk: console [ttyS1] enabled Oct 2 20:22:08.545946 kernel: ACPI: Core revision 20210730 Oct 2 20:22:08.545951 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 79635855245 ns Oct 2 20:22:08.545956 kernel: APIC: Switch to symmetric I/O mode setup Oct 2 20:22:08.545961 kernel: DMAR: Host address width 39 Oct 2 20:22:08.545966 kernel: DMAR: DRHD base: 0x000000fed90000 flags: 0x0 Oct 2 20:22:08.545971 kernel: DMAR: dmar0: reg_base_addr fed90000 ver 1:0 cap 1c0000c40660462 ecap 19e2ff0505e Oct 2 20:22:08.545975 kernel: DMAR: DRHD base: 0x000000fed91000 flags: 0x1 Oct 2 20:22:08.545980 kernel: DMAR: dmar1: reg_base_addr fed91000 ver 1:0 cap d2008c40660462 ecap f050da Oct 2 20:22:08.545986 kernel: DMAR: RMRR base: 0x00000079f11000 end: 0x0000007a15afff Oct 2 20:22:08.545991 kernel: DMAR: RMRR base: 0x0000007d000000 end: 0x0000007f7fffff Oct 2 20:22:08.545996 kernel: DMAR-IR: IOAPIC id 2 under DRHD base 0xfed91000 IOMMU 1 Oct 2 20:22:08.546000 kernel: DMAR-IR: HPET id 0 under DRHD base 0xfed91000 Oct 2 20:22:08.546005 kernel: DMAR-IR: Queued invalidation will be enabled to support x2apic and Intr-remapping. Oct 2 20:22:08.546010 kernel: DMAR-IR: Enabled IRQ remapping in x2apic mode Oct 2 20:22:08.546015 kernel: x2apic enabled Oct 2 20:22:08.546020 kernel: Switched APIC routing to cluster x2apic. Oct 2 20:22:08.546025 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Oct 2 20:22:08.546029 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3101f59f5e6, max_idle_ns: 440795259996 ns Oct 2 20:22:08.546035 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 6799.81 BogoMIPS (lpj=3399906) Oct 2 20:22:08.546040 kernel: CPU0: Thermal monitoring enabled (TM1) Oct 2 20:22:08.546045 kernel: process: using mwait in idle threads Oct 2 20:22:08.546050 kernel: Last level iTLB entries: 4KB 64, 2MB 8, 4MB 8 Oct 2 20:22:08.546054 kernel: Last level dTLB entries: 4KB 64, 2MB 0, 4MB 0, 1GB 4 Oct 2 20:22:08.546059 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Oct 2 20:22:08.546064 kernel: Spectre V2 : WARNING: Unprivileged eBPF is enabled with eIBRS on, data leaks possible via Spectre v2 BHB attacks! Oct 2 20:22:08.546069 kernel: Spectre V2 : Mitigation: Enhanced IBRS Oct 2 20:22:08.546075 kernel: Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch Oct 2 20:22:08.546080 kernel: Spectre V2 : Spectre v2 / PBRSB-eIBRS: Retire a single CALL on VMEXIT Oct 2 20:22:08.546084 kernel: RETBleed: Mitigation: Enhanced IBRS Oct 2 20:22:08.546089 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier Oct 2 20:22:08.546094 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl and seccomp Oct 2 20:22:08.546099 kernel: TAA: Mitigation: TSX disabled Oct 2 20:22:08.546104 kernel: MMIO Stale Data: Mitigation: Clear CPU buffers Oct 2 20:22:08.546109 kernel: SRBDS: Mitigation: Microcode Oct 2 20:22:08.546113 kernel: GDS: Vulnerable: No microcode Oct 2 20:22:08.546119 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Oct 2 20:22:08.546124 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Oct 2 20:22:08.546129 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Oct 2 20:22:08.546133 kernel: x86/fpu: Supporting XSAVE feature 0x008: 'MPX bounds registers' Oct 2 20:22:08.546138 kernel: x86/fpu: Supporting XSAVE feature 0x010: 'MPX CSR' Oct 2 20:22:08.546143 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Oct 2 20:22:08.546148 kernel: x86/fpu: xstate_offset[3]: 832, xstate_sizes[3]: 64 Oct 2 20:22:08.546153 kernel: x86/fpu: xstate_offset[4]: 896, xstate_sizes[4]: 64 Oct 2 20:22:08.546158 kernel: x86/fpu: Enabled xstate features 0x1f, context size is 960 bytes, using 'compacted' format. Oct 2 20:22:08.546163 kernel: Freeing SMP alternatives memory: 32K Oct 2 20:22:08.546168 kernel: pid_max: default: 32768 minimum: 301 Oct 2 20:22:08.546173 kernel: LSM: Security Framework initializing Oct 2 20:22:08.546177 kernel: SELinux: Initializing. Oct 2 20:22:08.546182 kernel: Mount-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 2 20:22:08.546187 kernel: Mountpoint-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 2 20:22:08.546192 kernel: smpboot: Estimated ratio of average max frequency by base frequency (times 1024): 1445 Oct 2 20:22:08.546197 kernel: smpboot: CPU0: Intel(R) Xeon(R) E-2278G CPU @ 3.40GHz (family: 0x6, model: 0x9e, stepping: 0xd) Oct 2 20:22:08.546202 kernel: Performance Events: PEBS fmt3+, Skylake events, 32-deep LBR, full-width counters, Intel PMU driver. Oct 2 20:22:08.546208 kernel: ... version: 4 Oct 2 20:22:08.546212 kernel: ... bit width: 48 Oct 2 20:22:08.546217 kernel: ... generic registers: 4 Oct 2 20:22:08.546222 kernel: ... value mask: 0000ffffffffffff Oct 2 20:22:08.546227 kernel: ... max period: 00007fffffffffff Oct 2 20:22:08.546232 kernel: ... fixed-purpose events: 3 Oct 2 20:22:08.546236 kernel: ... event mask: 000000070000000f Oct 2 20:22:08.546241 kernel: signal: max sigframe size: 2032 Oct 2 20:22:08.546246 kernel: rcu: Hierarchical SRCU implementation. Oct 2 20:22:08.546251 kernel: NMI watchdog: Enabled. Permanently consumes one hw-PMU counter. Oct 2 20:22:08.546256 kernel: smp: Bringing up secondary CPUs ... Oct 2 20:22:08.546261 kernel: x86: Booting SMP configuration: Oct 2 20:22:08.546266 kernel: .... node #0, CPUs: #1 #2 #3 #4 #5 #6 #7 #8 Oct 2 20:22:08.546271 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. Oct 2 20:22:08.546276 kernel: #9 #10 #11 #12 #13 #14 #15 Oct 2 20:22:08.546281 kernel: smp: Brought up 1 node, 16 CPUs Oct 2 20:22:08.546285 kernel: smpboot: Max logical packages: 1 Oct 2 20:22:08.546290 kernel: smpboot: Total of 16 processors activated (108796.99 BogoMIPS) Oct 2 20:22:08.546296 kernel: devtmpfs: initialized Oct 2 20:22:08.546301 kernel: x86/mm: Memory block size: 128MB Oct 2 20:22:08.546306 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x6dfb2000-0x6dfb2fff] (4096 bytes) Oct 2 20:22:08.546310 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x79231000-0x79662fff] (4399104 bytes) Oct 2 20:22:08.546315 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 2 20:22:08.546320 kernel: futex hash table entries: 4096 (order: 6, 262144 bytes, linear) Oct 2 20:22:08.546325 kernel: pinctrl core: initialized pinctrl subsystem Oct 2 20:22:08.546330 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Oct 2 20:22:08.546335 kernel: audit: initializing netlink subsys (disabled) Oct 2 20:22:08.546340 kernel: audit: type=2000 audit(1696278123.120:1): state=initialized audit_enabled=0 res=1 Oct 2 20:22:08.546345 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 2 20:22:08.546350 kernel: thermal_sys: Registered thermal governor 'user_space' Oct 2 20:22:08.546355 kernel: cpuidle: using governor menu Oct 2 20:22:08.546359 kernel: ACPI: bus type PCI registered Oct 2 20:22:08.546364 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 2 20:22:08.546369 kernel: dca service started, version 1.12.1 Oct 2 20:22:08.546374 kernel: PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xe0000000-0xefffffff] (base 0xe0000000) Oct 2 20:22:08.546379 kernel: PCI: MMCONFIG at [mem 0xe0000000-0xefffffff] reserved in E820 Oct 2 20:22:08.546384 kernel: PCI: Using configuration type 1 for base access Oct 2 20:22:08.546389 kernel: ENERGY_PERF_BIAS: Set to 'normal', was 'performance' Oct 2 20:22:08.546394 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Oct 2 20:22:08.546399 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Oct 2 20:22:08.546403 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Oct 2 20:22:08.546408 kernel: ACPI: Added _OSI(Module Device) Oct 2 20:22:08.546413 kernel: ACPI: Added _OSI(Processor Device) Oct 2 20:22:08.546418 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Oct 2 20:22:08.546423 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 2 20:22:08.546428 kernel: ACPI: Added _OSI(Linux-Dell-Video) Oct 2 20:22:08.546433 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Oct 2 20:22:08.546438 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Oct 2 20:22:08.546442 kernel: ACPI: 12 ACPI AML tables successfully acquired and loaded Oct 2 20:22:08.546447 kernel: ACPI: Dynamic OEM Table Load: Oct 2 20:22:08.546452 kernel: ACPI: SSDT 0xFFFF895880211800 0000F4 (v02 PmRef Cpu0Psd 00003000 INTL 20160527) Oct 2 20:22:08.546457 kernel: ACPI: \_SB_.PR00: _OSC native thermal LVT Acked Oct 2 20:22:08.546462 kernel: ACPI: Dynamic OEM Table Load: Oct 2 20:22:08.546467 kernel: ACPI: SSDT 0xFFFF895881CEF000 000400 (v02 PmRef Cpu0Cst 00003001 INTL 20160527) Oct 2 20:22:08.546472 kernel: ACPI: Dynamic OEM Table Load: Oct 2 20:22:08.546477 kernel: ACPI: SSDT 0xFFFF895881C51000 000683 (v02 PmRef Cpu0Ist 00003000 INTL 20160527) Oct 2 20:22:08.546482 kernel: ACPI: Dynamic OEM Table Load: Oct 2 20:22:08.546486 kernel: ACPI: SSDT 0xFFFF895881C54800 0005FC (v02 PmRef ApIst 00003000 INTL 20160527) Oct 2 20:22:08.546491 kernel: ACPI: Dynamic OEM Table Load: Oct 2 20:22:08.546496 kernel: ACPI: SSDT 0xFFFF895880149000 000AB0 (v02 PmRef ApPsd 00003000 INTL 20160527) Oct 2 20:22:08.546501 kernel: ACPI: Dynamic OEM Table Load: Oct 2 20:22:08.546507 kernel: ACPI: SSDT 0xFFFF895881CEC000 00030A (v02 PmRef ApCst 00003000 INTL 20160527) Oct 2 20:22:08.546512 kernel: ACPI: Interpreter enabled Oct 2 20:22:08.546534 kernel: ACPI: PM: (supports S0 S5) Oct 2 20:22:08.546539 kernel: ACPI: Using IOAPIC for interrupt routing Oct 2 20:22:08.546544 kernel: HEST: Enabling Firmware First mode for corrected errors. Oct 2 20:22:08.546549 kernel: mce: [Firmware Bug]: Ignoring request to disable invalid MCA bank 14. Oct 2 20:22:08.546554 kernel: HEST: Table parsing has been initialized. Oct 2 20:22:08.546575 kernel: GHES: APEI firmware first mode is enabled by APEI bit and WHEA _OSC. Oct 2 20:22:08.546580 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Oct 2 20:22:08.546585 kernel: ACPI: Enabled 9 GPEs in block 00 to 7F Oct 2 20:22:08.546590 kernel: ACPI: PM: Power Resource [USBC] Oct 2 20:22:08.546595 kernel: ACPI: PM: Power Resource [V0PR] Oct 2 20:22:08.546600 kernel: ACPI: PM: Power Resource [V1PR] Oct 2 20:22:08.546605 kernel: ACPI: PM: Power Resource [V2PR] Oct 2 20:22:08.546609 kernel: ACPI: PM: Power Resource [WRST] Oct 2 20:22:08.546614 kernel: ACPI: [Firmware Bug]: BIOS _OSI(Linux) query ignored Oct 2 20:22:08.546619 kernel: ACPI: PM: Power Resource [FN00] Oct 2 20:22:08.546624 kernel: ACPI: PM: Power Resource [FN01] Oct 2 20:22:08.546629 kernel: ACPI: PM: Power Resource [FN02] Oct 2 20:22:08.546633 kernel: ACPI: PM: Power Resource [FN03] Oct 2 20:22:08.546638 kernel: ACPI: PM: Power Resource [FN04] Oct 2 20:22:08.546643 kernel: ACPI: PM: Power Resource [PIN] Oct 2 20:22:08.546648 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-fe]) Oct 2 20:22:08.546710 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 2 20:22:08.546754 kernel: acpi PNP0A08:00: _OSC: platform does not support [AER] Oct 2 20:22:08.546793 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME PCIeCapability LTR] Oct 2 20:22:08.546800 kernel: PCI host bridge to bus 0000:00 Oct 2 20:22:08.546841 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Oct 2 20:22:08.546879 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Oct 2 20:22:08.546914 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Oct 2 20:22:08.546950 kernel: pci_bus 0000:00: root bus resource [mem 0x7f800000-0xdfffffff window] Oct 2 20:22:08.546984 kernel: pci_bus 0000:00: root bus resource [mem 0xfc800000-0xfe7fffff window] Oct 2 20:22:08.547018 kernel: pci_bus 0000:00: root bus resource [bus 00-fe] Oct 2 20:22:08.547066 kernel: pci 0000:00:00.0: [8086:3e31] type 00 class 0x060000 Oct 2 20:22:08.547116 kernel: pci 0000:00:01.0: [8086:1901] type 01 class 0x060400 Oct 2 20:22:08.547159 kernel: pci 0000:00:01.0: PME# supported from D0 D3hot D3cold Oct 2 20:22:08.547203 kernel: pci 0000:00:01.1: [8086:1905] type 01 class 0x060400 Oct 2 20:22:08.547245 kernel: pci 0000:00:01.1: PME# supported from D0 D3hot D3cold Oct 2 20:22:08.547288 kernel: pci 0000:00:02.0: [8086:3e9a] type 00 class 0x038000 Oct 2 20:22:08.547329 kernel: pci 0000:00:02.0: reg 0x10: [mem 0x94000000-0x94ffffff 64bit] Oct 2 20:22:08.547371 kernel: pci 0000:00:02.0: reg 0x18: [mem 0x80000000-0x8fffffff 64bit pref] Oct 2 20:22:08.547411 kernel: pci 0000:00:02.0: reg 0x20: [io 0x6000-0x603f] Oct 2 20:22:08.547458 kernel: pci 0000:00:08.0: [8086:1911] type 00 class 0x088000 Oct 2 20:22:08.547498 kernel: pci 0000:00:08.0: reg 0x10: [mem 0x9651f000-0x9651ffff 64bit] Oct 2 20:22:08.547565 kernel: pci 0000:00:12.0: [8086:a379] type 00 class 0x118000 Oct 2 20:22:08.547605 kernel: pci 0000:00:12.0: reg 0x10: [mem 0x9651e000-0x9651efff 64bit] Oct 2 20:22:08.547650 kernel: pci 0000:00:14.0: [8086:a36d] type 00 class 0x0c0330 Oct 2 20:22:08.547692 kernel: pci 0000:00:14.0: reg 0x10: [mem 0x96500000-0x9650ffff 64bit] Oct 2 20:22:08.547732 kernel: pci 0000:00:14.0: PME# supported from D3hot D3cold Oct 2 20:22:08.547778 kernel: pci 0000:00:14.2: [8086:a36f] type 00 class 0x050000 Oct 2 20:22:08.547818 kernel: pci 0000:00:14.2: reg 0x10: [mem 0x96512000-0x96513fff 64bit] Oct 2 20:22:08.547858 kernel: pci 0000:00:14.2: reg 0x18: [mem 0x9651d000-0x9651dfff 64bit] Oct 2 20:22:08.547902 kernel: pci 0000:00:15.0: [8086:a368] type 00 class 0x0c8000 Oct 2 20:22:08.547945 kernel: pci 0000:00:15.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit] Oct 2 20:22:08.547988 kernel: pci 0000:00:15.1: [8086:a369] type 00 class 0x0c8000 Oct 2 20:22:08.548028 kernel: pci 0000:00:15.1: reg 0x10: [mem 0x00000000-0x00000fff 64bit] Oct 2 20:22:08.548072 kernel: pci 0000:00:16.0: [8086:a360] type 00 class 0x078000 Oct 2 20:22:08.548112 kernel: pci 0000:00:16.0: reg 0x10: [mem 0x9651a000-0x9651afff 64bit] Oct 2 20:22:08.548160 kernel: pci 0000:00:16.0: PME# supported from D3hot Oct 2 20:22:08.548205 kernel: pci 0000:00:16.1: [8086:a361] type 00 class 0x078000 Oct 2 20:22:08.548246 kernel: pci 0000:00:16.1: reg 0x10: [mem 0x96519000-0x96519fff 64bit] Oct 2 20:22:08.548287 kernel: pci 0000:00:16.1: PME# supported from D3hot Oct 2 20:22:08.548332 kernel: pci 0000:00:16.4: [8086:a364] type 00 class 0x078000 Oct 2 20:22:08.548372 kernel: pci 0000:00:16.4: reg 0x10: [mem 0x96518000-0x96518fff 64bit] Oct 2 20:22:08.548411 kernel: pci 0000:00:16.4: PME# supported from D3hot Oct 2 20:22:08.548456 kernel: pci 0000:00:17.0: [8086:a352] type 00 class 0x010601 Oct 2 20:22:08.548497 kernel: pci 0000:00:17.0: reg 0x10: [mem 0x96510000-0x96511fff] Oct 2 20:22:08.548541 kernel: pci 0000:00:17.0: reg 0x14: [mem 0x96517000-0x965170ff] Oct 2 20:22:08.548580 kernel: pci 0000:00:17.0: reg 0x18: [io 0x6090-0x6097] Oct 2 20:22:08.548621 kernel: pci 0000:00:17.0: reg 0x1c: [io 0x6080-0x6083] Oct 2 20:22:08.548660 kernel: pci 0000:00:17.0: reg 0x20: [io 0x6060-0x607f] Oct 2 20:22:08.548701 kernel: pci 0000:00:17.0: reg 0x24: [mem 0x96516000-0x965167ff] Oct 2 20:22:08.548741 kernel: pci 0000:00:17.0: PME# supported from D3hot Oct 2 20:22:08.548790 kernel: pci 0000:00:1b.0: [8086:a340] type 01 class 0x060400 Oct 2 20:22:08.548832 kernel: pci 0000:00:1b.0: PME# supported from D0 D3hot D3cold Oct 2 20:22:08.548876 kernel: pci 0000:00:1b.4: [8086:a32c] type 01 class 0x060400 Oct 2 20:22:08.548921 kernel: pci 0000:00:1b.4: PME# supported from D0 D3hot D3cold Oct 2 20:22:08.548965 kernel: pci 0000:00:1b.5: [8086:a32d] type 01 class 0x060400 Oct 2 20:22:08.549007 kernel: pci 0000:00:1b.5: PME# supported from D0 D3hot D3cold Oct 2 20:22:08.549050 kernel: pci 0000:00:1c.0: [8086:a338] type 01 class 0x060400 Oct 2 20:22:08.549091 kernel: pci 0000:00:1c.0: PME# supported from D0 D3hot D3cold Oct 2 20:22:08.549136 kernel: pci 0000:00:1c.1: [8086:a339] type 01 class 0x060400 Oct 2 20:22:08.549177 kernel: pci 0000:00:1c.1: PME# supported from D0 D3hot D3cold Oct 2 20:22:08.549222 kernel: pci 0000:00:1e.0: [8086:a328] type 00 class 0x078000 Oct 2 20:22:08.549263 kernel: pci 0000:00:1e.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit] Oct 2 20:22:08.549308 kernel: pci 0000:00:1f.0: [8086:a309] type 00 class 0x060100 Oct 2 20:22:08.549352 kernel: pci 0000:00:1f.4: [8086:a323] type 00 class 0x0c0500 Oct 2 20:22:08.549393 kernel: pci 0000:00:1f.4: reg 0x10: [mem 0x96514000-0x965140ff 64bit] Oct 2 20:22:08.549434 kernel: pci 0000:00:1f.4: reg 0x20: [io 0xefa0-0xefbf] Oct 2 20:22:08.549478 kernel: pci 0000:00:1f.5: [8086:a324] type 00 class 0x0c8000 Oct 2 20:22:08.549521 kernel: pci 0000:00:1f.5: reg 0x10: [mem 0xfe010000-0xfe010fff] Oct 2 20:22:08.549562 kernel: pci 0000:00:01.0: PCI bridge to [bus 01] Oct 2 20:22:08.549609 kernel: pci 0000:02:00.0: [15b3:1015] type 00 class 0x020000 Oct 2 20:22:08.549651 kernel: pci 0000:02:00.0: reg 0x10: [mem 0x92000000-0x93ffffff 64bit pref] Oct 2 20:22:08.549693 kernel: pci 0000:02:00.0: reg 0x30: [mem 0x96200000-0x962fffff pref] Oct 2 20:22:08.549735 kernel: pci 0000:02:00.0: PME# supported from D3cold Oct 2 20:22:08.549779 kernel: pci 0000:02:00.0: reg 0x1a4: [mem 0x00000000-0x000fffff 64bit pref] Oct 2 20:22:08.549820 kernel: pci 0000:02:00.0: VF(n) BAR0 space: [mem 0x00000000-0x007fffff 64bit pref] (contains BAR0 for 8 VFs) Oct 2 20:22:08.549866 kernel: pci 0000:02:00.1: [15b3:1015] type 00 class 0x020000 Oct 2 20:22:08.549908 kernel: pci 0000:02:00.1: reg 0x10: [mem 0x90000000-0x91ffffff 64bit pref] Oct 2 20:22:08.549949 kernel: pci 0000:02:00.1: reg 0x30: [mem 0x96100000-0x961fffff pref] Oct 2 20:22:08.549991 kernel: pci 0000:02:00.1: PME# supported from D3cold Oct 2 20:22:08.550032 kernel: pci 0000:02:00.1: reg 0x1a4: [mem 0x00000000-0x000fffff 64bit pref] Oct 2 20:22:08.550076 kernel: pci 0000:02:00.1: VF(n) BAR0 space: [mem 0x00000000-0x007fffff 64bit pref] (contains BAR0 for 8 VFs) Oct 2 20:22:08.550116 kernel: pci 0000:00:01.1: PCI bridge to [bus 02] Oct 2 20:22:08.550157 kernel: pci 0000:00:01.1: bridge window [mem 0x96100000-0x962fffff] Oct 2 20:22:08.550198 kernel: pci 0000:00:01.1: bridge window [mem 0x90000000-0x93ffffff 64bit pref] Oct 2 20:22:08.550239 kernel: pci 0000:00:1b.0: PCI bridge to [bus 03] Oct 2 20:22:08.550283 kernel: pci 0000:04:00.0: [8086:1533] type 00 class 0x020000 Oct 2 20:22:08.550326 kernel: pci 0000:04:00.0: reg 0x10: [mem 0x96400000-0x9647ffff] Oct 2 20:22:08.550369 kernel: pci 0000:04:00.0: reg 0x18: [io 0x5000-0x501f] Oct 2 20:22:08.550411 kernel: pci 0000:04:00.0: reg 0x1c: [mem 0x96480000-0x96483fff] Oct 2 20:22:08.550452 kernel: pci 0000:04:00.0: PME# supported from D0 D3hot D3cold Oct 2 20:22:08.550493 kernel: pci 0000:00:1b.4: PCI bridge to [bus 04] Oct 2 20:22:08.550537 kernel: pci 0000:00:1b.4: bridge window [io 0x5000-0x5fff] Oct 2 20:22:08.550577 kernel: pci 0000:00:1b.4: bridge window [mem 0x96400000-0x964fffff] Oct 2 20:22:08.550627 kernel: pci 0000:05:00.0: [8086:1533] type 00 class 0x020000 Oct 2 20:22:08.550669 kernel: pci 0000:05:00.0: reg 0x10: [mem 0x96300000-0x9637ffff] Oct 2 20:22:08.550713 kernel: pci 0000:05:00.0: reg 0x18: [io 0x4000-0x401f] Oct 2 20:22:08.550773 kernel: pci 0000:05:00.0: reg 0x1c: [mem 0x96380000-0x96383fff] Oct 2 20:22:08.550815 kernel: pci 0000:05:00.0: PME# supported from D0 D3hot D3cold Oct 2 20:22:08.550854 kernel: pci 0000:00:1b.5: PCI bridge to [bus 05] Oct 2 20:22:08.550894 kernel: pci 0000:00:1b.5: bridge window [io 0x4000-0x4fff] Oct 2 20:22:08.550934 kernel: pci 0000:00:1b.5: bridge window [mem 0x96300000-0x963fffff] Oct 2 20:22:08.550973 kernel: pci 0000:00:1c.0: PCI bridge to [bus 06] Oct 2 20:22:08.551018 kernel: pci 0000:07:00.0: [1a03:1150] type 01 class 0x060400 Oct 2 20:22:08.551061 kernel: pci 0000:07:00.0: enabling Extended Tags Oct 2 20:22:08.551103 kernel: pci 0000:07:00.0: supports D1 D2 Oct 2 20:22:08.551144 kernel: pci 0000:07:00.0: PME# supported from D0 D1 D2 D3hot D3cold Oct 2 20:22:08.551184 kernel: pci 0000:00:1c.1: PCI bridge to [bus 07-08] Oct 2 20:22:08.551223 kernel: pci 0000:00:1c.1: bridge window [io 0x3000-0x3fff] Oct 2 20:22:08.551337 kernel: pci 0000:00:1c.1: bridge window [mem 0x95000000-0x960fffff] Oct 2 20:22:08.551380 kernel: pci_bus 0000:08: extended config space not accessible Oct 2 20:22:08.551430 kernel: pci 0000:08:00.0: [1a03:2000] type 00 class 0x030000 Oct 2 20:22:08.551474 kernel: pci 0000:08:00.0: reg 0x10: [mem 0x95000000-0x95ffffff] Oct 2 20:22:08.551542 kernel: pci 0000:08:00.0: reg 0x14: [mem 0x96000000-0x9601ffff] Oct 2 20:22:08.551605 kernel: pci 0000:08:00.0: reg 0x18: [io 0x3000-0x307f] Oct 2 20:22:08.551648 kernel: pci 0000:08:00.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Oct 2 20:22:08.551691 kernel: pci 0000:08:00.0: supports D1 D2 Oct 2 20:22:08.551734 kernel: pci 0000:08:00.0: PME# supported from D0 D1 D2 D3hot D3cold Oct 2 20:22:08.551778 kernel: pci 0000:07:00.0: PCI bridge to [bus 08] Oct 2 20:22:08.551819 kernel: pci 0000:07:00.0: bridge window [io 0x3000-0x3fff] Oct 2 20:22:08.551861 kernel: pci 0000:07:00.0: bridge window [mem 0x95000000-0x960fffff] Oct 2 20:22:08.551868 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 0 Oct 2 20:22:08.551874 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 1 Oct 2 20:22:08.551879 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 0 Oct 2 20:22:08.551884 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 0 Oct 2 20:22:08.551889 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 0 Oct 2 20:22:08.551896 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 0 Oct 2 20:22:08.551901 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 0 Oct 2 20:22:08.551906 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 0 Oct 2 20:22:08.551911 kernel: iommu: Default domain type: Translated Oct 2 20:22:08.551917 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Oct 2 20:22:08.551959 kernel: pci 0000:08:00.0: vgaarb: setting as boot VGA device Oct 2 20:22:08.552004 kernel: pci 0000:08:00.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Oct 2 20:22:08.552047 kernel: pci 0000:08:00.0: vgaarb: bridge control possible Oct 2 20:22:08.552054 kernel: vgaarb: loaded Oct 2 20:22:08.552061 kernel: pps_core: LinuxPPS API ver. 1 registered Oct 2 20:22:08.552066 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Oct 2 20:22:08.552071 kernel: PTP clock support registered Oct 2 20:22:08.552076 kernel: PCI: Using ACPI for IRQ routing Oct 2 20:22:08.552082 kernel: PCI: pci_cache_line_size set to 64 bytes Oct 2 20:22:08.552087 kernel: e820: reserve RAM buffer [mem 0x00099800-0x0009ffff] Oct 2 20:22:08.552092 kernel: e820: reserve RAM buffer [mem 0x6dfb2000-0x6fffffff] Oct 2 20:22:08.552097 kernel: e820: reserve RAM buffer [mem 0x77fc5000-0x77ffffff] Oct 2 20:22:08.552102 kernel: e820: reserve RAM buffer [mem 0x79231000-0x7bffffff] Oct 2 20:22:08.552108 kernel: e820: reserve RAM buffer [mem 0x7bf00000-0x7bffffff] Oct 2 20:22:08.552113 kernel: e820: reserve RAM buffer [mem 0x87f800000-0x87fffffff] Oct 2 20:22:08.552118 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0, 0, 0, 0, 0, 0 Oct 2 20:22:08.552123 kernel: hpet0: 8 comparators, 64-bit 24.000000 MHz counter Oct 2 20:22:08.552128 kernel: clocksource: Switched to clocksource tsc-early Oct 2 20:22:08.552133 kernel: VFS: Disk quotas dquot_6.6.0 Oct 2 20:22:08.552138 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 2 20:22:08.552143 kernel: pnp: PnP ACPI init Oct 2 20:22:08.552186 kernel: system 00:00: [mem 0x40000000-0x403fffff] has been reserved Oct 2 20:22:08.552229 kernel: pnp 00:02: [dma 0 disabled] Oct 2 20:22:08.552269 kernel: pnp 00:03: [dma 0 disabled] Oct 2 20:22:08.552308 kernel: system 00:04: [io 0x0680-0x069f] has been reserved Oct 2 20:22:08.552344 kernel: system 00:04: [io 0x164e-0x164f] has been reserved Oct 2 20:22:08.552383 kernel: system 00:05: [io 0x1854-0x1857] has been reserved Oct 2 20:22:08.552421 kernel: system 00:06: [mem 0xfed10000-0xfed17fff] has been reserved Oct 2 20:22:08.552460 kernel: system 00:06: [mem 0xfed18000-0xfed18fff] has been reserved Oct 2 20:22:08.552496 kernel: system 00:06: [mem 0xfed19000-0xfed19fff] has been reserved Oct 2 20:22:08.552576 kernel: system 00:06: [mem 0xe0000000-0xefffffff] has been reserved Oct 2 20:22:08.552611 kernel: system 00:06: [mem 0xfed20000-0xfed3ffff] has been reserved Oct 2 20:22:08.552647 kernel: system 00:06: [mem 0xfed90000-0xfed93fff] could not be reserved Oct 2 20:22:08.552682 kernel: system 00:06: [mem 0xfed45000-0xfed8ffff] has been reserved Oct 2 20:22:08.552719 kernel: system 00:06: [mem 0xfee00000-0xfeefffff] could not be reserved Oct 2 20:22:08.552759 kernel: system 00:07: [io 0x1800-0x18fe] could not be reserved Oct 2 20:22:08.552795 kernel: system 00:07: [mem 0xfd000000-0xfd69ffff] has been reserved Oct 2 20:22:08.552831 kernel: system 00:07: [mem 0xfd6c0000-0xfd6cffff] has been reserved Oct 2 20:22:08.552867 kernel: system 00:07: [mem 0xfd6f0000-0xfdffffff] has been reserved Oct 2 20:22:08.552903 kernel: system 00:07: [mem 0xfe000000-0xfe01ffff] could not be reserved Oct 2 20:22:08.552937 kernel: system 00:07: [mem 0xfe200000-0xfe7fffff] has been reserved Oct 2 20:22:08.552973 kernel: system 00:07: [mem 0xff000000-0xffffffff] has been reserved Oct 2 20:22:08.553012 kernel: system 00:08: [io 0x2000-0x20fe] has been reserved Oct 2 20:22:08.553020 kernel: pnp: PnP ACPI: found 10 devices Oct 2 20:22:08.553025 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Oct 2 20:22:08.553030 kernel: NET: Registered PF_INET protocol family Oct 2 20:22:08.553036 kernel: IP idents hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 2 20:22:08.553041 kernel: tcp_listen_portaddr_hash hash table entries: 16384 (order: 6, 262144 bytes, linear) Oct 2 20:22:08.553046 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Oct 2 20:22:08.553051 kernel: TCP established hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 2 20:22:08.553058 kernel: TCP bind hash table entries: 65536 (order: 8, 1048576 bytes, linear) Oct 2 20:22:08.553063 kernel: TCP: Hash tables configured (established 262144 bind 65536) Oct 2 20:22:08.553068 kernel: UDP hash table entries: 16384 (order: 7, 524288 bytes, linear) Oct 2 20:22:08.553073 kernel: UDP-Lite hash table entries: 16384 (order: 7, 524288 bytes, linear) Oct 2 20:22:08.553078 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Oct 2 20:22:08.553084 kernel: NET: Registered PF_XDP protocol family Oct 2 20:22:08.553124 kernel: pci 0000:00:15.0: BAR 0: assigned [mem 0x7f800000-0x7f800fff 64bit] Oct 2 20:22:08.553164 kernel: pci 0000:00:15.1: BAR 0: assigned [mem 0x7f801000-0x7f801fff 64bit] Oct 2 20:22:08.553206 kernel: pci 0000:00:1e.0: BAR 0: assigned [mem 0x7f802000-0x7f802fff 64bit] Oct 2 20:22:08.553247 kernel: pci 0000:00:01.0: PCI bridge to [bus 01] Oct 2 20:22:08.553289 kernel: pci 0000:02:00.0: BAR 7: no space for [mem size 0x00800000 64bit pref] Oct 2 20:22:08.553331 kernel: pci 0000:02:00.0: BAR 7: failed to assign [mem size 0x00800000 64bit pref] Oct 2 20:22:08.553372 kernel: pci 0000:02:00.1: BAR 7: no space for [mem size 0x00800000 64bit pref] Oct 2 20:22:08.553416 kernel: pci 0000:02:00.1: BAR 7: failed to assign [mem size 0x00800000 64bit pref] Oct 2 20:22:08.553457 kernel: pci 0000:00:01.1: PCI bridge to [bus 02] Oct 2 20:22:08.553498 kernel: pci 0000:00:01.1: bridge window [mem 0x96100000-0x962fffff] Oct 2 20:22:08.553583 kernel: pci 0000:00:01.1: bridge window [mem 0x90000000-0x93ffffff 64bit pref] Oct 2 20:22:08.553623 kernel: pci 0000:00:1b.0: PCI bridge to [bus 03] Oct 2 20:22:08.553664 kernel: pci 0000:00:1b.4: PCI bridge to [bus 04] Oct 2 20:22:08.553704 kernel: pci 0000:00:1b.4: bridge window [io 0x5000-0x5fff] Oct 2 20:22:08.553745 kernel: pci 0000:00:1b.4: bridge window [mem 0x96400000-0x964fffff] Oct 2 20:22:08.553786 kernel: pci 0000:00:1b.5: PCI bridge to [bus 05] Oct 2 20:22:08.553827 kernel: pci 0000:00:1b.5: bridge window [io 0x4000-0x4fff] Oct 2 20:22:08.553866 kernel: pci 0000:00:1b.5: bridge window [mem 0x96300000-0x963fffff] Oct 2 20:22:08.553907 kernel: pci 0000:00:1c.0: PCI bridge to [bus 06] Oct 2 20:22:08.553948 kernel: pci 0000:07:00.0: PCI bridge to [bus 08] Oct 2 20:22:08.553989 kernel: pci 0000:07:00.0: bridge window [io 0x3000-0x3fff] Oct 2 20:22:08.554032 kernel: pci 0000:07:00.0: bridge window [mem 0x95000000-0x960fffff] Oct 2 20:22:08.554071 kernel: pci 0000:00:1c.1: PCI bridge to [bus 07-08] Oct 2 20:22:08.554112 kernel: pci 0000:00:1c.1: bridge window [io 0x3000-0x3fff] Oct 2 20:22:08.554153 kernel: pci 0000:00:1c.1: bridge window [mem 0x95000000-0x960fffff] Oct 2 20:22:08.554190 kernel: pci_bus 0000:00: Some PCI device resources are unassigned, try booting with pci=realloc Oct 2 20:22:08.554226 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Oct 2 20:22:08.554261 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Oct 2 20:22:08.554296 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Oct 2 20:22:08.554331 kernel: pci_bus 0000:00: resource 7 [mem 0x7f800000-0xdfffffff window] Oct 2 20:22:08.554366 kernel: pci_bus 0000:00: resource 8 [mem 0xfc800000-0xfe7fffff window] Oct 2 20:22:08.554408 kernel: pci_bus 0000:02: resource 1 [mem 0x96100000-0x962fffff] Oct 2 20:22:08.554448 kernel: pci_bus 0000:02: resource 2 [mem 0x90000000-0x93ffffff 64bit pref] Oct 2 20:22:08.554490 kernel: pci_bus 0000:04: resource 0 [io 0x5000-0x5fff] Oct 2 20:22:08.554553 kernel: pci_bus 0000:04: resource 1 [mem 0x96400000-0x964fffff] Oct 2 20:22:08.554594 kernel: pci_bus 0000:05: resource 0 [io 0x4000-0x4fff] Oct 2 20:22:08.554632 kernel: pci_bus 0000:05: resource 1 [mem 0x96300000-0x963fffff] Oct 2 20:22:08.554673 kernel: pci_bus 0000:07: resource 0 [io 0x3000-0x3fff] Oct 2 20:22:08.554713 kernel: pci_bus 0000:07: resource 1 [mem 0x95000000-0x960fffff] Oct 2 20:22:08.554753 kernel: pci_bus 0000:08: resource 0 [io 0x3000-0x3fff] Oct 2 20:22:08.554793 kernel: pci_bus 0000:08: resource 1 [mem 0x95000000-0x960fffff] Oct 2 20:22:08.554800 kernel: PCI: CLS 64 bytes, default 64 Oct 2 20:22:08.554805 kernel: DMAR: No ATSR found Oct 2 20:22:08.554811 kernel: DMAR: No SATC found Oct 2 20:22:08.554816 kernel: DMAR: IOMMU feature fl1gp_support inconsistent Oct 2 20:22:08.554821 kernel: DMAR: IOMMU feature pgsel_inv inconsistent Oct 2 20:22:08.554828 kernel: DMAR: IOMMU feature nwfs inconsistent Oct 2 20:22:08.554833 kernel: DMAR: IOMMU feature pasid inconsistent Oct 2 20:22:08.554839 kernel: DMAR: IOMMU feature eafs inconsistent Oct 2 20:22:08.554844 kernel: DMAR: IOMMU feature prs inconsistent Oct 2 20:22:08.554849 kernel: DMAR: IOMMU feature nest inconsistent Oct 2 20:22:08.554854 kernel: DMAR: IOMMU feature mts inconsistent Oct 2 20:22:08.554860 kernel: DMAR: IOMMU feature sc_support inconsistent Oct 2 20:22:08.554865 kernel: DMAR: IOMMU feature dev_iotlb_support inconsistent Oct 2 20:22:08.554870 kernel: DMAR: dmar0: Using Queued invalidation Oct 2 20:22:08.554876 kernel: DMAR: dmar1: Using Queued invalidation Oct 2 20:22:08.554918 kernel: pci 0000:00:00.0: Adding to iommu group 0 Oct 2 20:22:08.554960 kernel: pci 0000:00:01.0: Adding to iommu group 1 Oct 2 20:22:08.555001 kernel: pci 0000:00:01.1: Adding to iommu group 1 Oct 2 20:22:08.555042 kernel: pci 0000:00:02.0: Adding to iommu group 2 Oct 2 20:22:08.555083 kernel: pci 0000:00:08.0: Adding to iommu group 3 Oct 2 20:22:08.555125 kernel: pci 0000:00:12.0: Adding to iommu group 4 Oct 2 20:22:08.555166 kernel: pci 0000:00:14.0: Adding to iommu group 5 Oct 2 20:22:08.555209 kernel: pci 0000:00:14.2: Adding to iommu group 5 Oct 2 20:22:08.555249 kernel: pci 0000:00:15.0: Adding to iommu group 6 Oct 2 20:22:08.555288 kernel: pci 0000:00:15.1: Adding to iommu group 6 Oct 2 20:22:08.555329 kernel: pci 0000:00:16.0: Adding to iommu group 7 Oct 2 20:22:08.555369 kernel: pci 0000:00:16.1: Adding to iommu group 7 Oct 2 20:22:08.555410 kernel: pci 0000:00:16.4: Adding to iommu group 7 Oct 2 20:22:08.555450 kernel: pci 0000:00:17.0: Adding to iommu group 8 Oct 2 20:22:08.555491 kernel: pci 0000:00:1b.0: Adding to iommu group 9 Oct 2 20:22:08.555536 kernel: pci 0000:00:1b.4: Adding to iommu group 10 Oct 2 20:22:08.555578 kernel: pci 0000:00:1b.5: Adding to iommu group 11 Oct 2 20:22:08.555618 kernel: pci 0000:00:1c.0: Adding to iommu group 12 Oct 2 20:22:08.555658 kernel: pci 0000:00:1c.1: Adding to iommu group 13 Oct 2 20:22:08.555699 kernel: pci 0000:00:1e.0: Adding to iommu group 14 Oct 2 20:22:08.555758 kernel: pci 0000:00:1f.0: Adding to iommu group 15 Oct 2 20:22:08.555798 kernel: pci 0000:00:1f.4: Adding to iommu group 15 Oct 2 20:22:08.555837 kernel: pci 0000:00:1f.5: Adding to iommu group 15 Oct 2 20:22:08.555879 kernel: pci 0000:02:00.0: Adding to iommu group 1 Oct 2 20:22:08.555922 kernel: pci 0000:02:00.1: Adding to iommu group 1 Oct 2 20:22:08.555964 kernel: pci 0000:04:00.0: Adding to iommu group 16 Oct 2 20:22:08.556006 kernel: pci 0000:05:00.0: Adding to iommu group 17 Oct 2 20:22:08.556048 kernel: pci 0000:07:00.0: Adding to iommu group 18 Oct 2 20:22:08.556091 kernel: pci 0000:08:00.0: Adding to iommu group 18 Oct 2 20:22:08.556098 kernel: DMAR: Intel(R) Virtualization Technology for Directed I/O Oct 2 20:22:08.556104 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) Oct 2 20:22:08.556110 kernel: software IO TLB: mapped [mem 0x0000000073fc5000-0x0000000077fc5000] (64MB) Oct 2 20:22:08.556116 kernel: RAPL PMU: API unit is 2^-32 Joules, 4 fixed counters, 655360 ms ovfl timer Oct 2 20:22:08.556121 kernel: RAPL PMU: hw unit of domain pp0-core 2^-14 Joules Oct 2 20:22:08.556126 kernel: RAPL PMU: hw unit of domain package 2^-14 Joules Oct 2 20:22:08.556131 kernel: RAPL PMU: hw unit of domain dram 2^-14 Joules Oct 2 20:22:08.556136 kernel: RAPL PMU: hw unit of domain pp1-gpu 2^-14 Joules Oct 2 20:22:08.556181 kernel: platform rtc_cmos: registered platform RTC device (no PNP device found) Oct 2 20:22:08.556189 kernel: Initialise system trusted keyrings Oct 2 20:22:08.556195 kernel: workingset: timestamp_bits=39 max_order=23 bucket_order=0 Oct 2 20:22:08.556200 kernel: Key type asymmetric registered Oct 2 20:22:08.556205 kernel: Asymmetric key parser 'x509' registered Oct 2 20:22:08.556210 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Oct 2 20:22:08.556216 kernel: io scheduler mq-deadline registered Oct 2 20:22:08.556221 kernel: io scheduler kyber registered Oct 2 20:22:08.556226 kernel: io scheduler bfq registered Oct 2 20:22:08.556267 kernel: pcieport 0000:00:01.0: PME: Signaling with IRQ 122 Oct 2 20:22:08.556307 kernel: pcieport 0000:00:01.1: PME: Signaling with IRQ 123 Oct 2 20:22:08.556350 kernel: pcieport 0000:00:1b.0: PME: Signaling with IRQ 124 Oct 2 20:22:08.556391 kernel: pcieport 0000:00:1b.4: PME: Signaling with IRQ 125 Oct 2 20:22:08.556431 kernel: pcieport 0000:00:1b.5: PME: Signaling with IRQ 126 Oct 2 20:22:08.556470 kernel: pcieport 0000:00:1c.0: PME: Signaling with IRQ 127 Oct 2 20:22:08.556534 kernel: pcieport 0000:00:1c.1: PME: Signaling with IRQ 128 Oct 2 20:22:08.556600 kernel: thermal LNXTHERM:00: registered as thermal_zone0 Oct 2 20:22:08.556607 kernel: ACPI: thermal: Thermal Zone [TZ00] (28 C) Oct 2 20:22:08.556614 kernel: ERST: Error Record Serialization Table (ERST) support is initialized. Oct 2 20:22:08.556619 kernel: pstore: Registered erst as persistent store backend Oct 2 20:22:08.556624 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Oct 2 20:22:08.556630 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 2 20:22:08.556635 kernel: 00:02: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Oct 2 20:22:08.556640 kernel: 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A Oct 2 20:22:08.556680 kernel: tpm_tis MSFT0101:00: 2.0 TPM (device-id 0x1B, rev-id 16) Oct 2 20:22:08.556687 kernel: i8042: PNP: No PS/2 controller found. Oct 2 20:22:08.556726 kernel: rtc_cmos rtc_cmos: RTC can wake from S4 Oct 2 20:22:08.556762 kernel: rtc_cmos rtc_cmos: registered as rtc0 Oct 2 20:22:08.556799 kernel: rtc_cmos rtc_cmos: setting system clock to 2023-10-02T20:22:07 UTC (1696278127) Oct 2 20:22:08.556835 kernel: rtc_cmos rtc_cmos: alarms up to one month, y3k, 114 bytes nvram Oct 2 20:22:08.556842 kernel: fail to initialize ptp_kvm Oct 2 20:22:08.556848 kernel: intel_pstate: Intel P-state driver initializing Oct 2 20:22:08.556853 kernel: intel_pstate: Disabling energy efficiency optimization Oct 2 20:22:08.556858 kernel: intel_pstate: HWP enabled Oct 2 20:22:08.556865 kernel: vesafb: mode is 1024x768x8, linelength=1024, pages=0 Oct 2 20:22:08.556870 kernel: vesafb: scrolling: redraw Oct 2 20:22:08.556875 kernel: vesafb: Pseudocolor: size=0:8:8:8, shift=0:0:0:0 Oct 2 20:22:08.556880 kernel: vesafb: framebuffer at 0x95000000, mapped to 0x000000003d17c20e, using 768k, total 768k Oct 2 20:22:08.556885 kernel: Console: switching to colour frame buffer device 128x48 Oct 2 20:22:08.556890 kernel: fb0: VESA VGA frame buffer device Oct 2 20:22:08.556896 kernel: NET: Registered PF_INET6 protocol family Oct 2 20:22:08.556901 kernel: Segment Routing with IPv6 Oct 2 20:22:08.556906 kernel: In-situ OAM (IOAM) with IPv6 Oct 2 20:22:08.556911 kernel: NET: Registered PF_PACKET protocol family Oct 2 20:22:08.556917 kernel: Key type dns_resolver registered Oct 2 20:22:08.556922 kernel: microcode: sig=0x906ed, pf=0x2, revision=0xf4 Oct 2 20:22:08.556927 kernel: microcode: Microcode Update Driver: v2.2. Oct 2 20:22:08.556932 kernel: IPI shorthand broadcast: enabled Oct 2 20:22:08.556937 kernel: sched_clock: Marking stable (1848544553, 1360111987)->(4631838877, -1423182337) Oct 2 20:22:08.556943 kernel: registered taskstats version 1 Oct 2 20:22:08.556948 kernel: Loading compiled-in X.509 certificates Oct 2 20:22:08.556953 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.15.132-flatcar: 6f9e51af8b3ef67eb6e93ecfe77d55665ad3d861' Oct 2 20:22:08.556958 kernel: Key type .fscrypt registered Oct 2 20:22:08.556964 kernel: Key type fscrypt-provisioning registered Oct 2 20:22:08.556969 kernel: pstore: Using crash dump compression: deflate Oct 2 20:22:08.556974 kernel: ima: Allocated hash algorithm: sha1 Oct 2 20:22:08.556979 kernel: ima: No architecture policies found Oct 2 20:22:08.556984 kernel: Freeing unused kernel image (initmem) memory: 45372K Oct 2 20:22:08.556990 kernel: Write protecting the kernel read-only data: 28672k Oct 2 20:22:08.556995 kernel: Freeing unused kernel image (text/rodata gap) memory: 2040K Oct 2 20:22:08.557000 kernel: Freeing unused kernel image (rodata/data gap) memory: 644K Oct 2 20:22:08.557006 kernel: Run /init as init process Oct 2 20:22:08.557011 kernel: with arguments: Oct 2 20:22:08.557016 kernel: /init Oct 2 20:22:08.557021 kernel: with environment: Oct 2 20:22:08.557026 kernel: HOME=/ Oct 2 20:22:08.557031 kernel: TERM=linux Oct 2 20:22:08.557036 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Oct 2 20:22:08.557043 systemd[1]: systemd 252 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL -ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE -TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified) Oct 2 20:22:08.557050 systemd[1]: Detected architecture x86-64. Oct 2 20:22:08.557056 systemd[1]: Running in initrd. Oct 2 20:22:08.557061 systemd[1]: No hostname configured, using default hostname. Oct 2 20:22:08.557066 systemd[1]: Hostname set to . Oct 2 20:22:08.557071 systemd[1]: Initializing machine ID from random generator. Oct 2 20:22:08.557077 systemd[1]: Queued start job for default target initrd.target. Oct 2 20:22:08.557082 systemd[1]: Started systemd-ask-password-console.path. Oct 2 20:22:08.557087 systemd[1]: Reached target cryptsetup.target. Oct 2 20:22:08.557093 systemd[1]: Reached target paths.target. Oct 2 20:22:08.557099 systemd[1]: Reached target slices.target. Oct 2 20:22:08.557104 systemd[1]: Reached target swap.target. Oct 2 20:22:08.557109 systemd[1]: Reached target timers.target. Oct 2 20:22:08.557115 systemd[1]: Listening on iscsid.socket. Oct 2 20:22:08.557121 systemd[1]: Listening on iscsiuio.socket. Oct 2 20:22:08.557126 systemd[1]: Listening on systemd-journald-audit.socket. Oct 2 20:22:08.557131 systemd[1]: Listening on systemd-journald-dev-log.socket. Oct 2 20:22:08.557137 systemd[1]: Listening on systemd-journald.socket. Oct 2 20:22:08.557143 systemd[1]: Listening on systemd-networkd.socket. Oct 2 20:22:08.557148 kernel: tsc: Refined TSC clocksource calibration: 3408.089 MHz Oct 2 20:22:08.557153 systemd[1]: Listening on systemd-udevd-control.socket. Oct 2 20:22:08.557159 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x312028a4a72, max_idle_ns: 440795370714 ns Oct 2 20:22:08.557164 kernel: clocksource: Switched to clocksource tsc Oct 2 20:22:08.557169 systemd[1]: Listening on systemd-udevd-kernel.socket. Oct 2 20:22:08.557175 systemd[1]: Reached target sockets.target. Oct 2 20:22:08.557180 systemd[1]: Starting kmod-static-nodes.service... Oct 2 20:22:08.557186 systemd[1]: Finished network-cleanup.service. Oct 2 20:22:08.557192 systemd[1]: Starting systemd-fsck-usr.service... Oct 2 20:22:08.557197 systemd[1]: Starting systemd-journald.service... Oct 2 20:22:08.557202 systemd[1]: Starting systemd-modules-load.service... Oct 2 20:22:08.557210 systemd-journald[269]: Journal started Oct 2 20:22:08.557235 systemd-journald[269]: Runtime Journal (/run/log/journal/da3135c1b8fd4e85af9f6b3afb1ce3cb) is 8.0M, max 639.3M, 631.3M free. Oct 2 20:22:08.560225 systemd-modules-load[270]: Inserted module 'overlay' Oct 2 20:22:08.618639 kernel: audit: type=1334 audit(1696278128.565:2): prog-id=6 op=LOAD Oct 2 20:22:08.618649 systemd[1]: Starting systemd-resolved.service... Oct 2 20:22:08.618657 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Oct 2 20:22:08.565000 audit: BPF prog-id=6 op=LOAD Oct 2 20:22:08.651560 kernel: Bridge firewalling registered Oct 2 20:22:08.651575 systemd[1]: Starting systemd-vconsole-setup.service... Oct 2 20:22:08.666540 systemd-modules-load[270]: Inserted module 'br_netfilter' Oct 2 20:22:08.672332 systemd-resolved[272]: Positive Trust Anchors: Oct 2 20:22:08.724292 kernel: SCSI subsystem initialized Oct 2 20:22:08.724303 systemd[1]: Started systemd-journald.service. Oct 2 20:22:08.724312 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Oct 2 20:22:08.672338 systemd-resolved[272]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 2 20:22:08.819533 kernel: device-mapper: uevent: version 1.0.3 Oct 2 20:22:08.819547 kernel: device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com Oct 2 20:22:08.819555 kernel: audit: type=1130 audit(1696278128.775:3): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:08.775000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:08.672358 systemd-resolved[272]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test Oct 2 20:22:08.917707 kernel: audit: type=1130 audit(1696278128.826:4): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:08.826000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:08.673930 systemd-resolved[272]: Defaulting to hostname 'linux'. Oct 2 20:22:08.924000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:08.777313 systemd[1]: Started systemd-resolved.service. Oct 2 20:22:09.026723 kernel: audit: type=1130 audit(1696278128.924:5): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:09.026737 kernel: audit: type=1130 audit(1696278128.975:6): 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' Oct 2 20:22:08.975000 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' Oct 2 20:22:08.819982 systemd-modules-load[270]: Inserted module 'dm_multipath' Oct 2 20:22:09.088715 kernel: audit: type=1130 audit(1696278129.034:7): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:09.034000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:08.827812 systemd[1]: Finished kmod-static-nodes.service. Oct 2 20:22:09.150717 kernel: audit: type=1130 audit(1696278129.096:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:09.096000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:08.925892 systemd[1]: Finished systemd-fsck-usr.service. Oct 2 20:22:08.976757 systemd[1]: Finished systemd-modules-load.service. Oct 2 20:22:09.035790 systemd[1]: Finished systemd-vconsole-setup.service. Oct 2 20:22:09.097789 systemd[1]: Reached target nss-lookup.target. Oct 2 20:22:09.160162 systemd[1]: Starting dracut-cmdline-ask.service... Oct 2 20:22:09.181266 systemd[1]: Starting systemd-sysctl.service... Oct 2 20:22:09.181632 systemd[1]: Starting systemd-tmpfiles-setup-dev.service... Oct 2 20:22:09.184621 systemd[1]: Finished systemd-tmpfiles-setup-dev.service. Oct 2 20:22:09.183000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:09.185342 systemd[1]: Finished systemd-sysctl.service. Oct 2 20:22:09.302786 kernel: audit: type=1130 audit(1696278129.183:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:09.302803 kernel: audit: type=1130 audit(1696278129.246:10): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:09.246000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:09.247840 systemd[1]: Finished dracut-cmdline-ask.service. Oct 2 20:22:09.310000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:09.312351 systemd[1]: Starting dracut-cmdline.service... Oct 2 20:22:09.333616 dracut-cmdline[294]: dracut-dracut-053 Oct 2 20:22:09.333616 dracut-cmdline[294]: 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=LA Oct 2 20:22:09.333616 dracut-cmdline[294]: BEL=ROOT console=tty0 console=ttyS1,115200n8 flatcar.first_boot=detected flatcar.oem.id=packet flatcar.autologin verity.usrhash=96b0fdb9f11bf1422adc9955c78c8182df387766badfd0b94e08fb9688739ee1 Oct 2 20:22:09.401576 kernel: Loading iSCSI transport class v2.0-870. Oct 2 20:22:09.401590 kernel: iscsi: registered transport (tcp) Oct 2 20:22:09.451726 kernel: iscsi: registered transport (qla4xxx) Oct 2 20:22:09.451771 kernel: QLogic iSCSI HBA Driver Oct 2 20:22:09.467679 systemd[1]: Finished dracut-cmdline.service. Oct 2 20:22:09.474000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:09.476267 systemd[1]: Starting dracut-pre-udev.service... Oct 2 20:22:09.531591 kernel: raid6: avx2x4 gen() 45799 MB/s Oct 2 20:22:09.566539 kernel: raid6: avx2x4 xor() 21809 MB/s Oct 2 20:22:09.601592 kernel: raid6: avx2x2 gen() 53834 MB/s Oct 2 20:22:09.636539 kernel: raid6: avx2x2 xor() 32078 MB/s Oct 2 20:22:09.671587 kernel: raid6: avx2x1 gen() 45227 MB/s Oct 2 20:22:09.706592 kernel: raid6: avx2x1 xor() 27766 MB/s Oct 2 20:22:09.740539 kernel: raid6: sse2x4 gen() 21354 MB/s Oct 2 20:22:09.774539 kernel: raid6: sse2x4 xor() 12009 MB/s Oct 2 20:22:09.808591 kernel: raid6: sse2x2 gen() 21653 MB/s Oct 2 20:22:09.842539 kernel: raid6: sse2x2 xor() 13434 MB/s Oct 2 20:22:09.876594 kernel: raid6: sse2x1 gen() 18247 MB/s Oct 2 20:22:09.927860 kernel: raid6: sse2x1 xor() 8924 MB/s Oct 2 20:22:09.927875 kernel: raid6: using algorithm avx2x2 gen() 53834 MB/s Oct 2 20:22:09.927883 kernel: raid6: .... xor() 32078 MB/s, rmw enabled Oct 2 20:22:09.945778 kernel: raid6: using avx2x2 recovery algorithm Oct 2 20:22:09.991508 kernel: xor: automatically using best checksumming function avx Oct 2 20:22:10.069509 kernel: Btrfs loaded, crc32c=crc32c-intel, zoned=no, fsverity=no Oct 2 20:22:10.074858 systemd[1]: Finished dracut-pre-udev.service. Oct 2 20:22:10.081000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-udev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:10.081000 audit: BPF prog-id=7 op=LOAD Oct 2 20:22:10.081000 audit: BPF prog-id=8 op=LOAD Oct 2 20:22:10.083517 systemd[1]: Starting systemd-udevd.service... Oct 2 20:22:10.091340 systemd-udevd[474]: Using default interface naming scheme 'v252'. Oct 2 20:22:10.110000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:10.097717 systemd[1]: Started systemd-udevd.service. Oct 2 20:22:10.135630 dracut-pre-trigger[486]: rd.md=0: removing MD RAID activation Oct 2 20:22:10.112155 systemd[1]: Starting dracut-pre-trigger.service... Oct 2 20:22:10.152000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:10.140105 systemd[1]: Finished dracut-pre-trigger.service. Oct 2 20:22:10.154695 systemd[1]: Starting systemd-udev-trigger.service... Oct 2 20:22:10.233628 systemd[1]: Finished systemd-udev-trigger.service. Oct 2 20:22:10.232000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:10.262517 kernel: cryptd: max_cpu_qlen set to 1000 Oct 2 20:22:10.268513 kernel: libata version 3.00 loaded. Oct 2 20:22:10.268550 kernel: ACPI: bus type USB registered Oct 2 20:22:10.302782 kernel: usbcore: registered new interface driver usbfs Oct 2 20:22:10.320483 kernel: usbcore: registered new interface driver hub Oct 2 20:22:10.320513 kernel: usbcore: registered new device driver usb Oct 2 20:22:10.338508 kernel: AVX2 version of gcm_enc/dec engaged. Oct 2 20:22:10.371541 kernel: AES CTR mode by8 optimization enabled Oct 2 20:22:10.372508 kernel: igb: Intel(R) Gigabit Ethernet Network Driver Oct 2 20:22:10.405935 kernel: igb: Copyright (c) 2007-2014 Intel Corporation. Oct 2 20:22:10.426730 kernel: ahci 0000:00:17.0: version 3.0 Oct 2 20:22:10.426827 kernel: ahci 0000:00:17.0: AHCI 0001.0301 32 slots 8 ports 6 Gbps 0xff impl SATA mode Oct 2 20:22:10.426889 kernel: mlx5_core 0000:02:00.0: firmware version: 14.29.2002 Oct 2 20:22:10.426952 kernel: ahci 0000:00:17.0: flags: 64bit ncq sntf clo only pio slum part ems deso sadm sds apst Oct 2 20:22:10.447513 kernel: mlx5_core 0000:02:00.0: 63.008 Gb/s available PCIe bandwidth (8.0 GT/s PCIe x8 link) Oct 2 20:22:10.447703 kernel: pps pps0: new PPS source ptp0 Oct 2 20:22:10.447890 kernel: igb 0000:04:00.0: added PHC on eth0 Oct 2 20:22:10.448073 kernel: igb 0000:04:00.0: Intel(R) Gigabit Ethernet Network Connection Oct 2 20:22:10.448263 kernel: igb 0000:04:00.0: eth0: (PCIe:2.5Gb/s:Width x1) 3c:ec:ef:73:1c:be Oct 2 20:22:10.448396 kernel: igb 0000:04:00.0: eth0: PBA No: 010000-000 Oct 2 20:22:10.448528 kernel: igb 0000:04:00.0: Using MSI-X interrupts. 4 rx queue(s), 4 tx queue(s) Oct 2 20:22:10.488506 kernel: scsi host0: ahci Oct 2 20:22:10.488535 kernel: pps pps1: new PPS source ptp1 Oct 2 20:22:10.488606 kernel: igb 0000:05:00.0: added PHC on eth1 Oct 2 20:22:10.488676 kernel: igb 0000:05:00.0: Intel(R) Gigabit Ethernet Network Connection Oct 2 20:22:10.488737 kernel: igb 0000:05:00.0: eth1: (PCIe:2.5Gb/s:Width x1) 3c:ec:ef:73:1c:bf Oct 2 20:22:10.488797 kernel: igb 0000:05:00.0: eth1: PBA No: 010000-000 Oct 2 20:22:10.488855 kernel: igb 0000:05:00.0: Using MSI-X interrupts. 4 rx queue(s), 4 tx queue(s) Oct 2 20:22:10.689006 kernel: scsi host1: ahci Oct 2 20:22:10.689137 kernel: scsi host2: ahci Oct 2 20:22:10.709119 kernel: scsi host3: ahci Oct 2 20:22:10.719010 kernel: scsi host4: ahci Oct 2 20:22:10.728796 kernel: scsi host5: ahci Oct 2 20:22:10.738568 kernel: scsi host6: ahci Oct 2 20:22:10.748365 kernel: scsi host7: ahci Oct 2 20:22:10.748454 kernel: mlx5_core 0000:02:00.0: E-Switch: Total vports 10, per vport: max uc(1024) max mc(16384) Oct 2 20:22:10.748522 kernel: ata1: SATA max UDMA/133 abar m2048@0x96516000 port 0x96516100 irq 134 Oct 2 20:22:10.794630 kernel: ata2: SATA max UDMA/133 abar m2048@0x96516000 port 0x96516180 irq 134 Oct 2 20:22:10.794652 kernel: ata3: SATA max UDMA/133 abar m2048@0x96516000 port 0x96516200 irq 134 Oct 2 20:22:10.824397 kernel: ata4: SATA max UDMA/133 abar m2048@0x96516000 port 0x96516280 irq 134 Oct 2 20:22:10.824419 kernel: ata5: SATA max UDMA/133 abar m2048@0x96516000 port 0x96516300 irq 134 Oct 2 20:22:10.854090 kernel: ata6: SATA max UDMA/133 abar m2048@0x96516000 port 0x96516380 irq 134 Oct 2 20:22:10.854111 kernel: ata7: SATA max UDMA/133 abar m2048@0x96516000 port 0x96516400 irq 134 Oct 2 20:22:10.883716 kernel: ata8: SATA max UDMA/133 abar m2048@0x96516000 port 0x96516480 irq 134 Oct 2 20:22:10.912540 kernel: mlx5_core 0000:02:00.0: MLX5E: StrdRq(0) RqSz(1024) StrdSz(256) RxCqeCmprss(0) Oct 2 20:22:11.144578 kernel: mlx5_core 0000:02:00.0: Supported tc offload range - chains: 4294967294, prios: 4294967295 Oct 2 20:22:11.189486 kernel: mlx5_core 0000:02:00.1: firmware version: 14.29.2002 Oct 2 20:22:11.189605 kernel: mlx5_core 0000:02:00.1: 63.008 Gb/s available PCIe bandwidth (8.0 GT/s PCIe x8 link) Oct 2 20:22:11.203507 kernel: ata8: SATA link down (SStatus 0 SControl 300) Oct 2 20:22:11.203524 kernel: ata4: SATA link down (SStatus 0 SControl 300) Oct 2 20:22:11.216506 kernel: ata7: SATA link down (SStatus 0 SControl 300) Oct 2 20:22:11.230538 kernel: ata6: SATA link down (SStatus 0 SControl 300) Oct 2 20:22:11.242533 kernel: ata2: SATA link up 6.0 Gbps (SStatus 133 SControl 300) Oct 2 20:22:11.256506 kernel: ata3: SATA link down (SStatus 0 SControl 300) Oct 2 20:22:11.269507 kernel: ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300) Oct 2 20:22:11.282508 kernel: ata5: SATA link down (SStatus 0 SControl 300) Oct 2 20:22:11.295506 kernel: ata2.00: ATA-11: Micron_5300_MTFDDAK480TDT, D3MU001, max UDMA/133 Oct 2 20:22:11.310538 kernel: ata1.00: ATA-11: Micron_5300_MTFDDAK480TDT, D3MU001, max UDMA/133 Oct 2 20:22:11.353271 kernel: ata2.00: 937703088 sectors, multi 16: LBA48 NCQ (depth 32), AA Oct 2 20:22:11.353287 kernel: ata2.00: Features: NCQ-prio Oct 2 20:22:11.353295 kernel: ata1.00: 937703088 sectors, multi 16: LBA48 NCQ (depth 32), AA Oct 2 20:22:11.382539 kernel: ata1.00: Features: NCQ-prio Oct 2 20:22:11.398567 kernel: ata2.00: configured for UDMA/133 Oct 2 20:22:11.398582 kernel: ata1.00: configured for UDMA/133 Oct 2 20:22:11.409570 kernel: scsi 0:0:0:0: Direct-Access ATA Micron_5300_MTFD U001 PQ: 0 ANSI: 5 Oct 2 20:22:11.424508 kernel: scsi 1:0:0:0: Direct-Access ATA Micron_5300_MTFD U001 PQ: 0 ANSI: 5 Oct 2 20:22:11.452507 kernel: igb 0000:05:00.0 eno2: renamed from eth1 Oct 2 20:22:11.452585 kernel: xhci_hcd 0000:00:14.0: xHCI Host Controller Oct 2 20:22:11.480942 kernel: mlx5_core 0000:02:00.1: E-Switch: Total vports 10, per vport: max uc(1024) max mc(16384) Oct 2 20:22:11.481035 kernel: xhci_hcd 0000:00:14.0: new USB bus registered, assigned bus number 1 Oct 2 20:22:11.496540 kernel: port_module: 9 callbacks suppressed Oct 2 20:22:11.496578 kernel: mlx5_core 0000:02:00.1: Port module event: module 1, Cable plugged Oct 2 20:22:11.507375 kernel: xhci_hcd 0000:00:14.0: hcc params 0x200077c1 hci version 0x110 quirks 0x0000000000009810 Oct 2 20:22:11.552065 kernel: xhci_hcd 0000:00:14.0: xHCI Host Controller Oct 2 20:22:11.552133 kernel: xhci_hcd 0000:00:14.0: new USB bus registered, assigned bus number 2 Oct 2 20:22:11.566885 kernel: xhci_hcd 0000:00:14.0: Host supports USB 3.1 Enhanced SuperSpeed Oct 2 20:22:11.592624 kernel: hub 1-0:1.0: USB hub found Oct 2 20:22:11.592706 kernel: igb 0000:04:00.0 eno1: renamed from eth0 Oct 2 20:22:11.592763 kernel: hub 1-0:1.0: 16 ports detected Oct 2 20:22:11.617507 kernel: ata1.00: Enabling discard_zeroes_data Oct 2 20:22:11.629859 kernel: hub 2-0:1.0: USB hub found Oct 2 20:22:11.629936 kernel: ata2.00: Enabling discard_zeroes_data Oct 2 20:22:11.654355 kernel: hub 2-0:1.0: 10 ports detected Oct 2 20:22:11.654436 kernel: sd 1:0:0:0: [sdb] 937703088 512-byte logical blocks: (480 GB/447 GiB) Oct 2 20:22:11.654522 kernel: sd 0:0:0:0: [sda] 937703088 512-byte logical blocks: (480 GB/447 GiB) Oct 2 20:22:11.654599 kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks Oct 2 20:22:11.654658 kernel: sd 0:0:0:0: [sda] Write Protect is off Oct 2 20:22:11.654723 kernel: sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00 Oct 2 20:22:11.654775 kernel: sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Oct 2 20:22:11.654826 kernel: ata1.00: Enabling discard_zeroes_data Oct 2 20:22:11.656545 kernel: mlx5_core 0000:02:00.1: MLX5E: StrdRq(0) RqSz(1024) StrdSz(256) RxCqeCmprss(0) Oct 2 20:22:11.656616 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Oct 2 20:22:11.656625 kernel: GPT:9289727 != 937703087 Oct 2 20:22:11.656633 kernel: GPT:Alternate GPT header not at the end of the disk. Oct 2 20:22:11.656640 kernel: GPT:9289727 != 937703087 Oct 2 20:22:11.656646 kernel: GPT: Use GNU Parted to correct GPT errors. Oct 2 20:22:11.656652 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Oct 2 20:22:11.657546 kernel: ata1.00: Enabling discard_zeroes_data Oct 2 20:22:11.657560 kernel: sd 0:0:0:0: [sda] Attached SCSI disk Oct 2 20:22:11.697316 kernel: usb: port power management may be unreliable Oct 2 20:22:11.697331 kernel: sd 1:0:0:0: [sdb] 4096-byte physical blocks Oct 2 20:22:11.855554 kernel: mlx5_core 0000:02:00.1: Supported tc offload range - chains: 4294967294, prios: 4294967295 Oct 2 20:22:11.855630 kernel: sd 1:0:0:0: [sdb] Write Protect is off Oct 2 20:22:11.860575 kernel: usb 1-14: new high-speed USB device number 2 using xhci_hcd Oct 2 20:22:11.977419 kernel: sd 1:0:0:0: [sdb] Mode Sense: 00 3a 00 00 Oct 2 20:22:11.977500 kernel: sd 1:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Oct 2 20:22:11.977570 kernel: ata2.00: Enabling discard_zeroes_data Oct 2 20:22:11.991985 kernel: hub 1-14:1.0: USB hub found Oct 2 20:22:12.019674 kernel: ata2.00: Enabling discard_zeroes_data Oct 2 20:22:12.019689 kernel: hub 1-14:1.0: 4 ports detected Oct 2 20:22:12.019760 kernel: sd 1:0:0:0: [sdb] Attached SCSI disk Oct 2 20:22:12.065549 kernel: mlx5_core 0000:02:00.1 enp2s0f1np1: renamed from eth0 Oct 2 20:22:12.078648 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device. Oct 2 20:22:12.123769 kernel: mlx5_core 0000:02:00.0 enp2s0f0np0: renamed from eth2 Oct 2 20:22:12.123852 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/sda6 scanned by (udev-worker) (535) Oct 2 20:22:12.122540 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device. Oct 2 20:22:12.133610 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device. Oct 2 20:22:12.157943 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device. Oct 2 20:22:12.179513 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. Oct 2 20:22:12.197267 systemd[1]: Starting disk-uuid.service... Oct 2 20:22:12.242637 kernel: ata1.00: Enabling discard_zeroes_data Oct 2 20:22:12.242662 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Oct 2 20:22:12.242767 disk-uuid[682]: Primary Header is updated. Oct 2 20:22:12.242767 disk-uuid[682]: Secondary Entries is updated. Oct 2 20:22:12.242767 disk-uuid[682]: Secondary Header is updated. Oct 2 20:22:12.297594 kernel: ata1.00: Enabling discard_zeroes_data Oct 2 20:22:12.297604 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Oct 2 20:22:12.297611 kernel: ata1.00: Enabling discard_zeroes_data Oct 2 20:22:12.319547 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Oct 2 20:22:12.342580 kernel: usb 1-14.1: new low-speed USB device number 3 using xhci_hcd Oct 2 20:22:12.483558 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 2 20:22:12.517853 kernel: usbcore: registered new interface driver usbhid Oct 2 20:22:12.517873 kernel: usbhid: USB HID core driver Oct 2 20:22:12.551684 kernel: input: HID 0557:2419 as /devices/pci0000:00/0000:00:14.0/usb1/1-14/1-14.1/1-14.1:1.0/0003:0557:2419.0001/input/input0 Oct 2 20:22:12.668833 kernel: hid-generic 0003:0557:2419.0001: input,hidraw0: USB HID v1.00 Keyboard [HID 0557:2419] on usb-0000:00:14.0-14.1/input0 Oct 2 20:22:12.668957 kernel: input: HID 0557:2419 as /devices/pci0000:00/0000:00:14.0/usb1/1-14/1-14.1/1-14.1:1.1/0003:0557:2419.0002/input/input1 Oct 2 20:22:12.668966 kernel: hid-generic 0003:0557:2419.0002: input,hidraw1: USB HID v1.00 Mouse [HID 0557:2419] on usb-0000:00:14.0-14.1/input1 Oct 2 20:22:13.303537 kernel: ata1.00: Enabling discard_zeroes_data Oct 2 20:22:13.323457 disk-uuid[683]: The operation has completed successfully. Oct 2 20:22:13.331626 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Oct 2 20:22:13.364068 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 2 20:22:13.462328 kernel: audit: type=1130 audit(1696278133.370:19): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=disk-uuid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:13.462343 kernel: audit: type=1131 audit(1696278133.370:20): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=disk-uuid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:13.370000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=disk-uuid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:13.370000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=disk-uuid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:13.364111 systemd[1]: Finished disk-uuid.service. Oct 2 20:22:13.492604 kernel: device-mapper: verity: sha256 using implementation "sha256-generic" Oct 2 20:22:13.380042 systemd[1]: Starting verity-setup.service... Oct 2 20:22:13.585120 systemd[1]: Found device dev-mapper-usr.device. Oct 2 20:22:13.597022 systemd[1]: Mounting sysusr-usr.mount... Oct 2 20:22:13.609239 systemd[1]: Finished verity-setup.service. Oct 2 20:22:13.622000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=verity-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:13.671517 kernel: audit: type=1130 audit(1696278133.622:21): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=verity-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:13.730080 systemd[1]: Mounted sysusr-usr.mount. Oct 2 20:22:13.744639 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: norecovery. Quota mode: none. Oct 2 20:22:13.737796 systemd[1]: afterburn-network-kargs.service was skipped because no trigger condition checks were met. Oct 2 20:22:13.827998 kernel: BTRFS info (device sda6): using crc32c (crc32c-intel) checksum algorithm Oct 2 20:22:13.828016 kernel: BTRFS info (device sda6): using free space tree Oct 2 20:22:13.828024 kernel: BTRFS info (device sda6): has skinny extents Oct 2 20:22:13.828030 kernel: BTRFS info (device sda6): enabling ssd optimizations Oct 2 20:22:13.738192 systemd[1]: Starting ignition-setup.service... Oct 2 20:22:13.759940 systemd[1]: Starting parse-ip-for-networkd.service... Oct 2 20:22:13.851000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:13.835945 systemd[1]: Finished ignition-setup.service. Oct 2 20:22:13.958308 kernel: audit: type=1130 audit(1696278133.851:22): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:13.958397 kernel: audit: type=1130 audit(1696278133.907:23): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=parse-ip-for-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:13.907000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=parse-ip-for-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:13.852848 systemd[1]: Finished parse-ip-for-networkd.service. Oct 2 20:22:13.989391 kernel: audit: type=1334 audit(1696278133.965:24): prog-id=9 op=LOAD Oct 2 20:22:13.965000 audit: BPF prog-id=9 op=LOAD Oct 2 20:22:13.909168 systemd[1]: Starting ignition-fetch-offline.service... Oct 2 20:22:13.967300 systemd[1]: Starting systemd-networkd.service... Oct 2 20:22:14.003090 systemd-networkd[867]: lo: Link UP Oct 2 20:22:14.016000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:14.045319 ignition[862]: Ignition 2.14.0 Oct 2 20:22:14.082752 kernel: audit: type=1130 audit(1696278134.016:25): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:14.003092 systemd-networkd[867]: lo: Gained carrier Oct 2 20:22:14.045324 ignition[862]: Stage: fetch-offline Oct 2 20:22:14.003415 systemd-networkd[867]: Enumeration completed Oct 2 20:22:14.154548 kernel: audit: type=1130 audit(1696278134.103:26): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=iscsiuio comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:14.103000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=iscsiuio comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:14.045351 ignition[862]: reading system config file "/usr/lib/ignition/base.d/base.ign" Oct 2 20:22:14.253633 kernel: audit: type=1130 audit(1696278134.161:27): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch-offline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:14.253663 kernel: mlx5_core 0000:02:00.1 enp2s0f1np1: Link up Oct 2 20:22:14.253936 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): enp2s0f1np1: link becomes ready Oct 2 20:22:14.161000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch-offline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:14.003485 systemd[1]: Started systemd-networkd.service. Oct 2 20:22:14.045365 ignition[862]: parsing config with SHA512: 0131bd505bfe1b1215ca4ec9809701a3323bf448114294874f7249d8d300440bd742a7532f60673bfa0746c04de0bd5ca68d0fe9a8ecd59464b13a6401323cb4 Oct 2 20:22:14.004261 systemd-networkd[867]: enp2s0f1np1: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 2 20:22:14.051814 ignition[862]: no config dir at "/usr/lib/ignition/base.platform.d/packet" Oct 2 20:22:14.017694 systemd[1]: Reached target network.target. Oct 2 20:22:14.309000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=iscsid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:14.051882 ignition[862]: parsed url from cmdline: "" Oct 2 20:22:14.052954 unknown[862]: fetched base config from "system" Oct 2 20:22:14.331711 iscsid[889]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Oct 2 20:22:14.331711 iscsid[889]: iscsid: Warning: InitiatorName file /etc/iscsi/initiatorname.iscsi does not exist or does not contain a properly formatted InitiatorName. If using software iscsi (iscsi_tcp or ib_iser) or partial offload (bnx2i or cxgbi iscsi), you may not be able to log Oct 2 20:22:14.331711 iscsid[889]: into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier]. Oct 2 20:22:14.331711 iscsid[889]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Oct 2 20:22:14.331711 iscsid[889]: If using hardware iscsi like qla4xxx this message can be ignored. Oct 2 20:22:14.331711 iscsid[889]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Oct 2 20:22:14.331711 iscsid[889]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Oct 2 20:22:14.376000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:14.051884 ignition[862]: no config URL provided Oct 2 20:22:14.052958 unknown[862]: fetched user config from "system" Oct 2 20:22:14.515689 kernel: mlx5_core 0000:02:00.0 enp2s0f0np0: Link up Oct 2 20:22:14.507000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:14.051887 ignition[862]: reading system config file "/usr/lib/ignition/user.ign" Oct 2 20:22:14.077189 systemd[1]: Starting iscsiuio.service... Oct 2 20:22:14.051900 ignition[862]: parsing config with SHA512: 25af43c3edd8492679ee7b5750a3c388a8b52c9f71b3376493d07c0ca44a60a90453eeaefc383e3e8f470d384b6cd943a5819a7c923fdc4d083cc27a1fb85ea6 Oct 2 20:22:14.082876 systemd[1]: Started iscsiuio.service. Oct 2 20:22:14.053091 ignition[862]: fetch-offline: fetch-offline passed Oct 2 20:22:14.104904 systemd[1]: Finished ignition-fetch-offline.service. Oct 2 20:22:14.053094 ignition[862]: POST message to Packet Timeline Oct 2 20:22:14.162866 systemd[1]: ignition-fetch.service was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Oct 2 20:22:14.053099 ignition[862]: POST Status error: resource requires networking Oct 2 20:22:14.163599 systemd[1]: Starting ignition-kargs.service... Oct 2 20:22:14.053130 ignition[862]: Ignition finished successfully Oct 2 20:22:14.237037 systemd-networkd[867]: enp2s0f0np0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 2 20:22:14.240493 ignition[877]: Ignition 2.14.0 Oct 2 20:22:14.275075 systemd[1]: Starting iscsid.service... Oct 2 20:22:14.240496 ignition[877]: Stage: kargs Oct 2 20:22:14.292851 systemd[1]: Started iscsid.service. Oct 2 20:22:14.240605 ignition[877]: reading system config file "/usr/lib/ignition/base.d/base.ign" Oct 2 20:22:14.312673 systemd[1]: Starting dracut-initqueue.service... Oct 2 20:22:14.240615 ignition[877]: parsing config with SHA512: 0131bd505bfe1b1215ca4ec9809701a3323bf448114294874f7249d8d300440bd742a7532f60673bfa0746c04de0bd5ca68d0fe9a8ecd59464b13a6401323cb4 Oct 2 20:22:14.341282 systemd[1]: Finished dracut-initqueue.service. Oct 2 20:22:14.241941 ignition[877]: no config dir at "/usr/lib/ignition/base.platform.d/packet" Oct 2 20:22:14.377855 systemd[1]: Reached target remote-fs-pre.target. Oct 2 20:22:14.243250 ignition[877]: kargs: kargs passed Oct 2 20:22:14.406677 systemd[1]: Reached target remote-cryptsetup.target. Oct 2 20:22:14.243253 ignition[877]: POST message to Packet Timeline Oct 2 20:22:14.406848 systemd[1]: Reached target remote-fs.target. Oct 2 20:22:14.243263 ignition[877]: GET https://metadata.packet.net/metadata: attempt #1 Oct 2 20:22:14.431406 systemd[1]: Starting dracut-pre-mount.service... Oct 2 20:22:14.255076 ignition[877]: GET error: Get "https://metadata.packet.net/metadata": dial tcp: lookup metadata.packet.net on [::1]:53: read udp [::1]:50186->[::1]:53: read: connection refused Oct 2 20:22:14.465921 systemd[1]: Finished dracut-pre-mount.service. Oct 2 20:22:14.455534 ignition[877]: GET https://metadata.packet.net/metadata: attempt #2 Oct 2 20:22:14.502917 systemd-networkd[867]: eno2: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 2 20:22:14.455880 ignition[877]: GET error: Get "https://metadata.packet.net/metadata": dial tcp: lookup metadata.packet.net on [::1]:53: read udp [::1]:48338->[::1]:53: read: connection refused Oct 2 20:22:14.532340 systemd-networkd[867]: eno1: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 2 20:22:14.563068 systemd-networkd[867]: enp2s0f1np1: Link UP Oct 2 20:22:14.563476 systemd-networkd[867]: enp2s0f1np1: Gained carrier Oct 2 20:22:14.576003 systemd-networkd[867]: enp2s0f0np0: Link UP Oct 2 20:22:14.576357 systemd-networkd[867]: eno2: Link UP Oct 2 20:22:14.576719 systemd-networkd[867]: eno1: Link UP Oct 2 20:22:14.856278 ignition[877]: GET https://metadata.packet.net/metadata: attempt #3 Oct 2 20:22:14.857448 ignition[877]: GET error: Get "https://metadata.packet.net/metadata": dial tcp: lookup metadata.packet.net on [::1]:53: read udp [::1]:41293->[::1]:53: read: connection refused Oct 2 20:22:15.272095 systemd-networkd[867]: enp2s0f0np0: Gained carrier Oct 2 20:22:15.280734 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): enp2s0f0np0: link becomes ready Oct 2 20:22:15.295710 systemd-networkd[867]: enp2s0f0np0: DHCPv4 address 139.178.90.63/31, gateway 139.178.90.62 acquired from 145.40.83.140 Oct 2 20:22:15.657887 ignition[877]: GET https://metadata.packet.net/metadata: attempt #4 Oct 2 20:22:15.659231 ignition[877]: GET error: Get "https://metadata.packet.net/metadata": dial tcp: lookup metadata.packet.net on [::1]:53: read udp [::1]:60402->[::1]:53: read: connection refused Oct 2 20:22:16.400978 systemd-networkd[867]: enp2s0f1np1: Gained IPv6LL Oct 2 20:22:16.912973 systemd-networkd[867]: enp2s0f0np0: Gained IPv6LL Oct 2 20:22:17.260847 ignition[877]: GET https://metadata.packet.net/metadata: attempt #5 Oct 2 20:22:17.261970 ignition[877]: GET error: Get "https://metadata.packet.net/metadata": dial tcp: lookup metadata.packet.net on [::1]:53: read udp [::1]:58619->[::1]:53: read: connection refused Oct 2 20:22:20.465433 ignition[877]: GET https://metadata.packet.net/metadata: attempt #6 Oct 2 20:22:20.503520 ignition[877]: GET result: OK Oct 2 20:22:20.803655 ignition[877]: Ignition finished successfully Oct 2 20:22:20.807894 systemd[1]: Finished ignition-kargs.service. Oct 2 20:22:20.895670 kernel: kauditd_printk_skb: 3 callbacks suppressed Oct 2 20:22:20.895686 kernel: audit: type=1130 audit(1696278140.817:31): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-kargs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:20.817000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-kargs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:20.828129 ignition[906]: Ignition 2.14.0 Oct 2 20:22:20.820928 systemd[1]: Starting ignition-disks.service... Oct 2 20:22:20.828132 ignition[906]: Stage: disks Oct 2 20:22:20.828188 ignition[906]: reading system config file "/usr/lib/ignition/base.d/base.ign" Oct 2 20:22:20.828197 ignition[906]: parsing config with SHA512: 0131bd505bfe1b1215ca4ec9809701a3323bf448114294874f7249d8d300440bd742a7532f60673bfa0746c04de0bd5ca68d0fe9a8ecd59464b13a6401323cb4 Oct 2 20:22:20.830854 ignition[906]: no config dir at "/usr/lib/ignition/base.platform.d/packet" Oct 2 20:22:20.831224 ignition[906]: disks: disks passed Oct 2 20:22:20.831227 ignition[906]: POST message to Packet Timeline Oct 2 20:22:20.831236 ignition[906]: GET https://metadata.packet.net/metadata: attempt #1 Oct 2 20:22:20.853252 ignition[906]: GET result: OK Oct 2 20:22:21.014369 ignition[906]: Ignition finished successfully Oct 2 20:22:21.017550 systemd[1]: Finished ignition-disks.service. Oct 2 20:22:21.094515 kernel: audit: type=1130 audit(1696278141.028:32): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-disks comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:21.028000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-disks comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:21.030173 systemd[1]: Reached target initrd-root-device.target. Oct 2 20:22:21.102688 systemd[1]: Reached target local-fs-pre.target. Oct 2 20:22:21.102803 systemd[1]: Reached target local-fs.target. Oct 2 20:22:21.130682 systemd[1]: Reached target sysinit.target. Oct 2 20:22:21.130793 systemd[1]: Reached target basic.target. Oct 2 20:22:21.152452 systemd[1]: Starting systemd-fsck-root.service... Oct 2 20:22:21.171046 systemd-fsck[922]: ROOT: clean, 603/553520 files, 56012/553472 blocks Oct 2 20:22:21.186039 systemd[1]: Finished systemd-fsck-root.service. Oct 2 20:22:21.278344 kernel: audit: type=1130 audit(1696278141.193:33): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:21.278358 kernel: EXT4-fs (sda9): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none. Oct 2 20:22:21.193000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:21.195143 systemd[1]: Mounting sysroot.mount... Oct 2 20:22:21.286119 systemd[1]: Mounted sysroot.mount. Oct 2 20:22:21.300772 systemd[1]: Reached target initrd-root-fs.target. Oct 2 20:22:21.309458 systemd[1]: Mounting sysroot-usr.mount... Oct 2 20:22:21.331459 systemd[1]: Starting flatcar-metadata-hostname.service... Oct 2 20:22:21.346168 systemd[1]: Starting flatcar-static-network.service... Oct 2 20:22:21.361630 systemd[1]: ignition-remount-sysroot.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Oct 2 20:22:21.361745 systemd[1]: Reached target ignition-diskful.target. Oct 2 20:22:21.379375 systemd[1]: Mounted sysroot-usr.mount. Oct 2 20:22:21.402824 systemd[1]: Mounting sysroot-usr-share-oem.mount... Oct 2 20:22:21.541533 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/sda6 scanned by mount (934) Oct 2 20:22:21.541558 kernel: BTRFS info (device sda6): using crc32c (crc32c-intel) checksum algorithm Oct 2 20:22:21.541566 kernel: BTRFS info (device sda6): using free space tree Oct 2 20:22:21.541573 kernel: BTRFS info (device sda6): has skinny extents Oct 2 20:22:21.541580 kernel: BTRFS info (device sda6): enabling ssd optimizations Oct 2 20:22:21.541639 coreos-metadata[929]: Oct 02 20:22:21.482 INFO Fetching https://metadata.packet.net/metadata: Attempt #1 Oct 2 20:22:21.541639 coreos-metadata[929]: Oct 02 20:22:21.504 INFO Fetch successful Oct 2 20:22:21.541639 coreos-metadata[929]: Oct 02 20:22:21.520 INFO wrote hostname ci-3510.3.0-a-52026787be to /sysroot/etc/hostname Oct 2 20:22:21.677762 kernel: audit: type=1130 audit(1696278141.548:34): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:21.677775 kernel: audit: type=1130 audit(1696278141.611:35): 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' Oct 2 20:22:21.548000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:21.611000 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' Oct 2 20:22:21.415578 systemd[1]: Starting initrd-setup-root.service... Oct 2 20:22:21.818765 kernel: audit: type=1130 audit(1696278141.696:36): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=flatcar-static-network comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:21.818783 kernel: audit: type=1131 audit(1696278141.696:37): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=flatcar-static-network comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:21.696000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=flatcar-static-network comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:21.696000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=flatcar-static-network comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:21.818837 coreos-metadata[930]: Oct 02 20:22:21.482 INFO Fetching https://metadata.packet.net/metadata: Attempt #1 Oct 2 20:22:21.818837 coreos-metadata[930]: Oct 02 20:22:21.504 INFO Fetch successful Oct 2 20:22:21.457728 systemd[1]: Finished initrd-setup-root.service. Oct 2 20:22:21.864641 initrd-setup-root[941]: cut: /sysroot/etc/passwd: No such file or directory Oct 2 20:22:21.550853 systemd[1]: Finished flatcar-metadata-hostname.service. Oct 2 20:22:21.879000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:21.914754 initrd-setup-root[949]: cut: /sysroot/etc/group: No such file or directory Oct 2 20:22:21.950767 kernel: audit: type=1130 audit(1696278141.879:38): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:21.612830 systemd[1]: flatcar-static-network.service: Deactivated successfully. Oct 2 20:22:21.961793 initrd-setup-root[957]: cut: /sysroot/etc/shadow: No such file or directory Oct 2 20:22:21.612869 systemd[1]: Finished flatcar-static-network.service. Oct 2 20:22:21.981694 ignition[1007]: INFO : Ignition 2.14.0 Oct 2 20:22:21.981694 ignition[1007]: INFO : Stage: mount Oct 2 20:22:21.981694 ignition[1007]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" Oct 2 20:22:21.981694 ignition[1007]: DEBUG : parsing config with SHA512: 0131bd505bfe1b1215ca4ec9809701a3323bf448114294874f7249d8d300440bd742a7532f60673bfa0746c04de0bd5ca68d0fe9a8ecd59464b13a6401323cb4 Oct 2 20:22:21.981694 ignition[1007]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/packet" Oct 2 20:22:21.981694 ignition[1007]: INFO : mount: mount passed Oct 2 20:22:21.981694 ignition[1007]: INFO : POST message to Packet Timeline Oct 2 20:22:21.981694 ignition[1007]: INFO : GET https://metadata.packet.net/metadata: attempt #1 Oct 2 20:22:21.981694 ignition[1007]: INFO : GET result: OK Oct 2 20:22:22.070766 initrd-setup-root[965]: cut: /sysroot/etc/gshadow: No such file or directory Oct 2 20:22:21.697759 systemd[1]: Mounted sysroot-usr-share-oem.mount. Oct 2 20:22:21.828201 systemd[1]: Starting ignition-mount.service... Oct 2 20:22:21.857056 systemd[1]: Starting sysroot-boot.service... Oct 2 20:22:22.103872 ignition[1007]: INFO : Ignition finished successfully Oct 2 20:22:22.110000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:21.872160 systemd[1]: sysusr-usr-share-oem.mount: Deactivated successfully. Oct 2 20:22:22.186689 kernel: audit: type=1130 audit(1696278142.110:39): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:21.872206 systemd[1]: sysroot-usr-share-oem.mount: Deactivated successfully. Oct 2 20:22:22.231597 kernel: BTRFS: device label OEM devid 1 transid 17 /dev/sda6 scanned by mount (1023) Oct 2 20:22:22.231609 kernel: BTRFS info (device sda6): using crc32c (crc32c-intel) checksum algorithm Oct 2 20:22:21.876482 systemd[1]: Finished sysroot-boot.service. Oct 2 20:22:22.276582 kernel: BTRFS info (device sda6): using free space tree Oct 2 20:22:22.276592 kernel: BTRFS info (device sda6): has skinny extents Oct 2 20:22:22.276599 kernel: BTRFS info (device sda6): enabling ssd optimizations Oct 2 20:22:22.098537 systemd[1]: Finished ignition-mount.service. Oct 2 20:22:22.113487 systemd[1]: Starting ignition-files.service... Oct 2 20:22:22.178276 systemd[1]: Mounting sysroot-usr-share-oem.mount... Oct 2 20:22:22.312661 systemd[1]: Mounted sysroot-usr-share-oem.mount. Oct 2 20:22:22.344922 unknown[1042]: wrote ssh authorized keys file for user: core Oct 2 20:22:22.368616 ignition[1042]: INFO : Ignition 2.14.0 Oct 2 20:22:22.368616 ignition[1042]: INFO : Stage: files Oct 2 20:22:22.368616 ignition[1042]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" Oct 2 20:22:22.368616 ignition[1042]: DEBUG : parsing config with SHA512: 0131bd505bfe1b1215ca4ec9809701a3323bf448114294874f7249d8d300440bd742a7532f60673bfa0746c04de0bd5ca68d0fe9a8ecd59464b13a6401323cb4 Oct 2 20:22:22.368616 ignition[1042]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/packet" Oct 2 20:22:22.368616 ignition[1042]: DEBUG : files: compiled without relabeling support, skipping Oct 2 20:22:22.368616 ignition[1042]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Oct 2 20:22:22.368616 ignition[1042]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Oct 2 20:22:22.368616 ignition[1042]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Oct 2 20:22:22.368616 ignition[1042]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Oct 2 20:22:22.368616 ignition[1042]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Oct 2 20:22:22.368616 ignition[1042]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/systemd/system/packet-phone-home.service" Oct 2 20:22:22.368616 ignition[1042]: INFO : files: createFilesystemsFiles: createFiles: op(3): oem config not found in "/usr/share/oem", looking on oem partition Oct 2 20:22:22.368616 ignition[1042]: INFO : files: createFilesystemsFiles: createFiles: op(3): op(4): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2008330102" Oct 2 20:22:22.368616 ignition[1042]: CRITICAL : files: createFilesystemsFiles: createFiles: op(3): op(4): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2008330102": device or resource busy Oct 2 20:22:22.368616 ignition[1042]: ERROR : files: createFilesystemsFiles: createFiles: op(3): failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem2008330102", trying btrfs: device or resource busy Oct 2 20:22:22.368616 ignition[1042]: INFO : files: createFilesystemsFiles: createFiles: op(3): op(5): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2008330102" Oct 2 20:22:22.664482 kernel: BTRFS info: devid 1 device path /dev/sda6 changed to /dev/disk/by-label/OEM scanned by ignition (1044) Oct 2 20:22:22.664498 kernel: audit: type=1130 audit(1696278142.604:40): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:22.604000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:22.591170 systemd[1]: Finished ignition-files.service. Oct 2 20:22:22.679781 ignition[1042]: INFO : files: createFilesystemsFiles: createFiles: op(3): op(5): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2008330102" Oct 2 20:22:22.679781 ignition[1042]: INFO : files: createFilesystemsFiles: createFiles: op(3): op(6): [started] unmounting "/mnt/oem2008330102" Oct 2 20:22:22.679781 ignition[1042]: INFO : files: createFilesystemsFiles: createFiles: op(3): op(6): [finished] unmounting "/mnt/oem2008330102" Oct 2 20:22:22.679781 ignition[1042]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/systemd/system/packet-phone-home.service" Oct 2 20:22:22.679781 ignition[1042]: INFO : files: op(7): [started] processing unit "coreos-metadata-sshkeys@.service" Oct 2 20:22:22.679781 ignition[1042]: INFO : files: op(7): [finished] processing unit "coreos-metadata-sshkeys@.service" Oct 2 20:22:22.679781 ignition[1042]: INFO : files: op(8): [started] processing unit "packet-phone-home.service" Oct 2 20:22:22.679781 ignition[1042]: INFO : files: op(8): [finished] processing unit "packet-phone-home.service" Oct 2 20:22:22.679781 ignition[1042]: INFO : files: op(9): [started] processing unit "coreos-metadata.service" Oct 2 20:22:22.679781 ignition[1042]: INFO : files: op(9): [finished] processing unit "coreos-metadata.service" Oct 2 20:22:22.679781 ignition[1042]: INFO : files: op(a): [started] processing unit "metadata.target" Oct 2 20:22:22.679781 ignition[1042]: INFO : files: op(a): op(b): [started] writing unit "metadata.target" at "/sysroot/etc/systemd/system/metadata.target" Oct 2 20:22:22.679781 ignition[1042]: INFO : files: op(a): op(b): [finished] writing unit "metadata.target" at "/sysroot/etc/systemd/system/metadata.target" Oct 2 20:22:22.679781 ignition[1042]: INFO : files: op(a): [finished] processing unit "metadata.target" Oct 2 20:22:22.679781 ignition[1042]: INFO : files: op(c): [started] setting preset to enabled for "coreos-metadata-sshkeys@.service " Oct 2 20:22:22.679781 ignition[1042]: INFO : files: op(c): [finished] setting preset to enabled for "coreos-metadata-sshkeys@.service " Oct 2 20:22:22.679781 ignition[1042]: INFO : files: op(d): [started] setting preset to enabled for "packet-phone-home.service" Oct 2 20:22:22.679781 ignition[1042]: INFO : files: op(d): [finished] setting preset to enabled for "packet-phone-home.service" Oct 2 20:22:22.679781 ignition[1042]: INFO : files: op(e): [started] setting preset to enabled for "coreos-metadata.service" Oct 2 20:22:22.679781 ignition[1042]: INFO : files: op(e): [finished] setting preset to enabled for "coreos-metadata.service" Oct 2 20:22:22.679781 ignition[1042]: INFO : files: op(f): [started] setting preset to enabled for "metadata.target" Oct 2 20:22:22.712000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:22.726000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:22.726000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:22.811000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:22.811000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:22.885000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:23.007000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:22.611392 systemd[1]: Starting initrd-setup-root-after-ignition.service... Oct 2 20:22:23.123850 ignition[1042]: INFO : files: op(f): [finished] setting preset to enabled for "metadata.target" Oct 2 20:22:23.123850 ignition[1042]: INFO : files: createResultFile: createFiles: op(10): [started] writing file "/sysroot/etc/.ignition-result.json" Oct 2 20:22:23.123850 ignition[1042]: INFO : files: createResultFile: createFiles: op(10): [finished] writing file "/sysroot/etc/.ignition-result.json" Oct 2 20:22:23.123850 ignition[1042]: INFO : files: files passed Oct 2 20:22:23.123850 ignition[1042]: INFO : POST message to Packet Timeline Oct 2 20:22:23.123850 ignition[1042]: INFO : GET https://metadata.packet.net/metadata: attempt #1 Oct 2 20:22:23.123850 ignition[1042]: INFO : GET result: OK Oct 2 20:22:23.123850 ignition[1042]: INFO : Ignition finished successfully Oct 2 20:22:23.253000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:22.672794 systemd[1]: torcx-profile-populate.service was skipped because of an unmet condition check (ConditionPathExists=/sysroot/etc/torcx/next-profile). Oct 2 20:22:23.286000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:23.305076 initrd-setup-root-after-ignition[1073]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 2 20:22:23.312000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch-offline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:22.673102 systemd[1]: Starting ignition-quench.service... Oct 2 20:22:22.679931 systemd[1]: Finished initrd-setup-root-after-ignition.service. Oct 2 20:22:22.713896 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 2 20:22:22.713954 systemd[1]: Finished ignition-quench.service. Oct 2 20:22:22.727914 systemd[1]: Reached target ignition-complete.target. Oct 2 20:22:22.758113 systemd[1]: Starting initrd-parse-etc.service... Oct 2 20:22:23.417000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:22.799618 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 2 20:22:23.435000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:22.799691 systemd[1]: Finished initrd-parse-etc.service. Oct 2 20:22:23.452000 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' Oct 2 20:22:22.812826 systemd[1]: Reached target initrd-fs.target. Oct 2 20:22:23.475565 ignition[1088]: INFO : Ignition 2.14.0 Oct 2 20:22:23.475565 ignition[1088]: INFO : Stage: umount Oct 2 20:22:23.475565 ignition[1088]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" Oct 2 20:22:23.475565 ignition[1088]: DEBUG : parsing config with SHA512: 0131bd505bfe1b1215ca4ec9809701a3323bf448114294874f7249d8d300440bd742a7532f60673bfa0746c04de0bd5ca68d0fe9a8ecd59464b13a6401323cb4 Oct 2 20:22:23.475565 ignition[1088]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/packet" Oct 2 20:22:23.475565 ignition[1088]: INFO : umount: umount passed Oct 2 20:22:23.475565 ignition[1088]: INFO : POST message to Packet Timeline Oct 2 20:22:23.475565 ignition[1088]: INFO : GET https://metadata.packet.net/metadata: attempt #1 Oct 2 20:22:23.524000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:23.552000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:23.571000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=iscsiuio comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:23.587000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:22.831794 systemd[1]: Reached target initrd.target. Oct 2 20:22:23.632887 ignition[1088]: INFO : GET result: OK Oct 2 20:22:22.849969 systemd[1]: dracut-mount.service was skipped because no trigger condition checks were met. Oct 2 20:22:23.664968 ignition[1088]: INFO : Ignition finished successfully Oct 2 20:22:23.671000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:22.852134 systemd[1]: Starting dracut-pre-pivot.service... Oct 2 20:22:23.687000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:22.862293 systemd[1]: Finished dracut-pre-pivot.service. Oct 2 20:22:23.703000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:23.703000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:22.888395 systemd[1]: Starting initrd-cleanup.service... Oct 2 20:22:23.718000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:23.718000 audit: BPF prog-id=6 op=UNLOAD Oct 2 20:22:22.923584 systemd[1]: Stopped target nss-lookup.target. Oct 2 20:22:22.943870 systemd[1]: Stopped target remote-cryptsetup.target. Oct 2 20:22:23.751000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-disks comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:22.964299 systemd[1]: Stopped target timers.target. Oct 2 20:22:23.768000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-kargs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:22.986092 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 2 20:22:23.784000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:22.986454 systemd[1]: Stopped dracut-pre-pivot.service. Oct 2 20:22:23.802000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:23.009363 systemd[1]: Stopped target initrd.target. Oct 2 20:22:23.029102 systemd[1]: Stopped target basic.target. Oct 2 20:22:23.831000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=parse-ip-for-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:23.049083 systemd[1]: Stopped target ignition-complete.target. Oct 2 20:22:23.846000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:23.071100 systemd[1]: Stopped target ignition-diskful.target. Oct 2 20:22:23.863000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:23.092086 systemd[1]: Stopped target initrd-root-device.target. Oct 2 20:22:23.114249 systemd[1]: Stopped target remote-fs.target. Oct 2 20:22:23.896000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:23.132094 systemd[1]: Stopped target remote-fs-pre.target. Oct 2 20:22:23.154112 systemd[1]: Stopped target sysinit.target. Oct 2 20:22:23.179256 systemd[1]: Stopped target local-fs.target. Oct 2 20:22:23.943000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-udev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:23.204233 systemd[1]: Stopped target local-fs-pre.target. Oct 2 20:22:23.958000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:23.221112 systemd[1]: Stopped target swap.target. Oct 2 20:22:23.973000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:23.236120 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 2 20:22:23.236475 systemd[1]: Stopped dracut-pre-mount.service. Oct 2 20:22:24.004000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:23.255311 systemd[1]: Stopped target cryptsetup.target. Oct 2 20:22:24.019000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:23.270990 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 2 20:22:24.034000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:23.271348 systemd[1]: Stopped dracut-initqueue.service. Oct 2 20:22:24.050000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-udevadm-cleanup-db comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:24.050000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-udevadm-cleanup-db comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:23.288250 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Oct 2 20:22:23.288625 systemd[1]: Stopped ignition-fetch-offline.service. Oct 2 20:22:23.314451 systemd[1]: Stopped target paths.target. Oct 2 20:22:23.335967 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 2 20:22:23.340764 systemd[1]: Stopped systemd-ask-password-console.path. Oct 2 20:22:23.352040 systemd[1]: Stopped target slices.target. Oct 2 20:22:23.368041 systemd[1]: Stopped target sockets.target. Oct 2 20:22:23.387080 systemd[1]: iscsid.socket: Deactivated successfully. Oct 2 20:22:23.387331 systemd[1]: Closed iscsid.socket. Oct 2 20:22:23.401100 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Oct 2 20:22:23.401464 systemd[1]: Stopped initrd-setup-root-after-ignition.service. Oct 2 20:22:23.419190 systemd[1]: ignition-files.service: Deactivated successfully. Oct 2 20:22:24.159000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=network-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:23.419553 systemd[1]: Stopped ignition-files.service. Oct 2 20:22:23.437197 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Oct 2 20:22:23.437570 systemd[1]: Stopped flatcar-metadata-hostname.service. Oct 2 20:22:23.456248 systemd[1]: Stopping ignition-mount.service... Oct 2 20:22:23.467690 systemd[1]: Stopping iscsiuio.service... Oct 2 20:22:23.484189 systemd[1]: Stopping sysroot-boot.service... Oct 2 20:22:23.499686 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 2 20:22:23.499833 systemd[1]: Stopped systemd-udev-trigger.service. Oct 2 20:22:23.526148 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 2 20:22:24.272995 iscsid[889]: iscsid shutting down. Oct 2 20:22:23.526440 systemd[1]: Stopped dracut-pre-trigger.service. Oct 2 20:22:23.561762 systemd[1]: sysroot-boot.mount: Deactivated successfully. Oct 2 20:22:23.563849 systemd[1]: iscsiuio.service: Deactivated successfully. Oct 2 20:22:23.564087 systemd[1]: Stopped iscsiuio.service. Oct 2 20:22:23.573850 systemd[1]: sysroot-boot.service: Deactivated successfully. Oct 2 20:22:23.574061 systemd[1]: Stopped sysroot-boot.service. Oct 2 20:22:23.589846 systemd[1]: Stopped target network.target. Oct 2 20:22:23.605844 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 2 20:22:23.605967 systemd[1]: Closed iscsiuio.socket. Oct 2 20:22:23.625063 systemd[1]: Stopping systemd-networkd.service... Oct 2 20:22:23.632661 systemd-networkd[867]: enp2s0f1np1: DHCPv6 lease lost Oct 2 20:22:23.639698 systemd-networkd[867]: enp2s0f0np0: DHCPv6 lease lost Oct 2 20:22:24.273561 systemd-journald[269]: Received SIGTERM from PID 1 (n/a). Oct 2 20:22:24.272000 audit: BPF prog-id=9 op=UNLOAD Oct 2 20:22:23.639955 systemd[1]: Stopping systemd-resolved.service... Oct 2 20:22:23.654526 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 2 20:22:23.654749 systemd[1]: Stopped systemd-resolved.service. Oct 2 20:22:23.674205 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 2 20:22:23.674556 systemd[1]: Stopped systemd-networkd.service. Oct 2 20:22:23.688823 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 2 20:22:23.688869 systemd[1]: Finished initrd-cleanup.service. Oct 2 20:22:23.704899 systemd[1]: ignition-mount.service: Deactivated successfully. Oct 2 20:22:23.704967 systemd[1]: Stopped ignition-mount.service. Oct 2 20:22:23.720347 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 2 20:22:23.720374 systemd[1]: Closed systemd-networkd.socket. Oct 2 20:22:23.735726 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 2 20:22:23.735781 systemd[1]: Stopped ignition-disks.service. Oct 2 20:22:23.753009 systemd[1]: ignition-kargs.service: Deactivated successfully. Oct 2 20:22:23.753119 systemd[1]: Stopped ignition-kargs.service. Oct 2 20:22:23.769910 systemd[1]: ignition-setup.service: Deactivated successfully. Oct 2 20:22:23.770049 systemd[1]: Stopped ignition-setup.service. Oct 2 20:22:23.786054 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 2 20:22:23.786197 systemd[1]: Stopped initrd-setup-root.service. Oct 2 20:22:23.805786 systemd[1]: Stopping network-cleanup.service... Oct 2 20:22:23.817715 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Oct 2 20:22:23.817862 systemd[1]: Stopped parse-ip-for-networkd.service. Oct 2 20:22:23.832851 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 2 20:22:23.832970 systemd[1]: Stopped systemd-sysctl.service. Oct 2 20:22:23.848202 systemd[1]: systemd-modules-load.service: Deactivated successfully. Oct 2 20:22:23.848336 systemd[1]: Stopped systemd-modules-load.service. Oct 2 20:22:23.865131 systemd[1]: Stopping systemd-udevd.service... Oct 2 20:22:23.882969 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Oct 2 20:22:23.884065 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 2 20:22:23.884121 systemd[1]: Stopped systemd-udevd.service. Oct 2 20:22:23.898996 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 2 20:22:23.899021 systemd[1]: Closed systemd-udevd-control.socket. Oct 2 20:22:23.912680 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 2 20:22:23.912705 systemd[1]: Closed systemd-udevd-kernel.socket. Oct 2 20:22:23.929799 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 2 20:22:23.929840 systemd[1]: Stopped dracut-pre-udev.service. Oct 2 20:22:23.944781 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 2 20:22:23.944827 systemd[1]: Stopped dracut-cmdline.service. Oct 2 20:22:23.959693 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 2 20:22:23.959728 systemd[1]: Stopped dracut-cmdline-ask.service. Oct 2 20:22:23.975514 systemd[1]: Starting initrd-udevadm-cleanup-db.service... Oct 2 20:22:23.989601 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 2 20:22:23.989640 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service. Oct 2 20:22:24.005670 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 2 20:22:24.005699 systemd[1]: Stopped kmod-static-nodes.service. Oct 2 20:22:24.020674 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 2 20:22:24.020713 systemd[1]: Stopped systemd-vconsole-setup.service. Oct 2 20:22:24.037022 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup\x2ddev.service.mount: Deactivated successfully. Oct 2 20:22:24.037758 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 2 20:22:24.037875 systemd[1]: Finished initrd-udevadm-cleanup-db.service. Oct 2 20:22:24.150437 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 2 20:22:24.150656 systemd[1]: Stopped network-cleanup.service. Oct 2 20:22:24.161033 systemd[1]: Reached target initrd-switch-root.target. Oct 2 20:22:24.180482 systemd[1]: Starting initrd-switch-root.service... Oct 2 20:22:24.214733 systemd[1]: Switching root. Oct 2 20:22:24.275639 systemd-journald[269]: Journal stopped Oct 2 20:22:27.993028 kernel: SELinux: Class mctp_socket not defined in policy. Oct 2 20:22:27.993042 kernel: SELinux: Class anon_inode not defined in policy. Oct 2 20:22:27.993050 kernel: SELinux: the above unknown classes and permissions will be allowed Oct 2 20:22:27.993055 kernel: SELinux: policy capability network_peer_controls=1 Oct 2 20:22:27.993060 kernel: SELinux: policy capability open_perms=1 Oct 2 20:22:27.993065 kernel: SELinux: policy capability extended_socket_class=1 Oct 2 20:22:27.993071 kernel: SELinux: policy capability always_check_network=0 Oct 2 20:22:27.993077 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 2 20:22:27.993083 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 2 20:22:27.993088 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 2 20:22:27.993092 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Oct 2 20:22:27.993098 systemd[1]: Successfully loaded SELinux policy in 294.714ms. Oct 2 20:22:27.993105 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.094ms. Oct 2 20:22:27.993111 systemd[1]: systemd 252 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL -ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE -TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified) Oct 2 20:22:27.993119 systemd[1]: Detected architecture x86-64. Oct 2 20:22:27.993125 systemd[1]: Detected first boot. Oct 2 20:22:27.993130 systemd[1]: Hostname set to . Oct 2 20:22:27.993136 systemd[1]: Initializing machine ID from random generator. Oct 2 20:22:27.993142 systemd[1]: Populated /etc with preset unit settings. Oct 2 20:22:27.993149 systemd[1]: /usr/lib/systemd/system/locksmithd.service:8: Unit uses CPUShares=; please use CPUWeight= instead. Support for CPUShares= will be removed soon. Oct 2 20:22:27.993155 systemd[1]: /usr/lib/systemd/system/locksmithd.service:9: Unit uses MemoryLimit=; please use MemoryMax= instead. Support for MemoryLimit= will be removed soon. Oct 2 20:22:27.993162 systemd[1]: /run/systemd/system/docker.socket:8: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Oct 2 20:22:27.993168 kernel: kauditd_printk_skb: 49 callbacks suppressed Oct 2 20:22:27.993174 kernel: audit: type=1334 audit(1696278146.523:90): prog-id=12 op=LOAD Oct 2 20:22:27.993179 kernel: audit: type=1334 audit(1696278146.523:91): prog-id=3 op=UNLOAD Oct 2 20:22:27.993185 kernel: audit: type=1334 audit(1696278146.566:92): prog-id=13 op=LOAD Oct 2 20:22:27.993191 kernel: audit: type=1334 audit(1696278146.608:93): prog-id=14 op=LOAD Oct 2 20:22:27.993196 kernel: audit: type=1334 audit(1696278146.608:94): prog-id=4 op=UNLOAD Oct 2 20:22:27.993202 kernel: audit: type=1334 audit(1696278146.608:95): prog-id=5 op=UNLOAD Oct 2 20:22:27.993207 kernel: audit: type=1334 audit(1696278146.668:96): prog-id=15 op=LOAD Oct 2 20:22:27.993212 kernel: audit: type=1334 audit(1696278146.668:97): prog-id=12 op=UNLOAD Oct 2 20:22:27.993218 kernel: audit: type=1334 audit(1696278146.706:98): prog-id=16 op=LOAD Oct 2 20:22:27.993223 kernel: audit: type=1334 audit(1696278146.724:99): prog-id=17 op=LOAD Oct 2 20:22:27.993228 systemd[1]: iscsid.service: Deactivated successfully. Oct 2 20:22:27.993236 systemd[1]: Stopped iscsid.service. Oct 2 20:22:27.993241 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 2 20:22:27.993248 systemd[1]: Stopped initrd-switch-root.service. Oct 2 20:22:27.993254 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 2 20:22:27.993260 systemd[1]: Created slice system-addon\x2dconfig.slice. Oct 2 20:22:27.993266 systemd[1]: Created slice system-addon\x2drun.slice. Oct 2 20:22:27.993274 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice. Oct 2 20:22:27.993280 systemd[1]: Created slice system-getty.slice. Oct 2 20:22:27.993287 systemd[1]: Created slice system-modprobe.slice. Oct 2 20:22:27.993293 systemd[1]: Created slice system-serial\x2dgetty.slice. Oct 2 20:22:27.993299 systemd[1]: Created slice system-system\x2dcloudinit.slice. Oct 2 20:22:27.993306 systemd[1]: Created slice system-systemd\x2dfsck.slice. Oct 2 20:22:27.993312 systemd[1]: Created slice user.slice. Oct 2 20:22:27.993318 systemd[1]: Started systemd-ask-password-console.path. Oct 2 20:22:27.993324 systemd[1]: Started systemd-ask-password-wall.path. Oct 2 20:22:27.993330 systemd[1]: Set up automount boot.automount. Oct 2 20:22:27.993336 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount. Oct 2 20:22:27.993343 systemd[1]: Stopped target initrd-switch-root.target. Oct 2 20:22:27.993349 systemd[1]: Stopped target initrd-fs.target. Oct 2 20:22:27.993355 systemd[1]: Stopped target initrd-root-fs.target. Oct 2 20:22:27.993361 systemd[1]: Reached target integritysetup.target. Oct 2 20:22:27.993368 systemd[1]: Reached target remote-cryptsetup.target. Oct 2 20:22:27.993374 systemd[1]: Reached target remote-fs.target. Oct 2 20:22:27.993380 systemd[1]: Reached target slices.target. Oct 2 20:22:27.993387 systemd[1]: Reached target swap.target. Oct 2 20:22:27.993393 systemd[1]: Reached target torcx.target. Oct 2 20:22:27.993399 systemd[1]: Reached target veritysetup.target. Oct 2 20:22:27.993405 systemd[1]: Listening on systemd-coredump.socket. Oct 2 20:22:27.993412 systemd[1]: Listening on systemd-initctl.socket. Oct 2 20:22:27.993419 systemd[1]: Listening on systemd-networkd.socket. Oct 2 20:22:27.993426 systemd[1]: Listening on systemd-udevd-control.socket. Oct 2 20:22:27.993432 systemd[1]: Listening on systemd-udevd-kernel.socket. Oct 2 20:22:27.993439 systemd[1]: Listening on systemd-userdbd.socket. Oct 2 20:22:27.993445 systemd[1]: Mounting dev-hugepages.mount... Oct 2 20:22:27.993451 systemd[1]: Mounting dev-mqueue.mount... Oct 2 20:22:27.993457 systemd[1]: Mounting media.mount... Oct 2 20:22:27.993463 systemd[1]: proc-xen.mount was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 2 20:22:27.993470 systemd[1]: Mounting sys-kernel-debug.mount... Oct 2 20:22:27.993477 systemd[1]: Mounting sys-kernel-tracing.mount... Oct 2 20:22:27.993483 systemd[1]: Mounting tmp.mount... Oct 2 20:22:27.993489 systemd[1]: Starting flatcar-tmpfiles.service... Oct 2 20:22:27.993496 systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. Oct 2 20:22:27.993505 systemd[1]: Starting kmod-static-nodes.service... Oct 2 20:22:27.993511 systemd[1]: Starting modprobe@configfs.service... Oct 2 20:22:27.993517 systemd[1]: Starting modprobe@dm_mod.service... Oct 2 20:22:27.993524 systemd[1]: Starting modprobe@drm.service... Oct 2 20:22:27.993530 systemd[1]: Starting modprobe@efi_pstore.service... Oct 2 20:22:27.993537 systemd[1]: Starting modprobe@fuse.service... Oct 2 20:22:27.993544 kernel: fuse: init (API version 7.34) Oct 2 20:22:27.993550 systemd[1]: Starting modprobe@loop.service... Oct 2 20:22:27.993556 kernel: loop: module loaded Oct 2 20:22:27.993562 systemd[1]: setup-nsswitch.service was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Oct 2 20:22:27.993568 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 2 20:22:27.993574 systemd[1]: Stopped systemd-fsck-root.service. Oct 2 20:22:27.993581 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 2 20:22:27.993587 systemd[1]: Stopped systemd-fsck-usr.service. Oct 2 20:22:27.993594 systemd[1]: Stopped systemd-journald.service. Oct 2 20:22:27.993601 systemd[1]: Starting systemd-journald.service... Oct 2 20:22:27.993607 systemd[1]: Starting systemd-modules-load.service... Oct 2 20:22:27.993615 systemd-journald[1238]: Journal started Oct 2 20:22:27.993640 systemd-journald[1238]: Runtime Journal (/run/log/journal/c7b5541a53984cc8b62ae82e18b21be2) is 8.0M, max 639.3M, 631.3M free. Oct 2 20:22:24.692000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 2 20:22:24.947000 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 Oct 2 20:22:24.949000 audit[1]: AVC avc: denied { bpf } for pid=1 comm="systemd" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1 Oct 2 20:22:24.949000 audit[1]: AVC avc: denied { perfmon } for pid=1 comm="systemd" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1 Oct 2 20:22:24.949000 audit: BPF prog-id=10 op=LOAD Oct 2 20:22:24.949000 audit: BPF prog-id=10 op=UNLOAD Oct 2 20:22:24.949000 audit: BPF prog-id=11 op=LOAD Oct 2 20:22:24.949000 audit: BPF prog-id=11 op=UNLOAD Oct 2 20:22:26.523000 audit: BPF prog-id=12 op=LOAD Oct 2 20:22:26.523000 audit: BPF prog-id=3 op=UNLOAD Oct 2 20:22:26.566000 audit: BPF prog-id=13 op=LOAD Oct 2 20:22:26.608000 audit: BPF prog-id=14 op=LOAD Oct 2 20:22:26.608000 audit: BPF prog-id=4 op=UNLOAD Oct 2 20:22:26.608000 audit: BPF prog-id=5 op=UNLOAD Oct 2 20:22:26.668000 audit: BPF prog-id=15 op=LOAD Oct 2 20:22:26.668000 audit: BPF prog-id=12 op=UNLOAD Oct 2 20:22:26.706000 audit: BPF prog-id=16 op=LOAD Oct 2 20:22:26.724000 audit: BPF prog-id=17 op=LOAD Oct 2 20:22:26.724000 audit: BPF prog-id=13 op=UNLOAD Oct 2 20:22:26.724000 audit: BPF prog-id=14 op=UNLOAD Oct 2 20:22:26.742000 audit: BPF prog-id=18 op=LOAD Oct 2 20:22:26.742000 audit: BPF prog-id=15 op=UNLOAD Oct 2 20:22:26.742000 audit: BPF prog-id=19 op=LOAD Oct 2 20:22:26.742000 audit: BPF prog-id=20 op=LOAD Oct 2 20:22:26.742000 audit: BPF prog-id=16 op=UNLOAD Oct 2 20:22:26.742000 audit: BPF prog-id=17 op=UNLOAD Oct 2 20:22:26.743000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:26.778000 audit: BPF prog-id=18 op=UNLOAD Oct 2 20:22:26.783000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=iscsid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:26.826000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=initrd-switch-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:26.826000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=initrd-switch-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:27.907000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:27.943000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:27.964000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:27.964000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:27.964000 audit: BPF prog-id=21 op=LOAD Oct 2 20:22:27.965000 audit: BPF prog-id=22 op=LOAD Oct 2 20:22:27.965000 audit: BPF prog-id=23 op=LOAD Oct 2 20:22:27.965000 audit: BPF prog-id=19 op=UNLOAD Oct 2 20:22:27.965000 audit: BPF prog-id=20 op=UNLOAD Oct 2 20:22:27.989000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Oct 2 20:22:27.989000 audit[1238]: SYSCALL arch=c000003e syscall=46 success=yes exit=60 a0=3 a1=7ffde5e54560 a2=4000 a3=7ffde5e545fc items=0 ppid=1 pid=1238 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="systemd-journal" exe="/usr/lib/systemd/systemd-journald" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 20:22:27.989000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Oct 2 20:22:26.523378 systemd[1]: Queued start job for default target multi-user.target. Oct 2 20:22:25.022975 /usr/lib/systemd/system-generators/torcx-generator[1127]: time="2023-10-02T20:22:25Z" level=debug msg="common configuration parsed" base_dir=/var/lib/torcx/ conf_dir=/etc/torcx/ run_dir=/run/torcx/ store_paths="[/usr/share/torcx/store /usr/share/oem/torcx/store/3510.3.0 /usr/share/oem/torcx/store /var/lib/torcx/store/3510.3.0 /var/lib/torcx/store]" Oct 2 20:22:26.744561 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 2 20:22:25.023406 /usr/lib/systemd/system-generators/torcx-generator[1127]: time="2023-10-02T20:22:25Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 2 20:22:25.023419 /usr/lib/systemd/system-generators/torcx-generator[1127]: time="2023-10-02T20:22:25Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 2 20:22:25.023440 /usr/lib/systemd/system-generators/torcx-generator[1127]: time="2023-10-02T20:22:25Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Oct 2 20:22:25.023446 /usr/lib/systemd/system-generators/torcx-generator[1127]: time="2023-10-02T20:22:25Z" level=debug msg="skipped missing lower profile" missing profile=oem Oct 2 20:22:25.023467 /usr/lib/systemd/system-generators/torcx-generator[1127]: time="2023-10-02T20:22:25Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Oct 2 20:22:25.023476 /usr/lib/systemd/system-generators/torcx-generator[1127]: time="2023-10-02T20:22:25Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Oct 2 20:22:25.023607 /usr/lib/systemd/system-generators/torcx-generator[1127]: time="2023-10-02T20:22:25Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Oct 2 20:22:25.023632 /usr/lib/systemd/system-generators/torcx-generator[1127]: time="2023-10-02T20:22:25Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 2 20:22:25.023641 /usr/lib/systemd/system-generators/torcx-generator[1127]: time="2023-10-02T20:22:25Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 2 20:22:25.024237 /usr/lib/systemd/system-generators/torcx-generator[1127]: time="2023-10-02T20:22:25Z" level=debug msg="new archive/reference added to cache" format=tgz name=docker path="/usr/share/torcx/store/docker:20.10.torcx.tgz" reference=20.10 Oct 2 20:22:25.024259 /usr/lib/systemd/system-generators/torcx-generator[1127]: time="2023-10-02T20:22:25Z" level=debug msg="new archive/reference added to cache" format=tgz name=docker path="/usr/share/torcx/store/docker:com.coreos.cl.torcx.tgz" reference=com.coreos.cl Oct 2 20:22:25.024272 /usr/lib/systemd/system-generators/torcx-generator[1127]: time="2023-10-02T20:22:25Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store/3510.3.0: no such file or directory" path=/usr/share/oem/torcx/store/3510.3.0 Oct 2 20:22:25.024281 /usr/lib/systemd/system-generators/torcx-generator[1127]: time="2023-10-02T20:22:25Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Oct 2 20:22:25.024292 /usr/lib/systemd/system-generators/torcx-generator[1127]: time="2023-10-02T20:22:25Z" level=info msg="store skipped" err="open /var/lib/torcx/store/3510.3.0: no such file or directory" path=/var/lib/torcx/store/3510.3.0 Oct 2 20:22:25.024301 /usr/lib/systemd/system-generators/torcx-generator[1127]: time="2023-10-02T20:22:25Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Oct 2 20:22:26.187429 /usr/lib/systemd/system-generators/torcx-generator[1127]: time="2023-10-02T20:22:26Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 2 20:22:26.187588 /usr/lib/systemd/system-generators/torcx-generator[1127]: time="2023-10-02T20:22:26Z" level=debug msg="binaries propagated" assets="[/bin/containerd /bin/containerd-shim /bin/ctr /bin/docker /bin/docker-containerd /bin/docker-containerd-shim /bin/docker-init /bin/docker-proxy /bin/docker-runc /bin/dockerd /bin/runc /bin/tini]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 2 20:22:26.187647 /usr/lib/systemd/system-generators/torcx-generator[1127]: time="2023-10-02T20:22:26Z" level=debug msg="networkd units propagated" assets="[/lib/systemd/network/50-docker.network /lib/systemd/network/90-docker-veth.network]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 2 20:22:26.187740 /usr/lib/systemd/system-generators/torcx-generator[1127]: time="2023-10-02T20:22:26Z" level=debug msg="systemd units propagated" assets="[/lib/systemd/system/containerd.service /lib/systemd/system/docker.service /lib/systemd/system/docker.socket /lib/systemd/system/sockets.target.wants /lib/systemd/system/multi-user.target.wants]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 2 20:22:26.187771 /usr/lib/systemd/system-generators/torcx-generator[1127]: time="2023-10-02T20:22:26Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Oct 2 20:22:26.187805 /usr/lib/systemd/system-generators/torcx-generator[1127]: time="2023-10-02T20:22:26Z" level=debug msg="system state sealed" content="[TORCX_LOWER_PROFILES=\"vendor\" TORCX_UPPER_PROFILE=\"\" TORCX_PROFILE_PATH=\"/run/torcx/profile.json\" TORCX_BINDIR=\"/run/torcx/bin\" TORCX_UNPACKDIR=\"/run/torcx/unpack\"]" path=/run/metadata/torcx Oct 2 20:22:28.024673 systemd[1]: Starting systemd-network-generator.service... Oct 2 20:22:28.046552 systemd[1]: Starting systemd-remount-fs.service... Oct 2 20:22:28.067545 systemd[1]: Starting systemd-udev-trigger.service... Oct 2 20:22:28.101050 systemd[1]: verity-setup.service: Deactivated successfully. Oct 2 20:22:28.101071 systemd[1]: Stopped verity-setup.service. Oct 2 20:22:28.106000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=verity-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:28.135552 systemd[1]: xenserver-pv-version.service was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 2 20:22:28.149603 systemd[1]: Started systemd-journald.service. Oct 2 20:22:28.156000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:28.158023 systemd[1]: Mounted dev-hugepages.mount. Oct 2 20:22:28.164765 systemd[1]: Mounted dev-mqueue.mount. Oct 2 20:22:28.171739 systemd[1]: Mounted media.mount. Oct 2 20:22:28.178766 systemd[1]: Mounted sys-kernel-debug.mount. Oct 2 20:22:28.187743 systemd[1]: Mounted sys-kernel-tracing.mount. Oct 2 20:22:28.196741 systemd[1]: Mounted tmp.mount. Oct 2 20:22:28.203813 systemd[1]: Finished flatcar-tmpfiles.service. Oct 2 20:22:28.210000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=flatcar-tmpfiles comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:28.211848 systemd[1]: Finished kmod-static-nodes.service. Oct 2 20:22:28.219000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:28.220833 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 2 20:22:28.220928 systemd[1]: Finished modprobe@configfs.service. Oct 2 20:22:28.228000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@configfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:28.228000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@configfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:28.229942 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 2 20:22:28.230058 systemd[1]: Finished modprobe@dm_mod.service. Oct 2 20:22:28.237000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@dm_mod comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:28.237000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@dm_mod comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:28.238974 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 2 20:22:28.239129 systemd[1]: Finished modprobe@drm.service. Oct 2 20:22:28.246000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@drm comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:28.246000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@drm comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:28.248175 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 2 20:22:28.248413 systemd[1]: Finished modprobe@efi_pstore.service. Oct 2 20:22:28.255000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@efi_pstore comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:28.255000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@efi_pstore comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:28.257282 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 2 20:22:28.257592 systemd[1]: Finished modprobe@fuse.service. Oct 2 20:22:28.264000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@fuse comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:28.264000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@fuse comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:28.266307 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 2 20:22:28.266620 systemd[1]: Finished modprobe@loop.service. Oct 2 20:22:28.273000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@loop comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:28.273000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@loop comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:28.275427 systemd[1]: Finished systemd-modules-load.service. Oct 2 20:22:28.282000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:28.284292 systemd[1]: Finished systemd-network-generator.service. Oct 2 20:22:28.291000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-network-generator comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:28.293277 systemd[1]: Finished systemd-remount-fs.service. Oct 2 20:22:28.300000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-remount-fs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:28.302275 systemd[1]: Finished systemd-udev-trigger.service. Oct 2 20:22:28.309000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:28.311856 systemd[1]: Reached target network-pre.target. Oct 2 20:22:28.323412 systemd[1]: Mounting sys-fs-fuse-connections.mount... Oct 2 20:22:28.334181 systemd[1]: Mounting sys-kernel-config.mount... Oct 2 20:22:28.340746 systemd[1]: remount-root.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Oct 2 20:22:28.341722 systemd[1]: Starting systemd-hwdb-update.service... Oct 2 20:22:28.349086 systemd[1]: Starting systemd-journal-flush.service... Oct 2 20:22:28.352487 systemd-journald[1238]: Time spent on flushing to /var/log/journal/c7b5541a53984cc8b62ae82e18b21be2 is 14.201ms for 1590 entries. Oct 2 20:22:28.352487 systemd-journald[1238]: System Journal (/var/log/journal/c7b5541a53984cc8b62ae82e18b21be2) is 8.0M, max 195.6M, 187.6M free. Oct 2 20:22:28.395640 systemd-journald[1238]: Received client request to flush runtime journal. Oct 2 20:22:28.365596 systemd[1]: systemd-pstore.service was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 2 20:22:28.366089 systemd[1]: Starting systemd-random-seed.service... Oct 2 20:22:28.376656 systemd[1]: systemd-repart.service was skipped because no trigger condition checks were met. Oct 2 20:22:28.377147 systemd[1]: Starting systemd-sysctl.service... Oct 2 20:22:28.384128 systemd[1]: Starting systemd-sysusers.service... Oct 2 20:22:28.391098 systemd[1]: Starting systemd-udev-settle.service... Oct 2 20:22:28.398618 systemd[1]: Mounted sys-fs-fuse-connections.mount. Oct 2 20:22:28.406660 systemd[1]: Mounted sys-kernel-config.mount. Oct 2 20:22:28.414731 systemd[1]: Finished systemd-journal-flush.service. Oct 2 20:22:28.421000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journal-flush comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:28.422763 systemd[1]: Finished systemd-random-seed.service. Oct 2 20:22:28.429000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-random-seed comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:28.430738 systemd[1]: Finished systemd-sysctl.service. Oct 2 20:22:28.437000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:28.438725 systemd[1]: Finished systemd-sysusers.service. Oct 2 20:22:28.445000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-sysusers comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:28.447763 systemd[1]: Reached target first-boot-complete.target. Oct 2 20:22:28.456237 systemd[1]: Starting systemd-tmpfiles-setup-dev.service... Oct 2 20:22:28.465545 udevadm[1254]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Oct 2 20:22:28.475282 systemd[1]: Finished systemd-tmpfiles-setup-dev.service. Oct 2 20:22:28.482000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:28.652808 systemd[1]: Finished systemd-hwdb-update.service. Oct 2 20:22:28.660000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-hwdb-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:28.660000 audit: BPF prog-id=24 op=LOAD Oct 2 20:22:28.660000 audit: BPF prog-id=25 op=LOAD Oct 2 20:22:28.661000 audit: BPF prog-id=7 op=UNLOAD Oct 2 20:22:28.661000 audit: BPF prog-id=8 op=UNLOAD Oct 2 20:22:28.662831 systemd[1]: Starting systemd-udevd.service... Oct 2 20:22:28.674248 systemd-udevd[1257]: Using default interface naming scheme 'v252'. Oct 2 20:22:28.692722 systemd[1]: Started systemd-udevd.service. Oct 2 20:22:28.699000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:28.703230 systemd[1]: Condition check resulted in dev-ttyS1.device being skipped. Oct 2 20:22:28.702000 audit: BPF prog-id=26 op=LOAD Oct 2 20:22:28.704616 systemd[1]: Starting systemd-networkd.service... Oct 2 20:22:28.726000 audit: BPF prog-id=27 op=LOAD Oct 2 20:22:28.741535 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input2 Oct 2 20:22:28.741635 kernel: ACPI: button: Sleep Button [SLPB] Oct 2 20:22:28.740000 audit: BPF prog-id=28 op=LOAD Oct 2 20:22:28.740000 audit: BPF prog-id=29 op=LOAD Oct 2 20:22:28.742174 systemd[1]: Starting systemd-userdbd.service... Oct 2 20:22:28.751511 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 Oct 2 20:22:28.751564 kernel: mousedev: PS/2 mouse device common for all mice Oct 2 20:22:28.751583 kernel: BTRFS info: devid 1 device path /dev/disk/by-label/OEM changed to /dev/sda6 scanned by (udev-worker) (1330) Oct 2 20:22:28.773555 kernel: ACPI: button: Power Button [PWRF] Oct 2 20:22:28.807521 kernel: IPMI message handler: version 39.2 Oct 2 20:22:28.738000 audit[1328]: AVC avc: denied { confidentiality } for pid=1328 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 Oct 2 20:22:28.738000 audit[1328]: SYSCALL arch=c000003e syscall=175 success=yes exit=0 a0=55802b3599b0 a1=4d8bc a2=7f4e52616bc5 a3=5 items=40 ppid=1257 pid=1328 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) Oct 2 20:22:28.738000 audit: CWD cwd="/" Oct 2 20:22:28.738000 audit: PATH item=0 name=(null) inode=27616 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 Oct 2 20:22:28.738000 audit: PATH item=1 name=(null) inode=27617 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 Oct 2 20:22:28.738000 audit: PATH item=2 name=(null) inode=27616 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 Oct 2 20:22:28.738000 audit: PATH item=3 name=(null) inode=27618 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 Oct 2 20:22:28.738000 audit: PATH item=4 name=(null) inode=27616 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 Oct 2 20:22:28.738000 audit: PATH item=5 name=(null) inode=27619 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 Oct 2 20:22:28.738000 audit: PATH item=6 name=(null) inode=27619 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 Oct 2 20:22:28.738000 audit: PATH item=7 name=(null) inode=27620 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 Oct 2 20:22:28.738000 audit: PATH item=8 name=(null) inode=27619 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 Oct 2 20:22:28.738000 audit: PATH item=9 name=(null) inode=27621 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 Oct 2 20:22:28.738000 audit: PATH item=10 name=(null) inode=27619 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 Oct 2 20:22:28.738000 audit: PATH item=11 name=(null) inode=27622 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 Oct 2 20:22:28.738000 audit: PATH item=12 name=(null) inode=27619 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 Oct 2 20:22:28.738000 audit: PATH item=13 name=(null) inode=27623 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 Oct 2 20:22:28.738000 audit: PATH item=14 name=(null) inode=27619 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 Oct 2 20:22:28.738000 audit: PATH item=15 name=(null) inode=27624 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 Oct 2 20:22:28.738000 audit: PATH item=16 name=(null) inode=27616 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 Oct 2 20:22:28.738000 audit: PATH item=17 name=(null) inode=27625 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 Oct 2 20:22:28.738000 audit: PATH item=18 name=(null) inode=27625 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 Oct 2 20:22:28.738000 audit: PATH item=19 name=(null) inode=27626 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 Oct 2 20:22:28.738000 audit: PATH item=20 name=(null) inode=27625 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 Oct 2 20:22:28.738000 audit: PATH item=21 name=(null) inode=27627 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 Oct 2 20:22:28.738000 audit: PATH item=22 name=(null) inode=27625 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 Oct 2 20:22:28.738000 audit: PATH item=23 name=(null) inode=27628 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 Oct 2 20:22:28.738000 audit: PATH item=24 name=(null) inode=27625 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 Oct 2 20:22:28.738000 audit: PATH item=25 name=(null) inode=27629 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 Oct 2 20:22:28.738000 audit: PATH item=26 name=(null) inode=27625 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 Oct 2 20:22:28.738000 audit: PATH item=27 name=(null) inode=27630 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 Oct 2 20:22:28.738000 audit: PATH item=28 name=(null) inode=27616 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 Oct 2 20:22:28.738000 audit: PATH item=29 name=(null) inode=27631 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 Oct 2 20:22:28.738000 audit: PATH item=30 name=(null) inode=27631 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 Oct 2 20:22:28.738000 audit: PATH item=31 name=(null) inode=27632 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 Oct 2 20:22:28.738000 audit: PATH item=32 name=(null) inode=27631 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 Oct 2 20:22:28.738000 audit: PATH item=33 name=(null) inode=27633 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 Oct 2 20:22:28.738000 audit: PATH item=34 name=(null) inode=27631 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 Oct 2 20:22:28.738000 audit: PATH item=35 name=(null) inode=27634 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 Oct 2 20:22:28.738000 audit: PATH item=36 name=(null) inode=27631 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 Oct 2 20:22:28.738000 audit: PATH item=37 name=(null) inode=27635 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 Oct 2 20:22:28.738000 audit: PATH item=38 name=(null) inode=27631 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 Oct 2 20:22:28.738000 audit: PATH item=39 name=(null) inode=27636 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 Oct 2 20:22:28.738000 audit: PROCTITLE proctitle="(udev-worker)" Oct 2 20:22:28.838514 kernel: i801_smbus 0000:00:1f.4: SPD Write Disable is set Oct 2 20:22:28.839045 kernel: ipmi device interface Oct 2 20:22:28.839070 kernel: mei_me 0000:00:16.4: Device doesn't have valid ME Interface Oct 2 20:22:28.839179 kernel: mei_me 0000:00:16.0: Device doesn't have valid ME Interface Oct 2 20:22:28.844922 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. Oct 2 20:22:28.863384 kernel: i801_smbus 0000:00:1f.4: SMBus using PCI interrupt Oct 2 20:22:28.913526 kernel: i2c i2c-0: 2/4 memory slots populated (from DMI) Oct 2 20:22:28.937284 systemd[1]: Started systemd-userdbd.service. Oct 2 20:22:28.945000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-userdbd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:28.999572 kernel: ipmi_si: IPMI System Interface driver Oct 2 20:22:28.999637 kernel: iTCO_vendor_support: vendor-support=0 Oct 2 20:22:28.999655 kernel: ipmi_si dmi-ipmi-si.0: ipmi_platform: probing via SMBIOS Oct 2 20:22:29.033195 kernel: ipmi_platform: ipmi_si: SMBIOS: io 0xca2 regsize 1 spacing 1 irq 0 Oct 2 20:22:29.033234 kernel: ipmi_si: Adding SMBIOS-specified kcs state machine Oct 2 20:22:29.050517 kernel: ipmi_si IPI0001:00: ipmi_platform: probing via ACPI Oct 2 20:22:29.075302 systemd-networkd[1288]: bond0: netdev ready Oct 2 20:22:29.077388 systemd-networkd[1288]: lo: Link UP Oct 2 20:22:29.077390 systemd-networkd[1288]: lo: Gained carrier Oct 2 20:22:29.077856 systemd-networkd[1288]: Enumeration completed Oct 2 20:22:29.077954 systemd[1]: Started systemd-networkd.service. Oct 2 20:22:29.078133 systemd-networkd[1288]: bond0: Configuring with /etc/systemd/network/05-bond0.network. Oct 2 20:22:29.081038 systemd-networkd[1288]: enp2s0f1np1: Configuring with /etc/systemd/network/10-04:3f:72:d9:81:67.network. Oct 2 20:22:29.083954 kernel: ipmi_si IPI0001:00: ipmi_platform: [io 0x0ca2] regsize 1 spacing 1 irq 0 Oct 2 20:22:29.090000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:29.115510 kernel: iTCO_wdt iTCO_wdt: unable to reset NO_REBOOT flag, device disabled by hardware/BIOS Oct 2 20:22:29.151943 kernel: ipmi_si dmi-ipmi-si.0: Removing SMBIOS-specified kcs state machine in favor of ACPI Oct 2 20:22:29.152018 kernel: ipmi_si: Adding ACPI-specified kcs state machine Oct 2 20:22:29.152035 kernel: ipmi_si: Trying ACPI-specified kcs state machine at i/o address 0xca2, slave address 0x20, irq 0 Oct 2 20:22:29.235313 kernel: intel_rapl_common: Found RAPL domain package Oct 2 20:22:29.235363 kernel: ipmi_si IPI0001:00: The BMC does not support clearing the recv irq bit, compensating, but the BMC needs to be fixed. Oct 2 20:22:29.235450 kernel: intel_rapl_common: Found RAPL domain core Oct 2 20:22:29.252545 kernel: ipmi_si IPI0001:00: IPMI message handler: Found new BMC (man_id: 0x002a7c, prod_id: 0x1b11, dev_id: 0x20) Oct 2 20:22:29.252627 kernel: intel_rapl_common: Found RAPL domain uncore Oct 2 20:22:29.252647 kernel: intel_rapl_common: Found RAPL domain dram Oct 2 20:22:29.372508 kernel: ipmi_si IPI0001:00: IPMI kcs interface initialized Oct 2 20:22:29.390509 kernel: ipmi_ssif: IPMI SSIF Interface driver Oct 2 20:22:29.453516 kernel: mlx5_core 0000:02:00.1 enp2s0f1np1: Link up Oct 2 20:22:29.476509 kernel: bond0: (slave enp2s0f1np1): Enslaving as a backup interface with an up link Oct 2 20:22:29.478915 systemd-networkd[1288]: enp2s0f0np0: Configuring with /etc/systemd/network/10-04:3f:72:d9:81:66.network. Oct 2 20:22:29.518428 systemd[1]: Finished systemd-udev-settle.service. Oct 2 20:22:29.518598 kernel: bond0: Warning: No 802.3ad response from the link partner for any adapters in the bond Oct 2 20:22:29.525000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udev-settle comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:29.527281 systemd[1]: Starting lvm2-activation-early.service... Oct 2 20:22:29.545197 lvm[1359]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 2 20:22:29.577935 systemd[1]: Finished lvm2-activation-early.service. Oct 2 20:22:29.584000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=lvm2-activation-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:29.585646 systemd[1]: Reached target cryptsetup.target. Oct 2 20:22:29.594174 systemd[1]: Starting lvm2-activation.service... Oct 2 20:22:29.596261 lvm[1360]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 2 20:22:29.627970 systemd[1]: Finished lvm2-activation.service. Oct 2 20:22:29.646506 kernel: bond0: Warning: No 802.3ad response from the link partner for any adapters in the bond Oct 2 20:22:29.652000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=lvm2-activation comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:29.653662 systemd[1]: Reached target local-fs-pre.target. Oct 2 20:22:29.661617 systemd[1]: var-lib-machines.mount was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Oct 2 20:22:29.661630 systemd[1]: Reached target local-fs.target. Oct 2 20:22:29.669608 systemd[1]: Reached target machines.target. Oct 2 20:22:29.678196 systemd[1]: Starting ldconfig.service... Oct 2 20:22:29.685308 systemd[1]: systemd-binfmt.service was skipped because no trigger condition checks were met. Oct 2 20:22:29.685329 systemd[1]: systemd-boot-system-token.service was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/LoaderFeatures-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). Oct 2 20:22:29.685875 systemd[1]: Starting systemd-boot-update.service... Oct 2 20:22:29.693009 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service... Oct 2 20:22:29.703105 systemd[1]: Starting systemd-machine-id-commit.service... Oct 2 20:22:29.703218 systemd[1]: systemd-sysext.service was skipped because no trigger condition checks were met. Oct 2 20:22:29.703259 systemd[1]: ensure-sysext.service was skipped because no trigger condition checks were met. Oct 2 20:22:29.703908 systemd[1]: Starting systemd-tmpfiles-setup.service... Oct 2 20:22:29.704175 systemd[1]: boot.automount: Got automount request for /boot, triggered by 1362 (bootctl) Oct 2 20:22:29.704962 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service... Oct 2 20:22:29.710591 systemd-tmpfiles[1366]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Oct 2 20:22:29.711393 systemd-tmpfiles[1366]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Oct 2 20:22:29.713262 systemd-tmpfiles[1366]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Oct 2 20:22:29.716292 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 2 20:22:29.716617 systemd[1]: Finished systemd-machine-id-commit.service. Oct 2 20:22:29.723000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-machine-id-commit comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:29.724991 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service. Oct 2 20:22:29.723000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck@dev-disk-by\x2dlabel-OEM comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:29.782971 systemd-fsck[1370]: fsck.fat 4.2 (2021-01-31) Oct 2 20:22:29.782971 systemd-fsck[1370]: /dev/sda1: 789 files, 115069/258078 clusters Oct 2 20:22:29.783678 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service. Oct 2 20:22:29.792000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:29.795374 systemd[1]: Mounting boot.mount... Oct 2 20:22:29.807091 systemd[1]: Mounted boot.mount. Oct 2 20:22:29.824482 systemd[1]: Finished systemd-boot-update.service. Oct 2 20:22:29.839509 kernel: mlx5_core 0000:02:00.0 enp2s0f0np0: Link up Oct 2 20:22:29.854000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-boot-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:29.857761 systemd[1]: Finished systemd-tmpfiles-setup.service. Oct 2 20:22:29.863507 kernel: bond0: (slave enp2s0f0np0): Enslaving as a backup interface with an up link Oct 2 20:22:29.863537 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): bond0: link becomes ready Oct 2 20:22:29.882998 systemd-networkd[1288]: bond0: Link UP Oct 2 20:22:29.883208 systemd-networkd[1288]: enp2s0f1np1: Link UP Oct 2 20:22:29.883355 systemd-networkd[1288]: enp2s0f1np1: Gained carrier Oct 2 20:22:29.884337 systemd-networkd[1288]: enp2s0f1np1: Reconfiguring with /etc/systemd/network/10-04:3f:72:d9:81:66.network. Oct 2 20:22:29.897000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:29.899397 systemd[1]: Starting audit-rules.service... Oct 2 20:22:29.906512 kernel: bond0: (slave enp2s0f1np1): link status definitely up, 25000 Mbps full duplex Oct 2 20:22:29.906543 kernel: bond0: active interface up! Oct 2 20:22:29.906558 kernel: bond0: (slave enp2s0f0np0): link status definitely up, 25000 Mbps full duplex Oct 2 20:22:29.918000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Oct 2 20:22:29.918000 audit[1389]: SYSCALL arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7ffdef114600 a2=420 a3=0 items=0 ppid=1374 pid=1389 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="auditctl" exe="/usr/sbin/auditctl" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 20:22:29.918000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Oct 2 20:22:29.920543 augenrules[1389]: No rules Oct 2 20:22:29.937210 systemd[1]: Starting clean-ca-certificates.service... Oct 2 20:22:29.950137 systemd[1]: Starting systemd-journal-catalog-update.service... Oct 2 20:22:29.959464 systemd[1]: Starting systemd-resolved.service... Oct 2 20:22:29.983508 kernel: bond0: Warning: No 802.3ad response from the link partner for any adapters in the bond Oct 2 20:22:29.983739 systemd[1]: Starting systemd-timesyncd.service... Oct 2 20:22:29.991084 systemd[1]: Starting systemd-update-utmp.service... Oct 2 20:22:29.997836 systemd[1]: Finished audit-rules.service. Oct 2 20:22:30.004729 systemd[1]: Finished clean-ca-certificates.service. Oct 2 20:22:30.006246 ldconfig[1361]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Oct 2 20:22:30.012730 systemd[1]: Finished ldconfig.service. Oct 2 20:22:30.020720 systemd[1]: Finished systemd-journal-catalog-update.service. Oct 2 20:22:30.032411 systemd[1]: Starting systemd-update-done.service... Oct 2 20:22:30.039586 systemd[1]: update-ca-certificates.service was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Oct 2 20:22:30.039840 systemd[1]: Finished systemd-update-utmp.service. Oct 2 20:22:30.041495 systemd-networkd[1288]: enp2s0f0np0: Link UP Oct 2 20:22:30.041671 systemd-networkd[1288]: bond0: Gained carrier Oct 2 20:22:30.041764 systemd-networkd[1288]: enp2s0f0np0: Gained carrier Oct 2 20:22:30.047713 systemd[1]: Finished systemd-update-done.service. Oct 2 20:22:30.087636 kernel: bond0: (slave enp2s0f1np1): link status down for interface, disabling it in 200 ms Oct 2 20:22:30.087660 kernel: bond0: (slave enp2s0f1np1): invalid new link 1 on slave Oct 2 20:22:30.089788 systemd-networkd[1288]: enp2s0f1np1: Link DOWN Oct 2 20:22:30.089790 systemd-networkd[1288]: enp2s0f1np1: Lost carrier Oct 2 20:22:30.096465 systemd[1]: Started systemd-timesyncd.service. Oct 2 20:22:30.099286 systemd-resolved[1396]: Positive Trust Anchors: Oct 2 20:22:30.099293 systemd-resolved[1396]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 2 20:22:30.099312 systemd-resolved[1396]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test Oct 2 20:22:30.103129 systemd-resolved[1396]: Using system hostname 'ci-3510.3.0-a-52026787be'. Oct 2 20:22:30.103712 systemd-timesyncd[1397]: Network configuration changed, trying to establish connection. Oct 2 20:22:30.103896 systemd-timesyncd[1397]: Network configuration changed, trying to establish connection. Oct 2 20:22:30.104829 systemd[1]: Started systemd-resolved.service. Oct 2 20:22:30.112622 systemd[1]: Reached target network.target. Oct 2 20:22:30.120606 systemd[1]: Reached target nss-lookup.target. Oct 2 20:22:30.128600 systemd[1]: Reached target sysinit.target. Oct 2 20:22:30.136627 systemd[1]: Started motdgen.path. Oct 2 20:22:30.143592 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path. Oct 2 20:22:30.153592 systemd[1]: Started systemd-tmpfiles-clean.timer. Oct 2 20:22:30.161586 systemd[1]: update-engine-stub.timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Oct 2 20:22:30.161603 systemd[1]: Reached target paths.target. Oct 2 20:22:30.168573 systemd[1]: Reached target time-set.target. Oct 2 20:22:30.176658 systemd[1]: Started logrotate.timer. Oct 2 20:22:30.183634 systemd[1]: Started mdadm.timer. Oct 2 20:22:30.190572 systemd[1]: Reached target timers.target. Oct 2 20:22:30.197722 systemd[1]: Listening on dbus.socket. Oct 2 20:22:30.205187 systemd[1]: Starting docker.socket... Oct 2 20:22:30.213036 systemd[1]: Listening on sshd.socket. Oct 2 20:22:30.219639 systemd[1]: systemd-pcrphase-sysinit.service was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/StubPcrKernelImage-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). Oct 2 20:22:30.219877 systemd[1]: Listening on docker.socket. Oct 2 20:22:30.226629 systemd[1]: Reached target sockets.target. Oct 2 20:22:30.234579 systemd[1]: Reached target basic.target. Oct 2 20:22:30.241607 systemd[1]: addon-config@usr-share-oem.service was skipped because no trigger condition checks were met. Oct 2 20:22:30.241622 systemd[1]: addon-run@usr-share-oem.service was skipped because no trigger condition checks were met. Oct 2 20:22:30.242083 systemd[1]: Starting containerd.service... Oct 2 20:22:30.249007 systemd[1]: Starting coreos-metadata-sshkeys@core.service... Oct 2 20:22:30.261100 systemd[1]: Starting coreos-metadata.service... Oct 2 20:22:30.273509 kernel: mlx5_core 0000:02:00.1 enp2s0f1np1: Link up Oct 2 20:22:30.278451 coreos-metadata[1404]: Oct 02 20:22:30.278 INFO Fetching https://metadata.packet.net/metadata: Attempt #1 Oct 2 20:22:30.290016 coreos-metadata[1407]: Oct 02 20:22:30.289 INFO Fetching https://metadata.packet.net/metadata: Attempt #1 Oct 2 20:22:30.291162 systemd[1]: Starting dbus.service... Oct 2 20:22:30.294509 kernel: bond0: (slave enp2s0f1np1): speed changed to 0 on port 1 Oct 2 20:22:30.298694 systemd-networkd[1288]: enp2s0f1np1: Link UP Oct 2 20:22:30.298856 systemd-timesyncd[1397]: Network configuration changed, trying to establish connection. Oct 2 20:22:30.298885 systemd-networkd[1288]: enp2s0f1np1: Gained carrier Oct 2 20:22:30.298911 systemd-timesyncd[1397]: Network configuration changed, trying to establish connection. Oct 2 20:22:30.306250 systemd[1]: Starting enable-oem-cloudinit.service... Oct 2 20:22:30.311146 jq[1413]: false Oct 2 20:22:30.311243 dbus-daemon[1412]: [system] SELinux support is enabled Oct 2 20:22:30.317507 kernel: bond0: (slave enp2s0f1np1): link status up again after 200 ms Oct 2 20:22:30.333892 systemd[1]: Starting extend-filesystems.service... Oct 2 20:22:30.338509 kernel: bond0: (slave enp2s0f1np1): link status definitely up, 25000 Mbps full duplex Oct 2 20:22:30.341413 extend-filesystems[1414]: Found sda Oct 2 20:22:30.351627 extend-filesystems[1414]: Found sda1 Oct 2 20:22:30.351627 extend-filesystems[1414]: Found sda2 Oct 2 20:22:30.351627 extend-filesystems[1414]: Found sda3 Oct 2 20:22:30.351627 extend-filesystems[1414]: Found usr Oct 2 20:22:30.351627 extend-filesystems[1414]: Found sda4 Oct 2 20:22:30.351627 extend-filesystems[1414]: Found sda6 Oct 2 20:22:30.351627 extend-filesystems[1414]: Found sda7 Oct 2 20:22:30.351627 extend-filesystems[1414]: Found sda9 Oct 2 20:22:30.351627 extend-filesystems[1414]: Checking size of /dev/sda9 Oct 2 20:22:30.351627 extend-filesystems[1414]: Resized partition /dev/sda9 Oct 2 20:22:30.467603 kernel: EXT4-fs (sda9): resizing filesystem from 553472 to 116605649 blocks Oct 2 20:22:30.344582 systemd[1]: flatcar-setup-environment.service was skipped because of an unmet condition check (ConditionPathExists=/usr/share/oem/bin/flatcar-setup-environment). Oct 2 20:22:30.467679 extend-filesystems[1422]: resize2fs 1.46.5 (30-Dec-2021) Oct 2 20:22:30.345189 systemd[1]: Starting motdgen.service... Oct 2 20:22:30.349840 systemd-timesyncd[1397]: Network configuration changed, trying to establish connection. Oct 2 20:22:30.349932 systemd-timesyncd[1397]: Network configuration changed, trying to establish connection. Oct 2 20:22:30.370999 systemd[1]: Starting ssh-key-proc-cmdline.service... Oct 2 20:22:30.384125 systemd[1]: Starting sshd-keygen.service... Oct 2 20:22:30.402794 systemd[1]: Starting systemd-logind.service... Oct 2 20:22:30.483971 jq[1441]: true Oct 2 20:22:30.420584 systemd[1]: systemd-pcrphase.service was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/StubPcrKernelImage-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). Oct 2 20:22:30.421096 systemd[1]: Starting tcsd.service... Oct 2 20:22:30.423910 systemd-logind[1438]: Watching system buttons on /dev/input/event3 (Power Button) Oct 2 20:22:30.423919 systemd-logind[1438]: Watching system buttons on /dev/input/event2 (Sleep Button) Oct 2 20:22:30.423928 systemd-logind[1438]: Watching system buttons on /dev/input/event0 (HID 0557:2419) Oct 2 20:22:30.424063 systemd-logind[1438]: New seat seat0. Oct 2 20:22:30.439817 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 2 20:22:30.440186 systemd[1]: Starting update-engine.service... Oct 2 20:22:30.460114 systemd[1]: Starting update-ssh-keys-after-ignition.service... Oct 2 20:22:30.475863 systemd[1]: Started dbus.service. Oct 2 20:22:30.492254 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Oct 2 20:22:30.492336 systemd[1]: Condition check resulted in enable-oem-cloudinit.service being skipped. Oct 2 20:22:30.492512 systemd[1]: motdgen.service: Deactivated successfully. Oct 2 20:22:30.492586 systemd[1]: Finished motdgen.service. Oct 2 20:22:30.495877 update_engine[1440]: I1002 20:22:30.495435 1440 main.cc:92] Flatcar Update Engine starting Oct 2 20:22:30.499201 update_engine[1440]: I1002 20:22:30.499190 1440 update_check_scheduler.cc:74] Next update check in 9m44s Oct 2 20:22:30.499777 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 2 20:22:30.499850 systemd[1]: Finished ssh-key-proc-cmdline.service. Oct 2 20:22:30.510156 jq[1443]: true Oct 2 20:22:30.510415 dbus-daemon[1412]: [system] Successfully activated service 'org.freedesktop.systemd1' Oct 2 20:22:30.515319 systemd[1]: tcsd.service: Skipped due to 'exec-condition'. Oct 2 20:22:30.515425 systemd[1]: Condition check resulted in tcsd.service being skipped. Oct 2 20:22:30.518142 systemd[1]: Started systemd-logind.service. Oct 2 20:22:30.519699 env[1444]: time="2023-10-02T20:22:30.519648200Z" level=info msg="starting containerd" revision=92b3a9d6f1b3bcc6dc74875cfdea653fe39f09c2 version=1.6.16 Oct 2 20:22:30.528208 env[1444]: time="2023-10-02T20:22:30.528163580Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Oct 2 20:22:30.528346 env[1444]: time="2023-10-02T20:22:30.528311896Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Oct 2 20:22:30.528596 systemd[1]: Started update-engine.service. Oct 2 20:22:30.528930 env[1444]: time="2023-10-02T20:22:30.528911891Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/5.15.132-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Oct 2 20:22:30.528966 env[1444]: time="2023-10-02T20:22:30.528929306Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Oct 2 20:22:30.530662 env[1444]: time="2023-10-02T20:22:30.530646728Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Oct 2 20:22:30.530704 env[1444]: time="2023-10-02T20:22:30.530661232Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Oct 2 20:22:30.530704 env[1444]: time="2023-10-02T20:22:30.530673809Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Oct 2 20:22:30.530704 env[1444]: time="2023-10-02T20:22:30.530683946Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Oct 2 20:22:30.530784 env[1444]: time="2023-10-02T20:22:30.530746639Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Oct 2 20:22:30.532823 env[1444]: time="2023-10-02T20:22:30.532812219Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Oct 2 20:22:30.532905 env[1444]: time="2023-10-02T20:22:30.532892976Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Oct 2 20:22:30.532940 env[1444]: time="2023-10-02T20:22:30.532904892Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Oct 2 20:22:30.532969 env[1444]: time="2023-10-02T20:22:30.532943915Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Oct 2 20:22:30.532969 env[1444]: time="2023-10-02T20:22:30.532955490Z" level=info msg="metadata content store policy set" policy=shared Oct 2 20:22:30.537076 bash[1471]: Updated "/home/core/.ssh/authorized_keys" Oct 2 20:22:30.538954 systemd[1]: Started locksmithd.service. Oct 2 20:22:30.541289 env[1444]: time="2023-10-02T20:22:30.541239754Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Oct 2 20:22:30.541289 env[1444]: time="2023-10-02T20:22:30.541255087Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Oct 2 20:22:30.541289 env[1444]: time="2023-10-02T20:22:30.541263545Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Oct 2 20:22:30.541289 env[1444]: time="2023-10-02T20:22:30.541279909Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Oct 2 20:22:30.541362 env[1444]: time="2023-10-02T20:22:30.541291304Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Oct 2 20:22:30.541362 env[1444]: time="2023-10-02T20:22:30.541299306Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Oct 2 20:22:30.541362 env[1444]: time="2023-10-02T20:22:30.541306100Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Oct 2 20:22:30.541362 env[1444]: time="2023-10-02T20:22:30.541313244Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Oct 2 20:22:30.541362 env[1444]: time="2023-10-02T20:22:30.541320359Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1 Oct 2 20:22:30.541362 env[1444]: time="2023-10-02T20:22:30.541327363Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Oct 2 20:22:30.541362 env[1444]: time="2023-10-02T20:22:30.541333899Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Oct 2 20:22:30.541362 env[1444]: time="2023-10-02T20:22:30.541340093Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Oct 2 20:22:30.541474 env[1444]: time="2023-10-02T20:22:30.541386426Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Oct 2 20:22:30.541474 env[1444]: time="2023-10-02T20:22:30.541430692Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Oct 2 20:22:30.541813 env[1444]: time="2023-10-02T20:22:30.541778036Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Oct 2 20:22:30.541921 env[1444]: time="2023-10-02T20:22:30.541871285Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Oct 2 20:22:30.541921 env[1444]: time="2023-10-02T20:22:30.541889969Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Oct 2 20:22:30.541968 env[1444]: time="2023-10-02T20:22:30.541927981Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Oct 2 20:22:30.541968 env[1444]: time="2023-10-02T20:22:30.541940635Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Oct 2 20:22:30.541968 env[1444]: time="2023-10-02T20:22:30.541952028Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Oct 2 20:22:30.541968 env[1444]: time="2023-10-02T20:22:30.541963015Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Oct 2 20:22:30.542045 env[1444]: time="2023-10-02T20:22:30.541973790Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Oct 2 20:22:30.542045 env[1444]: time="2023-10-02T20:22:30.541984657Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Oct 2 20:22:30.542045 env[1444]: time="2023-10-02T20:22:30.541995806Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Oct 2 20:22:30.542045 env[1444]: time="2023-10-02T20:22:30.542005771Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Oct 2 20:22:30.542045 env[1444]: time="2023-10-02T20:22:30.542014972Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Oct 2 20:22:30.542138 env[1444]: time="2023-10-02T20:22:30.542084917Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Oct 2 20:22:30.542138 env[1444]: time="2023-10-02T20:22:30.542099191Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Oct 2 20:22:30.542138 env[1444]: time="2023-10-02T20:22:30.542106131Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Oct 2 20:22:30.542138 env[1444]: time="2023-10-02T20:22:30.542112001Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Oct 2 20:22:30.542138 env[1444]: time="2023-10-02T20:22:30.542122735Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="no OpenTelemetry endpoint: skip plugin" type=io.containerd.tracing.processor.v1 Oct 2 20:22:30.542138 env[1444]: time="2023-10-02T20:22:30.542133213Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Oct 2 20:22:30.542226 env[1444]: time="2023-10-02T20:22:30.542145524Z" level=error msg="failed to initialize a tracing processor \"otlp\"" error="no OpenTelemetry endpoint: skip plugin" Oct 2 20:22:30.542226 env[1444]: time="2023-10-02T20:22:30.542166385Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Oct 2 20:22:30.542299 env[1444]: time="2023-10-02T20:22:30.542273828Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.6 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}" Oct 2 20:22:30.545145 env[1444]: time="2023-10-02T20:22:30.542305423Z" level=info msg="Connect containerd service" Oct 2 20:22:30.545145 env[1444]: time="2023-10-02T20:22:30.542322291Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Oct 2 20:22:30.545145 env[1444]: time="2023-10-02T20:22:30.542589099Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Oct 2 20:22:30.545145 env[1444]: time="2023-10-02T20:22:30.542673758Z" level=info msg="Start subscribing containerd event" Oct 2 20:22:30.545145 env[1444]: time="2023-10-02T20:22:30.542700299Z" level=info msg="Start recovering state" Oct 2 20:22:30.545145 env[1444]: time="2023-10-02T20:22:30.542710195Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 2 20:22:30.545145 env[1444]: time="2023-10-02T20:22:30.542731322Z" level=info msg="Start event monitor" Oct 2 20:22:30.545145 env[1444]: time="2023-10-02T20:22:30.542742516Z" level=info msg="Start snapshots syncer" Oct 2 20:22:30.545145 env[1444]: time="2023-10-02T20:22:30.542747961Z" level=info msg="Start cni network conf syncer for default" Oct 2 20:22:30.545145 env[1444]: time="2023-10-02T20:22:30.542731979Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 2 20:22:30.545145 env[1444]: time="2023-10-02T20:22:30.542752347Z" level=info msg="Start streaming server" Oct 2 20:22:30.545145 env[1444]: time="2023-10-02T20:22:30.542795983Z" level=info msg="containerd successfully booted in 0.023476s" Oct 2 20:22:30.545645 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Oct 2 20:22:30.545727 systemd[1]: Reached target system-config.target. Oct 2 20:22:30.553668 systemd[1]: user-cloudinit-proc-cmdline.service was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Oct 2 20:22:30.553739 systemd[1]: Reached target user-config.target. Oct 2 20:22:30.563032 systemd[1]: Started containerd.service. Oct 2 20:22:30.569778 systemd[1]: Finished update-ssh-keys-after-ignition.service. Oct 2 20:22:30.605396 locksmithd[1477]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 2 20:22:30.847511 kernel: EXT4-fs (sda9): resized filesystem to 116605649 Oct 2 20:22:30.875665 extend-filesystems[1422]: Filesystem at /dev/sda9 is mounted on /; on-line resizing required Oct 2 20:22:30.875665 extend-filesystems[1422]: old_desc_blocks = 1, new_desc_blocks = 56 Oct 2 20:22:30.875665 extend-filesystems[1422]: The filesystem on /dev/sda9 is now 116605649 (4k) blocks long. Oct 2 20:22:30.914604 extend-filesystems[1414]: Resized filesystem in /dev/sda9 Oct 2 20:22:30.914604 extend-filesystems[1414]: Found sdb Oct 2 20:22:30.876097 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 2 20:22:30.876179 systemd[1]: Finished extend-filesystems.service. Oct 2 20:22:31.118673 sshd_keygen[1437]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Oct 2 20:22:31.130202 systemd[1]: Finished sshd-keygen.service. Oct 2 20:22:31.140344 systemd[1]: Starting issuegen.service... Oct 2 20:22:31.148783 systemd[1]: issuegen.service: Deactivated successfully. Oct 2 20:22:31.148856 systemd[1]: Finished issuegen.service. Oct 2 20:22:31.157447 systemd[1]: Starting systemd-user-sessions.service... Oct 2 20:22:31.166797 systemd[1]: Finished systemd-user-sessions.service. Oct 2 20:22:31.176252 systemd[1]: Started getty@tty1.service. Oct 2 20:22:31.185225 systemd[1]: Started serial-getty@ttyS1.service. Oct 2 20:22:31.194688 systemd[1]: Reached target getty.target. Oct 2 20:22:31.504828 systemd-networkd[1288]: bond0: Gained IPv6LL Oct 2 20:22:31.504892 systemd-timesyncd[1397]: Network configuration changed, trying to establish connection. Oct 2 20:22:31.504980 systemd-timesyncd[1397]: Network configuration changed, trying to establish connection. Oct 2 20:22:32.775683 kernel: mlx5_core 0000:02:00.0: lag map port 1:1 port 2:2 shared_fdb:0 Oct 2 20:22:36.206162 login[1503]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Oct 2 20:22:36.212738 login[1502]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Oct 2 20:22:36.214315 systemd-logind[1438]: New session 1 of user core. Oct 2 20:22:36.214913 systemd[1]: Created slice user-500.slice. Oct 2 20:22:36.215415 systemd[1]: Starting user-runtime-dir@500.service... Oct 2 20:22:36.216766 systemd-logind[1438]: New session 2 of user core. Oct 2 20:22:36.220637 systemd[1]: Finished user-runtime-dir@500.service. Oct 2 20:22:36.221256 systemd[1]: Starting user@500.service... Oct 2 20:22:36.223421 (systemd)[1507]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 2 20:22:36.308137 systemd[1507]: Queued start job for default target default.target. Oct 2 20:22:36.308386 systemd[1507]: Reached target paths.target. Oct 2 20:22:36.308404 systemd[1507]: Reached target sockets.target. Oct 2 20:22:36.308417 systemd[1507]: Reached target timers.target. Oct 2 20:22:36.308429 systemd[1507]: Reached target basic.target. Oct 2 20:22:36.308456 systemd[1507]: Reached target default.target. Oct 2 20:22:36.308479 systemd[1507]: Startup finished in 82ms. Oct 2 20:22:36.308518 systemd[1]: Started user@500.service. Oct 2 20:22:36.309025 systemd[1]: Started session-1.scope. Oct 2 20:22:36.309374 systemd[1]: Started session-2.scope. Oct 2 20:22:36.433756 coreos-metadata[1404]: Oct 02 20:22:36.433 INFO Failed to fetch: error sending request for url (https://metadata.packet.net/metadata): error trying to connect: dns error: failed to lookup address information: Name or service not known Oct 2 20:22:36.434489 coreos-metadata[1407]: Oct 02 20:22:36.433 INFO Failed to fetch: error sending request for url (https://metadata.packet.net/metadata): error trying to connect: dns error: failed to lookup address information: Name or service not known Oct 2 20:22:37.433981 coreos-metadata[1407]: Oct 02 20:22:37.433 INFO Fetching https://metadata.packet.net/metadata: Attempt #2 Oct 2 20:22:37.434233 coreos-metadata[1404]: Oct 02 20:22:37.433 INFO Fetching https://metadata.packet.net/metadata: Attempt #2 Oct 2 20:22:37.798645 kernel: mlx5_core 0000:02:00.0: modify lag map port 1:2 port 2:2 Oct 2 20:22:37.798795 kernel: mlx5_core 0000:02:00.0: modify lag map port 1:1 port 2:2 Oct 2 20:22:38.504822 coreos-metadata[1407]: Oct 02 20:22:38.504 INFO Fetch successful Oct 2 20:22:38.505080 coreos-metadata[1404]: Oct 02 20:22:38.504 INFO Fetch successful Oct 2 20:22:38.526891 systemd[1]: Finished coreos-metadata.service. Oct 2 20:22:38.527165 systemd[1]: Reached target metadata.target. Oct 2 20:22:38.527255 unknown[1404]: wrote ssh authorized keys file for user: core Oct 2 20:22:38.528048 systemd[1]: Started packet-phone-home.service. Oct 2 20:22:38.534912 curl[1529]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 2 20:22:38.535066 curl[1529]: Dload Upload Total Spent Left Speed Oct 2 20:22:38.538424 update-ssh-keys[1530]: Updated "/home/core/.ssh/authorized_keys" Oct 2 20:22:38.538744 systemd[1]: Finished coreos-metadata-sshkeys@core.service. Oct 2 20:22:38.538992 systemd[1]: Reached target multi-user.target. Oct 2 20:22:38.539690 systemd[1]: Starting systemd-update-utmp-runlevel.service... Oct 2 20:22:38.543524 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Oct 2 20:22:38.543596 systemd[1]: Finished systemd-update-utmp-runlevel.service. Oct 2 20:22:38.543746 systemd[1]: Startup finished in 2.012s (kernel) + 16.548s (initrd) + 14.168s (userspace) = 32.730s. Oct 2 20:22:38.700128 curl[1529]: \u000d 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0\u000d 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 Oct 2 20:22:38.702642 systemd[1]: packet-phone-home.service: Deactivated successfully. Oct 2 20:22:38.743005 systemd[1]: Created slice system-sshd.slice. Oct 2 20:22:38.745895 systemd[1]: Started sshd@0-139.178.90.63:22-139.178.89.65:47280.service. Oct 2 20:22:38.823818 sshd[1534]: Accepted publickey for core from 139.178.89.65 port 47280 ssh2: RSA SHA256:M4fPbwtaE29dxMxiSyaa1yIvxglYsCEa+0scmSZWaB4 Oct 2 20:22:38.824627 sshd[1534]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 2 20:22:38.827562 systemd-logind[1438]: New session 3 of user core. Oct 2 20:22:38.828258 systemd[1]: Started session-3.scope. Oct 2 20:22:38.883793 systemd[1]: Started sshd@1-139.178.90.63:22-139.178.89.65:47286.service. Oct 2 20:22:38.914385 sshd[1539]: Accepted publickey for core from 139.178.89.65 port 47286 ssh2: RSA SHA256:M4fPbwtaE29dxMxiSyaa1yIvxglYsCEa+0scmSZWaB4 Oct 2 20:22:38.915072 sshd[1539]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 2 20:22:38.917225 systemd-logind[1438]: New session 4 of user core. Oct 2 20:22:38.917756 systemd[1]: Started session-4.scope. Oct 2 20:22:38.970298 sshd[1539]: pam_unix(sshd:session): session closed for user core Oct 2 20:22:38.971733 systemd[1]: sshd@1-139.178.90.63:22-139.178.89.65:47286.service: Deactivated successfully. Oct 2 20:22:38.972057 systemd[1]: session-4.scope: Deactivated successfully. Oct 2 20:22:38.972374 systemd-logind[1438]: Session 4 logged out. Waiting for processes to exit. Oct 2 20:22:38.972922 systemd[1]: Started sshd@2-139.178.90.63:22-139.178.89.65:47296.service. Oct 2 20:22:38.973399 systemd-logind[1438]: Removed session 4. Oct 2 20:22:39.001467 sshd[1545]: Accepted publickey for core from 139.178.89.65 port 47296 ssh2: RSA SHA256:M4fPbwtaE29dxMxiSyaa1yIvxglYsCEa+0scmSZWaB4 Oct 2 20:22:39.002506 sshd[1545]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 2 20:22:39.006025 systemd-logind[1438]: New session 5 of user core. Oct 2 20:22:39.006939 systemd[1]: Started session-5.scope. Oct 2 20:22:39.062695 sshd[1545]: pam_unix(sshd:session): session closed for user core Oct 2 20:22:39.069172 systemd[1]: sshd@2-139.178.90.63:22-139.178.89.65:47296.service: Deactivated successfully. Oct 2 20:22:39.070706 systemd[1]: session-5.scope: Deactivated successfully. Oct 2 20:22:39.072335 systemd-logind[1438]: Session 5 logged out. Waiting for processes to exit. Oct 2 20:22:39.074679 systemd[1]: Started sshd@3-139.178.90.63:22-139.178.89.65:47306.service. Oct 2 20:22:39.076916 systemd-logind[1438]: Removed session 5. Oct 2 20:22:39.136666 sshd[1552]: Accepted publickey for core from 139.178.89.65 port 47306 ssh2: RSA SHA256:M4fPbwtaE29dxMxiSyaa1yIvxglYsCEa+0scmSZWaB4 Oct 2 20:22:39.139437 sshd[1552]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 2 20:22:39.148703 systemd-logind[1438]: New session 6 of user core. Oct 2 20:22:39.150896 systemd[1]: Started session-6.scope. Oct 2 20:22:39.219449 sshd[1552]: pam_unix(sshd:session): session closed for user core Oct 2 20:22:39.220847 systemd[1]: sshd@3-139.178.90.63:22-139.178.89.65:47306.service: Deactivated successfully. Oct 2 20:22:39.221140 systemd[1]: session-6.scope: Deactivated successfully. Oct 2 20:22:39.221435 systemd-logind[1438]: Session 6 logged out. Waiting for processes to exit. Oct 2 20:22:39.221969 systemd[1]: Started sshd@4-139.178.90.63:22-139.178.89.65:47316.service. Oct 2 20:22:39.222405 systemd-logind[1438]: Removed session 6. Oct 2 20:22:39.249935 sshd[1558]: Accepted publickey for core from 139.178.89.65 port 47316 ssh2: RSA SHA256:M4fPbwtaE29dxMxiSyaa1yIvxglYsCEa+0scmSZWaB4 Oct 2 20:22:39.250870 sshd[1558]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 2 20:22:39.254207 systemd-logind[1438]: New session 7 of user core. Oct 2 20:22:39.254946 systemd[1]: Started session-7.scope. Oct 2 20:22:39.357297 sudo[1561]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Oct 2 20:22:39.357864 sudo[1561]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 2 20:22:39.375964 dbus-daemon[1412]: \xd0\xedq\x82\xe9U: received setenforce notice (enforcing=-184052032) Oct 2 20:22:39.380956 sudo[1561]: pam_unix(sudo:session): session closed for user root Oct 2 20:22:39.386627 sshd[1558]: pam_unix(sshd:session): session closed for user core Oct 2 20:22:39.393721 systemd[1]: sshd@4-139.178.90.63:22-139.178.89.65:47316.service: Deactivated successfully. Oct 2 20:22:39.395386 systemd[1]: session-7.scope: Deactivated successfully. Oct 2 20:22:39.397226 systemd-logind[1438]: Session 7 logged out. Waiting for processes to exit. Oct 2 20:22:39.399926 systemd[1]: Started sshd@5-139.178.90.63:22-139.178.89.65:47324.service. Oct 2 20:22:39.402332 systemd-logind[1438]: Removed session 7. Oct 2 20:22:39.458260 sshd[1565]: Accepted publickey for core from 139.178.89.65 port 47324 ssh2: RSA SHA256:M4fPbwtaE29dxMxiSyaa1yIvxglYsCEa+0scmSZWaB4 Oct 2 20:22:39.460431 sshd[1565]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 2 20:22:39.467341 systemd-logind[1438]: New session 8 of user core. Oct 2 20:22:39.468855 systemd[1]: Started session-8.scope. Oct 2 20:22:39.538302 sudo[1569]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Oct 2 20:22:39.538407 sudo[1569]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 2 20:22:39.540219 sudo[1569]: pam_unix(sudo:session): session closed for user root Oct 2 20:22:39.542462 sudo[1568]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules Oct 2 20:22:39.542573 sudo[1568]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 2 20:22:39.547824 systemd[1]: Stopping audit-rules.service... Oct 2 20:22:39.546000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 2 20:22:39.548542 auditctl[1572]: No rules Oct 2 20:22:39.548697 systemd[1]: audit-rules.service: Deactivated successfully. Oct 2 20:22:39.548787 systemd[1]: Stopped audit-rules.service. Oct 2 20:22:39.549647 systemd[1]: Starting audit-rules.service... Oct 2 20:22:39.554075 kernel: kauditd_printk_skb: 117 callbacks suppressed Oct 2 20:22:39.554126 kernel: audit: type=1305 audit(1696278159.546:170): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 2 20:22:39.560414 augenrules[1589]: No rules Oct 2 20:22:39.560818 systemd[1]: Finished audit-rules.service. Oct 2 20:22:39.561348 sudo[1568]: pam_unix(sudo:session): session closed for user root Oct 2 20:22:39.562341 sshd[1565]: pam_unix(sshd:session): session closed for user core Oct 2 20:22:39.564531 systemd[1]: Started sshd@6-139.178.90.63:22-139.178.89.65:47336.service. Oct 2 20:22:39.564873 systemd[1]: sshd@5-139.178.90.63:22-139.178.89.65:47324.service: Deactivated successfully. Oct 2 20:22:39.565263 systemd[1]: session-8.scope: Deactivated successfully. Oct 2 20:22:39.565689 systemd-logind[1438]: Session 8 logged out. Waiting for processes to exit. Oct 2 20:22:39.566328 systemd-logind[1438]: Removed session 8. Oct 2 20:22:39.546000 audit[1572]: SYSCALL arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7fff47359a00 a2=420 a3=0 items=0 ppid=1 pid=1572 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="auditctl" exe="/usr/sbin/auditctl" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 20:22:39.600665 kernel: audit: type=1300 audit(1696278159.546:170): arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7fff47359a00 a2=420 a3=0 items=0 ppid=1 pid=1572 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="auditctl" exe="/usr/sbin/auditctl" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 20:22:39.600723 kernel: audit: type=1327 audit(1696278159.546:170): proctitle=2F7362696E2F617564697463746C002D44 Oct 2 20:22:39.546000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D44 Oct 2 20:22:39.610188 kernel: audit: type=1131 audit(1696278159.547:171): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:39.547000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:39.632260 sshd[1594]: Accepted publickey for core from 139.178.89.65 port 47336 ssh2: RSA SHA256:M4fPbwtaE29dxMxiSyaa1yIvxglYsCEa+0scmSZWaB4 Oct 2 20:22:39.632659 kernel: audit: type=1130 audit(1696278159.559:172): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:39.559000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:39.633836 sshd[1594]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 2 20:22:39.636151 systemd-logind[1438]: New session 9 of user core. Oct 2 20:22:39.636580 systemd[1]: Started session-9.scope. Oct 2 20:22:39.655125 kernel: audit: type=1106 audit(1696278159.559:173): pid=1568 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' Oct 2 20:22:39.559000 audit[1568]: USER_END pid=1568 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' Oct 2 20:22:39.681100 kernel: audit: type=1104 audit(1696278159.559:174): pid=1568 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' Oct 2 20:22:39.559000 audit[1568]: CRED_DISP pid=1568 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' Oct 2 20:22:39.682446 sshd[1594]: pam_unix(sshd:session): session closed for user core Oct 2 20:22:39.683763 systemd[1]: sshd@6-139.178.90.63:22-139.178.89.65:47336.service: Deactivated successfully. Oct 2 20:22:39.684074 systemd[1]: session-9.scope: Deactivated successfully. Oct 2 20:22:39.684398 systemd-logind[1438]: Session 9 logged out. Waiting for processes to exit. Oct 2 20:22:39.684942 systemd-logind[1438]: Removed session 9. Oct 2 20:22:39.704635 kernel: audit: type=1106 audit(1696278159.561:175): pid=1565 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=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success' Oct 2 20:22:39.561000 audit[1565]: USER_END pid=1565 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=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success' Oct 2 20:22:39.561000 audit[1565]: CRED_DISP pid=1565 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=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success' Oct 2 20:22:39.762470 kernel: audit: type=1104 audit(1696278159.561:176): pid=1565 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=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success' Oct 2 20:22:39.762494 kernel: audit: type=1130 audit(1696278159.563:177): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-139.178.90.63:22-139.178.89.65:47336 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:39.563000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-139.178.90.63:22-139.178.89.65:47336 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:39.563000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-139.178.90.63:22-139.178.89.65:47324 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 20:22:39.630000 audit[1594]: USER_ACCT pid=1594 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=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success' Oct 2 20:22:39.632000 audit[1594]: CRED_ACQ pid=1594 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=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success' Oct 2 20:22:39.632000 audit[1594]: SYSCALL arch=c000003e syscall=1 success=yes exit=3 a0=5 a1=7ffc4c0eefc0 a2=3 a3=0 items=0 ppid=1 pid=1594 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) Oct 2 20:22:39.632000 audit: PROCTITLE proctitle=737368643A20636F7265205B707269765D Oct 2 20:22:39.637000 audit[1594]: USER_START pid=1594 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=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success' Oct 2 20:22:39.638000 audit[1597]: CRED_ACQ pid=1597 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=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success' Oct 2 20:22:39.681000 audit[1594]: USER_END pid=1594 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=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success' Oct 2 20:22:39.681000 audit[1594]: CRED_DISP pid=1594 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=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success' Oct 2 20:22:39.682000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-139.178.90.63:22-139.178.89.65:47336 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'