Feb 9 09:48:50.738437 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Feb 9 09:48:50.738457 kernel: Linux version 5.15.148-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 11.3.1_p20221209 p3) 11.3.1 20221209, GNU ld (Gentoo 2.39 p5) 2.39.0) #1 SMP PREEMPT Fri Feb 9 08:56:26 -00 2024 Feb 9 09:48:50.738465 kernel: efi: EFI v2.70 by EDK II Feb 9 09:48:50.738471 kernel: efi: SMBIOS 3.0=0xd9260000 ACPI 2.0=0xd9240000 MEMATTR=0xda32b018 RNG=0xd9220018 MEMRESERVE=0xd9521c18 Feb 9 09:48:50.738476 kernel: random: crng init done Feb 9 09:48:50.738481 kernel: ACPI: Early table checksum verification disabled Feb 9 09:48:50.738487 kernel: ACPI: RSDP 0x00000000D9240000 000024 (v02 BOCHS ) Feb 9 09:48:50.738494 kernel: ACPI: XSDT 0x00000000D9230000 000064 (v01 BOCHS BXPC 00000001 01000013) Feb 9 09:48:50.738499 kernel: ACPI: FACP 0x00000000D91E0000 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Feb 9 09:48:50.738504 kernel: ACPI: DSDT 0x00000000D91F0000 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Feb 9 09:48:50.738510 kernel: ACPI: APIC 0x00000000D91D0000 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Feb 9 09:48:50.738515 kernel: ACPI: PPTT 0x00000000D91C0000 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Feb 9 09:48:50.738520 kernel: ACPI: GTDT 0x00000000D91B0000 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Feb 9 09:48:50.738525 kernel: ACPI: MCFG 0x00000000D91A0000 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Feb 9 09:48:50.738533 kernel: ACPI: SPCR 0x00000000D9190000 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Feb 9 09:48:50.738539 kernel: ACPI: DBG2 0x00000000D9180000 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Feb 9 09:48:50.738545 kernel: ACPI: IORT 0x00000000D9170000 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Feb 9 09:48:50.738551 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Feb 9 09:48:50.738556 kernel: NUMA: Failed to initialise from firmware Feb 9 09:48:50.738562 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Feb 9 09:48:50.738568 kernel: NUMA: NODE_DATA [mem 0xdcb0b900-0xdcb10fff] Feb 9 09:48:50.738573 kernel: Zone ranges: Feb 9 09:48:50.738579 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Feb 9 09:48:50.738585 kernel: DMA32 empty Feb 9 09:48:50.738591 kernel: Normal empty Feb 9 09:48:50.738596 kernel: Movable zone start for each node Feb 9 09:48:50.738602 kernel: Early memory node ranges Feb 9 09:48:50.738608 kernel: node 0: [mem 0x0000000040000000-0x00000000d924ffff] Feb 9 09:48:50.738613 kernel: node 0: [mem 0x00000000d9250000-0x00000000d951ffff] Feb 9 09:48:50.738619 kernel: node 0: [mem 0x00000000d9520000-0x00000000dc7fffff] Feb 9 09:48:50.738624 kernel: node 0: [mem 0x00000000dc800000-0x00000000dc88ffff] Feb 9 09:48:50.738630 kernel: node 0: [mem 0x00000000dc890000-0x00000000dc89ffff] Feb 9 09:48:50.738636 kernel: node 0: [mem 0x00000000dc8a0000-0x00000000dc9bffff] Feb 9 09:48:50.738641 kernel: node 0: [mem 0x00000000dc9c0000-0x00000000dcffffff] Feb 9 09:48:50.738647 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Feb 9 09:48:50.738654 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Feb 9 09:48:50.738659 kernel: psci: probing for conduit method from ACPI. Feb 9 09:48:50.738665 kernel: psci: PSCIv1.1 detected in firmware. Feb 9 09:48:50.738670 kernel: psci: Using standard PSCI v0.2 function IDs Feb 9 09:48:50.738677 kernel: psci: Trusted OS migration not required Feb 9 09:48:50.738684 kernel: psci: SMC Calling Convention v1.1 Feb 9 09:48:50.738691 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Feb 9 09:48:50.738698 kernel: ACPI: SRAT not present Feb 9 09:48:50.738704 kernel: percpu: Embedded 29 pages/cpu s79960 r8192 d30632 u118784 Feb 9 09:48:50.738710 kernel: pcpu-alloc: s79960 r8192 d30632 u118784 alloc=29*4096 Feb 9 09:48:50.738716 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Feb 9 09:48:50.738722 kernel: Detected PIPT I-cache on CPU0 Feb 9 09:48:50.738728 kernel: CPU features: detected: GIC system register CPU interface Feb 9 09:48:50.738734 kernel: CPU features: detected: Hardware dirty bit management Feb 9 09:48:50.738740 kernel: CPU features: detected: Spectre-v4 Feb 9 09:48:50.738746 kernel: CPU features: detected: Spectre-BHB Feb 9 09:48:50.738753 kernel: CPU features: kernel page table isolation forced ON by KASLR Feb 9 09:48:50.738759 kernel: CPU features: detected: Kernel page table isolation (KPTI) Feb 9 09:48:50.738765 kernel: CPU features: detected: ARM erratum 1418040 Feb 9 09:48:50.738771 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Feb 9 09:48:50.738777 kernel: Policy zone: DMA Feb 9 09:48:50.738784 kernel: Kernel command line: BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected acpi=force verity.usrhash=14ffd9340f674a8d04c9d43eed85484d8b2b7e2bcd8b36a975c9ac66063d537d Feb 9 09:48:50.738790 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Feb 9 09:48:50.738797 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Feb 9 09:48:50.738803 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Feb 9 09:48:50.738809 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Feb 9 09:48:50.738815 kernel: Memory: 2459152K/2572288K available (9792K kernel code, 2092K rwdata, 7556K rodata, 34688K init, 778K bss, 113136K reserved, 0K cma-reserved) Feb 9 09:48:50.738823 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Feb 9 09:48:50.738829 kernel: trace event string verifier disabled Feb 9 09:48:50.738835 kernel: rcu: Preemptible hierarchical RCU implementation. Feb 9 09:48:50.738842 kernel: rcu: RCU event tracing is enabled. Feb 9 09:48:50.738855 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Feb 9 09:48:50.738861 kernel: Trampoline variant of Tasks RCU enabled. Feb 9 09:48:50.738867 kernel: Tracing variant of Tasks RCU enabled. Feb 9 09:48:50.738873 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Feb 9 09:48:50.738879 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Feb 9 09:48:50.738885 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Feb 9 09:48:50.738891 kernel: GICv3: 256 SPIs implemented Feb 9 09:48:50.738899 kernel: GICv3: 0 Extended SPIs implemented Feb 9 09:48:50.738905 kernel: GICv3: Distributor has no Range Selector support Feb 9 09:48:50.738911 kernel: Root IRQ handler: gic_handle_irq Feb 9 09:48:50.738917 kernel: GICv3: 16 PPIs implemented Feb 9 09:48:50.738923 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Feb 9 09:48:50.738929 kernel: ACPI: SRAT not present Feb 9 09:48:50.738934 kernel: ITS [mem 0x08080000-0x0809ffff] Feb 9 09:48:50.738941 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Feb 9 09:48:50.738947 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Feb 9 09:48:50.738953 kernel: GICv3: using LPI property table @0x00000000400d0000 Feb 9 09:48:50.738959 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Feb 9 09:48:50.738965 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Feb 9 09:48:50.738972 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Feb 9 09:48:50.738979 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Feb 9 09:48:50.738985 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Feb 9 09:48:50.738991 kernel: arm-pv: using stolen time PV Feb 9 09:48:50.738997 kernel: Console: colour dummy device 80x25 Feb 9 09:48:50.739003 kernel: ACPI: Core revision 20210730 Feb 9 09:48:50.739010 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Feb 9 09:48:50.739016 kernel: pid_max: default: 32768 minimum: 301 Feb 9 09:48:50.739022 kernel: LSM: Security Framework initializing Feb 9 09:48:50.739028 kernel: SELinux: Initializing. Feb 9 09:48:50.739036 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Feb 9 09:48:50.739042 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Feb 9 09:48:50.739048 kernel: rcu: Hierarchical SRCU implementation. Feb 9 09:48:50.739054 kernel: Platform MSI: ITS@0x8080000 domain created Feb 9 09:48:50.739060 kernel: PCI/MSI: ITS@0x8080000 domain created Feb 9 09:48:50.739066 kernel: Remapping and enabling EFI services. Feb 9 09:48:50.739072 kernel: smp: Bringing up secondary CPUs ... Feb 9 09:48:50.739078 kernel: Detected PIPT I-cache on CPU1 Feb 9 09:48:50.739085 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Feb 9 09:48:50.739092 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Feb 9 09:48:50.739099 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Feb 9 09:48:50.739105 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Feb 9 09:48:50.739111 kernel: Detected PIPT I-cache on CPU2 Feb 9 09:48:50.739117 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Feb 9 09:48:50.739123 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Feb 9 09:48:50.739130 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Feb 9 09:48:50.739136 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Feb 9 09:48:50.739142 kernel: Detected PIPT I-cache on CPU3 Feb 9 09:48:50.739148 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Feb 9 09:48:50.739155 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Feb 9 09:48:50.739161 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Feb 9 09:48:50.739167 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Feb 9 09:48:50.739174 kernel: smp: Brought up 1 node, 4 CPUs Feb 9 09:48:50.739184 kernel: SMP: Total of 4 processors activated. Feb 9 09:48:50.739191 kernel: CPU features: detected: 32-bit EL0 Support Feb 9 09:48:50.739198 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Feb 9 09:48:50.739205 kernel: CPU features: detected: Common not Private translations Feb 9 09:48:50.739211 kernel: CPU features: detected: CRC32 instructions Feb 9 09:48:50.739217 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Feb 9 09:48:50.739224 kernel: CPU features: detected: LSE atomic instructions Feb 9 09:48:50.739230 kernel: CPU features: detected: Privileged Access Never Feb 9 09:48:50.739238 kernel: CPU features: detected: RAS Extension Support Feb 9 09:48:50.739245 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Feb 9 09:48:50.739251 kernel: CPU: All CPU(s) started at EL1 Feb 9 09:48:50.739258 kernel: alternatives: patching kernel code Feb 9 09:48:50.739265 kernel: devtmpfs: initialized Feb 9 09:48:50.739272 kernel: KASLR enabled Feb 9 09:48:50.739278 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Feb 9 09:48:50.739298 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Feb 9 09:48:50.739305 kernel: pinctrl core: initialized pinctrl subsystem Feb 9 09:48:50.739312 kernel: SMBIOS 3.0.0 present. Feb 9 09:48:50.739318 kernel: DMI: QEMU KVM Virtual Machine, BIOS 0.0.0 02/06/2015 Feb 9 09:48:50.739325 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Feb 9 09:48:50.739331 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Feb 9 09:48:50.739338 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Feb 9 09:48:50.739346 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Feb 9 09:48:50.739352 kernel: audit: initializing netlink subsys (disabled) Feb 9 09:48:50.739359 kernel: audit: type=2000 audit(0.032:1): state=initialized audit_enabled=0 res=1 Feb 9 09:48:50.739365 kernel: thermal_sys: Registered thermal governor 'step_wise' Feb 9 09:48:50.739372 kernel: cpuidle: using governor menu Feb 9 09:48:50.739378 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Feb 9 09:48:50.739385 kernel: ASID allocator initialised with 32768 entries Feb 9 09:48:50.739391 kernel: ACPI: bus type PCI registered Feb 9 09:48:50.739398 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Feb 9 09:48:50.739405 kernel: Serial: AMBA PL011 UART driver Feb 9 09:48:50.739412 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Feb 9 09:48:50.739418 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Feb 9 09:48:50.739425 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Feb 9 09:48:50.739431 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Feb 9 09:48:50.739438 kernel: cryptd: max_cpu_qlen set to 1000 Feb 9 09:48:50.739444 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Feb 9 09:48:50.739451 kernel: ACPI: Added _OSI(Module Device) Feb 9 09:48:50.739457 kernel: ACPI: Added _OSI(Processor Device) Feb 9 09:48:50.739465 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Feb 9 09:48:50.739471 kernel: ACPI: Added _OSI(Processor Aggregator Device) Feb 9 09:48:50.739478 kernel: ACPI: Added _OSI(Linux-Dell-Video) Feb 9 09:48:50.739485 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Feb 9 09:48:50.739491 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Feb 9 09:48:50.739497 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Feb 9 09:48:50.739504 kernel: ACPI: Interpreter enabled Feb 9 09:48:50.739510 kernel: ACPI: Using GIC for interrupt routing Feb 9 09:48:50.739517 kernel: ACPI: MCFG table detected, 1 entries Feb 9 09:48:50.739525 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Feb 9 09:48:50.739531 kernel: printk: console [ttyAMA0] enabled Feb 9 09:48:50.739538 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Feb 9 09:48:50.739655 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Feb 9 09:48:50.739719 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Feb 9 09:48:50.739778 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Feb 9 09:48:50.739837 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Feb 9 09:48:50.739910 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Feb 9 09:48:50.739919 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Feb 9 09:48:50.739925 kernel: PCI host bridge to bus 0000:00 Feb 9 09:48:50.739990 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Feb 9 09:48:50.740044 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Feb 9 09:48:50.740096 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Feb 9 09:48:50.740148 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Feb 9 09:48:50.740226 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Feb 9 09:48:50.740320 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Feb 9 09:48:50.740384 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Feb 9 09:48:50.740443 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Feb 9 09:48:50.740505 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Feb 9 09:48:50.740571 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Feb 9 09:48:50.740631 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Feb 9 09:48:50.740692 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Feb 9 09:48:50.740747 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Feb 9 09:48:50.740799 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Feb 9 09:48:50.740862 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Feb 9 09:48:50.740871 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Feb 9 09:48:50.740879 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Feb 9 09:48:50.740886 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Feb 9 09:48:50.740895 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Feb 9 09:48:50.740901 kernel: iommu: Default domain type: Translated Feb 9 09:48:50.740908 kernel: iommu: DMA domain TLB invalidation policy: strict mode Feb 9 09:48:50.740915 kernel: vgaarb: loaded Feb 9 09:48:50.740921 kernel: pps_core: LinuxPPS API ver. 1 registered Feb 9 09:48:50.740928 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Feb 9 09:48:50.740935 kernel: PTP clock support registered Feb 9 09:48:50.740941 kernel: Registered efivars operations Feb 9 09:48:50.740948 kernel: clocksource: Switched to clocksource arch_sys_counter Feb 9 09:48:50.740955 kernel: VFS: Disk quotas dquot_6.6.0 Feb 9 09:48:50.740963 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Feb 9 09:48:50.740970 kernel: pnp: PnP ACPI init Feb 9 09:48:50.741039 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Feb 9 09:48:50.741048 kernel: pnp: PnP ACPI: found 1 devices Feb 9 09:48:50.741055 kernel: NET: Registered PF_INET protocol family Feb 9 09:48:50.741062 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Feb 9 09:48:50.741068 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Feb 9 09:48:50.741075 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Feb 9 09:48:50.741084 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Feb 9 09:48:50.741090 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Feb 9 09:48:50.741097 kernel: TCP: Hash tables configured (established 32768 bind 32768) Feb 9 09:48:50.741104 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Feb 9 09:48:50.741110 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Feb 9 09:48:50.741117 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Feb 9 09:48:50.741124 kernel: PCI: CLS 0 bytes, default 64 Feb 9 09:48:50.741130 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Feb 9 09:48:50.741138 kernel: kvm [1]: HYP mode not available Feb 9 09:48:50.741145 kernel: Initialise system trusted keyrings Feb 9 09:48:50.741151 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Feb 9 09:48:50.741158 kernel: Key type asymmetric registered Feb 9 09:48:50.741164 kernel: Asymmetric key parser 'x509' registered Feb 9 09:48:50.741171 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Feb 9 09:48:50.741177 kernel: io scheduler mq-deadline registered Feb 9 09:48:50.741184 kernel: io scheduler kyber registered Feb 9 09:48:50.741191 kernel: io scheduler bfq registered Feb 9 09:48:50.741197 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Feb 9 09:48:50.741205 kernel: ACPI: button: Power Button [PWRB] Feb 9 09:48:50.741212 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Feb 9 09:48:50.741271 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Feb 9 09:48:50.741279 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Feb 9 09:48:50.741301 kernel: thunder_xcv, ver 1.0 Feb 9 09:48:50.741308 kernel: thunder_bgx, ver 1.0 Feb 9 09:48:50.741315 kernel: nicpf, ver 1.0 Feb 9 09:48:50.741321 kernel: nicvf, ver 1.0 Feb 9 09:48:50.741390 kernel: rtc-efi rtc-efi.0: registered as rtc0 Feb 9 09:48:50.741451 kernel: rtc-efi rtc-efi.0: setting system clock to 2024-02-09T09:48:50 UTC (1707472130) Feb 9 09:48:50.741460 kernel: hid: raw HID events driver (C) Jiri Kosina Feb 9 09:48:50.741466 kernel: NET: Registered PF_INET6 protocol family Feb 9 09:48:50.741473 kernel: Segment Routing with IPv6 Feb 9 09:48:50.741480 kernel: In-situ OAM (IOAM) with IPv6 Feb 9 09:48:50.741486 kernel: NET: Registered PF_PACKET protocol family Feb 9 09:48:50.741492 kernel: Key type dns_resolver registered Feb 9 09:48:50.741499 kernel: registered taskstats version 1 Feb 9 09:48:50.741507 kernel: Loading compiled-in X.509 certificates Feb 9 09:48:50.741514 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.15.148-flatcar: ca91574208414224935c9cea513398977daf917d' Feb 9 09:48:50.741521 kernel: Key type .fscrypt registered Feb 9 09:48:50.741527 kernel: Key type fscrypt-provisioning registered Feb 9 09:48:50.741534 kernel: ima: No TPM chip found, activating TPM-bypass! Feb 9 09:48:50.741540 kernel: ima: Allocated hash algorithm: sha1 Feb 9 09:48:50.741547 kernel: ima: No architecture policies found Feb 9 09:48:50.741553 kernel: Freeing unused kernel memory: 34688K Feb 9 09:48:50.741559 kernel: Run /init as init process Feb 9 09:48:50.741567 kernel: with arguments: Feb 9 09:48:50.741573 kernel: /init Feb 9 09:48:50.741580 kernel: with environment: Feb 9 09:48:50.741586 kernel: HOME=/ Feb 9 09:48:50.741592 kernel: TERM=linux Feb 9 09:48:50.741599 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Feb 9 09:48:50.741607 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) Feb 9 09:48:50.741616 systemd[1]: Detected virtualization kvm. Feb 9 09:48:50.741624 systemd[1]: Detected architecture arm64. Feb 9 09:48:50.741631 systemd[1]: Running in initrd. Feb 9 09:48:50.741638 systemd[1]: No hostname configured, using default hostname. Feb 9 09:48:50.741645 systemd[1]: Hostname set to . Feb 9 09:48:50.741653 systemd[1]: Initializing machine ID from VM UUID. Feb 9 09:48:50.741660 systemd[1]: Queued start job for default target initrd.target. Feb 9 09:48:50.741666 systemd[1]: Started systemd-ask-password-console.path. Feb 9 09:48:50.741673 systemd[1]: Reached target cryptsetup.target. Feb 9 09:48:50.741681 systemd[1]: Reached target paths.target. Feb 9 09:48:50.741688 systemd[1]: Reached target slices.target. Feb 9 09:48:50.741695 systemd[1]: Reached target swap.target. Feb 9 09:48:50.741701 systemd[1]: Reached target timers.target. Feb 9 09:48:50.741709 systemd[1]: Listening on iscsid.socket. Feb 9 09:48:50.741716 systemd[1]: Listening on iscsiuio.socket. Feb 9 09:48:50.741723 systemd[1]: Listening on systemd-journald-audit.socket. Feb 9 09:48:50.741732 systemd[1]: Listening on systemd-journald-dev-log.socket. Feb 9 09:48:50.741739 systemd[1]: Listening on systemd-journald.socket. Feb 9 09:48:50.741745 systemd[1]: Listening on systemd-networkd.socket. Feb 9 09:48:50.741752 systemd[1]: Listening on systemd-udevd-control.socket. Feb 9 09:48:50.741760 systemd[1]: Listening on systemd-udevd-kernel.socket. Feb 9 09:48:50.741767 systemd[1]: Reached target sockets.target. Feb 9 09:48:50.741774 systemd[1]: Starting kmod-static-nodes.service... Feb 9 09:48:50.741780 systemd[1]: Finished network-cleanup.service. Feb 9 09:48:50.741787 systemd[1]: Starting systemd-fsck-usr.service... Feb 9 09:48:50.741795 systemd[1]: Starting systemd-journald.service... Feb 9 09:48:50.741802 systemd[1]: Starting systemd-modules-load.service... Feb 9 09:48:50.741809 systemd[1]: Starting systemd-resolved.service... Feb 9 09:48:50.741816 systemd[1]: Starting systemd-vconsole-setup.service... Feb 9 09:48:50.741823 systemd[1]: Finished kmod-static-nodes.service. Feb 9 09:48:50.741830 systemd[1]: Finished systemd-fsck-usr.service. Feb 9 09:48:50.741837 systemd[1]: Starting systemd-tmpfiles-setup-dev.service... Feb 9 09:48:50.741850 systemd[1]: Finished systemd-vconsole-setup.service. Feb 9 09:48:50.741859 systemd[1]: Starting dracut-cmdline-ask.service... Feb 9 09:48:50.741870 systemd-journald[290]: Journal started Feb 9 09:48:50.741907 systemd-journald[290]: Runtime Journal (/run/log/journal/e8e46936e35c4b20a926f2fd5c34fe52) is 6.0M, max 48.7M, 42.6M free. Feb 9 09:48:50.734172 systemd-modules-load[291]: Inserted module 'overlay' Feb 9 09:48:50.743823 systemd[1]: Started systemd-journald.service. Feb 9 09:48:50.743000 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' Feb 9 09:48:50.746438 kernel: audit: type=1130 audit(1707472130.743:2): 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' Feb 9 09:48:50.746590 systemd[1]: Finished systemd-tmpfiles-setup-dev.service. Feb 9 09:48:50.750932 kernel: audit: type=1130 audit(1707472130.747:3): 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' Feb 9 09:48:50.750957 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Feb 9 09:48:50.747000 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' Feb 9 09:48:50.752919 systemd-modules-load[291]: Inserted module 'br_netfilter' Feb 9 09:48:50.753598 kernel: Bridge firewalling registered Feb 9 09:48:50.761851 systemd-resolved[292]: Positive Trust Anchors: Feb 9 09:48:50.762666 systemd-resolved[292]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Feb 9 09:48:50.764252 systemd-resolved[292]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test Feb 9 09:48:50.768504 kernel: SCSI subsystem initialized Feb 9 09:48:50.769085 systemd[1]: Finished dracut-cmdline-ask.service. Feb 9 09:48:50.769000 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' Feb 9 09:48:50.769985 systemd-resolved[292]: Defaulting to hostname 'linux'. Feb 9 09:48:50.777459 kernel: audit: type=1130 audit(1707472130.769:4): 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' Feb 9 09:48:50.777479 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Feb 9 09:48:50.777488 kernel: device-mapper: uevent: version 1.0.3 Feb 9 09:48:50.777496 kernel: audit: type=1130 audit(1707472130.774:5): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Feb 9 09:48:50.777510 kernel: device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com Feb 9 09:48:50.774000 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' Feb 9 09:48:50.772219 systemd[1]: Started systemd-resolved.service. Feb 9 09:48:50.776741 systemd[1]: Reached target nss-lookup.target. Feb 9 09:48:50.778751 systemd[1]: Starting dracut-cmdline.service... Feb 9 09:48:50.780134 systemd-modules-load[291]: Inserted module 'dm_multipath' Feb 9 09:48:50.780804 systemd[1]: Finished systemd-modules-load.service. Feb 9 09:48:50.781000 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' Feb 9 09:48:50.782778 systemd[1]: Starting systemd-sysctl.service... Feb 9 09:48:50.785892 kernel: audit: type=1130 audit(1707472130.781:6): 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' Feb 9 09:48:50.789521 dracut-cmdline[309]: dracut-dracut-053 Feb 9 09:48:50.791028 systemd[1]: Finished systemd-sysctl.service. Feb 9 09:48:50.791000 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' Feb 9 09:48:50.794047 dracut-cmdline[309]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected acpi=force verity.usrhash=14ffd9340f674a8d04c9d43eed85484d8b2b7e2bcd8b36a975c9ac66063d537d Feb 9 09:48:50.797740 kernel: audit: type=1130 audit(1707472130.791:7): 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' Feb 9 09:48:50.846307 kernel: Loading iSCSI transport class v2.0-870. Feb 9 09:48:50.854308 kernel: iscsi: registered transport (tcp) Feb 9 09:48:50.869316 kernel: iscsi: registered transport (qla4xxx) Feb 9 09:48:50.869339 kernel: QLogic iSCSI HBA Driver Feb 9 09:48:50.902880 systemd[1]: Finished dracut-cmdline.service. Feb 9 09:48:50.903000 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' Feb 9 09:48:50.904446 systemd[1]: Starting dracut-pre-udev.service... Feb 9 09:48:50.907250 kernel: audit: type=1130 audit(1707472130.903:8): 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' Feb 9 09:48:50.947308 kernel: raid6: neonx8 gen() 13674 MB/s Feb 9 09:48:50.964296 kernel: raid6: neonx8 xor() 10787 MB/s Feb 9 09:48:50.981297 kernel: raid6: neonx4 gen() 13532 MB/s Feb 9 09:48:50.998300 kernel: raid6: neonx4 xor() 11218 MB/s Feb 9 09:48:51.015302 kernel: raid6: neonx2 gen() 12959 MB/s Feb 9 09:48:51.032299 kernel: raid6: neonx2 xor() 10307 MB/s Feb 9 09:48:51.049307 kernel: raid6: neonx1 gen() 10504 MB/s Feb 9 09:48:51.066298 kernel: raid6: neonx1 xor() 8786 MB/s Feb 9 09:48:51.083300 kernel: raid6: int64x8 gen() 6295 MB/s Feb 9 09:48:51.100299 kernel: raid6: int64x8 xor() 3544 MB/s Feb 9 09:48:51.117300 kernel: raid6: int64x4 gen() 7230 MB/s Feb 9 09:48:51.134307 kernel: raid6: int64x4 xor() 3852 MB/s Feb 9 09:48:51.151307 kernel: raid6: int64x2 gen() 6149 MB/s Feb 9 09:48:51.168298 kernel: raid6: int64x2 xor() 3321 MB/s Feb 9 09:48:51.185300 kernel: raid6: int64x1 gen() 5046 MB/s Feb 9 09:48:51.202583 kernel: raid6: int64x1 xor() 2645 MB/s Feb 9 09:48:51.202603 kernel: raid6: using algorithm neonx8 gen() 13674 MB/s Feb 9 09:48:51.202620 kernel: raid6: .... xor() 10787 MB/s, rmw enabled Feb 9 09:48:51.202637 kernel: raid6: using neon recovery algorithm Feb 9 09:48:51.213593 kernel: xor: measuring software checksum speed Feb 9 09:48:51.213606 kernel: 8regs : 17315 MB/sec Feb 9 09:48:51.214441 kernel: 32regs : 20765 MB/sec Feb 9 09:48:51.215593 kernel: arm64_neon : 27901 MB/sec Feb 9 09:48:51.215604 kernel: xor: using function: arm64_neon (27901 MB/sec) Feb 9 09:48:51.270308 kernel: Btrfs loaded, crc32c=crc32c-generic, zoned=no, fsverity=no Feb 9 09:48:51.281083 systemd[1]: Finished dracut-pre-udev.service. Feb 9 09:48:51.284641 kernel: audit: type=1130 audit(1707472131.281:9): 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' Feb 9 09:48:51.284667 kernel: audit: type=1334 audit(1707472131.283:10): prog-id=7 op=LOAD Feb 9 09:48:51.281000 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' Feb 9 09:48:51.283000 audit: BPF prog-id=7 op=LOAD Feb 9 09:48:51.284000 audit: BPF prog-id=8 op=LOAD Feb 9 09:48:51.285070 systemd[1]: Starting systemd-udevd.service... Feb 9 09:48:51.299162 systemd-udevd[490]: Using default interface naming scheme 'v252'. Feb 9 09:48:51.302515 systemd[1]: Started systemd-udevd.service. Feb 9 09:48:51.302000 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' Feb 9 09:48:51.303890 systemd[1]: Starting dracut-pre-trigger.service... Feb 9 09:48:51.315259 dracut-pre-trigger[497]: rd.md=0: removing MD RAID activation Feb 9 09:48:51.339908 systemd[1]: Finished dracut-pre-trigger.service. Feb 9 09:48:51.340000 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' Feb 9 09:48:51.341448 systemd[1]: Starting systemd-udev-trigger.service... Feb 9 09:48:51.374763 systemd[1]: Finished systemd-udev-trigger.service. Feb 9 09:48:51.375000 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' Feb 9 09:48:51.400320 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Feb 9 09:48:51.402305 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Feb 9 09:48:51.421309 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by (udev-worker) (552) Feb 9 09:48:51.425095 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device. Feb 9 09:48:51.428540 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device. Feb 9 09:48:51.431403 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device. Feb 9 09:48:51.432220 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device. Feb 9 09:48:51.438482 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. Feb 9 09:48:51.440171 systemd[1]: Starting disk-uuid.service... Feb 9 09:48:51.449354 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Feb 9 09:48:52.459439 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Feb 9 09:48:52.459487 disk-uuid[564]: The operation has completed successfully. Feb 9 09:48:52.483643 systemd[1]: disk-uuid.service: Deactivated successfully. Feb 9 09:48:52.484506 systemd[1]: Finished disk-uuid.service. Feb 9 09:48:52.485000 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' Feb 9 09:48:52.485000 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' Feb 9 09:48:52.488605 systemd[1]: Starting verity-setup.service... Feb 9 09:48:52.506313 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Feb 9 09:48:52.527198 systemd[1]: Found device dev-mapper-usr.device. Feb 9 09:48:52.529372 systemd[1]: Mounting sysusr-usr.mount... Feb 9 09:48:52.531086 systemd[1]: Finished verity-setup.service. Feb 9 09:48:52.531000 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' Feb 9 09:48:52.576307 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: norecovery. Quota mode: none. Feb 9 09:48:52.576455 systemd[1]: Mounted sysusr-usr.mount. Feb 9 09:48:52.577242 systemd[1]: afterburn-network-kargs.service was skipped because no trigger condition checks were met. Feb 9 09:48:52.578036 systemd[1]: Starting ignition-setup.service... Feb 9 09:48:52.580081 systemd[1]: Starting parse-ip-for-networkd.service... Feb 9 09:48:52.586438 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Feb 9 09:48:52.586471 kernel: BTRFS info (device vda6): using free space tree Feb 9 09:48:52.586481 kernel: BTRFS info (device vda6): has skinny extents Feb 9 09:48:52.594685 systemd[1]: mnt-oem.mount: Deactivated successfully. Feb 9 09:48:52.600213 systemd[1]: Finished ignition-setup.service. Feb 9 09:48:52.601685 systemd[1]: Starting ignition-fetch-offline.service... Feb 9 09:48:52.600000 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' Feb 9 09:48:52.670272 systemd[1]: Finished parse-ip-for-networkd.service. Feb 9 09:48:52.670000 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' Feb 9 09:48:52.671000 audit: BPF prog-id=9 op=LOAD Feb 9 09:48:52.672530 systemd[1]: Starting systemd-networkd.service... Feb 9 09:48:52.700620 systemd-networkd[740]: lo: Link UP Feb 9 09:48:52.700634 systemd-networkd[740]: lo: Gained carrier Feb 9 09:48:52.702000 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' Feb 9 09:48:52.701017 systemd-networkd[740]: Enumeration completed Feb 9 09:48:52.701176 systemd[1]: Started systemd-networkd.service. Feb 9 09:48:52.701191 systemd-networkd[740]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Feb 9 09:48:52.702226 systemd-networkd[740]: eth0: Link UP Feb 9 09:48:52.702230 systemd-networkd[740]: eth0: Gained carrier Feb 9 09:48:52.702409 systemd[1]: Reached target network.target. Feb 9 09:48:52.704194 systemd[1]: Starting iscsiuio.service... Feb 9 09:48:52.711653 ignition[644]: Ignition 2.14.0 Feb 9 09:48:52.711664 ignition[644]: Stage: fetch-offline Feb 9 09:48:52.711705 ignition[644]: no configs at "/usr/lib/ignition/base.d" Feb 9 09:48:52.711715 ignition[644]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Feb 9 09:48:52.714160 systemd[1]: Started iscsiuio.service. Feb 9 09:48:52.714000 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' Feb 9 09:48:52.711864 ignition[644]: parsed url from cmdline: "" Feb 9 09:48:52.715686 systemd[1]: Starting iscsid.service... Feb 9 09:48:52.711868 ignition[644]: no config URL provided Feb 9 09:48:52.711872 ignition[644]: reading system config file "/usr/lib/ignition/user.ign" Feb 9 09:48:52.711880 ignition[644]: no config at "/usr/lib/ignition/user.ign" Feb 9 09:48:52.720458 iscsid[746]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Feb 9 09:48:52.720458 iscsid[746]: iscsid: Warning: InitiatorName file /etc/iscsi/initiatorname.iscsi does not exist or does not contain a properly formatted InitiatorName. If using software iscsi (iscsi_tcp or ib_iser) or partial offload (bnx2i or cxgbi iscsi), you may not be able to log into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier]. Feb 9 09:48:52.720458 iscsid[746]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Feb 9 09:48:52.720458 iscsid[746]: If using hardware iscsi like qla4xxx this message can be ignored. Feb 9 09:48:52.720458 iscsid[746]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Feb 9 09:48:52.720458 iscsid[746]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Feb 9 09:48:52.722000 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' Feb 9 09:48:52.711899 ignition[644]: op(1): [started] loading QEMU firmware config module Feb 9 09:48:52.721718 systemd[1]: Started iscsid.service. Feb 9 09:48:52.711904 ignition[644]: op(1): executing: "modprobe" "qemu_fw_cfg" Feb 9 09:48:52.723079 systemd[1]: Starting dracut-initqueue.service... Feb 9 09:48:52.734000 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' Feb 9 09:48:52.717694 ignition[644]: op(1): [finished] loading QEMU firmware config module Feb 9 09:48:52.730418 systemd-networkd[740]: eth0: DHCPv4 address 10.0.0.33/16, gateway 10.0.0.1 acquired from 10.0.0.1 Feb 9 09:48:52.730566 ignition[644]: parsing config with SHA512: b5353c705665b1cbbf4a66436886e67544a060a2047498314eeb8e4bb77efe4c7ac6fb0a784ef9cf822dc8484f175a1c83ace2b08839895f730a575d1e34fe4a Feb 9 09:48:52.733700 systemd[1]: Finished dracut-initqueue.service. Feb 9 09:48:52.734645 systemd[1]: Reached target remote-fs-pre.target. Feb 9 09:48:52.735738 systemd[1]: Reached target remote-cryptsetup.target. Feb 9 09:48:52.736966 systemd[1]: Reached target remote-fs.target. Feb 9 09:48:52.739369 systemd[1]: Starting dracut-pre-mount.service... Feb 9 09:48:52.746404 unknown[644]: fetched base config from "system" Feb 9 09:48:52.746672 ignition[644]: fetch-offline: fetch-offline passed Feb 9 09:48:52.751000 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' Feb 9 09:48:52.746414 unknown[644]: fetched user config from "qemu" Feb 9 09:48:52.750691 ignition[644]: Ignition finished successfully Feb 9 09:48:52.752000 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' Feb 9 09:48:52.746889 systemd[1]: Finished dracut-pre-mount.service. Feb 9 09:48:52.752240 systemd[1]: Finished ignition-fetch-offline.service. Feb 9 09:48:52.753244 systemd[1]: ignition-fetch.service was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Feb 9 09:48:52.753939 systemd[1]: Starting ignition-kargs.service... Feb 9 09:48:52.762434 ignition[761]: Ignition 2.14.0 Feb 9 09:48:52.762445 ignition[761]: Stage: kargs Feb 9 09:48:52.762534 ignition[761]: no configs at "/usr/lib/ignition/base.d" Feb 9 09:48:52.762543 ignition[761]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Feb 9 09:48:52.763163 ignition[761]: kargs: kargs passed Feb 9 09:48:52.766000 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' Feb 9 09:48:52.765077 systemd[1]: Finished ignition-kargs.service. Feb 9 09:48:52.763199 ignition[761]: Ignition finished successfully Feb 9 09:48:52.767062 systemd[1]: Starting ignition-disks.service... Feb 9 09:48:52.773430 ignition[767]: Ignition 2.14.0 Feb 9 09:48:52.773439 ignition[767]: Stage: disks Feb 9 09:48:52.773526 ignition[767]: no configs at "/usr/lib/ignition/base.d" Feb 9 09:48:52.773535 ignition[767]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Feb 9 09:48:52.774200 ignition[767]: disks: disks passed Feb 9 09:48:52.776000 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' Feb 9 09:48:52.775892 systemd[1]: Finished ignition-disks.service. Feb 9 09:48:52.774238 ignition[767]: Ignition finished successfully Feb 9 09:48:52.777205 systemd[1]: Reached target initrd-root-device.target. Feb 9 09:48:52.778069 systemd[1]: Reached target local-fs-pre.target. Feb 9 09:48:52.779024 systemd[1]: Reached target local-fs.target. Feb 9 09:48:52.779959 systemd[1]: Reached target sysinit.target. Feb 9 09:48:52.780952 systemd[1]: Reached target basic.target. Feb 9 09:48:52.782662 systemd[1]: Starting systemd-fsck-root.service... Feb 9 09:48:52.792800 systemd-fsck[775]: ROOT: clean, 602/553520 files, 56013/553472 blocks Feb 9 09:48:52.796155 systemd[1]: Finished systemd-fsck-root.service. Feb 9 09:48:52.796000 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' Feb 9 09:48:52.797927 systemd[1]: Mounting sysroot.mount... Feb 9 09:48:52.804181 systemd[1]: Mounted sysroot.mount. Feb 9 09:48:52.805258 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none. Feb 9 09:48:52.804954 systemd[1]: Reached target initrd-root-fs.target. Feb 9 09:48:52.806902 systemd[1]: Mounting sysroot-usr.mount... Feb 9 09:48:52.807743 systemd[1]: flatcar-metadata-hostname.service was skipped because no trigger condition checks were met. Feb 9 09:48:52.807780 systemd[1]: ignition-remount-sysroot.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Feb 9 09:48:52.807805 systemd[1]: Reached target ignition-diskful.target. Feb 9 09:48:52.809647 systemd[1]: Mounted sysroot-usr.mount. Feb 9 09:48:52.812310 systemd[1]: Starting initrd-setup-root.service... Feb 9 09:48:52.816671 initrd-setup-root[785]: cut: /sysroot/etc/passwd: No such file or directory Feb 9 09:48:52.820649 initrd-setup-root[793]: cut: /sysroot/etc/group: No such file or directory Feb 9 09:48:52.824180 initrd-setup-root[801]: cut: /sysroot/etc/shadow: No such file or directory Feb 9 09:48:52.827760 initrd-setup-root[809]: cut: /sysroot/etc/gshadow: No such file or directory Feb 9 09:48:52.853069 systemd[1]: Finished initrd-setup-root.service. Feb 9 09:48:52.853000 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' Feb 9 09:48:52.854555 systemd[1]: Starting ignition-mount.service... Feb 9 09:48:52.855724 systemd[1]: Starting sysroot-boot.service... Feb 9 09:48:52.859523 bash[826]: umount: /sysroot/usr/share/oem: not mounted. Feb 9 09:48:52.868431 ignition[828]: INFO : Ignition 2.14.0 Feb 9 09:48:52.868431 ignition[828]: INFO : Stage: mount Feb 9 09:48:52.870000 ignition[828]: INFO : no configs at "/usr/lib/ignition/base.d" Feb 9 09:48:52.870000 ignition[828]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Feb 9 09:48:52.870000 ignition[828]: INFO : mount: mount passed Feb 9 09:48:52.870000 ignition[828]: INFO : Ignition finished successfully Feb 9 09:48:52.872000 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' Feb 9 09:48:52.871470 systemd[1]: Finished ignition-mount.service. Feb 9 09:48:52.877548 systemd[1]: Finished sysroot-boot.service. Feb 9 09:48:52.877000 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' Feb 9 09:48:53.538939 systemd[1]: Mounting sysroot-usr-share-oem.mount... Feb 9 09:48:53.547310 kernel: BTRFS: device label OEM devid 1 transid 13 /dev/vda6 scanned by mount (836) Feb 9 09:48:53.548647 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Feb 9 09:48:53.548664 kernel: BTRFS info (device vda6): using free space tree Feb 9 09:48:53.548680 kernel: BTRFS info (device vda6): has skinny extents Feb 9 09:48:53.552072 systemd[1]: Mounted sysroot-usr-share-oem.mount. Feb 9 09:48:53.553740 systemd[1]: Starting ignition-files.service... Feb 9 09:48:53.567648 ignition[856]: INFO : Ignition 2.14.0 Feb 9 09:48:53.567648 ignition[856]: INFO : Stage: files Feb 9 09:48:53.569374 ignition[856]: INFO : no configs at "/usr/lib/ignition/base.d" Feb 9 09:48:53.569374 ignition[856]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Feb 9 09:48:53.569374 ignition[856]: DEBUG : files: compiled without relabeling support, skipping Feb 9 09:48:53.595845 ignition[856]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "dockremap" Feb 9 09:48:53.595845 ignition[856]: DEBUG : files: ensureUsers: op(1): executing: "useradd" "--root" "/sysroot" "--create-home" "--password" "*" "dockremap" Feb 9 09:48:53.685134 ignition[856]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "dockremap" Feb 9 09:48:53.686299 ignition[856]: INFO : files: ensureUsers: op(2): [started] creating or modifying user "core" Feb 9 09:48:53.686299 ignition[856]: DEBUG : files: ensureUsers: op(2): executing: "usermod" "--root" "/sysroot" "core" Feb 9 09:48:53.688274 ignition[856]: INFO : files: ensureUsers: op(2): [finished] creating or modifying user "core" Feb 9 09:48:53.688274 ignition[856]: INFO : files: ensureUsers: op(3): [started] adding ssh keys to user "core" Feb 9 09:48:53.688274 ignition[856]: INFO : files: ensureUsers: op(3): [finished] adding ssh keys to user "core" Feb 9 09:48:53.688274 ignition[856]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/subuid" Feb 9 09:48:53.688274 ignition[856]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/subuid" Feb 9 09:48:53.688274 ignition[856]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing file "/sysroot/etc/subgid" Feb 9 09:48:53.688274 ignition[856]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing file "/sysroot/etc/subgid" Feb 9 09:48:53.687394 unknown[856]: wrote ssh authorized keys file for user: core Feb 9 09:48:53.697737 ignition[856]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/etc/flatcar/update.conf" Feb 9 09:48:53.697737 ignition[856]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/etc/flatcar/update.conf" Feb 9 09:48:53.697737 ignition[856]: INFO : files: op(7): [started] processing unit "docker.service" Feb 9 09:48:53.697737 ignition[856]: INFO : files: op(7): op(8): [started] writing systemd drop-in "10-userns.conf" at "/sysroot/etc/systemd/system/docker.service.d/10-userns.conf" Feb 9 09:48:53.697737 ignition[856]: INFO : files: op(7): op(8): [finished] writing systemd drop-in "10-userns.conf" at "/sysroot/etc/systemd/system/docker.service.d/10-userns.conf" Feb 9 09:48:53.697737 ignition[856]: INFO : files: op(7): [finished] processing unit "docker.service" Feb 9 09:48:53.697737 ignition[856]: INFO : files: op(9): [started] processing unit "coreos-metadata.service" Feb 9 09:48:53.697737 ignition[856]: INFO : files: op(9): op(a): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Feb 9 09:48:53.697737 ignition[856]: INFO : files: op(9): op(a): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Feb 9 09:48:53.697737 ignition[856]: INFO : files: op(9): [finished] processing unit "coreos-metadata.service" Feb 9 09:48:53.697737 ignition[856]: INFO : files: op(b): [started] setting preset to enabled for "docker.service" Feb 9 09:48:53.697737 ignition[856]: INFO : files: op(b): [finished] setting preset to enabled for "docker.service" Feb 9 09:48:53.697737 ignition[856]: INFO : files: op(c): [started] setting preset to disabled for "coreos-metadata.service" Feb 9 09:48:53.697737 ignition[856]: INFO : files: op(c): op(d): [started] removing enablement symlink(s) for "coreos-metadata.service" Feb 9 09:48:53.725598 ignition[856]: INFO : files: op(c): op(d): [finished] removing enablement symlink(s) for "coreos-metadata.service" Feb 9 09:48:53.727370 ignition[856]: INFO : files: op(c): [finished] setting preset to disabled for "coreos-metadata.service" Feb 9 09:48:53.727370 ignition[856]: INFO : files: createResultFile: createFiles: op(e): [started] writing file "/sysroot/etc/.ignition-result.json" Feb 9 09:48:53.727370 ignition[856]: INFO : files: createResultFile: createFiles: op(e): [finished] writing file "/sysroot/etc/.ignition-result.json" Feb 9 09:48:53.727370 ignition[856]: INFO : files: files passed Feb 9 09:48:53.727370 ignition[856]: INFO : Ignition finished successfully Feb 9 09:48:53.728000 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' Feb 9 09:48:53.727484 systemd[1]: Finished ignition-files.service. Feb 9 09:48:53.729960 systemd[1]: Starting initrd-setup-root-after-ignition.service... Feb 9 09:48:53.730906 systemd[1]: torcx-profile-populate.service was skipped because of an unmet condition check (ConditionPathExists=/sysroot/etc/torcx/next-profile). Feb 9 09:48:53.737000 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' Feb 9 09:48:53.737000 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' Feb 9 09:48:53.739189 initrd-setup-root-after-ignition[892]: grep: /sysroot/usr/share/oem/oem-release: No such file or directory Feb 9 09:48:53.731617 systemd[1]: Starting ignition-quench.service... Feb 9 09:48:53.741000 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' Feb 9 09:48:53.742127 initrd-setup-root-after-ignition[894]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Feb 9 09:48:53.736454 systemd[1]: ignition-quench.service: Deactivated successfully. Feb 9 09:48:53.736658 systemd[1]: Finished ignition-quench.service. Feb 9 09:48:53.739635 systemd[1]: Finished initrd-setup-root-after-ignition.service. Feb 9 09:48:53.741565 systemd[1]: Reached target ignition-complete.target. Feb 9 09:48:53.743392 systemd[1]: Starting initrd-parse-etc.service... Feb 9 09:48:53.756693 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Feb 9 09:48:53.756800 systemd[1]: Finished initrd-parse-etc.service. Feb 9 09:48:53.757000 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' Feb 9 09:48:53.757000 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' Feb 9 09:48:53.758330 systemd[1]: Reached target initrd-fs.target. Feb 9 09:48:53.759365 systemd[1]: Reached target initrd.target. Feb 9 09:48:53.760529 systemd[1]: dracut-mount.service was skipped because no trigger condition checks were met. Feb 9 09:48:53.761391 systemd[1]: Starting dracut-pre-pivot.service... Feb 9 09:48:53.771799 systemd[1]: Finished dracut-pre-pivot.service. Feb 9 09:48:53.772000 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' Feb 9 09:48:53.773189 systemd[1]: Starting initrd-cleanup.service... Feb 9 09:48:53.781682 systemd[1]: Stopped target nss-lookup.target. Feb 9 09:48:53.782505 systemd[1]: Stopped target remote-cryptsetup.target. Feb 9 09:48:53.783561 systemd[1]: Stopped target timers.target. Feb 9 09:48:53.784544 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Feb 9 09:48:53.785000 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' Feb 9 09:48:53.784652 systemd[1]: Stopped dracut-pre-pivot.service. Feb 9 09:48:53.785635 systemd[1]: Stopped target initrd.target. Feb 9 09:48:53.786622 systemd[1]: Stopped target basic.target. Feb 9 09:48:53.787550 systemd[1]: Stopped target ignition-complete.target. Feb 9 09:48:53.788536 systemd[1]: Stopped target ignition-diskful.target. Feb 9 09:48:53.789511 systemd[1]: Stopped target initrd-root-device.target. Feb 9 09:48:53.790568 systemd[1]: Stopped target remote-fs.target. Feb 9 09:48:53.791567 systemd[1]: Stopped target remote-fs-pre.target. Feb 9 09:48:53.792608 systemd[1]: Stopped target sysinit.target. Feb 9 09:48:53.793595 systemd[1]: Stopped target local-fs.target. Feb 9 09:48:53.794591 systemd[1]: Stopped target local-fs-pre.target. Feb 9 09:48:53.795542 systemd[1]: Stopped target swap.target. Feb 9 09:48:53.797000 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' Feb 9 09:48:53.796433 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Feb 9 09:48:53.796549 systemd[1]: Stopped dracut-pre-mount.service. Feb 9 09:48:53.799000 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' Feb 9 09:48:53.797594 systemd[1]: Stopped target cryptsetup.target. Feb 9 09:48:53.800000 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' Feb 9 09:48:53.798439 systemd[1]: dracut-initqueue.service: Deactivated successfully. Feb 9 09:48:53.798536 systemd[1]: Stopped dracut-initqueue.service. Feb 9 09:48:53.799619 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Feb 9 09:48:53.799723 systemd[1]: Stopped ignition-fetch-offline.service. Feb 9 09:48:53.800689 systemd[1]: Stopped target paths.target. Feb 9 09:48:53.801566 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Feb 9 09:48:53.806321 systemd[1]: Stopped systemd-ask-password-console.path. Feb 9 09:48:53.807666 systemd[1]: Stopped target slices.target. Feb 9 09:48:53.808262 systemd[1]: Stopped target sockets.target. Feb 9 09:48:53.809216 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Feb 9 09:48:53.810000 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' Feb 9 09:48:53.809354 systemd[1]: Stopped initrd-setup-root-after-ignition.service. Feb 9 09:48:53.811000 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' Feb 9 09:48:53.810439 systemd[1]: ignition-files.service: Deactivated successfully. Feb 9 09:48:53.810533 systemd[1]: Stopped ignition-files.service. Feb 9 09:48:53.815508 iscsid[746]: iscsid shutting down. Feb 9 09:48:53.812615 systemd[1]: Stopping ignition-mount.service... Feb 9 09:48:53.813611 systemd[1]: Stopping iscsid.service... Feb 9 09:48:53.816680 systemd[1]: Stopping sysroot-boot.service... Feb 9 09:48:53.818000 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' Feb 9 09:48:53.819333 ignition[907]: INFO : Ignition 2.14.0 Feb 9 09:48:53.819333 ignition[907]: INFO : Stage: umount Feb 9 09:48:53.819333 ignition[907]: INFO : no configs at "/usr/lib/ignition/base.d" Feb 9 09:48:53.819333 ignition[907]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Feb 9 09:48:53.819000 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' Feb 9 09:48:53.823000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=iscsid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Feb 9 09:48:53.817629 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Feb 9 09:48:53.825020 ignition[907]: INFO : umount: umount passed Feb 9 09:48:53.825020 ignition[907]: INFO : Ignition finished successfully Feb 9 09:48:53.817753 systemd[1]: Stopped systemd-udev-trigger.service. Feb 9 09:48:53.818879 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Feb 9 09:48:53.818971 systemd[1]: Stopped dracut-pre-trigger.service. Feb 9 09:48:53.831000 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' Feb 9 09:48:53.821239 systemd[1]: iscsid.service: Deactivated successfully. Feb 9 09:48:53.832000 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' Feb 9 09:48:53.832000 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' Feb 9 09:48:53.821384 systemd[1]: Stopped iscsid.service. Feb 9 09:48:53.833000 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' Feb 9 09:48:53.824945 systemd[1]: iscsid.socket: Deactivated successfully. Feb 9 09:48:53.834000 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' Feb 9 09:48:53.824999 systemd[1]: Closed iscsid.socket. Feb 9 09:48:53.826679 systemd[1]: Stopping iscsiuio.service... Feb 9 09:48:53.829622 systemd[1]: sysroot-boot.mount: Deactivated successfully. Feb 9 09:48:53.837000 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' Feb 9 09:48:53.830063 systemd[1]: iscsiuio.service: Deactivated successfully. Feb 9 09:48:53.838000 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' Feb 9 09:48:53.830160 systemd[1]: Stopped iscsiuio.service. Feb 9 09:48:53.840000 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' Feb 9 09:48:53.831520 systemd[1]: initrd-cleanup.service: Deactivated successfully. Feb 9 09:48:53.841000 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' Feb 9 09:48:53.831606 systemd[1]: Finished initrd-cleanup.service. Feb 9 09:48:53.832733 systemd[1]: ignition-mount.service: Deactivated successfully. Feb 9 09:48:53.832817 systemd[1]: Stopped ignition-mount.service. Feb 9 09:48:53.834019 systemd[1]: sysroot-boot.service: Deactivated successfully. Feb 9 09:48:53.834106 systemd[1]: Stopped sysroot-boot.service. Feb 9 09:48:53.835051 systemd[1]: Stopped target network.target. Feb 9 09:48:53.836089 systemd[1]: iscsiuio.socket: Deactivated successfully. Feb 9 09:48:53.836129 systemd[1]: Closed iscsiuio.socket. Feb 9 09:48:53.837056 systemd[1]: ignition-disks.service: Deactivated successfully. Feb 9 09:48:53.837098 systemd[1]: Stopped ignition-disks.service. Feb 9 09:48:53.838181 systemd[1]: ignition-kargs.service: Deactivated successfully. Feb 9 09:48:53.838254 systemd[1]: Stopped ignition-kargs.service. Feb 9 09:48:53.839346 systemd[1]: ignition-setup.service: Deactivated successfully. Feb 9 09:48:53.839385 systemd[1]: Stopped ignition-setup.service. Feb 9 09:48:53.840581 systemd[1]: initrd-setup-root.service: Deactivated successfully. Feb 9 09:48:53.840626 systemd[1]: Stopped initrd-setup-root.service. Feb 9 09:48:53.842008 systemd[1]: Stopping systemd-networkd.service... Feb 9 09:48:53.854000 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' Feb 9 09:48:53.842947 systemd[1]: Stopping systemd-resolved.service... Feb 9 09:48:53.855000 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' Feb 9 09:48:53.852591 systemd[1]: systemd-resolved.service: Deactivated successfully. Feb 9 09:48:53.852690 systemd[1]: Stopped systemd-resolved.service. Feb 9 09:48:53.853492 systemd-networkd[740]: eth0: DHCPv6 lease lost Feb 9 09:48:53.858000 audit: BPF prog-id=6 op=UNLOAD Feb 9 09:48:53.854884 systemd[1]: systemd-networkd.service: Deactivated successfully. Feb 9 09:48:53.859000 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' Feb 9 09:48:53.854978 systemd[1]: Stopped systemd-networkd.service. Feb 9 09:48:53.860000 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' Feb 9 09:48:53.855907 systemd[1]: systemd-networkd.socket: Deactivated successfully. Feb 9 09:48:53.855933 systemd[1]: Closed systemd-networkd.socket. Feb 9 09:48:53.862000 audit: BPF prog-id=9 op=UNLOAD Feb 9 09:48:53.862000 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' Feb 9 09:48:53.857353 systemd[1]: Stopping network-cleanup.service... Feb 9 09:48:53.858280 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Feb 9 09:48:53.858411 systemd[1]: Stopped parse-ip-for-networkd.service. Feb 9 09:48:53.859460 systemd[1]: systemd-sysctl.service: Deactivated successfully. Feb 9 09:48:53.859497 systemd[1]: Stopped systemd-sysctl.service. Feb 9 09:48:53.861011 systemd[1]: systemd-modules-load.service: Deactivated successfully. Feb 9 09:48:53.861050 systemd[1]: Stopped systemd-modules-load.service. Feb 9 09:48:53.870000 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' Feb 9 09:48:53.862897 systemd[1]: Stopping systemd-udevd.service... Feb 9 09:48:53.865782 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Feb 9 09:48:53.871000 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' Feb 9 09:48:53.869296 systemd[1]: network-cleanup.service: Deactivated successfully. Feb 9 09:48:53.869388 systemd[1]: Stopped network-cleanup.service. Feb 9 09:48:53.871107 systemd[1]: systemd-udevd.service: Deactivated successfully. Feb 9 09:48:53.875000 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' Feb 9 09:48:53.871228 systemd[1]: Stopped systemd-udevd.service. Feb 9 09:48:53.876000 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' Feb 9 09:48:53.872369 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Feb 9 09:48:53.878000 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' Feb 9 09:48:53.872405 systemd[1]: Closed systemd-udevd-control.socket. Feb 9 09:48:53.873759 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Feb 9 09:48:53.873793 systemd[1]: Closed systemd-udevd-kernel.socket. Feb 9 09:48:53.881000 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' Feb 9 09:48:53.875078 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Feb 9 09:48:53.875123 systemd[1]: Stopped dracut-pre-udev.service. Feb 9 09:48:53.883000 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' Feb 9 09:48:53.876233 systemd[1]: dracut-cmdline.service: Deactivated successfully. Feb 9 09:48:53.884000 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' Feb 9 09:48:53.876274 systemd[1]: Stopped dracut-cmdline.service. Feb 9 09:48:53.877326 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Feb 9 09:48:53.877369 systemd[1]: Stopped dracut-cmdline-ask.service. Feb 9 09:48:53.887000 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' Feb 9 09:48:53.887000 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' Feb 9 09:48:53.879225 systemd[1]: Starting initrd-udevadm-cleanup-db.service... Feb 9 09:48:53.880422 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Feb 9 09:48:53.880480 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service. Feb 9 09:48:53.882375 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Feb 9 09:48:53.882420 systemd[1]: Stopped kmod-static-nodes.service. Feb 9 09:48:53.883780 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Feb 9 09:48:53.883821 systemd[1]: Stopped systemd-vconsole-setup.service. Feb 9 09:48:53.885664 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup\x2ddev.service.mount: Deactivated successfully. Feb 9 09:48:53.886084 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Feb 9 09:48:53.886165 systemd[1]: Finished initrd-udevadm-cleanup-db.service. Feb 9 09:48:53.887663 systemd[1]: Reached target initrd-switch-root.target. Feb 9 09:48:53.889393 systemd[1]: Starting initrd-switch-root.service... Feb 9 09:48:53.896039 systemd[1]: Switching root. Feb 9 09:48:53.909686 systemd-journald[290]: Journal stopped Feb 9 09:48:55.925849 systemd-journald[290]: Received SIGTERM from PID 1 (systemd). Feb 9 09:48:55.925912 kernel: SELinux: Class mctp_socket not defined in policy. Feb 9 09:48:55.925925 kernel: SELinux: Class anon_inode not defined in policy. Feb 9 09:48:55.925935 kernel: SELinux: the above unknown classes and permissions will be allowed Feb 9 09:48:55.925945 kernel: SELinux: policy capability network_peer_controls=1 Feb 9 09:48:55.925959 kernel: SELinux: policy capability open_perms=1 Feb 9 09:48:55.925968 kernel: SELinux: policy capability extended_socket_class=1 Feb 9 09:48:55.925978 kernel: SELinux: policy capability always_check_network=0 Feb 9 09:48:55.925988 kernel: SELinux: policy capability cgroup_seclabel=1 Feb 9 09:48:55.925999 kernel: SELinux: policy capability nnp_nosuid_transition=1 Feb 9 09:48:55.926008 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Feb 9 09:48:55.926032 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Feb 9 09:48:55.926043 systemd[1]: Successfully loaded SELinux policy in 33.494ms. Feb 9 09:48:55.926055 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.802ms. Feb 9 09:48:55.926067 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) Feb 9 09:48:55.926078 systemd[1]: Detected virtualization kvm. Feb 9 09:48:55.926089 systemd[1]: Detected architecture arm64. Feb 9 09:48:55.926099 systemd[1]: Detected first boot. Feb 9 09:48:55.926111 systemd[1]: Initializing machine ID from VM UUID. Feb 9 09:48:55.926122 kernel: SELinux: Context system_u:object_r:container_file_t:s0:c1022,c1023 is not valid (left unmapped). Feb 9 09:48:55.926131 systemd[1]: Populated /etc with preset unit settings. Feb 9 09:48:55.926143 systemd[1]: /usr/lib/systemd/system/locksmithd.service:8: Unit uses CPUShares=; please use CPUWeight= instead. Support for CPUShares= will be removed soon. Feb 9 09:48:55.926154 systemd[1]: /usr/lib/systemd/system/locksmithd.service:9: Unit uses MemoryLimit=; please use MemoryMax= instead. Support for MemoryLimit= will be removed soon. Feb 9 09:48:55.926165 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. Feb 9 09:48:55.926176 kernel: kauditd_printk_skb: 80 callbacks suppressed Feb 9 09:48:55.926190 kernel: audit: type=1334 audit(1707472135.799:84): prog-id=12 op=LOAD Feb 9 09:48:55.926200 kernel: audit: type=1334 audit(1707472135.799:85): prog-id=3 op=UNLOAD Feb 9 09:48:55.926213 kernel: audit: type=1334 audit(1707472135.800:86): prog-id=13 op=LOAD Feb 9 09:48:55.926222 kernel: audit: type=1334 audit(1707472135.800:87): prog-id=14 op=LOAD Feb 9 09:48:55.926232 kernel: audit: type=1334 audit(1707472135.800:88): prog-id=4 op=UNLOAD Feb 9 09:48:55.926241 kernel: audit: type=1334 audit(1707472135.800:89): prog-id=5 op=UNLOAD Feb 9 09:48:55.926250 kernel: audit: type=1334 audit(1707472135.801:90): prog-id=15 op=LOAD Feb 9 09:48:55.926260 systemd[1]: initrd-switch-root.service: Deactivated successfully. Feb 9 09:48:55.926273 kernel: audit: type=1334 audit(1707472135.801:91): prog-id=12 op=UNLOAD Feb 9 09:48:55.926308 systemd[1]: Stopped initrd-switch-root.service. Feb 9 09:48:55.926321 kernel: audit: type=1334 audit(1707472135.803:92): prog-id=16 op=LOAD Feb 9 09:48:55.926331 kernel: audit: type=1334 audit(1707472135.804:93): prog-id=17 op=LOAD Feb 9 09:48:55.926341 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Feb 9 09:48:55.926352 systemd[1]: Created slice system-addon\x2dconfig.slice. Feb 9 09:48:55.926363 systemd[1]: Created slice system-addon\x2drun.slice. Feb 9 09:48:55.926374 systemd[1]: Created slice system-getty.slice. Feb 9 09:48:55.926386 systemd[1]: Created slice system-modprobe.slice. Feb 9 09:48:55.926396 systemd[1]: Created slice system-serial\x2dgetty.slice. Feb 9 09:48:55.926407 systemd[1]: Created slice system-system\x2dcloudinit.slice. Feb 9 09:48:55.926418 systemd[1]: Created slice system-systemd\x2dfsck.slice. Feb 9 09:48:55.926428 systemd[1]: Created slice user.slice. Feb 9 09:48:55.926438 systemd[1]: Started systemd-ask-password-console.path. Feb 9 09:48:55.926450 systemd[1]: Started systemd-ask-password-wall.path. Feb 9 09:48:55.926460 systemd[1]: Set up automount boot.automount. Feb 9 09:48:55.926471 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount. Feb 9 09:48:55.926481 systemd[1]: Stopped target initrd-switch-root.target. Feb 9 09:48:55.926491 systemd[1]: Stopped target initrd-fs.target. Feb 9 09:48:55.926501 systemd[1]: Stopped target initrd-root-fs.target. Feb 9 09:48:55.926511 systemd[1]: Reached target integritysetup.target. Feb 9 09:48:55.926523 systemd[1]: Reached target remote-cryptsetup.target. Feb 9 09:48:55.926533 systemd[1]: Reached target remote-fs.target. Feb 9 09:48:55.926544 systemd[1]: Reached target slices.target. Feb 9 09:48:55.926554 systemd[1]: Reached target swap.target. Feb 9 09:48:55.926564 systemd[1]: Reached target torcx.target. Feb 9 09:48:55.926575 systemd[1]: Reached target veritysetup.target. Feb 9 09:48:55.926586 systemd[1]: Listening on systemd-coredump.socket. Feb 9 09:48:55.926597 systemd[1]: Listening on systemd-initctl.socket. Feb 9 09:48:55.926607 systemd[1]: Listening on systemd-networkd.socket. Feb 9 09:48:55.926617 systemd[1]: Listening on systemd-udevd-control.socket. Feb 9 09:48:55.926629 systemd[1]: Listening on systemd-udevd-kernel.socket. Feb 9 09:48:55.926640 systemd[1]: Listening on systemd-userdbd.socket. Feb 9 09:48:55.926650 systemd[1]: Mounting dev-hugepages.mount... Feb 9 09:48:55.926660 systemd[1]: Mounting dev-mqueue.mount... Feb 9 09:48:55.926670 systemd[1]: Mounting media.mount... Feb 9 09:48:55.926681 systemd[1]: Mounting sys-kernel-debug.mount... Feb 9 09:48:55.926691 systemd[1]: Mounting sys-kernel-tracing.mount... Feb 9 09:48:55.926701 systemd[1]: Mounting tmp.mount... Feb 9 09:48:55.926712 systemd[1]: Starting flatcar-tmpfiles.service... Feb 9 09:48:55.926723 systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. Feb 9 09:48:55.926734 systemd[1]: Starting kmod-static-nodes.service... Feb 9 09:48:55.926744 systemd[1]: Starting modprobe@configfs.service... Feb 9 09:48:55.926755 systemd[1]: Starting modprobe@dm_mod.service... Feb 9 09:48:55.926765 systemd[1]: Starting modprobe@drm.service... Feb 9 09:48:55.926775 systemd[1]: Starting modprobe@efi_pstore.service... Feb 9 09:48:55.926785 systemd[1]: Starting modprobe@fuse.service... Feb 9 09:48:55.926795 systemd[1]: Starting modprobe@loop.service... Feb 9 09:48:55.926807 systemd[1]: setup-nsswitch.service was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Feb 9 09:48:55.926819 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Feb 9 09:48:55.926835 systemd[1]: Stopped systemd-fsck-root.service. Feb 9 09:48:55.926846 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Feb 9 09:48:55.926857 systemd[1]: Stopped systemd-fsck-usr.service. Feb 9 09:48:55.926867 systemd[1]: Stopped systemd-journald.service. Feb 9 09:48:55.926876 kernel: fuse: init (API version 7.34) Feb 9 09:48:55.926886 kernel: loop: module loaded Feb 9 09:48:55.926896 systemd[1]: Starting systemd-journald.service... Feb 9 09:48:55.926906 systemd[1]: Starting systemd-modules-load.service... Feb 9 09:48:55.926918 systemd[1]: Starting systemd-network-generator.service... Feb 9 09:48:55.926929 systemd[1]: Starting systemd-remount-fs.service... Feb 9 09:48:55.926939 systemd[1]: Starting systemd-udev-trigger.service... Feb 9 09:48:55.926949 systemd[1]: verity-setup.service: Deactivated successfully. Feb 9 09:48:55.926960 systemd[1]: Stopped verity-setup.service. Feb 9 09:48:55.926970 systemd[1]: Mounted dev-hugepages.mount. Feb 9 09:48:55.926980 systemd[1]: Mounted dev-mqueue.mount. Feb 9 09:48:55.926990 systemd[1]: Mounted media.mount. Feb 9 09:48:55.927000 systemd[1]: Mounted sys-kernel-debug.mount. Feb 9 09:48:55.927013 systemd-journald[1007]: Journal started Feb 9 09:48:55.927055 systemd-journald[1007]: Runtime Journal (/run/log/journal/e8e46936e35c4b20a926f2fd5c34fe52) is 6.0M, max 48.7M, 42.6M free. Feb 9 09:48:53.972000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Feb 9 09:48:54.022000 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 Feb 9 09:48:54.022000 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 Feb 9 09:48:54.022000 audit: BPF prog-id=10 op=LOAD Feb 9 09:48:54.022000 audit: BPF prog-id=10 op=UNLOAD Feb 9 09:48:54.022000 audit: BPF prog-id=11 op=LOAD Feb 9 09:48:54.022000 audit: BPF prog-id=11 op=UNLOAD Feb 9 09:48:54.062000 audit[941]: AVC avc: denied { associate } for pid=941 comm="torcx-generator" name="docker" dev="tmpfs" ino=2 scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 srawcon="system_u:object_r:container_file_t:s0:c1022,c1023" Feb 9 09:48:54.062000 audit[941]: SYSCALL arch=c00000b7 syscall=5 success=yes exit=0 a0=40001c58b2 a1=40000c8de0 a2=40000cf0c0 a3=32 items=0 ppid=924 pid=941 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="torcx-generator" exe="/usr/lib/systemd/system-generators/torcx-generator" subj=system_u:system_r:kernel_t:s0 key=(null) Feb 9 09:48:54.062000 audit: PROCTITLE proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61 Feb 9 09:48:54.063000 audit[941]: AVC avc: denied { associate } for pid=941 comm="torcx-generator" name="usr" scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 Feb 9 09:48:54.063000 audit[941]: SYSCALL arch=c00000b7 syscall=34 success=yes exit=0 a0=ffffffffffffff9c a1=40001c5989 a2=1ed a3=0 items=2 ppid=924 pid=941 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="torcx-generator" exe="/usr/lib/systemd/system-generators/torcx-generator" subj=system_u:system_r:kernel_t:s0 key=(null) Feb 9 09:48:54.063000 audit: CWD cwd="/" Feb 9 09:48:54.063000 audit: PATH item=0 name=(null) inode=2 dev=00:1c mode=040755 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:unlabeled_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Feb 9 09:48:54.063000 audit: PATH item=1 name=(null) inode=3 dev=00:1c mode=040755 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:unlabeled_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Feb 9 09:48:54.063000 audit: PROCTITLE proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61 Feb 9 09:48:55.799000 audit: BPF prog-id=12 op=LOAD Feb 9 09:48:55.799000 audit: BPF prog-id=3 op=UNLOAD Feb 9 09:48:55.800000 audit: BPF prog-id=13 op=LOAD Feb 9 09:48:55.800000 audit: BPF prog-id=14 op=LOAD Feb 9 09:48:55.800000 audit: BPF prog-id=4 op=UNLOAD Feb 9 09:48:55.800000 audit: BPF prog-id=5 op=UNLOAD Feb 9 09:48:55.801000 audit: BPF prog-id=15 op=LOAD Feb 9 09:48:55.801000 audit: BPF prog-id=12 op=UNLOAD Feb 9 09:48:55.803000 audit: BPF prog-id=16 op=LOAD Feb 9 09:48:55.804000 audit: BPF prog-id=17 op=LOAD Feb 9 09:48:55.804000 audit: BPF prog-id=13 op=UNLOAD Feb 9 09:48:55.804000 audit: BPF prog-id=14 op=UNLOAD Feb 9 09:48:55.804000 audit: BPF prog-id=18 op=LOAD Feb 9 09:48:55.927674 systemd[1]: Started systemd-journald.service. Feb 9 09:48:55.804000 audit: BPF prog-id=15 op=UNLOAD Feb 9 09:48:55.805000 audit: BPF prog-id=19 op=LOAD Feb 9 09:48:55.805000 audit: BPF prog-id=20 op=LOAD Feb 9 09:48:55.805000 audit: BPF prog-id=16 op=UNLOAD Feb 9 09:48:55.805000 audit: BPF prog-id=17 op=UNLOAD Feb 9 09:48:55.806000 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' Feb 9 09:48:55.811000 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' Feb 9 09:48:55.811000 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' Feb 9 09:48:55.819000 audit: BPF prog-id=18 op=UNLOAD Feb 9 09:48:55.898000 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' Feb 9 09:48:55.900000 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' Feb 9 09:48:55.902000 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' Feb 9 09:48:55.902000 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' Feb 9 09:48:55.904000 audit: BPF prog-id=21 op=LOAD Feb 9 09:48:55.904000 audit: BPF prog-id=22 op=LOAD Feb 9 09:48:55.905000 audit: BPF prog-id=23 op=LOAD Feb 9 09:48:55.905000 audit: BPF prog-id=19 op=UNLOAD Feb 9 09:48:55.905000 audit: BPF prog-id=20 op=UNLOAD Feb 9 09:48:55.919000 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' Feb 9 09:48:55.924000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Feb 9 09:48:55.924000 audit[1007]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=60 a0=4 a1=ffffec4ddcb0 a2=4000 a3=1 items=0 ppid=1 pid=1007 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) Feb 9 09:48:55.924000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Feb 9 09:48:55.798306 systemd[1]: Queued start job for default target multi-user.target. Feb 9 09:48:54.061344 /usr/lib/systemd/system-generators/torcx-generator[941]: time="2024-02-09T09:48:54Z" 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.2 /usr/share/oem/torcx/store /var/lib/torcx/store/3510.3.2 /var/lib/torcx/store]" Feb 9 09:48:55.798319 systemd[1]: Unnecessary job was removed for dev-vda6.device. Feb 9 09:48:55.928000 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' Feb 9 09:48:54.061890 /usr/lib/systemd/system-generators/torcx-generator[941]: time="2024-02-09T09:48:54Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Feb 9 09:48:55.806434 systemd[1]: systemd-journald.service: Deactivated successfully. Feb 9 09:48:54.061910 /usr/lib/systemd/system-generators/torcx-generator[941]: time="2024-02-09T09:48:54Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Feb 9 09:48:55.928558 systemd[1]: Mounted sys-kernel-tracing.mount. Feb 9 09:48:54.061941 /usr/lib/systemd/system-generators/torcx-generator[941]: time="2024-02-09T09:48:54Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Feb 9 09:48:55.929406 systemd[1]: Mounted tmp.mount. Feb 9 09:48:54.061950 /usr/lib/systemd/system-generators/torcx-generator[941]: time="2024-02-09T09:48:54Z" level=debug msg="skipped missing lower profile" missing profile=oem Feb 9 09:48:54.061981 /usr/lib/systemd/system-generators/torcx-generator[941]: time="2024-02-09T09:48:54Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Feb 9 09:48:54.061992 /usr/lib/systemd/system-generators/torcx-generator[941]: time="2024-02-09T09:48:54Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Feb 9 09:48:54.062183 /usr/lib/systemd/system-generators/torcx-generator[941]: time="2024-02-09T09:48:54Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Feb 9 09:48:54.062218 /usr/lib/systemd/system-generators/torcx-generator[941]: time="2024-02-09T09:48:54Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Feb 9 09:48:54.062230 /usr/lib/systemd/system-generators/torcx-generator[941]: time="2024-02-09T09:48:54Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Feb 9 09:48:54.062688 /usr/lib/systemd/system-generators/torcx-generator[941]: time="2024-02-09T09:48:54Z" 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 Feb 9 09:48:54.062726 /usr/lib/systemd/system-generators/torcx-generator[941]: time="2024-02-09T09:48:54Z" 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 Feb 9 09:48:54.062745 /usr/lib/systemd/system-generators/torcx-generator[941]: time="2024-02-09T09:48:54Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store/3510.3.2: no such file or directory" path=/usr/share/oem/torcx/store/3510.3.2 Feb 9 09:48:54.062759 /usr/lib/systemd/system-generators/torcx-generator[941]: time="2024-02-09T09:48:54Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Feb 9 09:48:54.062775 /usr/lib/systemd/system-generators/torcx-generator[941]: time="2024-02-09T09:48:54Z" level=info msg="store skipped" err="open /var/lib/torcx/store/3510.3.2: no such file or directory" path=/var/lib/torcx/store/3510.3.2 Feb 9 09:48:54.062788 /usr/lib/systemd/system-generators/torcx-generator[941]: time="2024-02-09T09:48:54Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Feb 9 09:48:55.503277 /usr/lib/systemd/system-generators/torcx-generator[941]: time="2024-02-09T09:48:55Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Feb 9 09:48:55.930485 systemd[1]: Finished kmod-static-nodes.service. Feb 9 09:48:55.503585 /usr/lib/systemd/system-generators/torcx-generator[941]: time="2024-02-09T09:48:55Z" level=debug msg="binaries propagated" assets="[/bin/containerd /bin/containerd-shim /bin/ctr /bin/docker /bin/docker-containerd /bin/docker-containerd-shim /bin/docker-init /bin/docker-proxy /bin/docker-runc /bin/dockerd /bin/runc /bin/tini]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Feb 9 09:48:55.503690 /usr/lib/systemd/system-generators/torcx-generator[941]: time="2024-02-09T09:48:55Z" level=debug msg="networkd units propagated" assets="[/lib/systemd/network/50-docker.network /lib/systemd/network/90-docker-veth.network]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Feb 9 09:48:55.503875 /usr/lib/systemd/system-generators/torcx-generator[941]: time="2024-02-09T09:48:55Z" level=debug msg="systemd units propagated" assets="[/lib/systemd/system/containerd.service /lib/systemd/system/docker.service /lib/systemd/system/docker.socket /lib/systemd/system/sockets.target.wants /lib/systemd/system/multi-user.target.wants]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Feb 9 09:48:55.503943 /usr/lib/systemd/system-generators/torcx-generator[941]: time="2024-02-09T09:48:55Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Feb 9 09:48:55.504004 /usr/lib/systemd/system-generators/torcx-generator[941]: time="2024-02-09T09:48:55Z" level=debug msg="system state sealed" content="[TORCX_LOWER_PROFILES=\"vendor\" TORCX_UPPER_PROFILE=\"\" TORCX_PROFILE_PATH=\"/run/torcx/profile.json\" TORCX_BINDIR=\"/run/torcx/bin\" TORCX_UNPACKDIR=\"/run/torcx/unpack\"]" path=/run/metadata/torcx Feb 9 09:48:55.930000 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' Feb 9 09:48:55.931652 systemd[1]: modprobe@configfs.service: Deactivated successfully. Feb 9 09:48:55.931803 systemd[1]: Finished modprobe@configfs.service. Feb 9 09:48:55.932000 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' Feb 9 09:48:55.932000 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' Feb 9 09:48:55.932846 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Feb 9 09:48:55.933003 systemd[1]: Finished modprobe@dm_mod.service. Feb 9 09:48:55.933000 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' Feb 9 09:48:55.933000 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' Feb 9 09:48:55.934003 systemd[1]: modprobe@drm.service: Deactivated successfully. Feb 9 09:48:55.934146 systemd[1]: Finished modprobe@drm.service. Feb 9 09:48:55.934000 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' Feb 9 09:48:55.934000 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' Feb 9 09:48:55.935254 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Feb 9 09:48:55.935392 systemd[1]: Finished modprobe@efi_pstore.service. Feb 9 09:48:55.935000 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' Feb 9 09:48:55.935000 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' Feb 9 09:48:55.936508 systemd[1]: modprobe@fuse.service: Deactivated successfully. Feb 9 09:48:55.936688 systemd[1]: Finished modprobe@fuse.service. Feb 9 09:48:55.937000 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' Feb 9 09:48:55.937000 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' Feb 9 09:48:55.937688 systemd[1]: Finished flatcar-tmpfiles.service. Feb 9 09:48:55.938000 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' Feb 9 09:48:55.938699 systemd[1]: modprobe@loop.service: Deactivated successfully. Feb 9 09:48:55.938853 systemd[1]: Finished modprobe@loop.service. Feb 9 09:48:55.939000 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' Feb 9 09:48:55.939000 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' Feb 9 09:48:55.939947 systemd[1]: Finished systemd-modules-load.service. Feb 9 09:48:55.940000 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' Feb 9 09:48:55.941039 systemd[1]: Finished systemd-network-generator.service. Feb 9 09:48:55.941000 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' Feb 9 09:48:55.942323 systemd[1]: Finished systemd-remount-fs.service. Feb 9 09:48:55.942000 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' Feb 9 09:48:55.943546 systemd[1]: Reached target network-pre.target. Feb 9 09:48:55.945265 systemd[1]: Mounting sys-fs-fuse-connections.mount... Feb 9 09:48:55.947050 systemd[1]: Mounting sys-kernel-config.mount... Feb 9 09:48:55.947719 systemd[1]: remount-root.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Feb 9 09:48:55.949277 systemd[1]: Starting systemd-hwdb-update.service... Feb 9 09:48:55.951107 systemd[1]: Starting systemd-journal-flush.service... Feb 9 09:48:55.951986 systemd[1]: systemd-pstore.service was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Feb 9 09:48:55.953002 systemd[1]: Starting systemd-random-seed.service... Feb 9 09:48:55.953706 systemd[1]: systemd-repart.service was skipped because no trigger condition checks were met. Feb 9 09:48:55.954769 systemd[1]: Starting systemd-sysctl.service... Feb 9 09:48:55.956902 systemd[1]: Starting systemd-sysusers.service... Feb 9 09:48:55.960092 systemd[1]: Mounted sys-fs-fuse-connections.mount. Feb 9 09:48:55.961011 systemd[1]: Mounted sys-kernel-config.mount. Feb 9 09:48:55.966354 systemd-journald[1007]: Time spent on flushing to /var/log/journal/e8e46936e35c4b20a926f2fd5c34fe52 is 12.674ms for 982 entries. Feb 9 09:48:55.966354 systemd-journald[1007]: System Journal (/var/log/journal/e8e46936e35c4b20a926f2fd5c34fe52) is 8.0M, max 195.6M, 187.6M free. Feb 9 09:48:55.988739 systemd-journald[1007]: Received client request to flush runtime journal. Feb 9 09:48:55.976000 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' Feb 9 09:48:55.979000 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' Feb 9 09:48:55.982000 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' Feb 9 09:48:55.975959 systemd[1]: Finished systemd-udev-trigger.service. Feb 9 09:48:55.989152 udevadm[1042]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Feb 9 09:48:55.978068 systemd[1]: Starting systemd-udev-settle.service... Feb 9 09:48:55.978944 systemd[1]: Finished systemd-random-seed.service. Feb 9 09:48:55.979865 systemd[1]: Reached target first-boot-complete.target. Feb 9 09:48:55.981669 systemd[1]: Finished systemd-sysctl.service. Feb 9 09:48:55.989665 systemd[1]: Finished systemd-journal-flush.service. Feb 9 09:48:55.990000 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' Feb 9 09:48:55.994754 systemd[1]: Finished systemd-sysusers.service. Feb 9 09:48:55.995000 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' Feb 9 09:48:55.996701 systemd[1]: Starting systemd-tmpfiles-setup-dev.service... Feb 9 09:48:56.011650 systemd[1]: Finished systemd-tmpfiles-setup-dev.service. Feb 9 09:48:56.012000 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' Feb 9 09:48:56.337640 systemd[1]: Finished systemd-hwdb-update.service. Feb 9 09:48:56.338000 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' Feb 9 09:48:56.338000 audit: BPF prog-id=24 op=LOAD Feb 9 09:48:56.338000 audit: BPF prog-id=25 op=LOAD Feb 9 09:48:56.338000 audit: BPF prog-id=7 op=UNLOAD Feb 9 09:48:56.338000 audit: BPF prog-id=8 op=UNLOAD Feb 9 09:48:56.339803 systemd[1]: Starting systemd-udevd.service... Feb 9 09:48:56.365152 systemd-udevd[1046]: Using default interface naming scheme 'v252'. Feb 9 09:48:56.377156 systemd[1]: Started systemd-udevd.service. Feb 9 09:48:56.377000 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' Feb 9 09:48:56.378000 audit: BPF prog-id=26 op=LOAD Feb 9 09:48:56.381486 systemd[1]: Starting systemd-networkd.service... Feb 9 09:48:56.388000 audit: BPF prog-id=27 op=LOAD Feb 9 09:48:56.388000 audit: BPF prog-id=28 op=LOAD Feb 9 09:48:56.388000 audit: BPF prog-id=29 op=LOAD Feb 9 09:48:56.389518 systemd[1]: Starting systemd-userdbd.service... Feb 9 09:48:56.403343 systemd[1]: Condition check resulted in dev-ttyAMA0.device being skipped. Feb 9 09:48:56.421001 systemd[1]: Started systemd-userdbd.service. Feb 9 09:48:56.421000 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' Feb 9 09:48:56.442583 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. Feb 9 09:48:56.485267 systemd-networkd[1055]: lo: Link UP Feb 9 09:48:56.485277 systemd-networkd[1055]: lo: Gained carrier Feb 9 09:48:56.485634 systemd-networkd[1055]: Enumeration completed Feb 9 09:48:56.485727 systemd[1]: Started systemd-networkd.service. Feb 9 09:48:56.486000 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' Feb 9 09:48:56.486604 systemd-networkd[1055]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Feb 9 09:48:56.486746 systemd[1]: Finished systemd-udev-settle.service. Feb 9 09:48:56.487000 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' Feb 9 09:48:56.488661 systemd[1]: Starting lvm2-activation-early.service... Feb 9 09:48:56.489658 systemd-networkd[1055]: eth0: Link UP Feb 9 09:48:56.489667 systemd-networkd[1055]: eth0: Gained carrier Feb 9 09:48:56.490575 systemd[1]: Starting systemd-networkd-wait-online.service... Feb 9 09:48:56.498487 lvm[1079]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Feb 9 09:48:56.504408 systemd-networkd[1055]: eth0: DHCPv4 address 10.0.0.33/16, gateway 10.0.0.1 acquired from 10.0.0.1 Feb 9 09:48:56.527083 systemd[1]: Finished lvm2-activation-early.service. Feb 9 09:48:56.527000 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' Feb 9 09:48:56.527893 systemd[1]: Reached target cryptsetup.target. Feb 9 09:48:56.529536 systemd[1]: Starting lvm2-activation.service... Feb 9 09:48:56.533022 lvm[1081]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Feb 9 09:48:56.560073 systemd[1]: Finished lvm2-activation.service. Feb 9 09:48:56.560000 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' Feb 9 09:48:56.560796 systemd[1]: Reached target local-fs-pre.target. Feb 9 09:48:56.561430 systemd[1]: var-lib-machines.mount was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Feb 9 09:48:56.561454 systemd[1]: Reached target local-fs.target. Feb 9 09:48:56.562010 systemd[1]: Reached target machines.target. Feb 9 09:48:56.563601 systemd[1]: Starting ldconfig.service... Feb 9 09:48:56.564483 systemd[1]: systemd-binfmt.service was skipped because no trigger condition checks were met. Feb 9 09:48:56.564533 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). Feb 9 09:48:56.565764 systemd[1]: Starting systemd-boot-update.service... Feb 9 09:48:56.567531 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service... Feb 9 09:48:56.569420 systemd[1]: Starting systemd-machine-id-commit.service... Feb 9 09:48:56.570781 systemd[1]: systemd-sysext.service was skipped because no trigger condition checks were met. Feb 9 09:48:56.570834 systemd[1]: ensure-sysext.service was skipped because no trigger condition checks were met. Feb 9 09:48:56.571768 systemd[1]: Starting systemd-tmpfiles-setup.service... Feb 9 09:48:56.573532 systemd[1]: boot.automount: Got automount request for /boot, triggered by 1083 (bootctl) Feb 9 09:48:56.576178 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service... Feb 9 09:48:56.579206 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service. Feb 9 09:48:56.579000 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' Feb 9 09:48:56.585753 systemd-tmpfiles[1086]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Feb 9 09:48:56.586504 systemd-tmpfiles[1086]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Feb 9 09:48:56.588271 systemd-tmpfiles[1086]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Feb 9 09:48:56.591173 systemd[1]: Finished systemd-machine-id-commit.service. Feb 9 09:48:56.592000 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' Feb 9 09:48:56.619976 systemd-fsck[1091]: fsck.fat 4.2 (2021-01-31) Feb 9 09:48:56.619976 systemd-fsck[1091]: /dev/vda1: 236 files, 113719/258078 clusters Feb 9 09:48:56.622571 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service. Feb 9 09:48:56.624000 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' Feb 9 09:48:56.673627 ldconfig[1082]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Feb 9 09:48:56.676365 systemd[1]: Finished ldconfig.service. Feb 9 09:48:56.676000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=ldconfig comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Feb 9 09:48:56.921580 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Feb 9 09:48:56.923020 systemd[1]: Mounting boot.mount... Feb 9 09:48:56.929579 systemd[1]: Mounted boot.mount. Feb 9 09:48:56.936161 systemd[1]: Finished systemd-boot-update.service. Feb 9 09:48:56.936000 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' Feb 9 09:48:56.990979 systemd[1]: Finished systemd-tmpfiles-setup.service. Feb 9 09:48:56.991000 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' Feb 9 09:48:56.993345 systemd[1]: Starting audit-rules.service... Feb 9 09:48:56.995161 systemd[1]: Starting clean-ca-certificates.service... Feb 9 09:48:56.997126 systemd[1]: Starting systemd-journal-catalog-update.service... Feb 9 09:48:56.998000 audit: BPF prog-id=30 op=LOAD Feb 9 09:48:57.000026 systemd[1]: Starting systemd-resolved.service... Feb 9 09:48:57.002000 audit: BPF prog-id=31 op=LOAD Feb 9 09:48:57.004032 systemd[1]: Starting systemd-timesyncd.service... Feb 9 09:48:57.005736 systemd[1]: Starting systemd-update-utmp.service... Feb 9 09:48:57.006991 systemd[1]: Finished clean-ca-certificates.service. Feb 9 09:48:57.007000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=clean-ca-certificates comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Feb 9 09:48:57.008156 systemd[1]: update-ca-certificates.service was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Feb 9 09:48:57.010000 audit[1106]: SYSTEM_BOOT pid=1106 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg=' comm="systemd-update-utmp" exe="/usr/lib/systemd/systemd-update-utmp" hostname=? addr=? terminal=? res=success' Feb 9 09:48:57.018776 systemd[1]: Finished systemd-journal-catalog-update.service. Feb 9 09:48:57.019000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journal-catalog-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Feb 9 09:48:57.019952 systemd[1]: Finished systemd-update-utmp.service. Feb 9 09:48:57.020000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-update-utmp comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Feb 9 09:48:57.022076 systemd[1]: Starting systemd-update-done.service... Feb 9 09:48:57.032948 systemd[1]: Finished systemd-update-done.service. Feb 9 09:48:57.033000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-update-done comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Feb 9 09:48:57.046000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Feb 9 09:48:57.046000 audit[1115]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffca5d31d0 a2=420 a3=0 items=0 ppid=1094 pid=1115 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) Feb 9 09:48:57.046000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Feb 9 09:48:57.047141 augenrules[1115]: No rules Feb 9 09:48:57.047780 systemd[1]: Finished audit-rules.service. Feb 9 09:48:57.054845 systemd-resolved[1098]: Positive Trust Anchors: Feb 9 09:48:57.055077 systemd-resolved[1098]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Feb 9 09:48:57.055166 systemd-resolved[1098]: 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 Feb 9 09:48:57.062586 systemd[1]: Started systemd-timesyncd.service. Feb 9 09:48:57.063330 systemd-timesyncd[1104]: Contacted time server 10.0.0.1:123 (10.0.0.1). Feb 9 09:48:57.063368 systemd-timesyncd[1104]: Initial clock synchronization to Fri 2024-02-09 09:48:56.770659 UTC. Feb 9 09:48:57.063650 systemd[1]: Reached target time-set.target. Feb 9 09:48:57.070466 systemd-resolved[1098]: Defaulting to hostname 'linux'. Feb 9 09:48:57.071906 systemd[1]: Started systemd-resolved.service. Feb 9 09:48:57.072601 systemd[1]: Reached target network.target. Feb 9 09:48:57.073163 systemd[1]: Reached target nss-lookup.target. Feb 9 09:48:57.073763 systemd[1]: Reached target sysinit.target. Feb 9 09:48:57.074384 systemd[1]: Started motdgen.path. Feb 9 09:48:57.074905 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path. Feb 9 09:48:57.075809 systemd[1]: Started logrotate.timer. Feb 9 09:48:57.076614 systemd[1]: Started mdadm.timer. Feb 9 09:48:57.077264 systemd[1]: Started systemd-tmpfiles-clean.timer. Feb 9 09:48:57.078041 systemd[1]: update-engine-stub.timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Feb 9 09:48:57.078076 systemd[1]: Reached target paths.target. Feb 9 09:48:57.078649 systemd[1]: Reached target timers.target. Feb 9 09:48:57.079611 systemd[1]: Listening on dbus.socket. Feb 9 09:48:57.081280 systemd[1]: Starting docker.socket... Feb 9 09:48:57.084372 systemd[1]: Listening on sshd.socket. Feb 9 09:48:57.085065 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). Feb 9 09:48:57.085505 systemd[1]: Listening on docker.socket. Feb 9 09:48:57.086267 systemd[1]: Reached target sockets.target. Feb 9 09:48:57.086878 systemd[1]: Reached target basic.target. Feb 9 09:48:57.087620 systemd[1]: addon-config@usr-share-oem.service was skipped because no trigger condition checks were met. Feb 9 09:48:57.087653 systemd[1]: addon-run@usr-share-oem.service was skipped because no trigger condition checks were met. Feb 9 09:48:57.088635 systemd[1]: Starting containerd.service... Feb 9 09:48:57.090246 systemd[1]: Starting dbus.service... Feb 9 09:48:57.091921 systemd[1]: Starting enable-oem-cloudinit.service... Feb 9 09:48:57.093781 systemd[1]: Starting extend-filesystems.service... Feb 9 09:48:57.094586 systemd[1]: flatcar-setup-environment.service was skipped because of an unmet condition check (ConditionPathExists=/usr/share/oem/bin/flatcar-setup-environment). Feb 9 09:48:57.095762 systemd[1]: Starting motdgen.service... Feb 9 09:48:57.102049 systemd[1]: Starting ssh-key-proc-cmdline.service... Feb 9 09:48:57.103860 systemd[1]: Starting sshd-keygen.service... Feb 9 09:48:57.104907 jq[1125]: false Feb 9 09:48:57.107478 systemd[1]: Starting systemd-logind.service... Feb 9 09:48:57.108170 systemd[1]: systemd-pcrphase.service was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/StubPcrKernelImage-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). Feb 9 09:48:57.108246 systemd[1]: tcsd.service was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Feb 9 09:48:57.108743 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Feb 9 09:48:57.109486 systemd[1]: Starting update-engine.service... Feb 9 09:48:57.111222 systemd[1]: Starting update-ssh-keys-after-ignition.service... Feb 9 09:48:57.113632 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Feb 9 09:48:57.113795 systemd[1]: Condition check resulted in enable-oem-cloudinit.service being skipped. Feb 9 09:48:57.114181 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Feb 9 09:48:57.114346 systemd[1]: Finished ssh-key-proc-cmdline.service. Feb 9 09:48:57.117867 jq[1138]: true Feb 9 09:48:57.121391 systemd[1]: motdgen.service: Deactivated successfully. Feb 9 09:48:57.121553 systemd[1]: Finished motdgen.service. Feb 9 09:48:57.132537 extend-filesystems[1126]: Found vda Feb 9 09:48:57.133501 extend-filesystems[1126]: Found vda1 Feb 9 09:48:57.133501 extend-filesystems[1126]: Found vda2 Feb 9 09:48:57.133501 extend-filesystems[1126]: Found vda3 Feb 9 09:48:57.133501 extend-filesystems[1126]: Found usr Feb 9 09:48:57.133501 extend-filesystems[1126]: Found vda4 Feb 9 09:48:57.133501 extend-filesystems[1126]: Found vda6 Feb 9 09:48:57.133501 extend-filesystems[1126]: Found vda7 Feb 9 09:48:57.133501 extend-filesystems[1126]: Found vda9 Feb 9 09:48:57.138528 jq[1146]: true Feb 9 09:48:57.138622 extend-filesystems[1126]: Checking size of /dev/vda9 Feb 9 09:48:57.155053 dbus-daemon[1124]: [system] SELinux support is enabled Feb 9 09:48:57.155219 systemd[1]: Started dbus.service. Feb 9 09:48:57.157462 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). Feb 9 09:48:57.157483 systemd[1]: Reached target system-config.target. Feb 9 09:48:57.158126 systemd[1]: user-cloudinit-proc-cmdline.service was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Feb 9 09:48:57.158145 systemd[1]: Reached target user-config.target. Feb 9 09:48:57.172185 extend-filesystems[1126]: Old size kept for /dev/vda9 Feb 9 09:48:57.172146 systemd[1]: extend-filesystems.service: Deactivated successfully. Feb 9 09:48:57.172307 systemd[1]: Finished extend-filesystems.service. Feb 9 09:48:57.185961 systemd-logind[1135]: Watching system buttons on /dev/input/event0 (Power Button) Feb 9 09:48:57.192384 systemd-logind[1135]: New seat seat0. Feb 9 09:48:57.196637 systemd[1]: Started systemd-logind.service. Feb 9 09:48:57.201771 update_engine[1137]: I0209 09:48:57.201566 1137 main.cc:92] Flatcar Update Engine starting Feb 9 09:48:57.202813 bash[1171]: Updated "/home/core/.ssh/authorized_keys" Feb 9 09:48:57.207944 systemd[1]: Started update-engine.service. Feb 9 09:48:57.208061 update_engine[1137]: I0209 09:48:57.207958 1137 update_check_scheduler.cc:74] Next update check in 10m22s Feb 9 09:48:57.210309 systemd[1]: Started locksmithd.service. Feb 9 09:48:57.213206 systemd[1]: Finished update-ssh-keys-after-ignition.service. Feb 9 09:48:57.239273 env[1144]: time="2024-02-09T09:48:57.239223720Z" level=info msg="starting containerd" revision=92b3a9d6f1b3bcc6dc74875cfdea653fe39f09c2 version=1.6.16 Feb 9 09:48:57.255571 locksmithd[1178]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Feb 9 09:48:57.257068 env[1144]: time="2024-02-09T09:48:57.257034040Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Feb 9 09:48:57.257227 env[1144]: time="2024-02-09T09:48:57.257185280Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Feb 9 09:48:57.258248 env[1144]: time="2024-02-09T09:48:57.258204080Z" 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.148-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Feb 9 09:48:57.258248 env[1144]: time="2024-02-09T09:48:57.258233280Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Feb 9 09:48:57.258463 env[1144]: time="2024-02-09T09:48:57.258430200Z" 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 Feb 9 09:48:57.258463 env[1144]: time="2024-02-09T09:48:57.258454600Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Feb 9 09:48:57.258514 env[1144]: time="2024-02-09T09:48:57.258467280Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Feb 9 09:48:57.258514 env[1144]: time="2024-02-09T09:48:57.258477000Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Feb 9 09:48:57.258563 env[1144]: time="2024-02-09T09:48:57.258547840Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Feb 9 09:48:57.258770 env[1144]: time="2024-02-09T09:48:57.258741240Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Feb 9 09:48:57.258896 env[1144]: time="2024-02-09T09:48:57.258874320Z" 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 Feb 9 09:48:57.258921 env[1144]: time="2024-02-09T09:48:57.258895520Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Feb 9 09:48:57.258963 env[1144]: time="2024-02-09T09:48:57.258948960Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Feb 9 09:48:57.258994 env[1144]: time="2024-02-09T09:48:57.258964960Z" level=info msg="metadata content store policy set" policy=shared Feb 9 09:48:57.261891 env[1144]: time="2024-02-09T09:48:57.261864920Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Feb 9 09:48:57.261949 env[1144]: time="2024-02-09T09:48:57.261896160Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Feb 9 09:48:57.261949 env[1144]: time="2024-02-09T09:48:57.261908800Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Feb 9 09:48:57.261949 env[1144]: time="2024-02-09T09:48:57.261936720Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Feb 9 09:48:57.262021 env[1144]: time="2024-02-09T09:48:57.261950560Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Feb 9 09:48:57.262021 env[1144]: time="2024-02-09T09:48:57.261963600Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Feb 9 09:48:57.262021 env[1144]: time="2024-02-09T09:48:57.261976240Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Feb 9 09:48:57.262350 env[1144]: time="2024-02-09T09:48:57.262330400Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Feb 9 09:48:57.262385 env[1144]: time="2024-02-09T09:48:57.262354360Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1 Feb 9 09:48:57.262385 env[1144]: time="2024-02-09T09:48:57.262367240Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Feb 9 09:48:57.262385 env[1144]: time="2024-02-09T09:48:57.262380440Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Feb 9 09:48:57.262448 env[1144]: time="2024-02-09T09:48:57.262392280Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Feb 9 09:48:57.262517 env[1144]: time="2024-02-09T09:48:57.262498400Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Feb 9 09:48:57.262594 env[1144]: time="2024-02-09T09:48:57.262580920Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Feb 9 09:48:57.262814 env[1144]: time="2024-02-09T09:48:57.262797640Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Feb 9 09:48:57.262853 env[1144]: time="2024-02-09T09:48:57.262833280Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Feb 9 09:48:57.262853 env[1144]: time="2024-02-09T09:48:57.262848400Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Feb 9 09:48:57.262992 env[1144]: time="2024-02-09T09:48:57.262978640Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Feb 9 09:48:57.263014 env[1144]: time="2024-02-09T09:48:57.262995560Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Feb 9 09:48:57.263014 env[1144]: time="2024-02-09T09:48:57.263008200Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Feb 9 09:48:57.263057 env[1144]: time="2024-02-09T09:48:57.263018840Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Feb 9 09:48:57.263085 env[1144]: time="2024-02-09T09:48:57.263071680Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Feb 9 09:48:57.263106 env[1144]: time="2024-02-09T09:48:57.263086240Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Feb 9 09:48:57.263106 env[1144]: time="2024-02-09T09:48:57.263097600Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Feb 9 09:48:57.263141 env[1144]: time="2024-02-09T09:48:57.263108400Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Feb 9 09:48:57.263141 env[1144]: time="2024-02-09T09:48:57.263121360Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Feb 9 09:48:57.263256 env[1144]: time="2024-02-09T09:48:57.263237720Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Feb 9 09:48:57.263295 env[1144]: time="2024-02-09T09:48:57.263259680Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Feb 9 09:48:57.263295 env[1144]: time="2024-02-09T09:48:57.263272080Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Feb 9 09:48:57.263338 env[1144]: time="2024-02-09T09:48:57.263296200Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Feb 9 09:48:57.263338 env[1144]: time="2024-02-09T09:48:57.263311880Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="no OpenTelemetry endpoint: skip plugin" type=io.containerd.tracing.processor.v1 Feb 9 09:48:57.263338 env[1144]: time="2024-02-09T09:48:57.263322120Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Feb 9 09:48:57.263401 env[1144]: time="2024-02-09T09:48:57.263339640Z" level=error msg="failed to initialize a tracing processor \"otlp\"" error="no OpenTelemetry endpoint: skip plugin" Feb 9 09:48:57.263401 env[1144]: time="2024-02-09T09:48:57.263370400Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Feb 9 09:48:57.263689 env[1144]: time="2024-02-09T09:48:57.263641520Z" 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}" Feb 9 09:48:57.264257 env[1144]: time="2024-02-09T09:48:57.263699120Z" level=info msg="Connect containerd service" Feb 9 09:48:57.264257 env[1144]: time="2024-02-09T09:48:57.263727160Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Feb 9 09:48:57.264458 env[1144]: time="2024-02-09T09:48:57.264428200Z" 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" Feb 9 09:48:57.264637 env[1144]: time="2024-02-09T09:48:57.264611520Z" level=info msg="Start subscribing containerd event" Feb 9 09:48:57.264663 env[1144]: time="2024-02-09T09:48:57.264652320Z" level=info msg="Start recovering state" Feb 9 09:48:57.264720 env[1144]: time="2024-02-09T09:48:57.264709040Z" level=info msg="Start event monitor" Feb 9 09:48:57.264742 env[1144]: time="2024-02-09T09:48:57.264730040Z" level=info msg="Start snapshots syncer" Feb 9 09:48:57.264742 env[1144]: time="2024-02-09T09:48:57.264739600Z" level=info msg="Start cni network conf syncer for default" Feb 9 09:48:57.264784 env[1144]: time="2024-02-09T09:48:57.264746600Z" level=info msg="Start streaming server" Feb 9 09:48:57.266585 env[1144]: time="2024-02-09T09:48:57.266554480Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Feb 9 09:48:57.266629 env[1144]: time="2024-02-09T09:48:57.266616920Z" level=info msg=serving... address=/run/containerd/containerd.sock Feb 9 09:48:57.266732 systemd[1]: Started containerd.service. Feb 9 09:48:57.267687 env[1144]: time="2024-02-09T09:48:57.267620160Z" level=info msg="containerd successfully booted in 0.029260s" Feb 9 09:48:57.982454 systemd-networkd[1055]: eth0: Gained IPv6LL Feb 9 09:48:57.984017 systemd[1]: Finished systemd-networkd-wait-online.service. Feb 9 09:48:57.985153 systemd[1]: Reached target network-online.target. Feb 9 09:48:57.987147 systemd[1]: Starting docker.service... Feb 9 09:48:58.066733 env[1189]: time="2024-02-09T09:48:58.066691929Z" level=info msg="Starting up" Feb 9 09:48:58.066967 env[1189]: time="2024-02-09T09:48:58.066830123Z" level=info msg="User namespaces: ID ranges will be mapped to subuid/subgid ranges of: dockremap" Feb 9 09:48:58.067752 env[1189]: time="2024-02-09T09:48:58.067727192Z" level=info msg="User namespaces: ID ranges will be mapped to subuid/subgid ranges of: dockremap" Feb 9 09:48:58.068485 env[1189]: time="2024-02-09T09:48:58.068394347Z" level=info msg="parsed scheme: \"unix\"" module=grpc Feb 9 09:48:58.068485 env[1189]: time="2024-02-09T09:48:58.068483676Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Feb 9 09:48:58.068549 env[1189]: time="2024-02-09T09:48:58.068502714Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/libcontainerd/docker-containerd.sock 0 }] }" module=grpc Feb 9 09:48:58.068549 env[1189]: time="2024-02-09T09:48:58.068512772Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Feb 9 09:48:58.070431 env[1189]: time="2024-02-09T09:48:58.070405178Z" level=info msg="parsed scheme: \"unix\"" module=grpc Feb 9 09:48:58.070431 env[1189]: time="2024-02-09T09:48:58.070426875Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Feb 9 09:48:58.070522 env[1189]: time="2024-02-09T09:48:58.070438243Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/libcontainerd/docker-containerd.sock 0 }] }" module=grpc Feb 9 09:48:58.070522 env[1189]: time="2024-02-09T09:48:58.070452540Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Feb 9 09:48:58.074201 systemd[1]: var-lib-docker-100000.100000-check\x2doverlayfs\x2dsupport2452045389-merged.mount: Deactivated successfully. Feb 9 09:48:58.094555 env[1189]: time="2024-02-09T09:48:58.094525440Z" level=info msg="Loading containers: start." Feb 9 09:48:58.178299 kernel: Initializing XFRM netlink socket Feb 9 09:48:58.199686 env[1189]: time="2024-02-09T09:48:58.199644595Z" level=info msg="Default bridge (docker0) is assigned with an IP address 172.17.0.0/16. Daemon option --bip can be used to set a preferred IP address" Feb 9 09:48:58.268983 systemd-networkd[1055]: docker0: Link UP Feb 9 09:48:58.276054 env[1189]: time="2024-02-09T09:48:58.276024615Z" level=info msg="Loading containers: done." Feb 9 09:48:58.293967 systemd[1]: var-lib-docker-100000.100000-overlay2-opaque\x2dbug\x2dcheck1993403118-merged.mount: Deactivated successfully. Feb 9 09:48:58.295595 env[1189]: time="2024-02-09T09:48:58.295564233Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Feb 9 09:48:58.295843 env[1189]: time="2024-02-09T09:48:58.295823164Z" level=info msg="Docker daemon" commit=112bdf3343 graphdriver(s)=overlay2 version=20.10.23 Feb 9 09:48:58.295991 env[1189]: time="2024-02-09T09:48:58.295975578Z" level=info msg="Daemon has completed initialization" Feb 9 09:48:58.309653 systemd[1]: Started docker.service. Feb 9 09:48:58.320347 env[1189]: time="2024-02-09T09:48:58.320223552Z" level=info msg="API listen on /run/docker.sock" Feb 9 09:48:59.088712 sshd_keygen[1145]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Feb 9 09:48:59.105773 systemd[1]: Finished sshd-keygen.service. Feb 9 09:48:59.107899 systemd[1]: Starting issuegen.service... Feb 9 09:48:59.112256 systemd[1]: issuegen.service: Deactivated successfully. Feb 9 09:48:59.112402 systemd[1]: Finished issuegen.service. Feb 9 09:48:59.114354 systemd[1]: Starting systemd-user-sessions.service... Feb 9 09:48:59.120615 systemd[1]: Finished systemd-user-sessions.service. Feb 9 09:48:59.122488 systemd[1]: Started getty@tty1.service. Feb 9 09:48:59.124203 systemd[1]: Started serial-getty@ttyAMA0.service. Feb 9 09:48:59.125001 systemd[1]: Reached target getty.target. Feb 9 09:48:59.125772 systemd[1]: Reached target multi-user.target. Feb 9 09:48:59.128075 systemd[1]: Starting systemd-update-utmp-runlevel.service... Feb 9 09:48:59.133506 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Feb 9 09:48:59.133639 systemd[1]: Finished systemd-update-utmp-runlevel.service. Feb 9 09:48:59.134380 systemd[1]: Startup finished in 571ms (kernel) + 3.347s (initrd) + 5.199s (userspace) = 9.119s. Feb 9 09:49:03.250895 systemd[1]: Created slice system-sshd.slice. Feb 9 09:49:03.251954 systemd[1]: Started sshd@0-10.0.0.33:22-10.0.0.1:37312.service. Feb 9 09:49:03.302252 sshd[1316]: Accepted publickey for core from 10.0.0.1 port 37312 ssh2: RSA SHA256:g0U6KM199woo3jVvTXJmbHJGWRxGxX9UCqO141QChXg Feb 9 09:49:03.304089 sshd[1316]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Feb 9 09:49:03.313379 systemd-logind[1135]: New session 1 of user core. Feb 9 09:49:03.314344 systemd[1]: Created slice user-500.slice. Feb 9 09:49:03.315454 systemd[1]: Starting user-runtime-dir@500.service... Feb 9 09:49:03.323155 systemd[1]: Finished user-runtime-dir@500.service. Feb 9 09:49:03.324431 systemd[1]: Starting user@500.service... Feb 9 09:49:03.326950 (systemd)[1319]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Feb 9 09:49:03.386634 systemd[1319]: Queued start job for default target default.target. Feb 9 09:49:03.387117 systemd[1319]: Reached target paths.target. Feb 9 09:49:03.387136 systemd[1319]: Reached target sockets.target. Feb 9 09:49:03.387159 systemd[1319]: Reached target timers.target. Feb 9 09:49:03.387171 systemd[1319]: Reached target basic.target. Feb 9 09:49:03.387215 systemd[1319]: Reached target default.target. Feb 9 09:49:03.387239 systemd[1319]: Startup finished in 55ms. Feb 9 09:49:03.387379 systemd[1]: Started user@500.service. Feb 9 09:49:03.388599 systemd[1]: Started session-1.scope. Feb 9 09:49:03.439245 systemd[1]: Started sshd@1-10.0.0.33:22-10.0.0.1:37320.service. Feb 9 09:49:03.475360 sshd[1328]: Accepted publickey for core from 10.0.0.1 port 37320 ssh2: RSA SHA256:g0U6KM199woo3jVvTXJmbHJGWRxGxX9UCqO141QChXg Feb 9 09:49:03.476553 sshd[1328]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Feb 9 09:49:03.480954 systemd-logind[1135]: New session 2 of user core. Feb 9 09:49:03.481763 systemd[1]: Started session-2.scope. Feb 9 09:49:03.534300 sshd[1328]: pam_unix(sshd:session): session closed for user core Feb 9 09:49:03.537681 systemd[1]: Started sshd@2-10.0.0.33:22-10.0.0.1:37326.service. Feb 9 09:49:03.539211 systemd[1]: sshd@1-10.0.0.33:22-10.0.0.1:37320.service: Deactivated successfully. Feb 9 09:49:03.539834 systemd[1]: session-2.scope: Deactivated successfully. Feb 9 09:49:03.540395 systemd-logind[1135]: Session 2 logged out. Waiting for processes to exit. Feb 9 09:49:03.541032 systemd-logind[1135]: Removed session 2. Feb 9 09:49:03.573485 sshd[1333]: Accepted publickey for core from 10.0.0.1 port 37326 ssh2: RSA SHA256:g0U6KM199woo3jVvTXJmbHJGWRxGxX9UCqO141QChXg Feb 9 09:49:03.574887 sshd[1333]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Feb 9 09:49:03.578332 systemd-logind[1135]: New session 3 of user core. Feb 9 09:49:03.578592 systemd[1]: Started session-3.scope. Feb 9 09:49:03.627510 sshd[1333]: pam_unix(sshd:session): session closed for user core Feb 9 09:49:03.629990 systemd[1]: sshd@2-10.0.0.33:22-10.0.0.1:37326.service: Deactivated successfully. Feb 9 09:49:03.630537 systemd[1]: session-3.scope: Deactivated successfully. Feb 9 09:49:03.631009 systemd-logind[1135]: Session 3 logged out. Waiting for processes to exit. Feb 9 09:49:03.631962 systemd[1]: Started sshd@3-10.0.0.33:22-10.0.0.1:37330.service. Feb 9 09:49:03.632476 systemd-logind[1135]: Removed session 3. Feb 9 09:49:03.668567 sshd[1340]: Accepted publickey for core from 10.0.0.1 port 37330 ssh2: RSA SHA256:g0U6KM199woo3jVvTXJmbHJGWRxGxX9UCqO141QChXg Feb 9 09:49:03.669641 sshd[1340]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Feb 9 09:49:03.672705 systemd-logind[1135]: New session 4 of user core. Feb 9 09:49:03.673467 systemd[1]: Started session-4.scope. Feb 9 09:49:03.724627 sshd[1340]: pam_unix(sshd:session): session closed for user core Feb 9 09:49:03.726766 systemd[1]: sshd@3-10.0.0.33:22-10.0.0.1:37330.service: Deactivated successfully. Feb 9 09:49:03.727315 systemd[1]: session-4.scope: Deactivated successfully. Feb 9 09:49:03.727793 systemd-logind[1135]: Session 4 logged out. Waiting for processes to exit. Feb 9 09:49:03.728694 systemd[1]: Started sshd@4-10.0.0.33:22-10.0.0.1:37332.service. Feb 9 09:49:03.729348 systemd-logind[1135]: Removed session 4. Feb 9 09:49:03.764940 sshd[1346]: Accepted publickey for core from 10.0.0.1 port 37332 ssh2: RSA SHA256:g0U6KM199woo3jVvTXJmbHJGWRxGxX9UCqO141QChXg Feb 9 09:49:03.765998 sshd[1346]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Feb 9 09:49:03.769133 systemd-logind[1135]: New session 5 of user core. Feb 9 09:49:03.769856 systemd[1]: Started session-5.scope. Feb 9 09:49:03.824122 sudo[1349]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Feb 9 09:49:03.824358 sudo[1349]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Feb 9 09:49:03.840485 dbus-daemon[1124]: avc: received setenforce notice (enforcing=1) Feb 9 09:49:03.842177 sudo[1349]: pam_unix(sudo:session): session closed for user root Feb 9 09:49:03.844114 sshd[1346]: pam_unix(sshd:session): session closed for user core Feb 9 09:49:03.847940 systemd[1]: sshd@4-10.0.0.33:22-10.0.0.1:37332.service: Deactivated successfully. Feb 9 09:49:03.848536 systemd[1]: session-5.scope: Deactivated successfully. Feb 9 09:49:03.849098 systemd-logind[1135]: Session 5 logged out. Waiting for processes to exit. Feb 9 09:49:03.850129 systemd[1]: Started sshd@5-10.0.0.33:22-10.0.0.1:37336.service. Feb 9 09:49:03.850906 systemd-logind[1135]: Removed session 5. Feb 9 09:49:03.885953 sshd[1353]: Accepted publickey for core from 10.0.0.1 port 37336 ssh2: RSA SHA256:g0U6KM199woo3jVvTXJmbHJGWRxGxX9UCqO141QChXg Feb 9 09:49:03.887368 sshd[1353]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Feb 9 09:49:03.890352 systemd-logind[1135]: New session 6 of user core. Feb 9 09:49:03.891110 systemd[1]: Started session-6.scope. Feb 9 09:49:03.941835 sudo[1357]: 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 Feb 9 09:49:03.942047 sudo[1357]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Feb 9 09:49:03.944476 sudo[1357]: pam_unix(sudo:session): session closed for user root Feb 9 09:49:03.948352 sudo[1356]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules Feb 9 09:49:03.948550 sudo[1356]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Feb 9 09:49:03.956102 systemd[1]: Stopping audit-rules.service... Feb 9 09:49:03.955000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Feb 9 09:49:03.957205 auditctl[1360]: No rules Feb 9 09:49:03.957507 systemd[1]: audit-rules.service: Deactivated successfully. Feb 9 09:49:03.957609 kernel: kauditd_printk_skb: 80 callbacks suppressed Feb 9 09:49:03.957644 kernel: audit: type=1305 audit(1707472143.955:170): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Feb 9 09:49:03.957660 systemd[1]: Stopped audit-rules.service. Feb 9 09:49:03.955000 audit[1360]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffd4641450 a2=420 a3=0 items=0 ppid=1 pid=1360 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) Feb 9 09:49:03.958923 systemd[1]: Starting audit-rules.service... Feb 9 09:49:03.961408 kernel: audit: type=1300 audit(1707472143.955:170): arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffd4641450 a2=420 a3=0 items=0 ppid=1 pid=1360 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) Feb 9 09:49:03.961484 kernel: audit: type=1327 audit(1707472143.955:170): proctitle=2F7362696E2F617564697463746C002D44 Feb 9 09:49:03.955000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D44 Feb 9 09:49:03.956000 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' Feb 9 09:49:03.963961 kernel: audit: type=1131 audit(1707472143.956: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' Feb 9 09:49:03.974601 augenrules[1377]: No rules Feb 9 09:49:03.975190 systemd[1]: Finished audit-rules.service. Feb 9 09:49:03.974000 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' Feb 9 09:49:03.976250 sudo[1356]: pam_unix(sudo:session): session closed for user root Feb 9 09:49:03.975000 audit[1356]: USER_END pid=1356 uid=500 auid=500 ses=6 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Feb 9 09:49:03.977657 sshd[1353]: pam_unix(sshd:session): session closed for user core Feb 9 09:49:03.980236 kernel: audit: type=1130 audit(1707472143.974: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' Feb 9 09:49:03.980303 kernel: audit: type=1106 audit(1707472143.975:173): pid=1356 uid=500 auid=500 ses=6 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Feb 9 09:49:03.980339 kernel: audit: type=1104 audit(1707472143.975:174): pid=1356 uid=500 auid=500 ses=6 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Feb 9 09:49:03.975000 audit[1356]: CRED_DISP pid=1356 uid=500 auid=500 ses=6 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Feb 9 09:49:03.980749 systemd[1]: Started sshd@6-10.0.0.33:22-10.0.0.1:37340.service. Feb 9 09:49:03.981218 systemd[1]: sshd@5-10.0.0.33:22-10.0.0.1:37336.service: Deactivated successfully. Feb 9 09:49:03.981575 kernel: audit: type=1106 audit(1707472143.977:175): pid=1353 uid=0 auid=500 ses=6 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Feb 9 09:49:03.977000 audit[1353]: USER_END pid=1353 uid=0 auid=500 ses=6 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Feb 9 09:49:03.981799 systemd[1]: session-6.scope: Deactivated successfully. Feb 9 09:49:03.982306 systemd-logind[1135]: Session 6 logged out. Waiting for processes to exit. Feb 9 09:49:03.983035 systemd-logind[1135]: Removed session 6. Feb 9 09:49:03.977000 audit[1353]: CRED_DISP pid=1353 uid=0 auid=500 ses=6 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Feb 9 09:49:03.986138 kernel: audit: type=1104 audit(1707472143.977:176): pid=1353 uid=0 auid=500 ses=6 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Feb 9 09:49:03.986203 kernel: audit: type=1130 audit(1707472143.979:177): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-10.0.0.33:22-10.0.0.1:37340 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Feb 9 09:49:03.979000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-10.0.0.33:22-10.0.0.1:37340 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Feb 9 09:49:03.981000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-10.0.0.33:22-10.0.0.1:37336 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Feb 9 09:49:04.016000 audit[1382]: USER_ACCT pid=1382 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_access,pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Feb 9 09:49:04.017745 sshd[1382]: Accepted publickey for core from 10.0.0.1 port 37340 ssh2: RSA SHA256:g0U6KM199woo3jVvTXJmbHJGWRxGxX9UCqO141QChXg Feb 9 09:49:04.017000 audit[1382]: CRED_ACQ pid=1382 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Feb 9 09:49:04.017000 audit[1382]: SYSCALL arch=c00000b7 syscall=64 success=yes exit=3 a0=5 a1=ffffe55f2e10 a2=3 a3=1 items=0 ppid=1 pid=1382 auid=500 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=7 comm="sshd" exe="/usr/sbin/sshd" subj=system_u:system_r:kernel_t:s0 key=(null) Feb 9 09:49:04.017000 audit: PROCTITLE proctitle=737368643A20636F7265205B707269765D Feb 9 09:49:04.018947 sshd[1382]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Feb 9 09:49:04.022417 systemd-logind[1135]: New session 7 of user core. Feb 9 09:49:04.022787 systemd[1]: Started session-7.scope. Feb 9 09:49:04.025000 audit[1382]: USER_START pid=1382 uid=0 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Feb 9 09:49:04.026000 audit[1385]: CRED_ACQ pid=1385 uid=0 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Feb 9 09:49:04.074000 audit[1390]: USER_ACCT pid=1390 uid=500 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Feb 9 09:49:04.075000 audit[1390]: CRED_REFR pid=1390 uid=500 auid=500 ses=7 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' Feb 9 09:49:04.076199 sudo[1390]: core : PWD=/tmp/tmp.5LsqavyBCW ; USER=root ; COMMAND=/usr/bin/ldd /usr/bin/echo /usr/bin/sleep Feb 9 09:49:04.077195 sudo[1390]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Feb 9 09:49:04.077000 audit[1390]: USER_START pid=1390 uid=500 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Feb 9 09:49:04.085582 sudo[1390]: pam_unix(sudo:session): session closed for user root Feb 9 09:49:04.084000 audit[1390]: USER_END pid=1390 uid=500 auid=500 ses=7 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' Feb 9 09:49:04.084000 audit[1390]: CRED_DISP pid=1390 uid=500 auid=500 ses=7 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' Feb 9 09:49:04.088000 audit[1402]: USER_ACCT pid=1402 uid=500 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Feb 9 09:49:04.090213 sudo[1402]: core : PWD=/tmp/tmp.5LsqavyBCW ; USER=root ; COMMAND=/usr/bin/rsync -av --relative --copy-links /usr/bin/echo /usr/bin/sleep /lib/ld-linux-aarch64.so.1 /lib64/ld-linux-aarch64.so.1 /lib64/libc.so.6 ./ Feb 9 09:49:04.089000 audit[1402]: CRED_REFR pid=1402 uid=500 auid=500 ses=7 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' Feb 9 09:49:04.090465 sudo[1402]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Feb 9 09:49:04.090000 audit[1402]: USER_START pid=1402 uid=500 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Feb 9 09:49:04.149649 sudo[1402]: pam_unix(sudo:session): session closed for user root Feb 9 09:49:04.148000 audit[1402]: USER_END pid=1402 uid=500 auid=500 ses=7 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' Feb 9 09:49:04.148000 audit[1402]: CRED_DISP pid=1402 uid=500 auid=500 ses=7 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' Feb 9 09:49:04.152000 audit[1386]: USER_ACCT pid=1386 uid=500 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Feb 9 09:49:04.154347 sudo[1386]: core : PWD=/tmp/tmp.5LsqavyBCW ; USER=root ; COMMAND=/usr/bin/docker build -t userns-test . Feb 9 09:49:04.153000 audit[1386]: CRED_REFR pid=1386 uid=500 auid=500 ses=7 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' Feb 9 09:49:04.154551 sudo[1386]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Feb 9 09:49:04.154000 audit[1386]: USER_START pid=1386 uid=500 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Feb 9 09:49:04.333000 audit[1386]: USER_END pid=1386 uid=500 auid=500 ses=7 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' Feb 9 09:49:04.333000 audit[1386]: CRED_DISP pid=1386 uid=500 auid=500 ses=7 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' Feb 9 09:49:04.334644 sudo[1386]: pam_unix(sudo:session): session closed for user root Feb 9 09:49:04.336811 sshd[1382]: pam_unix(sshd:session): session closed for user core Feb 9 09:49:04.337000 audit[1382]: USER_END pid=1382 uid=0 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Feb 9 09:49:04.337000 audit[1382]: CRED_DISP pid=1382 uid=0 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Feb 9 09:49:04.339658 systemd[1]: sshd@6-10.0.0.33:22-10.0.0.1:37340.service: Deactivated successfully. Feb 9 09:49:04.339000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-10.0.0.33:22-10.0.0.1:37340 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Feb 9 09:49:04.340310 systemd[1]: session-7.scope: Deactivated successfully. Feb 9 09:49:04.340854 systemd-logind[1135]: Session 7 logged out. Waiting for processes to exit. Feb 9 09:49:04.341954 systemd[1]: Started sshd@7-10.0.0.33:22-10.0.0.1:37342.service. Feb 9 09:49:04.341000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@7-10.0.0.33:22-10.0.0.1:37342 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Feb 9 09:49:04.342786 systemd-logind[1135]: Removed session 7. Feb 9 09:49:04.376000 audit[1445]: USER_ACCT pid=1445 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_access,pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Feb 9 09:49:04.378275 sshd[1445]: Accepted publickey for core from 10.0.0.1 port 37342 ssh2: RSA SHA256:g0U6KM199woo3jVvTXJmbHJGWRxGxX9UCqO141QChXg Feb 9 09:49:04.377000 audit[1445]: CRED_ACQ pid=1445 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Feb 9 09:49:04.377000 audit[1445]: SYSCALL arch=c00000b7 syscall=64 success=yes exit=3 a0=5 a1=ffffcd20e780 a2=3 a3=1 items=0 ppid=1 pid=1445 auid=500 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=8 comm="sshd" exe="/usr/sbin/sshd" subj=system_u:system_r:kernel_t:s0 key=(null) Feb 9 09:49:04.377000 audit: PROCTITLE proctitle=737368643A20636F7265205B707269765D Feb 9 09:49:04.379489 sshd[1445]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Feb 9 09:49:04.383358 systemd-logind[1135]: New session 8 of user core. Feb 9 09:49:04.383984 systemd[1]: Started session-8.scope. Feb 9 09:49:04.386000 audit[1445]: USER_START pid=1445 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Feb 9 09:49:04.388000 audit[1447]: CRED_ACQ pid=1447 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Feb 9 09:49:04.454351 systemd[1]: var-lib-docker-100000.100000-overlay2-77286ebee76c7e709fd8274e2fdb64101ce27ad03e347f3f282d07108441d761\x2dinit-merged.mount: Deactivated successfully. Feb 9 09:49:04.499607 kernel: docker0: port 1(veth8dd734c) entered blocking state Feb 9 09:49:04.499724 kernel: docker0: port 1(veth8dd734c) entered disabled state Feb 9 09:49:04.499746 kernel: device veth8dd734c entered promiscuous mode Feb 9 09:49:04.496000 audit: ANOM_PROMISCUOUS dev=veth8dd734c prom=256 old_prom=0 auid=4294967295 uid=0 gid=0 ses=4294967295 Feb 9 09:49:04.496000 audit[1189]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=40 a0=f a1=4000ed1cb0 a2=28 a3=0 items=0 ppid=1 pid=1189 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="dockerd" exe="/run/torcx/unpack/docker/bin/dockerd" subj=system_u:system_r:kernel_t:s0 key=(null) Feb 9 09:49:04.496000 audit: PROCTITLE proctitle=2F72756E2F746F7263782F62696E2F646F636B657264002D2D686F73743D66643A2F2F002D2D636F6E7461696E6572643D2F7661722F72756E2F646F636B65722F6C6962636F6E7461696E6572642F646F636B65722D636F6E7461696E6572642E736F636B002D2D73656C696E75782D656E61626C65643D74727565002D2D75 Feb 9 09:49:04.500319 systemd-networkd[1055]: veth8dd734c: Link UP Feb 9 09:49:04.548398 env[1144]: time="2024-02-09T09:49:04.548326766Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Feb 9 09:49:04.548398 env[1144]: time="2024-02-09T09:49:04.548366818Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Feb 9 09:49:04.548807 env[1144]: time="2024-02-09T09:49:04.548377087Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Feb 9 09:49:04.548807 env[1144]: time="2024-02-09T09:49:04.548548309Z" level=info msg="starting signal loop" namespace=moby path=/run/containerd/io.containerd.runtime.v2.task/moby/f6f5a4bae035a930fe1005a4f94b8e675c14ac79048b39f183d0d723f998538d pid=1475 runtime=io.containerd.runc.v2 Feb 9 09:49:04.558736 systemd[1]: Started docker-f6f5a4bae035a930fe1005a4f94b8e675c14ac79048b39f183d0d723f998538d.scope. Feb 9 09:49:04.594000 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=0 Feb 9 09:49:04.594000 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=0 Feb 9 09:49:04.594000 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=0 Feb 9 09:49:04.594000 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=0 Feb 9 09:49:04.594000 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=0 Feb 9 09:49:04.594000 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=0 Feb 9 09:49:04.594000 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=0 Feb 9 09:49:04.594000 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=0 Feb 9 09:49:04.594000 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=0 Feb 9 09:49:04.594000 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=0 Feb 9 09:49:04.594000 audit: BPF prog-id=37 op=LOAD Feb 9 09:49:04.594000 audit[1485]: AVC avc: denied { bpf } for pid=1485 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.594000 audit[1485]: SYSCALL arch=c00000b7 syscall=280 success=yes exit=0 a0=f a1=4000115b38 a2=10 a3=0 items=0 ppid=1475 pid=1485 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="runc" exe="/run/torcx/unpack/docker/bin/runc" subj=system_u:system_r:kernel_t:s0 key=(null) Feb 9 09:49:04.594000 audit: PROCTITLE proctitle=72756E63002D2D726F6F74002F7661722F72756E2F646F636B65722F72756E74696D652D72756E632F6D6F6279002D2D6C6F67002F72756E2F636F6E7461696E6572642F696F2E636F6E7461696E6572642E72756E74696D652E76322E7461736B2F6D6F62792F66366635613462616530333561393330666531303035613466 Feb 9 09:49:04.594000 audit[1485]: AVC avc: denied { perfmon } for pid=1485 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.594000 audit[1485]: SYSCALL arch=c00000b7 syscall=280 success=yes exit=16 a0=0 a1=40001155a0 a2=3c a3=0 items=0 ppid=1475 pid=1485 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="runc" exe="/run/torcx/unpack/docker/bin/runc" subj=system_u:system_r:kernel_t:s0 key=(null) Feb 9 09:49:04.594000 audit: PROCTITLE proctitle=72756E63002D2D726F6F74002F7661722F72756E2F646F636B65722F72756E74696D652D72756E632F6D6F6279002D2D6C6F67002F72756E2F636F6E7461696E6572642F696F2E636F6E7461696E6572642E72756E74696D652E76322E7461736B2F6D6F62792F66366635613462616530333561393330666531303035613466 Feb 9 09:49:04.594000 audit[1485]: AVC avc: denied { bpf } for pid=1485 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.594000 audit[1485]: AVC avc: denied { bpf } for pid=1485 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.594000 audit[1485]: AVC avc: denied { bpf } for pid=1485 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.594000 audit[1485]: AVC avc: denied { perfmon } for pid=1485 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.594000 audit[1485]: AVC avc: denied { perfmon } for pid=1485 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.594000 audit[1485]: AVC avc: denied { perfmon } for pid=1485 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.594000 audit[1485]: AVC avc: denied { perfmon } for pid=1485 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.594000 audit[1485]: AVC avc: denied { perfmon } for pid=1485 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.594000 audit[1485]: AVC avc: denied { bpf } for pid=1485 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.594000 audit[1485]: AVC avc: denied { bpf } for pid=1485 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.594000 audit: BPF prog-id=38 op=LOAD Feb 9 09:49:04.594000 audit[1485]: SYSCALL arch=c00000b7 syscall=280 success=yes exit=16 a0=5 a1=40001158e0 a2=78 a3=0 items=0 ppid=1475 pid=1485 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="runc" exe="/run/torcx/unpack/docker/bin/runc" subj=system_u:system_r:kernel_t:s0 key=(null) Feb 9 09:49:04.594000 audit: PROCTITLE proctitle=72756E63002D2D726F6F74002F7661722F72756E2F646F636B65722F72756E74696D652D72756E632F6D6F6279002D2D6C6F67002F72756E2F636F6E7461696E6572642F696F2E636F6E7461696E6572642E72756E74696D652E76322E7461736B2F6D6F62792F66366635613462616530333561393330666531303035613466 Feb 9 09:49:04.594000 audit[1485]: AVC avc: denied { bpf } for pid=1485 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.594000 audit[1485]: AVC avc: denied { bpf } for pid=1485 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.594000 audit[1485]: AVC avc: denied { perfmon } for pid=1485 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.594000 audit[1485]: AVC avc: denied { perfmon } for pid=1485 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.594000 audit[1485]: AVC avc: denied { perfmon } for pid=1485 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.594000 audit[1485]: AVC avc: denied { perfmon } for pid=1485 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.594000 audit[1485]: AVC avc: denied { perfmon } for pid=1485 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.594000 audit[1485]: AVC avc: denied { bpf } for pid=1485 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.594000 audit[1485]: AVC avc: denied { bpf } for pid=1485 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.594000 audit: BPF prog-id=39 op=LOAD Feb 9 09:49:04.594000 audit[1485]: SYSCALL arch=c00000b7 syscall=280 success=yes exit=18 a0=5 a1=4000115670 a2=78 a3=0 items=0 ppid=1475 pid=1485 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="runc" exe="/run/torcx/unpack/docker/bin/runc" subj=system_u:system_r:kernel_t:s0 key=(null) Feb 9 09:49:04.594000 audit: PROCTITLE proctitle=72756E63002D2D726F6F74002F7661722F72756E2F646F636B65722F72756E74696D652D72756E632F6D6F6279002D2D6C6F67002F72756E2F636F6E7461696E6572642F696F2E636F6E7461696E6572642E72756E74696D652E76322E7461736B2F6D6F62792F66366635613462616530333561393330666531303035613466 Feb 9 09:49:04.594000 audit: BPF prog-id=39 op=UNLOAD Feb 9 09:49:04.594000 audit: BPF prog-id=38 op=UNLOAD Feb 9 09:49:04.594000 audit[1485]: AVC avc: denied { bpf } for pid=1485 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.594000 audit[1485]: AVC avc: denied { bpf } for pid=1485 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.594000 audit[1485]: AVC avc: denied { bpf } for pid=1485 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.594000 audit[1485]: AVC avc: denied { perfmon } for pid=1485 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.594000 audit[1485]: AVC avc: denied { perfmon } for pid=1485 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.594000 audit[1485]: AVC avc: denied { perfmon } for pid=1485 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.594000 audit[1485]: AVC avc: denied { perfmon } for pid=1485 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.594000 audit[1485]: AVC avc: denied { perfmon } for pid=1485 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.594000 audit[1485]: AVC avc: denied { bpf } for pid=1485 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.594000 audit[1485]: AVC avc: denied { bpf } for pid=1485 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.594000 audit: BPF prog-id=40 op=LOAD Feb 9 09:49:04.594000 audit[1485]: SYSCALL arch=c00000b7 syscall=280 success=yes exit=16 a0=5 a1=4000115b40 a2=78 a3=0 items=0 ppid=1475 pid=1485 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="runc" exe="/run/torcx/unpack/docker/bin/runc" subj=system_u:system_r:kernel_t:s0 key=(null) Feb 9 09:49:04.594000 audit: PROCTITLE proctitle=72756E63002D2D726F6F74002F7661722F72756E2F646F636B65722F72756E74696D652D72756E632F6D6F6279002D2D6C6F67002F72756E2F636F6E7461696E6572642F696F2E636F6E7461696E6572642E72756E74696D652E76322E7461736B2F6D6F62792F66366635613462616530333561393330666531303035613466 Feb 9 09:49:04.679302 kernel: eth0: renamed from veth0374fee Feb 9 09:49:04.691681 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): veth8dd734c: link becomes ready Feb 9 09:49:04.691755 kernel: docker0: port 1(veth8dd734c) entered blocking state Feb 9 09:49:04.691775 kernel: docker0: port 1(veth8dd734c) entered forwarding state Feb 9 09:49:04.692277 systemd-networkd[1055]: veth8dd734c: Gained carrier Feb 9 09:49:04.692785 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): docker0: link becomes ready Feb 9 09:49:04.692885 systemd-networkd[1055]: docker0: Gained carrier Feb 9 09:49:04.695416 systemd-resolved[1098]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Feb 9 09:49:04.714722 systemd[1]: docker-f6f5a4bae035a930fe1005a4f94b8e675c14ac79048b39f183d0d723f998538d.scope: Deactivated successfully. Feb 9 09:49:04.714000 audit: BPF prog-id=37 op=UNLOAD Feb 9 09:49:04.725008 env[1189]: time="2024-02-09T09:49:04.724962865Z" level=info msg="ignoring event" container=f6f5a4bae035a930fe1005a4f94b8e675c14ac79048b39f183d0d723f998538d module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Feb 9 09:49:04.725253 env[1144]: time="2024-02-09T09:49:04.724963927Z" level=info msg="shim disconnected" id=f6f5a4bae035a930fe1005a4f94b8e675c14ac79048b39f183d0d723f998538d Feb 9 09:49:04.725253 env[1144]: time="2024-02-09T09:49:04.725002051Z" level=warning msg="cleaning up after shim disconnected" id=f6f5a4bae035a930fe1005a4f94b8e675c14ac79048b39f183d0d723f998538d namespace=moby Feb 9 09:49:04.725253 env[1144]: time="2024-02-09T09:49:04.725012202Z" level=info msg="cleaning up dead shim" Feb 9 09:49:04.731404 env[1144]: time="2024-02-09T09:49:04.731368457Z" level=warning msg="cleanup warnings time=\"2024-02-09T09:49:04Z\" level=info msg=\"starting signal loop\" namespace=moby pid=1534 runtime=io.containerd.runc.v2\n" Feb 9 09:49:04.734746 systemd-networkd[1055]: veth8dd734c: Lost carrier Feb 9 09:49:04.735457 kernel: docker0: port 1(veth8dd734c) entered disabled state Feb 9 09:49:04.735500 kernel: veth0374fee: renamed from eth0 Feb 9 09:49:04.751708 systemd-networkd[1055]: veth8dd734c: Link DOWN Feb 9 09:49:04.753296 kernel: docker0: port 1(veth8dd734c) entered disabled state Feb 9 09:49:04.750000 audit: ANOM_PROMISCUOUS dev=veth8dd734c prom=0 old_prom=256 auid=4294967295 uid=0 gid=0 ses=4294967295 Feb 9 09:49:04.754491 kernel: device veth8dd734c left promiscuous mode Feb 9 09:49:04.754535 kernel: docker0: port 1(veth8dd734c) entered disabled state Feb 9 09:49:04.750000 audit[1189]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=32 a0=f a1=4000bd4220 a2=20 a3=0 items=0 ppid=1 pid=1189 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="dockerd" exe="/run/torcx/unpack/docker/bin/dockerd" subj=system_u:system_r:kernel_t:s0 key=(null) Feb 9 09:49:04.750000 audit: PROCTITLE proctitle=2F72756E2F746F7263782F62696E2F646F636B657264002D2D686F73743D66643A2F2F002D2D636F6E7461696E6572643D2F7661722F72756E2F646F636B65722F6C6962636F6E7461696E6572642F646F636B65722D636F6E7461696E6572642E736F636B002D2D73656C696E75782D656E61626C65643D74727565002D2D75 Feb 9 09:49:04.790209 sshd[1445]: pam_unix(sshd:session): session closed for user core Feb 9 09:49:04.789000 audit[1445]: USER_END pid=1445 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Feb 9 09:49:04.789000 audit[1445]: CRED_DISP pid=1445 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Feb 9 09:49:04.792000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@7-10.0.0.33:22-10.0.0.1:37342 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Feb 9 09:49:04.794006 systemd[1]: sshd@7-10.0.0.33:22-10.0.0.1:37342.service: Deactivated successfully. Feb 9 09:49:04.794558 systemd[1]: session-8.scope: Deactivated successfully. Feb 9 09:49:04.795054 systemd-logind[1135]: Session 8 logged out. Waiting for processes to exit. Feb 9 09:49:04.794000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@8-10.0.0.33:22-10.0.0.1:37352 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Feb 9 09:49:04.796014 systemd[1]: Started sshd@8-10.0.0.33:22-10.0.0.1:37352.service. Feb 9 09:49:04.796879 systemd-logind[1135]: Removed session 8. Feb 9 09:49:04.814000 audit: BPF prog-id=40 op=UNLOAD Feb 9 09:49:04.831000 audit[1551]: USER_ACCT pid=1551 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_access,pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Feb 9 09:49:04.831523 sshd[1551]: Accepted publickey for core from 10.0.0.1 port 37352 ssh2: RSA SHA256:g0U6KM199woo3jVvTXJmbHJGWRxGxX9UCqO141QChXg Feb 9 09:49:04.832000 audit[1551]: CRED_ACQ pid=1551 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Feb 9 09:49:04.832000 audit[1551]: SYSCALL arch=c00000b7 syscall=64 success=yes exit=3 a0=5 a1=ffffd3ae2380 a2=3 a3=1 items=0 ppid=1 pid=1551 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) Feb 9 09:49:04.832000 audit: PROCTITLE proctitle=737368643A20636F7265205B707269765D Feb 9 09:49:04.832636 sshd[1551]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Feb 9 09:49:04.835999 systemd-logind[1135]: New session 9 of user core. Feb 9 09:49:04.836374 systemd[1]: Started session-9.scope. Feb 9 09:49:04.838000 audit[1551]: USER_START pid=1551 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Feb 9 09:49:04.839000 audit[1553]: CRED_ACQ pid=1553 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Feb 9 09:49:04.917481 kernel: docker0: port 1(veth2e72bae) entered blocking state Feb 9 09:49:04.917596 kernel: docker0: port 1(veth2e72bae) entered disabled state Feb 9 09:49:04.917619 kernel: device veth2e72bae entered promiscuous mode Feb 9 09:49:04.917637 kernel: docker0: port 1(veth2e72bae) entered blocking state Feb 9 09:49:04.914000 audit: ANOM_PROMISCUOUS dev=veth2e72bae prom=256 old_prom=0 auid=4294967295 uid=0 gid=0 ses=4294967295 Feb 9 09:49:04.914000 audit[1189]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=40 a0=f a1=4000bd3ef0 a2=28 a3=0 items=0 ppid=1 pid=1189 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="dockerd" exe="/run/torcx/unpack/docker/bin/dockerd" subj=system_u:system_r:kernel_t:s0 key=(null) Feb 9 09:49:04.914000 audit: PROCTITLE proctitle=2F72756E2F746F7263782F62696E2F646F636B657264002D2D686F73743D66643A2F2F002D2D636F6E7461696E6572643D2F7661722F72756E2F646F636B65722F6C6962636F6E7461696E6572642F646F636B65722D636F6E7461696E6572642E736F636B002D2D73656C696E75782D656E61626C65643D74727565002D2D75 Feb 9 09:49:04.918301 kernel: docker0: port 1(veth2e72bae) entered forwarding state Feb 9 09:49:04.918848 systemd-networkd[1055]: veth2e72bae: Link UP Feb 9 09:49:04.941279 env[1144]: time="2024-02-09T09:49:04.941117295Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Feb 9 09:49:04.941279 env[1144]: time="2024-02-09T09:49:04.941154868Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Feb 9 09:49:04.941279 env[1144]: time="2024-02-09T09:49:04.941165098Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Feb 9 09:49:04.941460 env[1144]: time="2024-02-09T09:49:04.941322432Z" level=info msg="starting signal loop" namespace=moby path=/run/containerd/io.containerd.runtime.v2.task/moby/3e66bad92ef1062653621d46b3b5a46a7c2098e075e2841dc69c5f9712adbc8b pid=1573 runtime=io.containerd.runc.v2 Feb 9 09:49:04.950531 systemd[1]: Started docker-3e66bad92ef1062653621d46b3b5a46a7c2098e075e2841dc69c5f9712adbc8b.scope. Feb 9 09:49:04.972000 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=0 Feb 9 09:49:04.972000 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=0 Feb 9 09:49:04.972000 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=0 Feb 9 09:49:04.972000 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=0 Feb 9 09:49:04.972000 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=0 Feb 9 09:49:04.972000 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=0 Feb 9 09:49:04.972000 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=0 Feb 9 09:49:04.972000 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=0 Feb 9 09:49:04.972000 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=0 Feb 9 09:49:04.972000 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=0 Feb 9 09:49:04.972000 audit: BPF prog-id=41 op=LOAD Feb 9 09:49:04.972000 audit[1582]: AVC avc: denied { bpf } for pid=1582 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.972000 audit[1582]: SYSCALL arch=c00000b7 syscall=280 success=yes exit=0 a0=f a1=4000195b38 a2=10 a3=0 items=0 ppid=1573 pid=1582 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="runc" exe="/run/torcx/unpack/docker/bin/runc" subj=system_u:system_r:kernel_t:s0 key=(null) Feb 9 09:49:04.972000 audit: PROCTITLE proctitle=72756E63002D2D726F6F74002F7661722F72756E2F646F636B65722F72756E74696D652D72756E632F6D6F6279002D2D6C6F67002F72756E2F636F6E7461696E6572642F696F2E636F6E7461696E6572642E72756E74696D652E76322E7461736B2F6D6F62792F33653636626164393265663130363236353336323164343662 Feb 9 09:49:04.972000 audit[1582]: AVC avc: denied { perfmon } for pid=1582 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.972000 audit[1582]: SYSCALL arch=c00000b7 syscall=280 success=yes exit=16 a0=0 a1=40001955a0 a2=3c a3=0 items=0 ppid=1573 pid=1582 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="runc" exe="/run/torcx/unpack/docker/bin/runc" subj=system_u:system_r:kernel_t:s0 key=(null) Feb 9 09:49:04.972000 audit: PROCTITLE proctitle=72756E63002D2D726F6F74002F7661722F72756E2F646F636B65722F72756E74696D652D72756E632F6D6F6279002D2D6C6F67002F72756E2F636F6E7461696E6572642F696F2E636F6E7461696E6572642E72756E74696D652E76322E7461736B2F6D6F62792F33653636626164393265663130363236353336323164343662 Feb 9 09:49:04.972000 audit[1582]: AVC avc: denied { bpf } for pid=1582 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.972000 audit[1582]: AVC avc: denied { bpf } for pid=1582 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.972000 audit[1582]: AVC avc: denied { bpf } for pid=1582 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.972000 audit[1582]: AVC avc: denied { perfmon } for pid=1582 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.972000 audit[1582]: AVC avc: denied { perfmon } for pid=1582 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.972000 audit[1582]: AVC avc: denied { perfmon } for pid=1582 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.972000 audit[1582]: AVC avc: denied { perfmon } for pid=1582 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.972000 audit[1582]: AVC avc: denied { perfmon } for pid=1582 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.972000 audit[1582]: AVC avc: denied { bpf } for pid=1582 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.972000 audit[1582]: AVC avc: denied { bpf } for pid=1582 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.972000 audit: BPF prog-id=42 op=LOAD Feb 9 09:49:04.972000 audit[1582]: SYSCALL arch=c00000b7 syscall=280 success=yes exit=16 a0=5 a1=40001958e0 a2=78 a3=0 items=0 ppid=1573 pid=1582 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="runc" exe="/run/torcx/unpack/docker/bin/runc" subj=system_u:system_r:kernel_t:s0 key=(null) Feb 9 09:49:04.972000 audit: PROCTITLE proctitle=72756E63002D2D726F6F74002F7661722F72756E2F646F636B65722F72756E74696D652D72756E632F6D6F6279002D2D6C6F67002F72756E2F636F6E7461696E6572642F696F2E636F6E7461696E6572642E72756E74696D652E76322E7461736B2F6D6F62792F33653636626164393265663130363236353336323164343662 Feb 9 09:49:04.972000 audit[1582]: AVC avc: denied { bpf } for pid=1582 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.972000 audit[1582]: AVC avc: denied { bpf } for pid=1582 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.972000 audit[1582]: AVC avc: denied { perfmon } for pid=1582 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.972000 audit[1582]: AVC avc: denied { perfmon } for pid=1582 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.972000 audit[1582]: AVC avc: denied { perfmon } for pid=1582 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.972000 audit[1582]: AVC avc: denied { perfmon } for pid=1582 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.972000 audit[1582]: AVC avc: denied { perfmon } for pid=1582 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.972000 audit[1582]: AVC avc: denied { bpf } for pid=1582 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.972000 audit[1582]: AVC avc: denied { bpf } for pid=1582 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.972000 audit: BPF prog-id=43 op=LOAD Feb 9 09:49:04.972000 audit[1582]: SYSCALL arch=c00000b7 syscall=280 success=yes exit=18 a0=5 a1=4000195670 a2=78 a3=0 items=0 ppid=1573 pid=1582 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="runc" exe="/run/torcx/unpack/docker/bin/runc" subj=system_u:system_r:kernel_t:s0 key=(null) Feb 9 09:49:04.972000 audit: PROCTITLE proctitle=72756E63002D2D726F6F74002F7661722F72756E2F646F636B65722F72756E74696D652D72756E632F6D6F6279002D2D6C6F67002F72756E2F636F6E7461696E6572642F696F2E636F6E7461696E6572642E72756E74696D652E76322E7461736B2F6D6F62792F33653636626164393265663130363236353336323164343662 Feb 9 09:49:04.972000 audit: BPF prog-id=43 op=UNLOAD Feb 9 09:49:04.972000 audit: BPF prog-id=42 op=UNLOAD Feb 9 09:49:04.972000 audit[1582]: AVC avc: denied { bpf } for pid=1582 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.972000 audit[1582]: AVC avc: denied { bpf } for pid=1582 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.972000 audit[1582]: AVC avc: denied { bpf } for pid=1582 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.972000 audit[1582]: AVC avc: denied { perfmon } for pid=1582 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.972000 audit[1582]: AVC avc: denied { perfmon } for pid=1582 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.972000 audit[1582]: AVC avc: denied { perfmon } for pid=1582 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.972000 audit[1582]: AVC avc: denied { perfmon } for pid=1582 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.972000 audit[1582]: AVC avc: denied { perfmon } for pid=1582 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.972000 audit[1582]: AVC avc: denied { bpf } for pid=1582 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.972000 audit[1582]: AVC avc: denied { bpf } for pid=1582 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Feb 9 09:49:04.972000 audit: BPF prog-id=44 op=LOAD Feb 9 09:49:04.972000 audit[1582]: SYSCALL arch=c00000b7 syscall=280 success=yes exit=16 a0=5 a1=4000195b40 a2=78 a3=0 items=0 ppid=1573 pid=1582 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="runc" exe="/run/torcx/unpack/docker/bin/runc" subj=system_u:system_r:kernel_t:s0 key=(null) Feb 9 09:49:04.972000 audit: PROCTITLE proctitle=72756E63002D2D726F6F74002F7661722F72756E2F646F636B65722F72756E74696D652D72756E632F6D6F6279002D2D6C6F67002F72756E2F636F6E7461696E6572642F696F2E636F6E7461696E6572642E72756E74696D652E76322E7461736B2F6D6F62792F33653636626164393265663130363236353336323164343662 Feb 9 09:49:05.049300 kernel: eth0: renamed from vethb65ece7 Feb 9 09:49:05.060167 systemd-networkd[1055]: veth2e72bae: Gained carrier Feb 9 09:49:05.060306 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): veth2e72bae: link becomes ready Feb 9 09:49:05.063580 systemd-resolved[1098]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Feb 9 09:49:05.085209 sshd[1551]: pam_unix(sshd:session): session closed for user core Feb 9 09:49:05.085000 audit[1551]: USER_END pid=1551 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Feb 9 09:49:05.085000 audit[1551]: CRED_DISP pid=1551 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Feb 9 09:49:05.088432 systemd[1]: Started sshd@9-10.0.0.33:22-10.0.0.1:37358.service. Feb 9 09:49:05.087000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@9-10.0.0.33:22-10.0.0.1:37358 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Feb 9 09:49:05.088919 systemd[1]: sshd@8-10.0.0.33:22-10.0.0.1:37352.service: Deactivated successfully. Feb 9 09:49:05.087000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@8-10.0.0.33:22-10.0.0.1:37352 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Feb 9 09:49:05.089475 systemd[1]: session-9.scope: Deactivated successfully. Feb 9 09:49:05.089919 systemd-logind[1135]: Session 9 logged out. Waiting for processes to exit. Feb 9 09:49:05.090599 systemd-logind[1135]: Removed session 9. Feb 9 09:49:05.122000 audit[1626]: USER_ACCT pid=1626 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_access,pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Feb 9 09:49:05.124099 sshd[1626]: Accepted publickey for core from 10.0.0.1 port 37358 ssh2: RSA SHA256:g0U6KM199woo3jVvTXJmbHJGWRxGxX9UCqO141QChXg Feb 9 09:49:05.123000 audit[1626]: CRED_ACQ pid=1626 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Feb 9 09:49:05.123000 audit[1626]: SYSCALL arch=c00000b7 syscall=64 success=yes exit=3 a0=5 a1=ffffd57742f0 a2=3 a3=1 items=0 ppid=1 pid=1626 auid=500 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=10 comm="sshd" exe="/usr/sbin/sshd" subj=system_u:system_r:kernel_t:s0 key=(null) Feb 9 09:49:05.123000 audit: PROCTITLE proctitle=737368643A20636F7265205B707269765D Feb 9 09:49:05.125111 sshd[1626]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Feb 9 09:49:05.127998 systemd-logind[1135]: New session 10 of user core. Feb 9 09:49:05.128734 systemd[1]: Started session-10.scope. Feb 9 09:49:05.130000 audit[1626]: USER_START pid=1626 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Feb 9 09:49:05.131000 audit[1629]: CRED_ACQ pid=1629 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Feb 9 09:49:05.233978 systemd[1]: docker-3e66bad92ef1062653621d46b3b5a46a7c2098e075e2841dc69c5f9712adbc8b.scope: Deactivated successfully. Feb 9 09:49:05.232000 audit: BPF prog-id=41 op=UNLOAD Feb 9 09:49:05.244850 env[1189]: time="2024-02-09T09:49:05.244807870Z" level=info msg="ignoring event" container=3e66bad92ef1062653621d46b3b5a46a7c2098e075e2841dc69c5f9712adbc8b module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Feb 9 09:49:05.245086 env[1144]: time="2024-02-09T09:49:05.245048090Z" level=info msg="shim disconnected" id=3e66bad92ef1062653621d46b3b5a46a7c2098e075e2841dc69c5f9712adbc8b Feb 9 09:49:05.245344 env[1144]: time="2024-02-09T09:49:05.245322531Z" level=warning msg="cleaning up after shim disconnected" id=3e66bad92ef1062653621d46b3b5a46a7c2098e075e2841dc69c5f9712adbc8b namespace=moby Feb 9 09:49:05.245582 env[1144]: time="2024-02-09T09:49:05.245561213Z" level=info msg="cleaning up dead shim" Feb 9 09:49:05.251561 env[1144]: time="2024-02-09T09:49:05.251533672Z" level=warning msg="cleanup warnings time=\"2024-02-09T09:49:05Z\" level=info msg=\"starting signal loop\" namespace=moby pid=1669 runtime=io.containerd.runc.v2\n" Feb 9 09:49:05.254899 systemd-networkd[1055]: veth2e72bae: Lost carrier Feb 9 09:49:05.255534 kernel: docker0: port 1(veth2e72bae) entered disabled state Feb 9 09:49:05.255582 kernel: vethb65ece7: renamed from eth0 Feb 9 09:49:05.283028 systemd-networkd[1055]: veth2e72bae: Link DOWN Feb 9 09:49:05.284359 kernel: docker0: port 1(veth2e72bae) entered disabled state Feb 9 09:49:05.284402 kernel: device veth2e72bae left promiscuous mode Feb 9 09:49:05.284430 kernel: docker0: port 1(veth2e72bae) entered disabled state Feb 9 09:49:05.282000 audit: ANOM_PROMISCUOUS dev=veth2e72bae prom=0 old_prom=256 auid=4294967295 uid=0 gid=0 ses=4294967295 Feb 9 09:49:05.282000 audit[1189]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=32 a0=f a1=40008bb540 a2=20 a3=0 items=0 ppid=1 pid=1189 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="dockerd" exe="/run/torcx/unpack/docker/bin/dockerd" subj=system_u:system_r:kernel_t:s0 key=(null) Feb 9 09:49:05.282000 audit: PROCTITLE proctitle=2F72756E2F746F7263782F62696E2F646F636B657264002D2D686F73743D66643A2F2F002D2D636F6E7461696E6572643D2F7661722F72756E2F646F636B65722F6C6962636F6E7461696E6572642F646F636B65722D636F6E7461696E6572642E736F636B002D2D73656C696E75782D656E61626C65643D74727565002D2D75 Feb 9 09:49:05.324599 sshd[1626]: pam_unix(sshd:session): session closed for user core Feb 9 09:49:05.323000 audit[1626]: USER_END pid=1626 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Feb 9 09:49:05.324000 audit[1626]: CRED_DISP pid=1626 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Feb 9 09:49:05.326703 systemd[1]: sshd@9-10.0.0.33:22-10.0.0.1:37358.service: Deactivated successfully. Feb 9 09:49:05.325000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@9-10.0.0.33:22-10.0.0.1:37358 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Feb 9 09:49:05.327323 systemd[1]: session-10.scope: Deactivated successfully. Feb 9 09:49:05.327884 systemd-logind[1135]: Session 10 logged out. Waiting for processes to exit. Feb 9 09:49:05.328664 systemd-logind[1135]: Removed session 10. Feb 9 09:49:05.361000 audit: BPF prog-id=44 op=UNLOAD Feb 9 09:49:05.451980 systemd[1]: var-lib-docker-100000.100000-overlay2-77286ebee76c7e709fd8274e2fdb64101ce27ad03e347f3f282d07108441d761-merged.mount: Deactivated successfully. Feb 9 09:49:05.502485 systemd-networkd[1055]: docker0: Lost carrier Feb 9 09:49:06.430464 systemd-networkd[1055]: docker0: Gained IPv6LL