Nov 1 00:15:50.031374 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Nov 1 00:15:50.031393 kernel: Linux version 5.15.192-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 Oct 31 23:12:38 -00 2025 Nov 1 00:15:50.031401 kernel: earlycon: pl11 at MMIO 0x00000000effec000 (options '') Nov 1 00:15:50.031408 kernel: printk: bootconsole [pl11] enabled Nov 1 00:15:50.031413 kernel: efi: EFI v2.70 by EDK II Nov 1 00:15:50.031418 kernel: efi: ACPI 2.0=0x3fd5f018 SMBIOS=0x3e580000 SMBIOS 3.0=0x3e560000 MEMATTR=0x3ead8b98 RNG=0x3fd5f998 MEMRESERVE=0x3761cf98 Nov 1 00:15:50.031425 kernel: random: crng init done Nov 1 00:15:50.031430 kernel: ACPI: Early table checksum verification disabled Nov 1 00:15:50.031436 kernel: ACPI: RSDP 0x000000003FD5F018 000024 (v02 VRTUAL) Nov 1 00:15:50.031441 kernel: ACPI: XSDT 0x000000003FD5FF18 00006C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Nov 1 00:15:50.031446 kernel: ACPI: FACP 0x000000003FD5FC18 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) Nov 1 00:15:50.031452 kernel: ACPI: DSDT 0x000000003FD41018 01DFCD (v02 MSFTVM DSDT01 00000001 INTL 20230628) Nov 1 00:15:50.031458 kernel: ACPI: DBG2 0x000000003FD5FB18 000072 (v00 VRTUAL MICROSFT 00000001 MSFT 00000001) Nov 1 00:15:50.031464 kernel: ACPI: GTDT 0x000000003FD5FD98 000060 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Nov 1 00:15:50.031470 kernel: ACPI: OEM0 0x000000003FD5F098 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Nov 1 00:15:50.031476 kernel: ACPI: SPCR 0x000000003FD5FA98 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Nov 1 00:15:50.031482 kernel: ACPI: APIC 0x000000003FD5F818 0000FC (v04 VRTUAL MICROSFT 00000001 MSFT 00000001) Nov 1 00:15:50.031489 kernel: ACPI: SRAT 0x000000003FD5F198 000234 (v03 VRTUAL MICROSFT 00000001 MSFT 00000001) Nov 1 00:15:50.031495 kernel: ACPI: PPTT 0x000000003FD5F418 000120 (v01 VRTUAL MICROSFT 00000000 MSFT 00000000) Nov 1 00:15:50.031500 kernel: ACPI: BGRT 0x000000003FD5FE98 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Nov 1 00:15:50.031506 kernel: ACPI: SPCR: console: pl011,mmio32,0xeffec000,115200 Nov 1 00:15:50.031512 kernel: NUMA: Failed to initialise from firmware Nov 1 00:15:50.031518 kernel: NUMA: Faking a node at [mem 0x0000000000000000-0x00000001bfffffff] Nov 1 00:15:50.031524 kernel: NUMA: NODE_DATA [mem 0x1bf7f3900-0x1bf7f8fff] Nov 1 00:15:50.031529 kernel: Zone ranges: Nov 1 00:15:50.031535 kernel: DMA [mem 0x0000000000000000-0x00000000ffffffff] Nov 1 00:15:50.031540 kernel: DMA32 empty Nov 1 00:15:50.031546 kernel: Normal [mem 0x0000000100000000-0x00000001bfffffff] Nov 1 00:15:50.031553 kernel: Movable zone start for each node Nov 1 00:15:50.031559 kernel: Early memory node ranges Nov 1 00:15:50.031564 kernel: node 0: [mem 0x0000000000000000-0x00000000007fffff] Nov 1 00:15:50.031570 kernel: node 0: [mem 0x0000000000824000-0x000000003e54ffff] Nov 1 00:15:50.031576 kernel: node 0: [mem 0x000000003e550000-0x000000003e87ffff] Nov 1 00:15:50.031581 kernel: node 0: [mem 0x000000003e880000-0x000000003fc7ffff] Nov 1 00:15:50.031587 kernel: node 0: [mem 0x000000003fc80000-0x000000003fcfffff] Nov 1 00:15:50.031592 kernel: node 0: [mem 0x000000003fd00000-0x000000003fffffff] Nov 1 00:15:50.031598 kernel: node 0: [mem 0x0000000100000000-0x00000001bfffffff] Nov 1 00:15:50.031604 kernel: Initmem setup node 0 [mem 0x0000000000000000-0x00000001bfffffff] Nov 1 00:15:50.031609 kernel: On node 0, zone DMA: 36 pages in unavailable ranges Nov 1 00:15:50.031615 kernel: psci: probing for conduit method from ACPI. Nov 1 00:15:50.031624 kernel: psci: PSCIv1.1 detected in firmware. Nov 1 00:15:50.031630 kernel: psci: Using standard PSCI v0.2 function IDs Nov 1 00:15:50.031636 kernel: psci: MIGRATE_INFO_TYPE not supported. Nov 1 00:15:50.031642 kernel: psci: SMC Calling Convention v1.4 Nov 1 00:15:50.031648 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x0 -> Node -1 Nov 1 00:15:50.031655 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x1 -> Node -1 Nov 1 00:15:50.031661 kernel: percpu: Embedded 30 pages/cpu s83032 r8192 d31656 u122880 Nov 1 00:15:50.031667 kernel: pcpu-alloc: s83032 r8192 d31656 u122880 alloc=30*4096 Nov 1 00:15:50.031673 kernel: pcpu-alloc: [0] 0 [0] 1 Nov 1 00:15:50.031679 kernel: Detected PIPT I-cache on CPU0 Nov 1 00:15:50.031685 kernel: CPU features: detected: GIC system register CPU interface Nov 1 00:15:50.031691 kernel: CPU features: detected: Hardware dirty bit management Nov 1 00:15:50.031697 kernel: CPU features: detected: Spectre-BHB Nov 1 00:15:50.031703 kernel: CPU features: kernel page table isolation forced ON by KASLR Nov 1 00:15:50.031709 kernel: CPU features: detected: Kernel page table isolation (KPTI) Nov 1 00:15:50.031715 kernel: CPU features: detected: ARM erratum 1418040 Nov 1 00:15:50.031723 kernel: CPU features: detected: ARM erratum 1542419 (kernel portion) Nov 1 00:15:50.031729 kernel: CPU features: detected: SSBS not fully self-synchronizing Nov 1 00:15:50.031735 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1032156 Nov 1 00:15:50.031741 kernel: Policy zone: Normal Nov 1 00:15:50.031748 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=tty1 console=ttyAMA0,115200n8 earlycon=pl011,0xeffec000 flatcar.first_boot=detected acpi=force flatcar.oem.id=azure flatcar.autologin verity.usrhash=284392058f112e827cd7c521dcce1be27e1367d0030df494642d12e41e342e29 Nov 1 00:15:50.031755 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Nov 1 00:15:50.031761 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Nov 1 00:15:50.031767 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Nov 1 00:15:50.031773 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Nov 1 00:15:50.031779 kernel: software IO TLB: mapped [mem 0x000000003a550000-0x000000003e550000] (64MB) Nov 1 00:15:50.031786 kernel: Memory: 3986880K/4194160K available (9792K kernel code, 2094K rwdata, 7592K rodata, 36416K init, 777K bss, 207280K reserved, 0K cma-reserved) Nov 1 00:15:50.031793 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Nov 1 00:15:50.031799 kernel: trace event string verifier disabled Nov 1 00:15:50.031806 kernel: rcu: Preemptible hierarchical RCU implementation. Nov 1 00:15:50.031812 kernel: rcu: RCU event tracing is enabled. Nov 1 00:15:50.031818 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Nov 1 00:15:50.031825 kernel: Trampoline variant of Tasks RCU enabled. Nov 1 00:15:50.031830 kernel: Tracing variant of Tasks RCU enabled. Nov 1 00:15:50.031837 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Nov 1 00:15:50.031843 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Nov 1 00:15:50.031848 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Nov 1 00:15:50.031854 kernel: GICv3: 960 SPIs implemented Nov 1 00:15:50.031861 kernel: GICv3: 0 Extended SPIs implemented Nov 1 00:15:50.031867 kernel: GICv3: Distributor has no Range Selector support Nov 1 00:15:50.031873 kernel: Root IRQ handler: gic_handle_irq Nov 1 00:15:50.031879 kernel: GICv3: 16 PPIs implemented Nov 1 00:15:50.031885 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000effee000 Nov 1 00:15:50.031891 kernel: ITS: No ITS available, not enabling LPIs Nov 1 00:15:50.031897 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 1 00:15:50.031904 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Nov 1 00:15:50.031910 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Nov 1 00:15:50.031916 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Nov 1 00:15:50.031923 kernel: Console: colour dummy device 80x25 Nov 1 00:15:50.031930 kernel: printk: console [tty1] enabled Nov 1 00:15:50.031937 kernel: ACPI: Core revision 20210730 Nov 1 00:15:50.031943 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Nov 1 00:15:50.031949 kernel: pid_max: default: 32768 minimum: 301 Nov 1 00:15:50.031955 kernel: LSM: Security Framework initializing Nov 1 00:15:50.031961 kernel: SELinux: Initializing. Nov 1 00:15:50.031968 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 1 00:15:50.031974 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 1 00:15:50.031980 kernel: Hyper-V: privilege flags low 0x2e7f, high 0x3a8030, hints 0xe, misc 0x31e1 Nov 1 00:15:50.031988 kernel: Hyper-V: Host Build 10.0.22477.1619-1-0 Nov 1 00:15:50.031994 kernel: rcu: Hierarchical SRCU implementation. Nov 1 00:15:50.032001 kernel: Remapping and enabling EFI services. Nov 1 00:15:50.032007 kernel: smp: Bringing up secondary CPUs ... Nov 1 00:15:50.032013 kernel: Detected PIPT I-cache on CPU1 Nov 1 00:15:50.032019 kernel: GICv3: CPU1: found redistributor 1 region 1:0x00000000f000e000 Nov 1 00:15:50.032026 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 1 00:15:50.032055 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Nov 1 00:15:50.032063 kernel: smp: Brought up 1 node, 2 CPUs Nov 1 00:15:50.032069 kernel: SMP: Total of 2 processors activated. Nov 1 00:15:50.032078 kernel: CPU features: detected: 32-bit EL0 Support Nov 1 00:15:50.032084 kernel: CPU features: detected: Instruction cache invalidation not required for I/D coherence Nov 1 00:15:50.032091 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Nov 1 00:15:50.032097 kernel: CPU features: detected: CRC32 instructions Nov 1 00:15:50.032104 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Nov 1 00:15:50.032110 kernel: CPU features: detected: LSE atomic instructions Nov 1 00:15:50.032117 kernel: CPU features: detected: Privileged Access Never Nov 1 00:15:50.032123 kernel: CPU: All CPU(s) started at EL1 Nov 1 00:15:50.032129 kernel: alternatives: patching kernel code Nov 1 00:15:50.032137 kernel: devtmpfs: initialized Nov 1 00:15:50.032147 kernel: KASLR enabled Nov 1 00:15:50.032154 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Nov 1 00:15:50.032162 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Nov 1 00:15:50.032169 kernel: pinctrl core: initialized pinctrl subsystem Nov 1 00:15:50.032175 kernel: SMBIOS 3.1.0 present. Nov 1 00:15:50.032182 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 09/28/2024 Nov 1 00:15:50.032188 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Nov 1 00:15:50.032195 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Nov 1 00:15:50.032203 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Nov 1 00:15:50.032210 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Nov 1 00:15:50.032216 kernel: audit: initializing netlink subsys (disabled) Nov 1 00:15:50.032223 kernel: audit: type=2000 audit(0.088:1): state=initialized audit_enabled=0 res=1 Nov 1 00:15:50.032229 kernel: thermal_sys: Registered thermal governor 'step_wise' Nov 1 00:15:50.032236 kernel: cpuidle: using governor menu Nov 1 00:15:50.032242 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Nov 1 00:15:50.032251 kernel: ASID allocator initialised with 32768 entries Nov 1 00:15:50.032257 kernel: ACPI: bus type PCI registered Nov 1 00:15:50.032264 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Nov 1 00:15:50.032270 kernel: Serial: AMBA PL011 UART driver Nov 1 00:15:50.032277 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Nov 1 00:15:50.032283 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Nov 1 00:15:50.032290 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Nov 1 00:15:50.032296 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Nov 1 00:15:50.032303 kernel: cryptd: max_cpu_qlen set to 1000 Nov 1 00:15:50.032311 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Nov 1 00:15:50.032318 kernel: ACPI: Added _OSI(Module Device) Nov 1 00:15:50.032324 kernel: ACPI: Added _OSI(Processor Device) Nov 1 00:15:50.032331 kernel: ACPI: Added _OSI(Processor Aggregator Device) Nov 1 00:15:50.032338 kernel: ACPI: Added _OSI(Linux-Dell-Video) Nov 1 00:15:50.032344 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Nov 1 00:15:50.032351 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Nov 1 00:15:50.032358 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Nov 1 00:15:50.032364 kernel: ACPI: Interpreter enabled Nov 1 00:15:50.032372 kernel: ACPI: Using GIC for interrupt routing Nov 1 00:15:50.032379 kernel: ARMH0011:00: ttyAMA0 at MMIO 0xeffec000 (irq = 12, base_baud = 0) is a SBSA Nov 1 00:15:50.032385 kernel: printk: console [ttyAMA0] enabled Nov 1 00:15:50.032392 kernel: printk: bootconsole [pl11] disabled Nov 1 00:15:50.032398 kernel: ARMH0011:01: ttyAMA1 at MMIO 0xeffeb000 (irq = 13, base_baud = 0) is a SBSA Nov 1 00:15:50.032405 kernel: iommu: Default domain type: Translated Nov 1 00:15:50.032411 kernel: iommu: DMA domain TLB invalidation policy: strict mode Nov 1 00:15:50.032418 kernel: vgaarb: loaded Nov 1 00:15:50.032425 kernel: pps_core: LinuxPPS API ver. 1 registered Nov 1 00:15:50.032432 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Nov 1 00:15:50.032439 kernel: PTP clock support registered Nov 1 00:15:50.032446 kernel: Registered efivars operations Nov 1 00:15:50.032453 kernel: No ACPI PMU IRQ for CPU0 Nov 1 00:15:50.032459 kernel: No ACPI PMU IRQ for CPU1 Nov 1 00:15:50.032466 kernel: clocksource: Switched to clocksource arch_sys_counter Nov 1 00:15:50.032472 kernel: VFS: Disk quotas dquot_6.6.0 Nov 1 00:15:50.032479 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Nov 1 00:15:50.032486 kernel: pnp: PnP ACPI init Nov 1 00:15:50.032492 kernel: pnp: PnP ACPI: found 0 devices Nov 1 00:15:50.032500 kernel: NET: Registered PF_INET protocol family Nov 1 00:15:50.032507 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Nov 1 00:15:50.032513 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Nov 1 00:15:50.032520 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Nov 1 00:15:50.032527 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Nov 1 00:15:50.032533 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Nov 1 00:15:50.032540 kernel: TCP: Hash tables configured (established 32768 bind 32768) Nov 1 00:15:50.032546 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 1 00:15:50.032554 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 1 00:15:50.032561 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Nov 1 00:15:50.032568 kernel: PCI: CLS 0 bytes, default 64 Nov 1 00:15:50.032574 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 1 counters available Nov 1 00:15:50.032581 kernel: kvm [1]: HYP mode not available Nov 1 00:15:50.032587 kernel: Initialise system trusted keyrings Nov 1 00:15:50.032594 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Nov 1 00:15:50.032600 kernel: Key type asymmetric registered Nov 1 00:15:50.032607 kernel: Asymmetric key parser 'x509' registered Nov 1 00:15:50.032614 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Nov 1 00:15:50.032621 kernel: io scheduler mq-deadline registered Nov 1 00:15:50.032628 kernel: io scheduler kyber registered Nov 1 00:15:50.032634 kernel: io scheduler bfq registered Nov 1 00:15:50.032641 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Nov 1 00:15:50.032647 kernel: thunder_xcv, ver 1.0 Nov 1 00:15:50.032654 kernel: thunder_bgx, ver 1.0 Nov 1 00:15:50.032660 kernel: nicpf, ver 1.0 Nov 1 00:15:50.032667 kernel: nicvf, ver 1.0 Nov 1 00:15:50.032791 kernel: rtc-efi rtc-efi.0: registered as rtc0 Nov 1 00:15:50.032854 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-11-01T00:15:49 UTC (1761956149) Nov 1 00:15:50.032863 kernel: efifb: probing for efifb Nov 1 00:15:50.032870 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k Nov 1 00:15:50.032877 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 Nov 1 00:15:50.032883 kernel: efifb: scrolling: redraw Nov 1 00:15:50.032890 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Nov 1 00:15:50.032897 kernel: Console: switching to colour frame buffer device 128x48 Nov 1 00:15:50.032905 kernel: fb0: EFI VGA frame buffer device Nov 1 00:15:50.032912 kernel: SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... Nov 1 00:15:50.032919 kernel: hid: raw HID events driver (C) Jiri Kosina Nov 1 00:15:50.032926 kernel: NET: Registered PF_INET6 protocol family Nov 1 00:15:50.032932 kernel: Segment Routing with IPv6 Nov 1 00:15:50.032938 kernel: In-situ OAM (IOAM) with IPv6 Nov 1 00:15:50.032945 kernel: NET: Registered PF_PACKET protocol family Nov 1 00:15:50.032952 kernel: Key type dns_resolver registered Nov 1 00:15:50.032958 kernel: registered taskstats version 1 Nov 1 00:15:50.032965 kernel: Loading compiled-in X.509 certificates Nov 1 00:15:50.032973 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.15.192-flatcar: 4aa5071b9a6f96878595e36d4bd5862a671c915d' Nov 1 00:15:50.032979 kernel: Key type .fscrypt registered Nov 1 00:15:50.032986 kernel: Key type fscrypt-provisioning registered Nov 1 00:15:50.032992 kernel: ima: No TPM chip found, activating TPM-bypass! Nov 1 00:15:50.032999 kernel: ima: Allocated hash algorithm: sha1 Nov 1 00:15:50.033005 kernel: ima: No architecture policies found Nov 1 00:15:50.033012 kernel: clk: Disabling unused clocks Nov 1 00:15:50.033018 kernel: Freeing unused kernel memory: 36416K Nov 1 00:15:50.033026 kernel: Run /init as init process Nov 1 00:15:50.033046 kernel: with arguments: Nov 1 00:15:50.033052 kernel: /init Nov 1 00:15:50.033059 kernel: with environment: Nov 1 00:15:50.033065 kernel: HOME=/ Nov 1 00:15:50.033071 kernel: TERM=linux Nov 1 00:15:50.033077 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Nov 1 00:15:50.033086 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) Nov 1 00:15:50.033100 systemd[1]: Detected virtualization microsoft. Nov 1 00:15:50.033107 systemd[1]: Detected architecture arm64. Nov 1 00:15:50.033115 systemd[1]: Running in initrd. Nov 1 00:15:50.033122 systemd[1]: No hostname configured, using default hostname. Nov 1 00:15:50.033129 systemd[1]: Hostname set to . Nov 1 00:15:50.033137 systemd[1]: Initializing machine ID from random generator. Nov 1 00:15:50.033144 systemd[1]: Queued start job for default target initrd.target. Nov 1 00:15:50.033151 systemd[1]: Started systemd-ask-password-console.path. Nov 1 00:15:50.033160 systemd[1]: Reached target cryptsetup.target. Nov 1 00:15:50.033167 systemd[1]: Reached target paths.target. Nov 1 00:15:50.033174 systemd[1]: Reached target slices.target. Nov 1 00:15:50.033181 systemd[1]: Reached target swap.target. Nov 1 00:15:50.033189 systemd[1]: Reached target timers.target. Nov 1 00:15:50.033197 systemd[1]: Listening on iscsid.socket. Nov 1 00:15:50.033204 systemd[1]: Listening on iscsiuio.socket. Nov 1 00:15:50.033211 systemd[1]: Listening on systemd-journald-audit.socket. Nov 1 00:15:50.033221 systemd[1]: Listening on systemd-journald-dev-log.socket. Nov 1 00:15:50.033228 systemd[1]: Listening on systemd-journald.socket. Nov 1 00:15:50.033236 systemd[1]: Listening on systemd-networkd.socket. Nov 1 00:15:50.033243 systemd[1]: Listening on systemd-udevd-control.socket. Nov 1 00:15:50.033250 systemd[1]: Listening on systemd-udevd-kernel.socket. Nov 1 00:15:50.033257 systemd[1]: Reached target sockets.target. Nov 1 00:15:50.033265 systemd[1]: Starting kmod-static-nodes.service... Nov 1 00:15:50.033272 systemd[1]: Finished network-cleanup.service. Nov 1 00:15:50.033279 systemd[1]: Starting systemd-fsck-usr.service... Nov 1 00:15:50.033287 systemd[1]: Starting systemd-journald.service... Nov 1 00:15:50.033294 systemd[1]: Starting systemd-modules-load.service... Nov 1 00:15:50.033302 systemd[1]: Starting systemd-resolved.service... Nov 1 00:15:50.033309 systemd[1]: Starting systemd-vconsole-setup.service... Nov 1 00:15:50.033320 systemd-journald[276]: Journal started Nov 1 00:15:50.033362 systemd-journald[276]: Runtime Journal (/run/log/journal/d4b0b0d248cb48e393d0be6f47660e04) is 8.0M, max 78.5M, 70.5M free. Nov 1 00:15:50.014095 systemd-modules-load[277]: Inserted module 'overlay' Nov 1 00:15:50.067893 systemd[1]: Started systemd-journald.service. Nov 1 00:15:50.067915 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Nov 1 00:15:50.059265 systemd-resolved[278]: Positive Trust Anchors: Nov 1 00:15:50.059273 systemd-resolved[278]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 1 00:15:50.126346 kernel: Bridge firewalling registered Nov 1 00:15:50.126370 kernel: audit: type=1130 audit(1761956150.090: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' Nov 1 00:15:50.126388 kernel: SCSI subsystem initialized Nov 1 00:15:50.126397 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Nov 1 00:15:50.126406 kernel: device-mapper: uevent: version 1.0.3 Nov 1 00:15:50.090000 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' Nov 1 00:15:50.059300 systemd-resolved[278]: 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 Nov 1 00:15:50.168341 kernel: device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com Nov 1 00:15:50.061396 systemd-resolved[278]: Defaulting to hostname 'linux'. Nov 1 00:15:50.194318 kernel: audit: type=1130 audit(1761956150.173:3): 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' Nov 1 00:15:50.173000 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' Nov 1 00:15:50.079945 systemd-modules-load[277]: Inserted module 'br_netfilter' Nov 1 00:15:50.219601 kernel: audit: type=1130 audit(1761956150.198:4): 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' Nov 1 00:15:50.198000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:15:50.106647 systemd[1]: Started systemd-resolved.service. Nov 1 00:15:50.247118 kernel: audit: type=1130 audit(1761956150.223:5): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:15:50.223000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:15:50.173478 systemd[1]: Finished kmod-static-nodes.service. Nov 1 00:15:50.199367 systemd[1]: Finished systemd-fsck-usr.service. Nov 1 00:15:50.247000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:15:50.223289 systemd-modules-load[277]: Inserted module 'dm_multipath' Nov 1 00:15:50.224151 systemd[1]: Finished systemd-vconsole-setup.service. Nov 1 00:15:50.310065 kernel: audit: type=1130 audit(1761956150.247:6): 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' Nov 1 00:15:50.310093 kernel: audit: type=1130 audit(1761956150.272:7): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:15:50.272000 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' Nov 1 00:15:50.247821 systemd[1]: Finished systemd-modules-load.service. Nov 1 00:15:50.272857 systemd[1]: Reached target nss-lookup.target. Nov 1 00:15:50.281941 systemd[1]: Starting dracut-cmdline-ask.service... Nov 1 00:15:50.309455 systemd[1]: Starting systemd-sysctl.service... Nov 1 00:15:50.324886 systemd[1]: Starting systemd-tmpfiles-setup-dev.service... Nov 1 00:15:50.334177 systemd[1]: Finished systemd-sysctl.service. Nov 1 00:15:50.374017 kernel: audit: type=1130 audit(1761956150.349:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:15:50.349000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:15:50.349573 systemd[1]: Finished systemd-tmpfiles-setup-dev.service. Nov 1 00:15:50.374000 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' Nov 1 00:15:50.398314 systemd[1]: Finished dracut-cmdline-ask.service. Nov 1 00:15:50.428339 kernel: audit: type=1130 audit(1761956150.374:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:15:50.428362 kernel: audit: type=1130 audit(1761956150.402:10): 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' Nov 1 00:15:50.402000 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' Nov 1 00:15:50.403732 systemd[1]: Starting dracut-cmdline.service... Nov 1 00:15:50.437018 dracut-cmdline[299]: dracut-dracut-053 Nov 1 00:15:50.442434 dracut-cmdline[299]: 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=tty1 console=ttyAMA0,115200n8 earlycon=pl011,0xeffec000 flatcar.first_boot=detected acpi=force flatcar.oem.id=azure flatcar.autologin verity.usrhash=284392058f112e827cd7c521dcce1be27e1367d0030df494642d12e41e342e29 Nov 1 00:15:50.533058 kernel: Loading iSCSI transport class v2.0-870. Nov 1 00:15:50.550070 kernel: iscsi: registered transport (tcp) Nov 1 00:15:50.571275 kernel: iscsi: registered transport (qla4xxx) Nov 1 00:15:50.571348 kernel: QLogic iSCSI HBA Driver Nov 1 00:15:50.607898 systemd[1]: Finished dracut-cmdline.service. Nov 1 00:15:50.612000 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' Nov 1 00:15:50.613339 systemd[1]: Starting dracut-pre-udev.service... Nov 1 00:15:50.667056 kernel: raid6: neonx8 gen() 13822 MB/s Nov 1 00:15:50.688057 kernel: raid6: neonx8 xor() 10819 MB/s Nov 1 00:15:50.708060 kernel: raid6: neonx4 gen() 13541 MB/s Nov 1 00:15:50.730050 kernel: raid6: neonx4 xor() 11058 MB/s Nov 1 00:15:50.750044 kernel: raid6: neonx2 gen() 12956 MB/s Nov 1 00:15:50.770058 kernel: raid6: neonx2 xor() 10250 MB/s Nov 1 00:15:50.791052 kernel: raid6: neonx1 gen() 10565 MB/s Nov 1 00:15:50.812072 kernel: raid6: neonx1 xor() 8782 MB/s Nov 1 00:15:50.832062 kernel: raid6: int64x8 gen() 6269 MB/s Nov 1 00:15:50.853050 kernel: raid6: int64x8 xor() 3544 MB/s Nov 1 00:15:50.873048 kernel: raid6: int64x4 gen() 7212 MB/s Nov 1 00:15:50.893044 kernel: raid6: int64x4 xor() 3858 MB/s Nov 1 00:15:50.914084 kernel: raid6: int64x2 gen() 6155 MB/s Nov 1 00:15:50.935056 kernel: raid6: int64x2 xor() 3321 MB/s Nov 1 00:15:50.955067 kernel: raid6: int64x1 gen() 5047 MB/s Nov 1 00:15:50.980708 kernel: raid6: int64x1 xor() 2646 MB/s Nov 1 00:15:50.980756 kernel: raid6: using algorithm neonx8 gen() 13822 MB/s Nov 1 00:15:50.980765 kernel: raid6: .... xor() 10819 MB/s, rmw enabled Nov 1 00:15:50.984862 kernel: raid6: using neon recovery algorithm Nov 1 00:15:51.005506 kernel: xor: measuring software checksum speed Nov 1 00:15:51.005521 kernel: 8regs : 17188 MB/sec Nov 1 00:15:51.009341 kernel: 32regs : 20665 MB/sec Nov 1 00:15:51.013295 kernel: arm64_neon : 27598 MB/sec Nov 1 00:15:51.013305 kernel: xor: using function: arm64_neon (27598 MB/sec) Nov 1 00:15:51.074051 kernel: Btrfs loaded, crc32c=crc32c-generic, zoned=no, fsverity=no Nov 1 00:15:51.085976 systemd[1]: Finished dracut-pre-udev.service. Nov 1 00:15:51.090000 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' Nov 1 00:15:51.094000 audit: BPF prog-id=7 op=LOAD Nov 1 00:15:51.094000 audit: BPF prog-id=8 op=LOAD Nov 1 00:15:51.094991 systemd[1]: Starting systemd-udevd.service... Nov 1 00:15:51.109580 systemd-udevd[475]: Using default interface naming scheme 'v252'. Nov 1 00:15:51.115410 systemd[1]: Started systemd-udevd.service. Nov 1 00:15:51.121000 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' Nov 1 00:15:51.126259 systemd[1]: Starting dracut-pre-trigger.service... Nov 1 00:15:51.143540 dracut-pre-trigger[496]: rd.md=0: removing MD RAID activation Nov 1 00:15:51.169754 systemd[1]: Finished dracut-pre-trigger.service. Nov 1 00:15:51.174000 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' Nov 1 00:15:51.175462 systemd[1]: Starting systemd-udev-trigger.service... Nov 1 00:15:51.213660 systemd[1]: Finished systemd-udev-trigger.service. Nov 1 00:15:51.220000 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' Nov 1 00:15:51.271096 kernel: hv_vmbus: Vmbus version:5.3 Nov 1 00:15:51.280065 kernel: hv_vmbus: registering driver hyperv_keyboard Nov 1 00:15:51.292066 kernel: hv_vmbus: registering driver hid_hyperv Nov 1 00:15:51.292109 kernel: hv_vmbus: registering driver hv_storvsc Nov 1 00:15:51.298743 kernel: hv_vmbus: registering driver hv_netvsc Nov 1 00:15:51.299053 kernel: input: AT Translated Set 2 keyboard as /devices/LNXSYSTM:00/LNXSYBUS:00/ACPI0004:00/MSFT1000:00/d34b2567-b9b6-42b9-8778-0a4ec0b955bf/serio0/input/input0 Nov 1 00:15:51.300128 kernel: scsi host1: storvsc_host_t Nov 1 00:15:51.300648 kernel: scsi host0: storvsc_host_t Nov 1 00:15:51.300748 kernel: scsi 0:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 Nov 1 00:15:51.300771 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input1 Nov 1 00:15:51.300780 kernel: hid-generic 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on Nov 1 00:15:51.301045 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 0 Nov 1 00:15:51.334063 kernel: sr 0:0:0:2: [sr0] scsi-1 drive Nov 1 00:15:51.337947 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Nov 1 00:15:51.337961 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0 Nov 1 00:15:51.395478 kernel: sd 0:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB) Nov 1 00:15:51.426620 kernel: hv_netvsc 000d3a07-7eb4-000d-3a07-7eb4000d3a07 eth0: VF slot 1 added Nov 1 00:15:51.426748 kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks Nov 1 00:15:51.426843 kernel: sd 0:0:0:0: [sda] Write Protect is off Nov 1 00:15:51.426933 kernel: sd 0:0:0:0: [sda] Mode Sense: 0f 00 10 00 Nov 1 00:15:51.427018 kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA Nov 1 00:15:51.427122 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Nov 1 00:15:51.427132 kernel: sd 0:0:0:0: [sda] Attached SCSI disk Nov 1 00:15:51.435059 kernel: hv_vmbus: registering driver hv_pci Nov 1 00:15:51.445078 kernel: hv_pci 234983be-84c5-4d8d-a206-72e40753ecce: PCI VMBus probing: Using version 0x10004 Nov 1 00:15:51.531068 kernel: hv_pci 234983be-84c5-4d8d-a206-72e40753ecce: PCI host bridge to bus 84c5:00 Nov 1 00:15:51.531180 kernel: pci_bus 84c5:00: root bus resource [mem 0xfc0000000-0xfc00fffff window] Nov 1 00:15:51.531284 kernel: pci_bus 84c5:00: No busn resource found for root bus, will use [bus 00-ff] Nov 1 00:15:51.531355 kernel: pci 84c5:00:02.0: [15b3:1018] type 00 class 0x020000 Nov 1 00:15:51.531442 kernel: pci 84c5:00:02.0: reg 0x10: [mem 0xfc0000000-0xfc00fffff 64bit pref] Nov 1 00:15:51.531518 kernel: pci 84c5:00:02.0: enabling Extended Tags Nov 1 00:15:51.531591 kernel: pci 84c5:00:02.0: 0.000 Gb/s available PCIe bandwidth, limited by Unknown x0 link at 84c5:00:02.0 (capable of 126.016 Gb/s with 8.0 GT/s PCIe x16 link) Nov 1 00:15:51.531664 kernel: pci_bus 84c5:00: busn_res: [bus 00-ff] end is updated to 00 Nov 1 00:15:51.531735 kernel: pci 84c5:00:02.0: BAR 0: assigned [mem 0xfc0000000-0xfc00fffff 64bit pref] Nov 1 00:15:51.569119 kernel: mlx5_core 84c5:00:02.0: enabling device (0000 -> 0002) Nov 1 00:15:51.795405 kernel: mlx5_core 84c5:00:02.0: firmware version: 16.30.1284 Nov 1 00:15:51.795553 kernel: mlx5_core 84c5:00:02.0: MLX5E: StrdRq(1) RqSz(8) StrdSz(2048) RxCqeCmprss(0) Nov 1 00:15:51.795639 kernel: hv_netvsc 000d3a07-7eb4-000d-3a07-7eb4000d3a07 eth0: VF registering: eth1 Nov 1 00:15:51.795723 kernel: mlx5_core 84c5:00:02.0 eth1: joined to eth0 Nov 1 00:15:51.804055 kernel: mlx5_core 84c5:00:02.0 enP33989s1: renamed from eth1 Nov 1 00:15:51.905060 kernel: BTRFS: device label OEM devid 1 transid 9 /dev/sda6 scanned by (udev-worker) (531) Nov 1 00:15:51.915271 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device. Nov 1 00:15:51.931350 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. Nov 1 00:15:52.188703 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device. Nov 1 00:15:52.376948 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device. Nov 1 00:15:52.384006 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device. Nov 1 00:15:52.400513 systemd[1]: Starting disk-uuid.service... Nov 1 00:15:52.432064 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Nov 1 00:15:53.457970 disk-uuid[605]: The operation has completed successfully. Nov 1 00:15:53.463950 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Nov 1 00:15:53.525134 systemd[1]: disk-uuid.service: Deactivated successfully. Nov 1 00:15:53.526170 systemd[1]: Finished disk-uuid.service. Nov 1 00:15:53.535000 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' Nov 1 00:15:53.535000 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' Nov 1 00:15:53.540529 systemd[1]: Starting verity-setup.service... Nov 1 00:15:53.585062 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Nov 1 00:15:54.009142 systemd[1]: Found device dev-mapper-usr.device. Nov 1 00:15:54.014471 systemd[1]: Finished verity-setup.service. Nov 1 00:15:54.023000 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' Nov 1 00:15:54.024554 systemd[1]: Mounting sysusr-usr.mount... Nov 1 00:15:54.058487 kernel: kauditd_printk_skb: 9 callbacks suppressed Nov 1 00:15:54.058514 kernel: audit: type=1130 audit(1761956154.023:20): 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' Nov 1 00:15:54.113067 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: norecovery. Quota mode: none. Nov 1 00:15:54.113281 systemd[1]: Mounted sysusr-usr.mount. Nov 1 00:15:54.117398 systemd[1]: afterburn-network-kargs.service was skipped because no trigger condition checks were met. Nov 1 00:15:54.118215 systemd[1]: Starting ignition-setup.service... Nov 1 00:15:54.125570 systemd[1]: Starting parse-ip-for-networkd.service... Nov 1 00:15:54.172685 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Nov 1 00:15:54.172758 kernel: BTRFS info (device sda6): using free space tree Nov 1 00:15:54.178228 kernel: BTRFS info (device sda6): has skinny extents Nov 1 00:15:54.219841 systemd[1]: Finished parse-ip-for-networkd.service. Nov 1 00:15:54.225000 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' Nov 1 00:15:54.256911 kernel: audit: type=1130 audit(1761956154.225:21): 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' Nov 1 00:15:54.256976 kernel: audit: type=1334 audit(1761956154.250:22): prog-id=9 op=LOAD Nov 1 00:15:54.250000 audit: BPF prog-id=9 op=LOAD Nov 1 00:15:54.257243 systemd[1]: Starting systemd-networkd.service... Nov 1 00:15:54.286458 systemd-networkd[869]: lo: Link UP Nov 1 00:15:54.286469 systemd-networkd[869]: lo: Gained carrier Nov 1 00:15:54.321804 kernel: audit: type=1130 audit(1761956154.295:23): 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' Nov 1 00:15:54.295000 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' Nov 1 00:15:54.286926 systemd-networkd[869]: Enumeration completed Nov 1 00:15:54.287635 systemd-networkd[869]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Nov 1 00:15:54.290758 systemd[1]: Started systemd-networkd.service. Nov 1 00:15:54.296243 systemd[1]: Reached target network.target. Nov 1 00:15:54.374450 kernel: audit: type=1130 audit(1761956154.346:24): 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' Nov 1 00:15:54.346000 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' Nov 1 00:15:54.322779 systemd[1]: Starting iscsiuio.service... Nov 1 00:15:54.374000 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' Nov 1 00:15:54.394624 iscsid[876]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Nov 1 00:15:54.394624 iscsid[876]: 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 Nov 1 00:15:54.394624 iscsid[876]: into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier]. Nov 1 00:15:54.394624 iscsid[876]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Nov 1 00:15:54.394624 iscsid[876]: If using hardware iscsi like qla4xxx this message can be ignored. Nov 1 00:15:54.394624 iscsid[876]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Nov 1 00:15:54.394624 iscsid[876]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Nov 1 00:15:54.545752 kernel: audit: type=1130 audit(1761956154.374:25): 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' Nov 1 00:15:54.545778 kernel: mlx5_core 84c5:00:02.0 enP33989s1: Link up Nov 1 00:15:54.545925 kernel: buffer_size[0]=0 is not enough for lossless buffer Nov 1 00:15:54.545935 kernel: hv_netvsc 000d3a07-7eb4-000d-3a07-7eb4000d3a07 eth0: Data path switched to VF: enP33989s1 Nov 1 00:15:54.546020 kernel: audit: type=1130 audit(1761956154.458:26): 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' Nov 1 00:15:54.546055 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Nov 1 00:15:54.458000 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' Nov 1 00:15:54.338458 systemd[1]: Started iscsiuio.service. Nov 1 00:15:54.347858 systemd[1]: Starting iscsid.service... Nov 1 00:15:54.560000 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' Nov 1 00:15:54.370676 systemd[1]: Started iscsid.service. Nov 1 00:15:54.587613 kernel: audit: type=1130 audit(1761956154.560:27): 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' Nov 1 00:15:54.394964 systemd[1]: Starting dracut-initqueue.service... Nov 1 00:15:54.424138 systemd[1]: Finished dracut-initqueue.service. Nov 1 00:15:54.489198 systemd[1]: Reached target remote-fs-pre.target. Nov 1 00:15:54.489954 systemd-networkd[869]: enP33989s1: Link UP Nov 1 00:15:54.490059 systemd-networkd[869]: eth0: Link UP Nov 1 00:15:54.491001 systemd-networkd[869]: eth0: Gained carrier Nov 1 00:15:54.502373 systemd[1]: Reached target remote-cryptsetup.target. Nov 1 00:15:54.508484 systemd[1]: Reached target remote-fs.target. Nov 1 00:15:54.510303 systemd-networkd[869]: enP33989s1: Gained carrier Nov 1 00:15:54.536134 systemd[1]: Starting dracut-pre-mount.service... Nov 1 00:15:54.540448 systemd-networkd[869]: eth0: DHCPv4 address 10.200.20.39/24, gateway 10.200.20.1 acquired from 168.63.129.16 Nov 1 00:15:54.551827 systemd[1]: mnt-oem.mount: Deactivated successfully. Nov 1 00:15:54.554087 systemd[1]: Finished dracut-pre-mount.service. Nov 1 00:15:55.006345 systemd[1]: Finished ignition-setup.service. Nov 1 00:15:55.011803 systemd[1]: Starting ignition-fetch-offline.service... Nov 1 00:15:55.038776 kernel: audit: type=1130 audit(1761956155.010:28): 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' Nov 1 00:15:55.010000 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' Nov 1 00:15:55.594178 systemd-networkd[869]: eth0: Gained IPv6LL Nov 1 00:15:58.999734 ignition[896]: Ignition 2.14.0 Nov 1 00:15:58.999746 ignition[896]: Stage: fetch-offline Nov 1 00:15:58.999801 ignition[896]: reading system config file "/usr/lib/ignition/base.d/base.ign" Nov 1 00:15:58.999823 ignition[896]: parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63 Nov 1 00:15:59.128686 ignition[896]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Nov 1 00:15:59.128886 ignition[896]: parsed url from cmdline: "" Nov 1 00:15:59.135839 systemd[1]: Finished ignition-fetch-offline.service. Nov 1 00:15:59.141000 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' Nov 1 00:15:59.128891 ignition[896]: no config URL provided Nov 1 00:15:59.142327 systemd[1]: Starting ignition-fetch.service... Nov 1 00:15:59.175806 kernel: audit: type=1130 audit(1761956159.141:29): 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' Nov 1 00:15:59.128896 ignition[896]: reading system config file "/usr/lib/ignition/user.ign" Nov 1 00:15:59.128905 ignition[896]: no config at "/usr/lib/ignition/user.ign" Nov 1 00:15:59.128910 ignition[896]: failed to fetch config: resource requires networking Nov 1 00:15:59.129173 ignition[896]: Ignition finished successfully Nov 1 00:15:59.162226 ignition[902]: Ignition 2.14.0 Nov 1 00:15:59.162232 ignition[902]: Stage: fetch Nov 1 00:15:59.162343 ignition[902]: reading system config file "/usr/lib/ignition/base.d/base.ign" Nov 1 00:15:59.162364 ignition[902]: parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63 Nov 1 00:15:59.169250 ignition[902]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Nov 1 00:15:59.169436 ignition[902]: parsed url from cmdline: "" Nov 1 00:15:59.169440 ignition[902]: no config URL provided Nov 1 00:15:59.169451 ignition[902]: reading system config file "/usr/lib/ignition/user.ign" Nov 1 00:15:59.169460 ignition[902]: no config at "/usr/lib/ignition/user.ign" Nov 1 00:15:59.169493 ignition[902]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 Nov 1 00:15:59.267899 ignition[902]: GET result: OK Nov 1 00:15:59.267952 ignition[902]: config has been read from IMDS userdata Nov 1 00:15:59.271386 unknown[902]: fetched base config from "system" Nov 1 00:15:59.267974 ignition[902]: parsing config with SHA512: eeebb20abf4df968c1b7c58706216ea1a453091b9a617369913a6278bc7ffbb92b3813ef9552a6e6471efc9ccd83aaf0e713771a7f92939320dcae86e31128b5 Nov 1 00:15:59.271395 unknown[902]: fetched base config from "system" Nov 1 00:15:59.285000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:15:59.271767 ignition[902]: fetch: fetch complete Nov 1 00:15:59.310603 kernel: audit: type=1130 audit(1761956159.285:30): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:15:59.271403 unknown[902]: fetched user config from "azure" Nov 1 00:15:59.271772 ignition[902]: fetch: fetch passed Nov 1 00:15:59.277321 systemd[1]: Finished ignition-fetch.service. Nov 1 00:15:59.271820 ignition[902]: Ignition finished successfully Nov 1 00:15:59.338000 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' Nov 1 00:15:59.306843 systemd[1]: Starting ignition-kargs.service... Nov 1 00:15:59.360505 kernel: audit: type=1130 audit(1761956159.338:31): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-kargs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:15:59.321902 ignition[908]: Ignition 2.14.0 Nov 1 00:15:59.330490 systemd[1]: Finished ignition-kargs.service. Nov 1 00:15:59.321908 ignition[908]: Stage: kargs Nov 1 00:15:59.359293 systemd[1]: Starting ignition-disks.service... Nov 1 00:15:59.322046 ignition[908]: reading system config file "/usr/lib/ignition/base.d/base.ign" Nov 1 00:15:59.322072 ignition[908]: parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63 Nov 1 00:15:59.325386 ignition[908]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Nov 1 00:15:59.327949 ignition[908]: kargs: kargs passed Nov 1 00:15:59.328000 ignition[908]: Ignition finished successfully Nov 1 00:15:59.371644 ignition[914]: Ignition 2.14.0 Nov 1 00:15:59.371650 ignition[914]: Stage: disks Nov 1 00:15:59.371752 ignition[914]: reading system config file "/usr/lib/ignition/base.d/base.ign" Nov 1 00:15:59.371770 ignition[914]: parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63 Nov 1 00:15:59.375723 ignition[914]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Nov 1 00:15:59.377876 ignition[914]: disks: createFilesystems: op(1): [started] waiting for devices [/dev/disk/by-partlabel/ROOT] Nov 1 00:15:59.383131 ignition[914]: disks: createFilesystems: op(1): [finished] waiting for devices [/dev/disk/by-partlabel/ROOT] Nov 1 00:15:59.383200 ignition[914]: disks: createFilesystems: created device alias for "/dev/disk/by-partlabel/ROOT": "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" -> "/dev/sda9" Nov 1 00:15:59.383307 ignition[914]: disks: createFilesystems: op(2): [started] determining filesystem type of "/dev/disk/by-partlabel/ROOT" Nov 1 00:15:59.462360 ignition[914]: disks: createFilesystems: op(2): [finished] determining filesystem type of "/dev/disk/by-partlabel/ROOT" Nov 1 00:15:59.462379 ignition[914]: disks: createFilesystems: found ext4 filesystem at "/dev/disk/by-partlabel/ROOT" with uuid "445e3239-ef99-4225-bd1f-da28b8b5d88b" and label "ROOT" Nov 1 00:15:59.473321 systemd[1]: Finished ignition-disks.service. Nov 1 00:15:59.488000 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' Nov 1 00:15:59.462384 ignition[914]: disks: createFilesystems: filesystem at "/dev/disk/by-partlabel/ROOT" is already correctly formatted. Skipping mkfs... Nov 1 00:15:59.462401 ignition[914]: disks: disks passed Nov 1 00:15:59.510528 systemd[1]: Reached target initrd-root-device.target. Nov 1 00:15:59.537831 kernel: audit: type=1130 audit(1761956159.488:32): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-disks comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:15:59.462503 ignition[914]: Ignition finished successfully Nov 1 00:15:59.524636 systemd[1]: Reached target local-fs-pre.target. Nov 1 00:15:59.533216 systemd[1]: Reached target local-fs.target. Nov 1 00:15:59.542096 systemd[1]: Reached target sysinit.target. Nov 1 00:15:59.550234 systemd[1]: Reached target basic.target. Nov 1 00:15:59.562430 systemd[1]: Starting systemd-fsck-root.service... Nov 1 00:15:59.638225 systemd-fsck[923]: ROOT: clean, 637/7326000 files, 481087/7359488 blocks Nov 1 00:15:59.646672 systemd[1]: Finished systemd-fsck-root.service. Nov 1 00:15:59.674988 kernel: audit: type=1130 audit(1761956159.651:33): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:15:59.651000 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' Nov 1 00:15:59.653013 systemd[1]: Mounting sysroot.mount... Nov 1 00:15:59.694093 kernel: EXT4-fs (sda9): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none. Nov 1 00:15:59.692554 systemd[1]: Mounted sysroot.mount. Nov 1 00:15:59.696418 systemd[1]: Reached target initrd-root-fs.target. Nov 1 00:15:59.740129 systemd[1]: Mounting sysroot-usr.mount... Nov 1 00:15:59.744928 systemd[1]: Starting flatcar-metadata-hostname.service... Nov 1 00:15:59.758171 systemd[1]: ignition-remount-sysroot.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Nov 1 00:15:59.758221 systemd[1]: Reached target ignition-diskful.target. Nov 1 00:15:59.774074 systemd[1]: Mounted sysroot-usr.mount. Nov 1 00:15:59.836648 systemd[1]: Mounting sysroot-usr-share-oem.mount... Nov 1 00:15:59.842531 systemd[1]: Starting initrd-setup-root.service... Nov 1 00:15:59.866061 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 scanned by mount (934) Nov 1 00:15:59.880736 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Nov 1 00:15:59.880795 kernel: BTRFS info (device sda6): using free space tree Nov 1 00:15:59.886079 kernel: BTRFS info (device sda6): has skinny extents Nov 1 00:15:59.886314 initrd-setup-root[939]: cut: /sysroot/etc/passwd: No such file or directory Nov 1 00:15:59.900957 systemd[1]: Mounted sysroot-usr-share-oem.mount. Nov 1 00:15:59.941238 initrd-setup-root[965]: cut: /sysroot/etc/group: No such file or directory Nov 1 00:15:59.969857 initrd-setup-root[973]: cut: /sysroot/etc/shadow: No such file or directory Nov 1 00:15:59.997754 initrd-setup-root[981]: cut: /sysroot/etc/gshadow: No such file or directory Nov 1 00:16:00.815351 systemd[1]: Finished initrd-setup-root.service. Nov 1 00:16:00.820000 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' Nov 1 00:16:00.821382 systemd[1]: Starting ignition-mount.service... Nov 1 00:16:00.848446 kernel: audit: type=1130 audit(1761956160.820:34): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:16:00.849211 systemd[1]: Starting sysroot-boot.service... Nov 1 00:16:00.854143 systemd[1]: sysusr-usr-share-oem.mount: Deactivated successfully. Nov 1 00:16:00.854251 systemd[1]: sysroot-usr-share-oem.mount: Deactivated successfully. Nov 1 00:16:00.891437 ignition[1003]: INFO : Ignition 2.14.0 Nov 1 00:16:00.891437 ignition[1003]: INFO : Stage: mount Nov 1 00:16:00.906000 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' Nov 1 00:16:00.901589 systemd[1]: Finished sysroot-boot.service. Nov 1 00:16:00.927839 kernel: audit: type=1130 audit(1761956160.906:35): 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' Nov 1 00:16:00.927862 ignition[1003]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" Nov 1 00:16:00.927862 ignition[1003]: DEBUG : parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63 Nov 1 00:16:00.927862 ignition[1003]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Nov 1 00:16:00.954642 ignition[1003]: INFO : mount: op(1): [started] mounting "/dev/disk/by-partlabel/ROOT" at "/sysroot/tmp/_translate-filesystem-0-ign1" with type "ext4" and options "" Nov 1 00:16:00.954642 ignition[1003]: DEBUG : mount: op(1): executing: "mount" "-o" "" "-t" "ext4" "/dev/disk/by-partlabel/ROOT" "/sysroot/tmp/_translate-filesystem-0-ign1" Nov 1 00:16:01.405204 coreos-metadata[933]: Nov 01 00:16:01.405 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Nov 1 00:16:01.413812 coreos-metadata[933]: Nov 01 00:16:01.413 INFO Fetch successful Nov 1 00:16:01.443544 coreos-metadata[933]: Nov 01 00:16:01.443 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 Nov 1 00:16:01.455773 coreos-metadata[933]: Nov 01 00:16:01.455 INFO Fetch successful Nov 1 00:16:01.472495 coreos-metadata[933]: Nov 01 00:16:01.472 INFO wrote hostname ci-3510.3.8-n-26178e8619 to /sysroot/etc/hostname Nov 1 00:16:01.481946 systemd[1]: Finished flatcar-metadata-hostname.service. Nov 1 00:16:01.487000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=flatcar-metadata-hostname comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:16:01.511058 kernel: audit: type=1130 audit(1761956161.487:36): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=flatcar-metadata-hostname comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:16:01.916630 ignition[1003]: INFO : mount: op(1): [finished] mounting "/dev/disk/by-partlabel/ROOT" at "/sysroot/tmp/_translate-filesystem-0-ign1" with type "ext4" and options "" Nov 1 00:16:01.916630 ignition[1003]: INFO : mount: mount passed Nov 1 00:16:01.933000 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' Nov 1 00:16:01.954080 ignition[1003]: INFO : Ignition finished successfully Nov 1 00:16:01.962078 kernel: audit: type=1130 audit(1761956161.933:37): 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' Nov 1 00:16:01.928968 systemd[1]: Finished ignition-mount.service. Nov 1 00:16:01.955030 systemd[1]: Starting ignition-files.service... Nov 1 00:16:01.969281 systemd[1]: Mounting sysroot-usr-share-oem.mount... Nov 1 00:16:01.993083 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/sda6 scanned by mount (1014) Nov 1 00:16:02.006427 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Nov 1 00:16:02.006485 kernel: BTRFS info (device sda6): using free space tree Nov 1 00:16:02.006505 kernel: BTRFS info (device sda6): has skinny extents Nov 1 00:16:02.020126 systemd[1]: Mounted sysroot-usr-share-oem.mount. Nov 1 00:16:02.034094 ignition[1033]: INFO : Ignition 2.14.0 Nov 1 00:16:02.034094 ignition[1033]: INFO : Stage: files Nov 1 00:16:02.045674 ignition[1033]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" Nov 1 00:16:02.045674 ignition[1033]: DEBUG : parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63 Nov 1 00:16:02.045674 ignition[1033]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Nov 1 00:16:02.045674 ignition[1033]: DEBUG : files: compiled without relabeling support, skipping Nov 1 00:16:02.254230 ignition[1033]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Nov 1 00:16:02.254230 ignition[1033]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Nov 1 00:16:02.367651 ignition[1033]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Nov 1 00:16:02.375696 ignition[1033]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Nov 1 00:16:02.388402 unknown[1033]: wrote ssh authorized keys file for user: core Nov 1 00:16:02.394938 ignition[1033]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Nov 1 00:16:02.435650 ignition[1033]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/systemd/system/waagent.service" Nov 1 00:16:02.447717 ignition[1033]: INFO : files: createFilesystemsFiles: createFiles: op(3): oem config not found in "/usr/share/oem", looking on oem partition Nov 1 00:16:02.447717 ignition[1033]: INFO : files: createFilesystemsFiles: createFiles: op(3): op(4): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1394979134" Nov 1 00:16:02.447717 ignition[1033]: CRITICAL : files: createFilesystemsFiles: createFiles: op(3): op(4): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1394979134": device or resource busy Nov 1 00:16:02.447717 ignition[1033]: ERROR : files: createFilesystemsFiles: createFiles: op(3): failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem1394979134", trying btrfs: device or resource busy Nov 1 00:16:02.447717 ignition[1033]: INFO : files: createFilesystemsFiles: createFiles: op(3): op(5): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1394979134" Nov 1 00:16:02.447717 ignition[1033]: INFO : files: createFilesystemsFiles: createFiles: op(3): op(5): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1394979134" Nov 1 00:16:02.523865 ignition[1033]: INFO : files: createFilesystemsFiles: createFiles: op(3): op(6): [started] unmounting "/mnt/oem1394979134" Nov 1 00:16:02.523865 ignition[1033]: INFO : files: createFilesystemsFiles: createFiles: op(3): op(6): [finished] unmounting "/mnt/oem1394979134" Nov 1 00:16:02.523865 ignition[1033]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/systemd/system/waagent.service" Nov 1 00:16:02.523865 ignition[1033]: INFO : files: createFilesystemsFiles: createFiles: op(7): [started] writing file "/sysroot/etc/systemd/system/nvidia.service" Nov 1 00:16:02.523865 ignition[1033]: INFO : files: createFilesystemsFiles: createFiles: op(7): oem config not found in "/usr/share/oem", looking on oem partition Nov 1 00:16:02.523865 ignition[1033]: INFO : files: createFilesystemsFiles: createFiles: op(7): op(8): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem360628213" Nov 1 00:16:02.523865 ignition[1033]: CRITICAL : files: createFilesystemsFiles: createFiles: op(7): op(8): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem360628213": device or resource busy Nov 1 00:16:02.523865 ignition[1033]: ERROR : files: createFilesystemsFiles: createFiles: op(7): failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem360628213", trying btrfs: device or resource busy Nov 1 00:16:02.523865 ignition[1033]: INFO : files: createFilesystemsFiles: createFiles: op(7): op(9): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem360628213" Nov 1 00:16:02.523865 ignition[1033]: INFO : files: createFilesystemsFiles: createFiles: op(7): op(9): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem360628213" Nov 1 00:16:02.523865 ignition[1033]: INFO : files: createFilesystemsFiles: createFiles: op(7): op(a): [started] unmounting "/mnt/oem360628213" Nov 1 00:16:02.523865 ignition[1033]: INFO : files: createFilesystemsFiles: createFiles: op(7): op(a): [finished] unmounting "/mnt/oem360628213" Nov 1 00:16:02.523865 ignition[1033]: INFO : files: createFilesystemsFiles: createFiles: op(7): [finished] writing file "/sysroot/etc/systemd/system/nvidia.service" Nov 1 00:16:02.523865 ignition[1033]: INFO : files: createFilesystemsFiles: createFiles: op(b): [started] writing file "/sysroot/tmp/_translate-filesystem-0-ign1/etc/flatcar/update.conf" Nov 1 00:16:02.523865 ignition[1033]: INFO : files: createFilesystemsFiles: createFiles: op(b): [finished] writing file "/sysroot/tmp/_translate-filesystem-0-ign1/etc/flatcar/update.conf" Nov 1 00:16:02.774937 kernel: audit: type=1130 audit(1761956162.528:38): 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' Nov 1 00:16:02.528000 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' Nov 1 00:16:02.604000 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' Nov 1 00:16:02.604000 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' Nov 1 00:16:02.623000 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' Nov 1 00:16:02.705000 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' Nov 1 00:16:02.705000 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' Nov 1 00:16:02.461326 systemd[1]: mnt-oem1394979134.mount: Deactivated successfully. Nov 1 00:16:02.781809 ignition[1033]: INFO : files: op(c): [started] processing unit "waagent.service" Nov 1 00:16:02.781809 ignition[1033]: INFO : files: op(c): [finished] processing unit "waagent.service" Nov 1 00:16:02.781809 ignition[1033]: INFO : files: op(d): [started] processing unit "nvidia.service" Nov 1 00:16:02.781809 ignition[1033]: INFO : files: op(d): [finished] processing unit "nvidia.service" Nov 1 00:16:02.781809 ignition[1033]: INFO : files: op(e): [started] processing unit "coreos-metadata.service" Nov 1 00:16:02.781809 ignition[1033]: INFO : files: op(e): [finished] processing unit "coreos-metadata.service" Nov 1 00:16:02.781809 ignition[1033]: INFO : files: op(f): [started] processing unit "metadata.target" Nov 1 00:16:02.781809 ignition[1033]: INFO : files: op(f): op(10): [started] writing unit "metadata.target" at "/sysroot/etc/systemd/system/metadata.target" Nov 1 00:16:02.781809 ignition[1033]: INFO : files: op(f): op(10): [finished] writing unit "metadata.target" at "/sysroot/etc/systemd/system/metadata.target" Nov 1 00:16:02.781809 ignition[1033]: INFO : files: op(f): [finished] processing unit "metadata.target" Nov 1 00:16:02.781809 ignition[1033]: INFO : files: op(11): [started] setting preset to enabled for "waagent.service" Nov 1 00:16:02.781809 ignition[1033]: INFO : files: op(11): [finished] setting preset to enabled for "waagent.service" Nov 1 00:16:02.781809 ignition[1033]: INFO : files: op(12): [started] setting preset to enabled for "nvidia.service" Nov 1 00:16:02.781809 ignition[1033]: INFO : files: op(12): [finished] setting preset to enabled for "nvidia.service" Nov 1 00:16:02.781809 ignition[1033]: INFO : files: op(13): [started] setting preset to enabled for "coreos-metadata.service" Nov 1 00:16:02.781809 ignition[1033]: INFO : files: op(13): [finished] setting preset to enabled for "coreos-metadata.service" Nov 1 00:16:02.781809 ignition[1033]: INFO : files: op(14): [started] setting preset to enabled for "metadata.target" Nov 1 00:16:02.781809 ignition[1033]: INFO : files: op(14): [finished] setting preset to enabled for "metadata.target" Nov 1 00:16:02.781809 ignition[1033]: INFO : files: createResultFile: createFiles: op(15): [started] writing file "/sysroot/etc/.ignition-result.json" Nov 1 00:16:02.781809 ignition[1033]: INFO : files: createResultFile: createFiles: op(15): [finished] writing file "/sysroot/etc/.ignition-result.json" Nov 1 00:16:02.781809 ignition[1033]: INFO : files: files passed Nov 1 00:16:02.781809 ignition[1033]: INFO : Ignition finished successfully Nov 1 00:16:02.800000 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' Nov 1 00:16:02.873000 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' Nov 1 00:16:03.035000 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' Nov 1 00:16:02.523854 systemd[1]: Finished ignition-files.service. Nov 1 00:16:03.057000 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' Nov 1 00:16:02.555007 systemd[1]: Starting initrd-setup-root-after-ignition.service... Nov 1 00:16:03.067000 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' Nov 1 00:16:03.074133 initrd-setup-root-after-ignition[1058]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Nov 1 00:16:03.078000 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' Nov 1 00:16:02.560502 systemd[1]: torcx-profile-populate.service was skipped because of an unmet condition check (ConditionPathExists=/sysroot/etc/torcx/next-profile). Nov 1 00:16:03.092000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=flatcar-metadata-hostname comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:16:02.561366 systemd[1]: Starting ignition-quench.service... Nov 1 00:16:03.118602 iscsid[876]: iscsid shutting down. Nov 1 00:16:02.587629 systemd[1]: ignition-quench.service: Deactivated successfully. Nov 1 00:16:03.138000 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' Nov 1 00:16:02.587741 systemd[1]: Finished ignition-quench.service. Nov 1 00:16:02.604927 systemd[1]: Finished initrd-setup-root-after-ignition.service. Nov 1 00:16:03.159000 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' Nov 1 00:16:02.623618 systemd[1]: Reached target ignition-complete.target. Nov 1 00:16:03.170000 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' Nov 1 00:16:02.642200 systemd[1]: Starting initrd-parse-etc.service... Nov 1 00:16:03.181000 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' Nov 1 00:16:03.186700 ignition[1071]: INFO : Ignition 2.14.0 Nov 1 00:16:03.186700 ignition[1071]: INFO : Stage: umount Nov 1 00:16:03.186700 ignition[1071]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" Nov 1 00:16:03.186700 ignition[1071]: DEBUG : parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63 Nov 1 00:16:03.186700 ignition[1071]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Nov 1 00:16:03.186700 ignition[1071]: INFO : umount: op(1): [started] umounting "/sysroot/tmp/_translate-filesystem-0-ign1" Nov 1 00:16:03.186700 ignition[1071]: INFO : umount: op(1): [finished] umounting "/sysroot/tmp/_translate-filesystem-0-ign1" Nov 1 00:16:03.186700 ignition[1071]: INFO : umount: umount passed Nov 1 00:16:03.186700 ignition[1071]: INFO : Ignition finished successfully Nov 1 00:16:03.191000 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' Nov 1 00:16:03.201000 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' Nov 1 00:16:03.210000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:16:03.216000 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' Nov 1 00:16:03.299000 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' Nov 1 00:16:02.690865 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Nov 1 00:16:02.691086 systemd[1]: Finished initrd-parse-etc.service. Nov 1 00:16:03.319000 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' Nov 1 00:16:02.705417 systemd[1]: Reached target initrd-fs.target. Nov 1 00:16:03.329000 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' Nov 1 00:16:02.718871 systemd[1]: Reached target initrd.target. Nov 1 00:16:02.733170 systemd[1]: dracut-mount.service was skipped because no trigger condition checks were met. Nov 1 00:16:02.734181 systemd[1]: Starting dracut-pre-pivot.service... Nov 1 00:16:03.359000 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' Nov 1 00:16:02.789235 systemd[1]: Finished dracut-pre-pivot.service. Nov 1 00:16:02.801851 systemd[1]: Starting initrd-cleanup.service... Nov 1 00:16:02.822847 systemd[1]: Stopped target nss-lookup.target. Nov 1 00:16:03.386000 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' Nov 1 00:16:03.386000 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' Nov 1 00:16:02.833179 systemd[1]: Stopped target remote-cryptsetup.target. Nov 1 00:16:03.397000 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' Nov 1 00:16:02.846558 systemd[1]: Stopped target timers.target. Nov 1 00:16:03.406000 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' Nov 1 00:16:03.406000 audit: BPF prog-id=6 op=UNLOAD Nov 1 00:16:02.858717 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Nov 1 00:16:02.858831 systemd[1]: Stopped dracut-pre-pivot.service. Nov 1 00:16:03.430000 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' Nov 1 00:16:02.873540 systemd[1]: Stopped target initrd.target. Nov 1 00:16:03.439000 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' Nov 1 00:16:02.887768 systemd[1]: Stopped target basic.target. Nov 1 00:16:03.447000 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' Nov 1 00:16:02.898408 systemd[1]: Stopped target ignition-complete.target. Nov 1 00:16:02.911165 systemd[1]: Stopped target ignition-diskful.target. Nov 1 00:16:02.923579 systemd[1]: Stopped target initrd-root-device.target. Nov 1 00:16:03.471000 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' Nov 1 00:16:02.936291 systemd[1]: Stopped target remote-fs.target. Nov 1 00:16:02.948851 systemd[1]: Stopped target remote-fs-pre.target. Nov 1 00:16:02.962488 systemd[1]: Stopped target sysinit.target. Nov 1 00:16:03.502000 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' Nov 1 00:16:02.976463 systemd[1]: Stopped target local-fs.target. Nov 1 00:16:03.521863 kernel: hv_netvsc 000d3a07-7eb4-000d-3a07-7eb4000d3a07 eth0: Data path switched from VF: enP33989s1 Nov 1 00:16:02.989875 systemd[1]: Stopped target local-fs-pre.target. Nov 1 00:16:03.526000 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' Nov 1 00:16:03.003556 systemd[1]: Stopped target swap.target. Nov 1 00:16:03.536000 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' Nov 1 00:16:03.019438 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Nov 1 00:16:03.019553 systemd[1]: Stopped dracut-pre-mount.service. Nov 1 00:16:03.036064 systemd[1]: Stopped target cryptsetup.target. Nov 1 00:16:03.046626 systemd[1]: dracut-initqueue.service: Deactivated successfully. Nov 1 00:16:03.564000 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' Nov 1 00:16:03.046730 systemd[1]: Stopped dracut-initqueue.service. Nov 1 00:16:03.575000 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' Nov 1 00:16:03.057354 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Nov 1 00:16:03.585000 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' Nov 1 00:16:03.057446 systemd[1]: Stopped initrd-setup-root-after-ignition.service. Nov 1 00:16:03.598000 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' Nov 1 00:16:03.598000 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' Nov 1 00:16:03.068171 systemd[1]: ignition-files.service: Deactivated successfully. Nov 1 00:16:03.068257 systemd[1]: Stopped ignition-files.service. Nov 1 00:16:03.078969 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Nov 1 00:16:03.079075 systemd[1]: Stopped flatcar-metadata-hostname.service. Nov 1 00:16:03.094151 systemd[1]: Stopping ignition-mount.service... Nov 1 00:16:03.110219 systemd[1]: Stopping iscsid.service... Nov 1 00:16:03.124960 systemd[1]: Stopping sysroot-boot.service... Nov 1 00:16:03.132969 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Nov 1 00:16:03.643000 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' Nov 1 00:16:03.133151 systemd[1]: Stopped systemd-udev-trigger.service. Nov 1 00:16:03.138759 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Nov 1 00:16:03.138855 systemd[1]: Stopped dracut-pre-trigger.service. Nov 1 00:16:03.162220 systemd[1]: sysroot-tmp-_translate\x2dfilesystem\x2d0\x2dign1.mount: Deactivated successfully. Nov 1 00:16:03.162850 systemd[1]: iscsid.service: Deactivated successfully. Nov 1 00:16:03.162982 systemd[1]: Stopped iscsid.service. Nov 1 00:16:03.171198 systemd[1]: ignition-mount.service: Deactivated successfully. Nov 1 00:16:03.171300 systemd[1]: Stopped ignition-mount.service. Nov 1 00:16:03.715245 systemd-journald[276]: Received SIGTERM from PID 1 (n/a). Nov 1 00:16:03.182609 systemd[1]: sysroot-boot.mount: Deactivated successfully. Nov 1 00:16:03.183413 systemd[1]: ignition-disks.service: Deactivated successfully. Nov 1 00:16:03.183517 systemd[1]: Stopped ignition-disks.service. Nov 1 00:16:03.191698 systemd[1]: ignition-kargs.service: Deactivated successfully. Nov 1 00:16:03.191792 systemd[1]: Stopped ignition-kargs.service. Nov 1 00:16:03.201373 systemd[1]: ignition-fetch.service: Deactivated successfully. Nov 1 00:16:03.201459 systemd[1]: Stopped ignition-fetch.service. Nov 1 00:16:03.210662 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Nov 1 00:16:03.210759 systemd[1]: Stopped ignition-fetch-offline.service. Nov 1 00:16:03.216377 systemd[1]: Stopped target paths.target. Nov 1 00:16:03.229497 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Nov 1 00:16:03.240060 systemd[1]: Stopped systemd-ask-password-console.path. Nov 1 00:16:03.250805 systemd[1]: Stopped target slices.target. Nov 1 00:16:03.263069 systemd[1]: Stopped target sockets.target. Nov 1 00:16:03.276787 systemd[1]: iscsid.socket: Deactivated successfully. Nov 1 00:16:03.276877 systemd[1]: Closed iscsid.socket. Nov 1 00:16:03.289942 systemd[1]: ignition-setup.service: Deactivated successfully. Nov 1 00:16:03.290048 systemd[1]: Stopped ignition-setup.service. Nov 1 00:16:03.300190 systemd[1]: Stopping iscsiuio.service... Nov 1 00:16:03.310255 systemd[1]: iscsiuio.service: Deactivated successfully. Nov 1 00:16:03.310372 systemd[1]: Stopped iscsiuio.service. Nov 1 00:16:03.320391 systemd[1]: sysroot-boot.service: Deactivated successfully. Nov 1 00:16:03.320476 systemd[1]: Stopped sysroot-boot.service. Nov 1 00:16:03.329790 systemd[1]: Stopped target network.target. Nov 1 00:16:03.339386 systemd[1]: iscsiuio.socket: Deactivated successfully. Nov 1 00:16:03.339421 systemd[1]: Closed iscsiuio.socket. Nov 1 00:16:03.347485 systemd[1]: initrd-setup-root.service: Deactivated successfully. Nov 1 00:16:03.347530 systemd[1]: Stopped initrd-setup-root.service. Nov 1 00:16:03.359439 systemd[1]: Stopping systemd-networkd.service... Nov 1 00:16:03.367958 systemd[1]: Stopping systemd-resolved.service... Nov 1 00:16:03.377381 systemd-networkd[869]: eth0: DHCPv6 lease lost Nov 1 00:16:03.715000 audit: BPF prog-id=9 op=UNLOAD Nov 1 00:16:03.378581 systemd[1]: initrd-cleanup.service: Deactivated successfully. Nov 1 00:16:03.378667 systemd[1]: Finished initrd-cleanup.service. Nov 1 00:16:03.387285 systemd[1]: systemd-networkd.service: Deactivated successfully. Nov 1 00:16:03.387372 systemd[1]: Stopped systemd-networkd.service. Nov 1 00:16:03.397578 systemd[1]: systemd-resolved.service: Deactivated successfully. Nov 1 00:16:03.397668 systemd[1]: Stopped systemd-resolved.service. Nov 1 00:16:03.408081 systemd[1]: systemd-networkd.socket: Deactivated successfully. Nov 1 00:16:03.408124 systemd[1]: Closed systemd-networkd.socket. Nov 1 00:16:03.416275 systemd[1]: Stopping network-cleanup.service... Nov 1 00:16:03.425494 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Nov 1 00:16:03.425559 systemd[1]: Stopped parse-ip-for-networkd.service. Nov 1 00:16:03.430783 systemd[1]: systemd-sysctl.service: Deactivated successfully. Nov 1 00:16:03.430840 systemd[1]: Stopped systemd-sysctl.service. Nov 1 00:16:03.442598 systemd[1]: systemd-modules-load.service: Deactivated successfully. Nov 1 00:16:03.442637 systemd[1]: Stopped systemd-modules-load.service. Nov 1 00:16:03.447479 systemd[1]: Stopping systemd-udevd.service... Nov 1 00:16:03.456879 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Nov 1 00:16:03.466985 systemd[1]: systemd-udevd.service: Deactivated successfully. Nov 1 00:16:03.467148 systemd[1]: Stopped systemd-udevd.service. Nov 1 00:16:03.472126 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Nov 1 00:16:03.472168 systemd[1]: Closed systemd-udevd-control.socket. Nov 1 00:16:03.482475 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Nov 1 00:16:03.482521 systemd[1]: Closed systemd-udevd-kernel.socket. Nov 1 00:16:03.492881 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Nov 1 00:16:03.492933 systemd[1]: Stopped dracut-pre-udev.service. Nov 1 00:16:03.502878 systemd[1]: dracut-cmdline.service: Deactivated successfully. Nov 1 00:16:03.502920 systemd[1]: Stopped dracut-cmdline.service. Nov 1 00:16:03.526593 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Nov 1 00:16:03.526645 systemd[1]: Stopped dracut-cmdline-ask.service. Nov 1 00:16:03.540472 systemd[1]: Starting initrd-udevadm-cleanup-db.service... Nov 1 00:16:03.555388 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Nov 1 00:16:03.555476 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service. Nov 1 00:16:03.569626 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Nov 1 00:16:03.569690 systemd[1]: Stopped kmod-static-nodes.service. Nov 1 00:16:03.575322 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 1 00:16:03.575369 systemd[1]: Stopped systemd-vconsole-setup.service. Nov 1 00:16:03.586454 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup\x2ddev.service.mount: Deactivated successfully. Nov 1 00:16:03.586937 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Nov 1 00:16:03.587042 systemd[1]: Finished initrd-udevadm-cleanup-db.service. Nov 1 00:16:03.634816 systemd[1]: network-cleanup.service: Deactivated successfully. Nov 1 00:16:03.634924 systemd[1]: Stopped network-cleanup.service. Nov 1 00:16:03.643272 systemd[1]: Reached target initrd-switch-root.target. Nov 1 00:16:03.654543 systemd[1]: Starting initrd-switch-root.service... Nov 1 00:16:03.674481 systemd[1]: Switching root. Nov 1 00:16:03.717140 systemd-journald[276]: Journal stopped Nov 1 00:16:20.234412 kernel: SELinux: Class mctp_socket not defined in policy. Nov 1 00:16:20.234431 kernel: SELinux: Class anon_inode not defined in policy. Nov 1 00:16:20.234441 kernel: SELinux: the above unknown classes and permissions will be allowed Nov 1 00:16:20.234451 kernel: SELinux: policy capability network_peer_controls=1 Nov 1 00:16:20.234459 kernel: SELinux: policy capability open_perms=1 Nov 1 00:16:20.234467 kernel: SELinux: policy capability extended_socket_class=1 Nov 1 00:16:20.234476 kernel: SELinux: policy capability always_check_network=0 Nov 1 00:16:20.234483 kernel: SELinux: policy capability cgroup_seclabel=1 Nov 1 00:16:20.234491 kernel: SELinux: policy capability nnp_nosuid_transition=1 Nov 1 00:16:20.234499 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Nov 1 00:16:20.234507 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Nov 1 00:16:20.234516 kernel: kauditd_printk_skb: 43 callbacks suppressed Nov 1 00:16:20.234526 kernel: audit: type=1403 audit(1761956165.976:82): auid=4294967295 ses=4294967295 lsm=selinux res=1 Nov 1 00:16:20.234536 systemd[1]: Successfully loaded SELinux policy in 339.947ms. Nov 1 00:16:20.234547 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 26.162ms. Nov 1 00:16:20.234559 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) Nov 1 00:16:20.234568 systemd[1]: Detected virtualization microsoft. Nov 1 00:16:20.234577 systemd[1]: Detected architecture arm64. Nov 1 00:16:20.234586 systemd[1]: Detected first boot. Nov 1 00:16:20.234596 systemd[1]: Hostname set to . Nov 1 00:16:20.234605 systemd[1]: Initializing machine ID from random generator. Nov 1 00:16:20.234614 kernel: audit: type=1400 audit(1761956167.067:83): avc: denied { bpf } for pid=1 comm="systemd" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1 Nov 1 00:16:20.234625 kernel: audit: type=1400 audit(1761956167.067:84): avc: denied { perfmon } for pid=1 comm="systemd" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1 Nov 1 00:16:20.234634 kernel: audit: type=1334 audit(1761956167.087:85): prog-id=10 op=LOAD Nov 1 00:16:20.234642 kernel: audit: type=1334 audit(1761956167.087:86): prog-id=10 op=UNLOAD Nov 1 00:16:20.234651 kernel: audit: type=1334 audit(1761956167.107:87): prog-id=11 op=LOAD Nov 1 00:16:20.234659 kernel: audit: type=1334 audit(1761956167.107:88): prog-id=11 op=UNLOAD Nov 1 00:16:20.234668 kernel: SELinux: Context system_u:object_r:container_file_t:s0:c1022,c1023 is not valid (left unmapped). Nov 1 00:16:20.234677 kernel: audit: type=1400 audit(1761956168.686:89): avc: denied { associate } for pid=1104 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" Nov 1 00:16:20.234688 kernel: audit: type=1300 audit(1761956168.686:89): arch=c00000b7 syscall=5 success=yes exit=0 a0=400014587c a1=40000c6de0 a2=40000cd0c0 a3=32 items=0 ppid=1087 pid=1104 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) Nov 1 00:16:20.234698 kernel: audit: type=1327 audit(1761956168.686:89): proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61 Nov 1 00:16:20.234707 systemd[1]: Populated /etc with preset unit settings. Nov 1 00:16:20.234716 systemd[1]: /usr/lib/systemd/system/locksmithd.service:8: Unit uses CPUShares=; please use CPUWeight= instead. Support for CPUShares= will be removed soon. Nov 1 00:16:20.234727 systemd[1]: /usr/lib/systemd/system/locksmithd.service:9: Unit uses MemoryLimit=; please use MemoryMax= instead. Support for MemoryLimit= will be removed soon. Nov 1 00:16:20.234737 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. Nov 1 00:16:20.234747 kernel: kauditd_printk_skb: 6 callbacks suppressed Nov 1 00:16:20.234755 kernel: audit: type=1334 audit(1761956179.461:91): prog-id=12 op=LOAD Nov 1 00:16:20.234764 kernel: audit: type=1334 audit(1761956179.461:92): prog-id=3 op=UNLOAD Nov 1 00:16:20.234772 kernel: audit: type=1334 audit(1761956179.467:93): prog-id=13 op=LOAD Nov 1 00:16:20.234781 kernel: audit: type=1334 audit(1761956179.473:94): prog-id=14 op=LOAD Nov 1 00:16:20.234792 kernel: audit: type=1334 audit(1761956179.473:95): prog-id=4 op=UNLOAD Nov 1 00:16:20.234801 systemd[1]: initrd-switch-root.service: Deactivated successfully. Nov 1 00:16:20.234810 kernel: audit: type=1334 audit(1761956179.473:96): prog-id=5 op=UNLOAD Nov 1 00:16:20.234819 systemd[1]: Stopped initrd-switch-root.service. Nov 1 00:16:20.234830 kernel: audit: type=1334 audit(1761956179.479:97): prog-id=15 op=LOAD Nov 1 00:16:20.234839 kernel: audit: type=1334 audit(1761956179.479:98): prog-id=12 op=UNLOAD Nov 1 00:16:20.234847 kernel: audit: type=1334 audit(1761956179.484:99): prog-id=16 op=LOAD Nov 1 00:16:20.234856 kernel: audit: type=1334 audit(1761956179.490:100): prog-id=17 op=LOAD Nov 1 00:16:20.234865 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Nov 1 00:16:20.234874 systemd[1]: Created slice system-addon\x2dconfig.slice. Nov 1 00:16:20.234884 systemd[1]: Created slice system-addon\x2drun.slice. Nov 1 00:16:20.234894 systemd[1]: Created slice system-getty.slice. Nov 1 00:16:20.234903 systemd[1]: Created slice system-modprobe.slice. Nov 1 00:16:20.234913 systemd[1]: Created slice system-serial\x2dgetty.slice. Nov 1 00:16:20.234923 systemd[1]: Created slice system-system\x2dcloudinit.slice. Nov 1 00:16:20.234933 systemd[1]: Created slice system-systemd\x2dfsck.slice. Nov 1 00:16:20.234942 systemd[1]: Created slice user.slice. Nov 1 00:16:20.234951 systemd[1]: Started systemd-ask-password-console.path. Nov 1 00:16:20.234961 systemd[1]: Started systemd-ask-password-wall.path. Nov 1 00:16:20.234970 systemd[1]: Set up automount boot.automount. Nov 1 00:16:20.234981 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount. Nov 1 00:16:20.234990 systemd[1]: Stopped target initrd-switch-root.target. Nov 1 00:16:20.235000 systemd[1]: Stopped target initrd-fs.target. Nov 1 00:16:20.235009 systemd[1]: Stopped target initrd-root-fs.target. Nov 1 00:16:20.235018 systemd[1]: Reached target integritysetup.target. Nov 1 00:16:20.235028 systemd[1]: Reached target remote-cryptsetup.target. Nov 1 00:16:20.235059 systemd[1]: Reached target remote-fs.target. Nov 1 00:16:20.235069 systemd[1]: Reached target slices.target. Nov 1 00:16:20.235080 systemd[1]: Reached target swap.target. Nov 1 00:16:20.235089 systemd[1]: Reached target torcx.target. Nov 1 00:16:20.235098 systemd[1]: Reached target veritysetup.target. Nov 1 00:16:20.235108 systemd[1]: Listening on systemd-coredump.socket. Nov 1 00:16:20.235117 systemd[1]: Listening on systemd-initctl.socket. Nov 1 00:16:20.235126 systemd[1]: Listening on systemd-networkd.socket. Nov 1 00:16:20.235137 systemd[1]: Listening on systemd-udevd-control.socket. Nov 1 00:16:20.235148 systemd[1]: Listening on systemd-udevd-kernel.socket. Nov 1 00:16:20.235157 systemd[1]: Listening on systemd-userdbd.socket. Nov 1 00:16:20.235167 systemd[1]: Mounting dev-hugepages.mount... Nov 1 00:16:20.235176 systemd[1]: Mounting dev-mqueue.mount... Nov 1 00:16:20.235185 systemd[1]: Mounting media.mount... Nov 1 00:16:20.235195 systemd[1]: Mounting sys-kernel-debug.mount... Nov 1 00:16:20.235204 systemd[1]: Mounting sys-kernel-tracing.mount... Nov 1 00:16:20.235215 systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Nov 1 00:16:20.235225 systemd[1]: Mounting tmp.mount... Nov 1 00:16:20.235234 systemd[1]: Starting flatcar-tmpfiles.service... Nov 1 00:16:20.235243 systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. Nov 1 00:16:20.235253 systemd[1]: Starting kmod-static-nodes.service... Nov 1 00:16:20.235262 systemd[1]: Starting modprobe@configfs.service... Nov 1 00:16:20.235271 systemd[1]: Starting modprobe@dm_mod.service... Nov 1 00:16:20.235281 systemd[1]: Starting modprobe@drm.service... Nov 1 00:16:20.235291 systemd[1]: Starting modprobe@efi_pstore.service... Nov 1 00:16:20.235301 systemd[1]: Starting modprobe@fuse.service... Nov 1 00:16:20.235310 systemd[1]: Starting modprobe@loop.service... Nov 1 00:16:20.235320 systemd[1]: setup-nsswitch.service was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Nov 1 00:16:20.235330 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Nov 1 00:16:20.235339 systemd[1]: Stopped systemd-fsck-root.service. Nov 1 00:16:20.235350 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Nov 1 00:16:20.235359 systemd[1]: Stopped systemd-fsck-usr.service. Nov 1 00:16:20.235368 systemd[1]: Stopped systemd-journald.service. Nov 1 00:16:20.235379 systemd[1]: systemd-journald.service: Consumed 2.916s CPU time. Nov 1 00:16:20.235388 systemd[1]: Starting systemd-journald.service... Nov 1 00:16:20.235397 kernel: loop: module loaded Nov 1 00:16:20.235407 systemd[1]: Starting systemd-modules-load.service... Nov 1 00:16:20.235416 systemd[1]: Starting systemd-network-generator.service... Nov 1 00:16:20.235425 kernel: fuse: init (API version 7.34) Nov 1 00:16:20.235434 systemd[1]: Starting systemd-remount-fs.service... Nov 1 00:16:20.235443 systemd[1]: Starting systemd-udev-trigger.service... Nov 1 00:16:20.235453 systemd[1]: verity-setup.service: Deactivated successfully. Nov 1 00:16:20.235463 systemd[1]: Stopped verity-setup.service. Nov 1 00:16:20.235472 systemd[1]: Mounted dev-hugepages.mount. Nov 1 00:16:20.235481 systemd[1]: Mounted dev-mqueue.mount. Nov 1 00:16:20.235490 systemd[1]: Mounted media.mount. Nov 1 00:16:20.235500 systemd[1]: Mounted sys-kernel-debug.mount. Nov 1 00:16:20.235512 systemd-journald[1202]: Journal started Nov 1 00:16:20.235549 systemd-journald[1202]: Runtime Journal (/run/log/journal/5e1de31caf5f4918a02e0b9edc0c76b0) is 8.0M, max 78.5M, 70.5M free. Nov 1 00:16:05.976000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Nov 1 00:16:07.067000 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 Nov 1 00:16:07.067000 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 Nov 1 00:16:07.087000 audit: BPF prog-id=10 op=LOAD Nov 1 00:16:07.087000 audit: BPF prog-id=10 op=UNLOAD Nov 1 00:16:07.107000 audit: BPF prog-id=11 op=LOAD Nov 1 00:16:07.107000 audit: BPF prog-id=11 op=UNLOAD Nov 1 00:16:08.686000 audit[1104]: AVC avc: denied { associate } for pid=1104 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" Nov 1 00:16:08.686000 audit[1104]: SYSCALL arch=c00000b7 syscall=5 success=yes exit=0 a0=400014587c a1=40000c6de0 a2=40000cd0c0 a3=32 items=0 ppid=1087 pid=1104 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) Nov 1 00:16:08.686000 audit: PROCTITLE proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61 Nov 1 00:16:08.695000 audit[1104]: AVC avc: denied { associate } for pid=1104 comm="torcx-generator" name="bin" scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 Nov 1 00:16:08.695000 audit[1104]: SYSCALL arch=c00000b7 syscall=34 success=yes exit=0 a0=ffffffffffffff9c a1=4000145959 a2=1ed a3=0 items=2 ppid=1087 pid=1104 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) Nov 1 00:16:08.695000 audit: CWD cwd="/" Nov 1 00:16:08.695000 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 Nov 1 00:16:08.695000 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 Nov 1 00:16:08.695000 audit: PROCTITLE proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61 Nov 1 00:16:19.461000 audit: BPF prog-id=12 op=LOAD Nov 1 00:16:19.461000 audit: BPF prog-id=3 op=UNLOAD Nov 1 00:16:19.467000 audit: BPF prog-id=13 op=LOAD Nov 1 00:16:19.473000 audit: BPF prog-id=14 op=LOAD Nov 1 00:16:19.473000 audit: BPF prog-id=4 op=UNLOAD Nov 1 00:16:19.473000 audit: BPF prog-id=5 op=UNLOAD Nov 1 00:16:19.479000 audit: BPF prog-id=15 op=LOAD Nov 1 00:16:19.479000 audit: BPF prog-id=12 op=UNLOAD Nov 1 00:16:19.484000 audit: BPF prog-id=16 op=LOAD Nov 1 00:16:19.490000 audit: BPF prog-id=17 op=LOAD Nov 1 00:16:19.490000 audit: BPF prog-id=13 op=UNLOAD Nov 1 00:16:19.490000 audit: BPF prog-id=14 op=UNLOAD Nov 1 00:16:19.491000 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' Nov 1 00:16:19.527000 audit: BPF prog-id=15 op=UNLOAD Nov 1 00:16:19.541000 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' Nov 1 00:16:19.541000 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' Nov 1 00:16:20.066000 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' Nov 1 00:16:20.084000 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' Nov 1 00:16:20.094000 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' Nov 1 00:16:20.094000 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' Nov 1 00:16:20.101000 audit: BPF prog-id=18 op=LOAD Nov 1 00:16:20.101000 audit: BPF prog-id=19 op=LOAD Nov 1 00:16:20.101000 audit: BPF prog-id=20 op=LOAD Nov 1 00:16:20.101000 audit: BPF prog-id=16 op=UNLOAD Nov 1 00:16:20.101000 audit: BPF prog-id=17 op=UNLOAD Nov 1 00:16:20.207000 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' Nov 1 00:16:20.232000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Nov 1 00:16:20.232000 audit[1202]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=60 a0=6 a1=ffffc2df3e90 a2=4000 a3=1 items=0 ppid=1 pid=1202 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) Nov 1 00:16:20.232000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Nov 1 00:16:19.460310 systemd[1]: Queued start job for default target multi-user.target. Nov 1 00:16:08.601635 /usr/lib/systemd/system-generators/torcx-generator[1104]: time="2025-11-01T00:16:08Z" 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.8 /usr/share/oem/torcx/store /var/lib/torcx/store/3510.3.8 /var/lib/torcx/store]" Nov 1 00:16:19.460323 systemd[1]: Unnecessary job was removed for dev-sda6.device. Nov 1 00:16:08.635108 /usr/lib/systemd/system-generators/torcx-generator[1104]: time="2025-11-01T00:16:08Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Nov 1 00:16:19.491592 systemd[1]: systemd-journald.service: Deactivated successfully. Nov 1 00:16:08.635127 /usr/lib/systemd/system-generators/torcx-generator[1104]: time="2025-11-01T00:16:08Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Nov 1 00:16:19.491947 systemd[1]: systemd-journald.service: Consumed 2.916s CPU time. Nov 1 00:16:08.635179 /usr/lib/systemd/system-generators/torcx-generator[1104]: time="2025-11-01T00:16:08Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Nov 1 00:16:08.635188 /usr/lib/systemd/system-generators/torcx-generator[1104]: time="2025-11-01T00:16:08Z" level=debug msg="skipped missing lower profile" missing profile=oem Nov 1 00:16:08.635222 /usr/lib/systemd/system-generators/torcx-generator[1104]: time="2025-11-01T00:16:08Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Nov 1 00:16:08.635235 /usr/lib/systemd/system-generators/torcx-generator[1104]: time="2025-11-01T00:16:08Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Nov 1 00:16:08.635441 /usr/lib/systemd/system-generators/torcx-generator[1104]: time="2025-11-01T00:16:08Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Nov 1 00:16:08.635479 /usr/lib/systemd/system-generators/torcx-generator[1104]: time="2025-11-01T00:16:08Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Nov 1 00:16:08.635490 /usr/lib/systemd/system-generators/torcx-generator[1104]: time="2025-11-01T00:16:08Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Nov 1 00:16:08.668718 /usr/lib/systemd/system-generators/torcx-generator[1104]: time="2025-11-01T00:16:08Z" 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 Nov 1 00:16:08.668774 /usr/lib/systemd/system-generators/torcx-generator[1104]: time="2025-11-01T00:16:08Z" 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 Nov 1 00:16:08.668795 /usr/lib/systemd/system-generators/torcx-generator[1104]: time="2025-11-01T00:16:08Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store/3510.3.8: no such file or directory" path=/usr/share/oem/torcx/store/3510.3.8 Nov 1 00:16:08.668809 /usr/lib/systemd/system-generators/torcx-generator[1104]: time="2025-11-01T00:16:08Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Nov 1 00:16:08.668829 /usr/lib/systemd/system-generators/torcx-generator[1104]: time="2025-11-01T00:16:08Z" level=info msg="store skipped" err="open /var/lib/torcx/store/3510.3.8: no such file or directory" path=/var/lib/torcx/store/3510.3.8 Nov 1 00:16:08.668843 /usr/lib/systemd/system-generators/torcx-generator[1104]: time="2025-11-01T00:16:08Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Nov 1 00:16:15.208827 /usr/lib/systemd/system-generators/torcx-generator[1104]: time="2025-11-01T00:16:15Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Nov 1 00:16:15.209103 /usr/lib/systemd/system-generators/torcx-generator[1104]: time="2025-11-01T00:16:15Z" 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 Nov 1 00:16:15.209203 /usr/lib/systemd/system-generators/torcx-generator[1104]: time="2025-11-01T00:16:15Z" 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 Nov 1 00:16:15.209358 /usr/lib/systemd/system-generators/torcx-generator[1104]: time="2025-11-01T00:16:15Z" 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 Nov 1 00:16:15.209407 /usr/lib/systemd/system-generators/torcx-generator[1104]: time="2025-11-01T00:16:15Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Nov 1 00:16:15.209460 /usr/lib/systemd/system-generators/torcx-generator[1104]: time="2025-11-01T00:16:15Z" 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 Nov 1 00:16:20.254029 systemd[1]: Started systemd-journald.service. Nov 1 00:16:20.252000 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' Nov 1 00:16:20.252944 systemd[1]: Mounted sys-kernel-tracing.mount. Nov 1 00:16:20.257835 systemd[1]: Mounted tmp.mount. Nov 1 00:16:20.261817 systemd[1]: Finished flatcar-tmpfiles.service. Nov 1 00:16:20.266000 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' Nov 1 00:16:20.266864 systemd[1]: Finished kmod-static-nodes.service. Nov 1 00:16:20.271000 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' Nov 1 00:16:20.272212 systemd[1]: modprobe@configfs.service: Deactivated successfully. Nov 1 00:16:20.272335 systemd[1]: Finished modprobe@configfs.service. Nov 1 00:16:20.277000 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' Nov 1 00:16:20.277000 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' Nov 1 00:16:20.277621 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 1 00:16:20.277742 systemd[1]: Finished modprobe@dm_mod.service. Nov 1 00:16:20.282000 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' Nov 1 00:16:20.282000 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' Nov 1 00:16:20.282578 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 1 00:16:20.282688 systemd[1]: Finished modprobe@drm.service. Nov 1 00:16:20.287000 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' Nov 1 00:16:20.287000 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' Nov 1 00:16:20.287521 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 1 00:16:20.287640 systemd[1]: Finished modprobe@efi_pstore.service. Nov 1 00:16:20.292000 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' Nov 1 00:16:20.292000 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' Nov 1 00:16:20.292671 systemd[1]: modprobe@fuse.service: Deactivated successfully. Nov 1 00:16:20.292795 systemd[1]: Finished modprobe@fuse.service. Nov 1 00:16:20.297000 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' Nov 1 00:16:20.297000 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' Nov 1 00:16:20.297583 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 1 00:16:20.297703 systemd[1]: Finished modprobe@loop.service. Nov 1 00:16:20.302000 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' Nov 1 00:16:20.302000 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' Nov 1 00:16:20.303287 systemd[1]: Finished systemd-network-generator.service. Nov 1 00:16:20.308000 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' Nov 1 00:16:20.309111 systemd[1]: Finished systemd-remount-fs.service. Nov 1 00:16:20.314000 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' Nov 1 00:16:20.314888 systemd[1]: Reached target network-pre.target. Nov 1 00:16:20.321231 systemd[1]: Mounting sys-fs-fuse-connections.mount... Nov 1 00:16:20.326963 systemd[1]: Mounting sys-kernel-config.mount... Nov 1 00:16:20.331453 systemd[1]: remount-root.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Nov 1 00:16:20.365078 systemd[1]: Starting systemd-hwdb-update.service... Nov 1 00:16:20.371095 systemd[1]: Starting systemd-journal-flush.service... Nov 1 00:16:20.375757 systemd[1]: systemd-pstore.service was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Nov 1 00:16:20.376917 systemd[1]: Starting systemd-random-seed.service... Nov 1 00:16:20.381636 systemd[1]: systemd-repart.service was skipped because no trigger condition checks were met. Nov 1 00:16:20.382835 systemd[1]: Starting systemd-sysusers.service... Nov 1 00:16:20.388852 systemd[1]: Finished systemd-modules-load.service. Nov 1 00:16:20.393000 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' Nov 1 00:16:20.394030 systemd[1]: Finished systemd-udev-trigger.service. Nov 1 00:16:20.399000 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' Nov 1 00:16:20.400258 systemd[1]: Mounted sys-fs-fuse-connections.mount. Nov 1 00:16:20.405717 systemd[1]: Mounted sys-kernel-config.mount. Nov 1 00:16:20.411364 systemd[1]: Starting systemd-sysctl.service... Nov 1 00:16:20.416779 systemd[1]: Starting systemd-udev-settle.service... Nov 1 00:16:20.426410 udevadm[1224]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Nov 1 00:16:20.444801 systemd-journald[1202]: Time spent on flushing to /var/log/journal/5e1de31caf5f4918a02e0b9edc0c76b0 is 14.486ms for 1102 entries. Nov 1 00:16:20.444801 systemd-journald[1202]: System Journal (/var/log/journal/5e1de31caf5f4918a02e0b9edc0c76b0) is 8.0M, max 2.6G, 2.6G free. Nov 1 00:16:20.562677 systemd-journald[1202]: Received client request to flush runtime journal. Nov 1 00:16:20.468000 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' Nov 1 00:16:20.463378 systemd[1]: Finished systemd-random-seed.service. Nov 1 00:16:20.468535 systemd[1]: Reached target first-boot-complete.target. Nov 1 00:16:20.563843 systemd[1]: Finished systemd-journal-flush.service. Nov 1 00:16:20.569000 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' Nov 1 00:16:20.623386 systemd[1]: Finished systemd-sysctl.service. Nov 1 00:16:20.627000 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' Nov 1 00:16:21.344622 systemd[1]: Finished systemd-sysusers.service. Nov 1 00:16:21.349000 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' Nov 1 00:16:21.350474 systemd[1]: Starting systemd-tmpfiles-setup-dev.service... Nov 1 00:16:22.167803 systemd[1]: Finished systemd-hwdb-update.service. Nov 1 00:16:22.173000 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' Nov 1 00:16:22.403847 systemd[1]: Finished systemd-tmpfiles-setup-dev.service. Nov 1 00:16:22.409000 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' Nov 1 00:16:22.409000 audit: BPF prog-id=21 op=LOAD Nov 1 00:16:22.409000 audit: BPF prog-id=22 op=LOAD Nov 1 00:16:22.409000 audit: BPF prog-id=7 op=UNLOAD Nov 1 00:16:22.409000 audit: BPF prog-id=8 op=UNLOAD Nov 1 00:16:22.410523 systemd[1]: Starting systemd-udevd.service... Nov 1 00:16:22.428607 systemd-udevd[1229]: Using default interface naming scheme 'v252'. Nov 1 00:16:23.652150 systemd[1]: Started systemd-udevd.service. Nov 1 00:16:23.660000 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' Nov 1 00:16:23.662000 audit: BPF prog-id=23 op=LOAD Nov 1 00:16:23.663402 systemd[1]: Starting systemd-networkd.service... Nov 1 00:16:23.695267 systemd[1]: Condition check resulted in dev-ttyAMA0.device being skipped. Nov 1 00:16:23.761056 kernel: mousedev: PS/2 mouse device common for all mice Nov 1 00:16:23.766619 systemd[1]: Starting systemd-userdbd.service... Nov 1 00:16:23.765000 audit: BPF prog-id=24 op=LOAD Nov 1 00:16:23.765000 audit: BPF prog-id=25 op=LOAD Nov 1 00:16:23.765000 audit: BPF prog-id=26 op=LOAD Nov 1 00:16:23.770000 audit[1246]: AVC avc: denied { confidentiality } for pid=1246 comm="(udev-worker)" lockdown_reason="use of tracefs" scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=lockdown permissive=1 Nov 1 00:16:23.777066 kernel: hv_vmbus: registering driver hv_balloon Nov 1 00:16:23.777147 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0 Nov 1 00:16:23.786855 kernel: hv_balloon: Memory hot add disabled on ARM64 Nov 1 00:16:23.770000 audit[1246]: SYSCALL arch=c00000b7 syscall=105 success=yes exit=0 a0=aaaacd211f80 a1=aa2c a2=ffff85ef24b0 a3=aaaacd16b010 items=12 ppid=1229 pid=1246 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="(udev-worker)" exe="/usr/bin/udevadm" subj=system_u:system_r:kernel_t:s0 key=(null) Nov 1 00:16:23.770000 audit: CWD cwd="/" Nov 1 00:16:23.770000 audit: PATH item=0 name=(null) inode=7292 dev=00:0a mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Nov 1 00:16:23.770000 audit: PATH item=1 name=(null) inode=11422 dev=00:0a mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Nov 1 00:16:23.770000 audit: PATH item=2 name=(null) inode=11422 dev=00:0a mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Nov 1 00:16:23.770000 audit: PATH item=3 name=(null) inode=11423 dev=00:0a mode=0100640 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Nov 1 00:16:23.770000 audit: PATH item=4 name=(null) inode=11422 dev=00:0a mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Nov 1 00:16:23.770000 audit: PATH item=5 name=(null) inode=11424 dev=00:0a mode=0100440 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Nov 1 00:16:23.770000 audit: PATH item=6 name=(null) inode=11422 dev=00:0a mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Nov 1 00:16:23.770000 audit: PATH item=7 name=(null) inode=11425 dev=00:0a mode=0100640 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Nov 1 00:16:23.770000 audit: PATH item=8 name=(null) inode=11422 dev=00:0a mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Nov 1 00:16:23.770000 audit: PATH item=9 name=(null) inode=11426 dev=00:0a mode=0100640 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Nov 1 00:16:23.770000 audit: PATH item=10 name=(null) inode=11422 dev=00:0a mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Nov 1 00:16:23.770000 audit: PATH item=11 name=(null) inode=11427 dev=00:0a mode=0100440 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Nov 1 00:16:23.770000 audit: PROCTITLE proctitle="(udev-worker)" Nov 1 00:16:23.816083 kernel: hv_vmbus: registering driver hyperv_fb Nov 1 00:16:23.830105 kernel: hyperv_fb: Synthvid Version major 3, minor 5 Nov 1 00:16:23.830203 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 Nov 1 00:16:23.836104 kernel: Console: switching to colour dummy device 80x25 Nov 1 00:16:23.840061 kernel: Console: switching to colour frame buffer device 128x48 Nov 1 00:16:23.866141 kernel: hv_utils: Registering HyperV Utility Driver Nov 1 00:16:23.866261 kernel: hv_vmbus: registering driver hv_utils Nov 1 00:16:23.871179 kernel: hv_utils: Heartbeat IC version 3.0 Nov 1 00:16:23.871270 kernel: hv_utils: Shutdown IC version 3.2 Nov 1 00:16:23.871155 systemd[1]: Started systemd-userdbd.service. Nov 1 00:16:23.883072 kernel: hv_utils: TimeSync IC version 4.0 Nov 1 00:16:24.142000 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' Nov 1 00:16:24.512804 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. Nov 1 00:16:24.519971 systemd[1]: Finished systemd-udev-settle.service. Nov 1 00:16:24.523000 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' Nov 1 00:16:24.526193 systemd[1]: Starting lvm2-activation-early.service... Nov 1 00:16:24.871656 lvm[1306]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 1 00:16:24.906573 systemd-networkd[1250]: lo: Link UP Nov 1 00:16:24.906852 systemd-networkd[1250]: lo: Gained carrier Nov 1 00:16:24.907303 systemd-networkd[1250]: Enumeration completed Nov 1 00:16:24.907401 systemd[1]: Started systemd-networkd.service. Nov 1 00:16:24.911000 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' Nov 1 00:16:24.915819 systemd[1]: Starting systemd-networkd-wait-online.service... Nov 1 00:16:24.918114 kernel: kauditd_printk_skb: 71 callbacks suppressed Nov 1 00:16:24.918182 kernel: audit: type=1130 audit(1761956184.911:155): 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' Nov 1 00:16:24.943932 systemd-networkd[1250]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Nov 1 00:16:24.955571 systemd[1]: Finished lvm2-activation-early.service. Nov 1 00:16:24.959000 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' Nov 1 00:16:24.961549 systemd[1]: Reached target cryptsetup.target. Nov 1 00:16:24.988479 kernel: audit: type=1130 audit(1761956184.959:156): 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' Nov 1 00:16:24.990951 systemd[1]: Starting lvm2-activation.service... Nov 1 00:16:24.994892 lvm[1308]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 1 00:16:25.023096 kernel: mlx5_core 84c5:00:02.0 enP33989s1: Link up Nov 1 00:16:25.023347 kernel: buffer_size[0]=0 is not enough for lossless buffer Nov 1 00:16:25.023400 systemd[1]: Finished lvm2-activation.service. Nov 1 00:16:25.027000 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' Nov 1 00:16:25.030636 systemd[1]: Reached target local-fs-pre.target. Nov 1 00:16:25.062343 kernel: audit: type=1130 audit(1761956185.027:157): 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' Nov 1 00:16:25.062451 kernel: hv_netvsc 000d3a07-7eb4-000d-3a07-7eb4000d3a07 eth0: Data path switched to VF: enP33989s1 Nov 1 00:16:25.063046 systemd-networkd[1250]: enP33989s1: Link UP Nov 1 00:16:25.063137 systemd-networkd[1250]: eth0: Link UP Nov 1 00:16:25.063141 systemd-networkd[1250]: eth0: Gained carrier Nov 1 00:16:25.063834 systemd[1]: var-lib-machines.mount was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Nov 1 00:16:25.063863 systemd[1]: Reached target local-fs.target. Nov 1 00:16:25.068997 systemd[1]: Reached target machines.target. Nov 1 00:16:25.075767 systemd-networkd[1250]: enP33989s1: Gained carrier Nov 1 00:16:25.076222 systemd[1]: Starting ldconfig.service... Nov 1 00:16:25.084586 systemd-networkd[1250]: eth0: DHCPv4 address 10.200.20.39/24, gateway 10.200.20.1 acquired from 168.63.129.16 Nov 1 00:16:25.112713 systemd[1]: systemd-binfmt.service was skipped because no trigger condition checks were met. Nov 1 00:16:25.112925 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). Nov 1 00:16:25.114200 systemd[1]: Starting systemd-boot-update.service... Nov 1 00:16:25.120503 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service... Nov 1 00:16:25.127988 systemd[1]: Starting systemd-machine-id-commit.service... Nov 1 00:16:25.133617 systemd[1]: systemd-sysext.service was skipped because no trigger condition checks were met. Nov 1 00:16:25.133684 systemd[1]: ensure-sysext.service was skipped because no trigger condition checks were met. Nov 1 00:16:25.134891 systemd[1]: Starting systemd-tmpfiles-setup.service... Nov 1 00:16:25.164636 systemd-tmpfiles[1313]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Nov 1 00:16:25.241258 systemd[1]: boot.automount: Got automount request for /boot, triggered by 1310 (bootctl) Nov 1 00:16:25.242682 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service... Nov 1 00:16:25.274997 systemd-tmpfiles[1313]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Nov 1 00:16:25.277759 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service. Nov 1 00:16:25.283000 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' Nov 1 00:16:25.304494 kernel: audit: type=1130 audit(1761956185.283:158): 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' Nov 1 00:16:25.304609 systemd-tmpfiles[1313]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Nov 1 00:16:25.350787 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Nov 1 00:16:25.351390 systemd[1]: Finished systemd-machine-id-commit.service. Nov 1 00:16:25.355000 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' Nov 1 00:16:25.376502 kernel: audit: type=1130 audit(1761956185.355:159): 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' Nov 1 00:16:25.553352 systemd-fsck[1318]: fsck.fat 4.2 (2021-01-31) Nov 1 00:16:25.553352 systemd-fsck[1318]: /dev/sda1: 236 files, 117310/258078 clusters Nov 1 00:16:25.555274 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service. Nov 1 00:16:25.560000 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' Nov 1 00:16:25.563269 systemd[1]: Mounting boot.mount... Nov 1 00:16:25.587015 kernel: audit: type=1130 audit(1761956185.560:160): 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' Nov 1 00:16:25.592385 systemd[1]: Mounted boot.mount. Nov 1 00:16:25.606785 systemd[1]: Finished systemd-boot-update.service. Nov 1 00:16:25.610000 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' Nov 1 00:16:25.632481 kernel: audit: type=1130 audit(1761956185.610:161): 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' Nov 1 00:16:26.446629 systemd-networkd[1250]: eth0: Gained IPv6LL Nov 1 00:16:26.451385 systemd[1]: Finished systemd-networkd-wait-online.service. Nov 1 00:16:26.455000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-networkd-wait-online comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:16:26.477504 kernel: audit: type=1130 audit(1761956186.455:162): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-networkd-wait-online comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:16:28.979270 systemd[1]: Finished systemd-tmpfiles-setup.service. Nov 1 00:16:28.983000 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' Nov 1 00:16:28.986658 systemd[1]: Starting audit-rules.service... Nov 1 00:16:29.008734 kernel: audit: type=1130 audit(1761956188.983:163): 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' Nov 1 00:16:29.010201 systemd[1]: Starting clean-ca-certificates.service... Nov 1 00:16:29.015602 systemd[1]: Starting systemd-journal-catalog-update.service... Nov 1 00:16:29.020000 audit: BPF prog-id=27 op=LOAD Nov 1 00:16:29.027868 systemd[1]: Starting systemd-resolved.service... Nov 1 00:16:29.029475 kernel: audit: type=1334 audit(1761956189.020:164): prog-id=27 op=LOAD Nov 1 00:16:29.032000 audit: BPF prog-id=28 op=LOAD Nov 1 00:16:29.034643 systemd[1]: Starting systemd-timesyncd.service... Nov 1 00:16:29.040349 systemd[1]: Starting systemd-update-utmp.service... Nov 1 00:16:29.116478 systemd[1]: Finished clean-ca-certificates.service. Nov 1 00:16:29.120000 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' Nov 1 00:16:29.121639 systemd[1]: update-ca-certificates.service was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Nov 1 00:16:29.146000 audit[1331]: SYSTEM_BOOT pid=1331 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' Nov 1 00:16:29.151260 systemd[1]: Finished systemd-update-utmp.service. Nov 1 00:16:29.155000 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' Nov 1 00:16:29.169677 systemd[1]: Started systemd-timesyncd.service. Nov 1 00:16:29.173000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-timesyncd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:16:29.174980 systemd[1]: Reached target time-set.target. Nov 1 00:16:29.237184 systemd-resolved[1329]: Positive Trust Anchors: Nov 1 00:16:29.237544 systemd-resolved[1329]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 1 00:16:29.237622 systemd-resolved[1329]: 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 Nov 1 00:16:29.327913 systemd-resolved[1329]: Using system hostname 'ci-3510.3.8-n-26178e8619'. Nov 1 00:16:29.329438 systemd[1]: Started systemd-resolved.service. Nov 1 00:16:29.332000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:16:29.334104 systemd[1]: Reached target network.target. Nov 1 00:16:29.338815 systemd[1]: Reached target network-online.target. Nov 1 00:16:29.343616 systemd[1]: Reached target nss-lookup.target. Nov 1 00:16:29.448643 systemd[1]: Finished systemd-journal-catalog-update.service. Nov 1 00:16:29.453000 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' Nov 1 00:16:29.561430 systemd-timesyncd[1330]: Contacted time server 23.186.168.132:123 (0.flatcar.pool.ntp.org). Nov 1 00:16:29.561506 systemd-timesyncd[1330]: Initial clock synchronization to Sat 2025-11-01 00:16:29.559769 UTC. Nov 1 00:16:29.628014 augenrules[1346]: No rules Nov 1 00:16:29.626000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Nov 1 00:16:29.626000 audit[1346]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffe4c909c0 a2=420 a3=0 items=0 ppid=1325 pid=1346 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) Nov 1 00:16:29.626000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Nov 1 00:16:29.628750 systemd[1]: Finished audit-rules.service. Nov 1 00:16:38.401419 ldconfig[1309]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Nov 1 00:16:38.412479 systemd[1]: Finished ldconfig.service. Nov 1 00:16:38.419344 systemd[1]: Starting systemd-update-done.service... Nov 1 00:16:38.473068 systemd[1]: Finished systemd-update-done.service. Nov 1 00:16:38.478122 systemd[1]: Reached target sysinit.target. Nov 1 00:16:38.482597 systemd[1]: Started motdgen.path. Nov 1 00:16:38.486353 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path. Nov 1 00:16:38.493094 systemd[1]: Started logrotate.timer. Nov 1 00:16:38.497104 systemd[1]: Started mdadm.timer. Nov 1 00:16:38.500673 systemd[1]: Started systemd-tmpfiles-clean.timer. Nov 1 00:16:38.505388 systemd[1]: update-engine-stub.timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Nov 1 00:16:38.505422 systemd[1]: Reached target paths.target. Nov 1 00:16:38.509665 systemd[1]: Reached target timers.target. Nov 1 00:16:38.514373 systemd[1]: Listening on dbus.socket. Nov 1 00:16:38.519549 systemd[1]: Starting docker.socket... Nov 1 00:16:38.556618 systemd[1]: Listening on sshd.socket. Nov 1 00:16:38.561025 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). Nov 1 00:16:38.561568 systemd[1]: Listening on docker.socket. Nov 1 00:16:38.565879 systemd[1]: Reached target sockets.target. Nov 1 00:16:38.570384 systemd[1]: Reached target basic.target. Nov 1 00:16:38.574667 systemd[1]: addon-config@usr-share-oem.service was skipped because no trigger condition checks were met. Nov 1 00:16:38.574697 systemd[1]: addon-run@usr-share-oem.service was skipped because no trigger condition checks were met. Nov 1 00:16:38.575976 systemd[1]: Starting containerd.service... Nov 1 00:16:38.580864 systemd[1]: Starting coreos-metadata.service... Nov 1 00:16:38.586139 systemd[1]: Starting dbus.service... Nov 1 00:16:38.590532 systemd[1]: Starting enable-oem-cloudinit.service... Nov 1 00:16:38.595950 systemd[1]: Starting extend-filesystems.service... Nov 1 00:16:38.600629 systemd[1]: flatcar-setup-environment.service was skipped because of an unmet condition check (ConditionPathExists=/usr/share/oem/bin/flatcar-setup-environment). Nov 1 00:16:38.601909 systemd[1]: Starting motdgen.service... Nov 1 00:16:38.606904 systemd[1]: Started nvidia.service. Nov 1 00:16:38.611935 systemd[1]: Starting ssh-key-proc-cmdline.service... Nov 1 00:16:38.617508 systemd[1]: Starting sshd-keygen.service... Nov 1 00:16:38.623338 systemd[1]: Starting systemd-logind.service... Nov 1 00:16:38.629680 systemd[1]: systemd-pcrphase.service was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/StubPcrKernelImage-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). Nov 1 00:16:38.629739 systemd[1]: tcsd.service was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Nov 1 00:16:38.630176 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Nov 1 00:16:38.632044 systemd[1]: Starting update-engine.service... Nov 1 00:16:38.637005 systemd[1]: Starting update-ssh-keys-after-ignition.service... Nov 1 00:16:38.647273 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Nov 1 00:16:38.647466 systemd[1]: Finished ssh-key-proc-cmdline.service. Nov 1 00:16:38.688318 coreos-metadata[1355]: Nov 01 00:16:38.688 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Nov 1 00:16:38.692972 jq[1369]: true Nov 1 00:16:38.693358 jq[1359]: false Nov 1 00:16:38.693546 coreos-metadata[1355]: Nov 01 00:16:38.693 INFO Fetch successful Nov 1 00:16:38.693714 coreos-metadata[1355]: Nov 01 00:16:38.693 INFO Fetching http://168.63.129.16/machine/?comp=goalstate: Attempt #1 Nov 1 00:16:38.697945 coreos-metadata[1355]: Nov 01 00:16:38.697 INFO Fetch successful Nov 1 00:16:38.698421 coreos-metadata[1355]: Nov 01 00:16:38.698 INFO Fetching http://168.63.129.16/machine/f21307bc-933e-4c92-ba00-1c749ffc9a1e/0979ee4a%2Df601%2D4052%2Db0ae%2D3ef3a12989ae.%5Fci%2D3510.3.8%2Dn%2D26178e8619?comp=config&type=sharedConfig&incarnation=1: Attempt #1 Nov 1 00:16:38.700339 coreos-metadata[1355]: Nov 01 00:16:38.700 INFO Fetch successful Nov 1 00:16:38.711837 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Nov 1 00:16:38.712017 systemd[1]: Condition check resulted in enable-oem-cloudinit.service being skipped. Nov 1 00:16:38.727169 systemd[1]: motdgen.service: Deactivated successfully. Nov 1 00:16:38.727355 systemd[1]: Finished motdgen.service. Nov 1 00:16:38.736075 extend-filesystems[1360]: Found sda Nov 1 00:16:38.740187 extend-filesystems[1360]: Found sda1 Nov 1 00:16:38.740187 extend-filesystems[1360]: Found sda2 Nov 1 00:16:38.750237 extend-filesystems[1360]: Found sda3 Nov 1 00:16:38.750237 extend-filesystems[1360]: Found usr Nov 1 00:16:38.750237 extend-filesystems[1360]: Found sda4 Nov 1 00:16:38.750237 extend-filesystems[1360]: Found sda6 Nov 1 00:16:38.750237 extend-filesystems[1360]: Found sda7 Nov 1 00:16:38.750237 extend-filesystems[1360]: Found sda9 Nov 1 00:16:38.750237 extend-filesystems[1360]: Checking size of /dev/sda9 Nov 1 00:16:38.808948 jq[1379]: true Nov 1 00:16:38.774214 systemd-logind[1365]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Nov 1 00:16:38.809282 coreos-metadata[1355]: Nov 01 00:16:38.765 INFO Fetching http://169.254.169.254/metadata/instance/compute/vmSize?api-version=2017-08-01&format=text: Attempt #1 Nov 1 00:16:38.809282 coreos-metadata[1355]: Nov 01 00:16:38.789 INFO Fetch successful Nov 1 00:16:38.774547 systemd-logind[1365]: New seat seat0. Nov 1 00:16:38.808903 systemd[1]: Finished coreos-metadata.service. Nov 1 00:16:38.813904 systemd[1]: Reached target metadata.target. Nov 1 00:16:38.828150 env[1380]: time="2025-11-01T00:16:38.828098515Z" level=info msg="starting containerd" revision=92b3a9d6f1b3bcc6dc74875cfdea653fe39f09c2 version=1.6.16 Nov 1 00:16:38.858223 env[1380]: time="2025-11-01T00:16:38.858166407Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Nov 1 00:16:38.858365 env[1380]: time="2025-11-01T00:16:38.858337357Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Nov 1 00:16:38.860559 env[1380]: time="2025-11-01T00:16:38.860520830Z" 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.192-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Nov 1 00:16:38.860559 env[1380]: time="2025-11-01T00:16:38.860558028Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Nov 1 00:16:38.860816 env[1380]: time="2025-11-01T00:16:38.860787614Z" 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 Nov 1 00:16:38.860816 env[1380]: time="2025-11-01T00:16:38.860812853Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Nov 1 00:16:38.860877 env[1380]: time="2025-11-01T00:16:38.860826652Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Nov 1 00:16:38.860877 env[1380]: time="2025-11-01T00:16:38.860836572Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Nov 1 00:16:38.860920 env[1380]: time="2025-11-01T00:16:38.860908527Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Nov 1 00:16:38.861137 env[1380]: time="2025-11-01T00:16:38.861111796Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Nov 1 00:16:38.861273 env[1380]: time="2025-11-01T00:16:38.861249188Z" 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 Nov 1 00:16:38.861273 env[1380]: time="2025-11-01T00:16:38.861270466Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Nov 1 00:16:38.861343 env[1380]: time="2025-11-01T00:16:38.861322223Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Nov 1 00:16:38.861343 env[1380]: time="2025-11-01T00:16:38.861340062Z" level=info msg="metadata content store policy set" policy=shared Nov 1 00:16:38.876432 env[1380]: time="2025-11-01T00:16:38.876379788Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Nov 1 00:16:38.876552 env[1380]: time="2025-11-01T00:16:38.876439904Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Nov 1 00:16:38.876552 env[1380]: time="2025-11-01T00:16:38.876478702Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Nov 1 00:16:38.876552 env[1380]: time="2025-11-01T00:16:38.876527299Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Nov 1 00:16:38.876552 env[1380]: time="2025-11-01T00:16:38.876543898Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Nov 1 00:16:38.876638 env[1380]: time="2025-11-01T00:16:38.876557897Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Nov 1 00:16:38.876638 env[1380]: time="2025-11-01T00:16:38.876570617Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Nov 1 00:16:38.876996 env[1380]: time="2025-11-01T00:16:38.876968074Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Nov 1 00:16:38.877028 env[1380]: time="2025-11-01T00:16:38.876996952Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1 Nov 1 00:16:38.877028 env[1380]: time="2025-11-01T00:16:38.877012551Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Nov 1 00:16:38.877028 env[1380]: time="2025-11-01T00:16:38.877024750Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Nov 1 00:16:38.877090 env[1380]: time="2025-11-01T00:16:38.877037509Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Nov 1 00:16:38.877233 env[1380]: time="2025-11-01T00:16:38.877210419Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Nov 1 00:16:38.877334 env[1380]: time="2025-11-01T00:16:38.877312813Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Nov 1 00:16:38.877880 env[1380]: time="2025-11-01T00:16:38.877854182Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Nov 1 00:16:38.877927 env[1380]: time="2025-11-01T00:16:38.877907739Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Nov 1 00:16:38.877967 env[1380]: time="2025-11-01T00:16:38.877928178Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Nov 1 00:16:38.878011 env[1380]: time="2025-11-01T00:16:38.877991374Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Nov 1 00:16:38.878011 env[1380]: time="2025-11-01T00:16:38.878010373Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Nov 1 00:16:38.878065 env[1380]: time="2025-11-01T00:16:38.878022452Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Nov 1 00:16:38.878111 env[1380]: time="2025-11-01T00:16:38.878034811Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Nov 1 00:16:38.878140 env[1380]: time="2025-11-01T00:16:38.878110527Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Nov 1 00:16:38.878140 env[1380]: time="2025-11-01T00:16:38.878124286Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Nov 1 00:16:38.878140 env[1380]: time="2025-11-01T00:16:38.878135766Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Nov 1 00:16:38.878200 env[1380]: time="2025-11-01T00:16:38.878147125Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Nov 1 00:16:38.878200 env[1380]: time="2025-11-01T00:16:38.878162524Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Nov 1 00:16:38.878375 env[1380]: time="2025-11-01T00:16:38.878354273Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Nov 1 00:16:38.878408 env[1380]: time="2025-11-01T00:16:38.878376912Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Nov 1 00:16:38.878408 env[1380]: time="2025-11-01T00:16:38.878390951Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Nov 1 00:16:38.878467 env[1380]: time="2025-11-01T00:16:38.878402830Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Nov 1 00:16:38.878467 env[1380]: time="2025-11-01T00:16:38.878428789Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="no OpenTelemetry endpoint: skip plugin" type=io.containerd.tracing.processor.v1 Nov 1 00:16:38.878467 env[1380]: time="2025-11-01T00:16:38.878440148Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Nov 1 00:16:38.878540 env[1380]: time="2025-11-01T00:16:38.878472626Z" level=error msg="failed to initialize a tracing processor \"otlp\"" error="no OpenTelemetry endpoint: skip plugin" Nov 1 00:16:38.878540 env[1380]: time="2025-11-01T00:16:38.878513144Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Nov 1 00:16:38.878785 env[1380]: time="2025-11-01T00:16:38.878731171Z" 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}" Nov 1 00:16:38.899705 env[1380]: time="2025-11-01T00:16:38.878798847Z" level=info msg="Connect containerd service" Nov 1 00:16:38.899705 env[1380]: time="2025-11-01T00:16:38.878830685Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Nov 1 00:16:38.899705 env[1380]: time="2025-11-01T00:16:38.879523365Z" 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" Nov 1 00:16:38.899705 env[1380]: time="2025-11-01T00:16:38.879643678Z" level=info msg="Start subscribing containerd event" Nov 1 00:16:38.899705 env[1380]: time="2025-11-01T00:16:38.879681316Z" level=info msg="Start recovering state" Nov 1 00:16:38.899705 env[1380]: time="2025-11-01T00:16:38.879743432Z" level=info msg="Start event monitor" Nov 1 00:16:38.899705 env[1380]: time="2025-11-01T00:16:38.879757911Z" level=info msg="Start snapshots syncer" Nov 1 00:16:38.899705 env[1380]: time="2025-11-01T00:16:38.879766471Z" level=info msg="Start cni network conf syncer for default" Nov 1 00:16:38.899705 env[1380]: time="2025-11-01T00:16:38.879774070Z" level=info msg="Start streaming server" Nov 1 00:16:38.899705 env[1380]: time="2025-11-01T00:16:38.880128890Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Nov 1 00:16:38.899705 env[1380]: time="2025-11-01T00:16:38.880188206Z" level=info msg=serving... address=/run/containerd/containerd.sock Nov 1 00:16:38.899705 env[1380]: time="2025-11-01T00:16:38.894178953Z" level=info msg="containerd successfully booted in 0.066989s" Nov 1 00:16:38.880358 systemd[1]: Started containerd.service. Nov 1 00:16:38.931249 extend-filesystems[1360]: Old size kept for /dev/sda9 Nov 1 00:16:38.931249 extend-filesystems[1360]: Found sr0 Nov 1 00:16:38.931743 systemd[1]: extend-filesystems.service: Deactivated successfully. Nov 1 00:16:38.931968 systemd[1]: Finished extend-filesystems.service. Nov 1 00:16:38.976484 bash[1422]: Updated "/home/core/.ssh/authorized_keys" Nov 1 00:16:38.979485 systemd[1]: Finished update-ssh-keys-after-ignition.service. Nov 1 00:16:39.089848 systemd[1]: nvidia.service: Deactivated successfully. Nov 1 00:16:39.484705 dbus-daemon[1358]: [system] SELinux support is enabled Nov 1 00:16:39.484864 systemd[1]: Started dbus.service. Nov 1 00:16:39.490357 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). Nov 1 00:16:39.490390 systemd[1]: Reached target system-config.target. Nov 1 00:16:39.497083 systemd[1]: user-cloudinit-proc-cmdline.service was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Nov 1 00:16:39.497105 systemd[1]: Reached target user-config.target. Nov 1 00:16:39.502966 dbus-daemon[1358]: [system] Successfully activated service 'org.freedesktop.systemd1' Nov 1 00:16:39.503108 systemd[1]: Started systemd-logind.service. Nov 1 00:16:39.663547 update_engine[1368]: I1101 00:16:39.647500 1368 main.cc:92] Flatcar Update Engine starting Nov 1 00:16:39.738270 systemd[1]: Started update-engine.service. Nov 1 00:16:39.738619 update_engine[1368]: I1101 00:16:39.738322 1368 update_check_scheduler.cc:74] Next update check in 6m46s Nov 1 00:16:39.747500 systemd[1]: Started locksmithd.service. Nov 1 00:16:40.475182 sshd_keygen[1376]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Nov 1 00:16:40.492698 systemd[1]: Finished sshd-keygen.service. Nov 1 00:16:40.498627 systemd[1]: Starting issuegen.service... Nov 1 00:16:40.503378 systemd[1]: Started waagent.service. Nov 1 00:16:40.508331 systemd[1]: issuegen.service: Deactivated successfully. Nov 1 00:16:40.508528 systemd[1]: Finished issuegen.service. Nov 1 00:16:40.513941 systemd[1]: Starting systemd-user-sessions.service... Nov 1 00:16:40.592453 systemd[1]: Finished systemd-user-sessions.service. Nov 1 00:16:40.599417 systemd[1]: Started getty@tty1.service. Nov 1 00:16:40.605934 systemd[1]: Started serial-getty@ttyAMA0.service. Nov 1 00:16:40.611562 systemd[1]: Reached target getty.target. Nov 1 00:16:40.616433 systemd[1]: Reached target multi-user.target. Nov 1 00:16:40.622984 systemd[1]: Starting systemd-update-utmp-runlevel.service... Nov 1 00:16:40.637397 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Nov 1 00:16:40.637585 systemd[1]: Finished systemd-update-utmp-runlevel.service. Nov 1 00:16:40.643250 systemd[1]: Startup finished in 733ms (kernel) + 15.752s (initrd) + 34.991s (userspace) = 51.476s. Nov 1 00:16:41.505326 locksmithd[1463]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Nov 1 00:16:41.887089 login[1481]: pam_lastlog(login:session): file /var/log/lastlog is locked/read Nov 1 00:16:41.929281 login[1482]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Nov 1 00:16:42.118938 systemd[1]: Created slice user-500.slice. Nov 1 00:16:42.120182 systemd[1]: Starting user-runtime-dir@500.service... Nov 1 00:16:42.123564 systemd-logind[1365]: New session 2 of user core. Nov 1 00:16:42.179111 systemd[1]: Finished user-runtime-dir@500.service. Nov 1 00:16:42.180713 systemd[1]: Starting user@500.service... Nov 1 00:16:42.263441 (systemd)[1485]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Nov 1 00:16:42.764398 systemd[1485]: Queued start job for default target default.target. Nov 1 00:16:42.764942 systemd[1485]: Reached target paths.target. Nov 1 00:16:42.764963 systemd[1485]: Reached target sockets.target. Nov 1 00:16:42.764974 systemd[1485]: Reached target timers.target. Nov 1 00:16:42.764984 systemd[1485]: Reached target basic.target. Nov 1 00:16:42.765081 systemd[1]: Started user@500.service. Nov 1 00:16:42.765929 systemd[1]: Started session-2.scope. Nov 1 00:16:42.766382 systemd[1485]: Reached target default.target. Nov 1 00:16:42.766637 systemd[1485]: Startup finished in 495ms. Nov 1 00:16:42.887447 login[1481]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Nov 1 00:16:42.891705 systemd[1]: Started session-1.scope. Nov 1 00:16:42.892037 systemd-logind[1365]: New session 1 of user core. Nov 1 00:16:51.231735 waagent[1478]: 2025-11-01T00:16:51.231621Z INFO Daemon Daemon Azure Linux Agent Version:2.6.0.2 Nov 1 00:16:51.257129 waagent[1478]: 2025-11-01T00:16:51.257016Z INFO Daemon Daemon OS: flatcar 3510.3.8 Nov 1 00:16:51.261957 waagent[1478]: 2025-11-01T00:16:51.261882Z INFO Daemon Daemon Python: 3.9.16 Nov 1 00:16:51.272509 waagent[1478]: 2025-11-01T00:16:51.266558Z INFO Daemon Daemon Run daemon Nov 1 00:16:51.272509 waagent[1478]: 2025-11-01T00:16:51.271659Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='3510.3.8' Nov 1 00:16:51.305218 waagent[1478]: 2025-11-01T00:16:51.305059Z INFO Daemon Daemon Unable to get cloud-init enabled status from systemctl: Command '['systemctl', 'is-enabled', 'cloud-init-local.service']' returned non-zero exit status 1. Nov 1 00:16:51.320786 waagent[1478]: 2025-11-01T00:16:51.320638Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' Nov 1 00:16:51.331166 waagent[1478]: 2025-11-01T00:16:51.331077Z INFO Daemon Daemon cloud-init is enabled: False Nov 1 00:16:51.336312 waagent[1478]: 2025-11-01T00:16:51.336234Z INFO Daemon Daemon Using waagent for provisioning Nov 1 00:16:51.342167 waagent[1478]: 2025-11-01T00:16:51.342094Z INFO Daemon Daemon Activate resource disk Nov 1 00:16:51.347200 waagent[1478]: 2025-11-01T00:16:51.347130Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb Nov 1 00:16:51.362174 waagent[1478]: 2025-11-01T00:16:51.362089Z INFO Daemon Daemon Found device: None Nov 1 00:16:51.367266 waagent[1478]: 2025-11-01T00:16:51.367190Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology Nov 1 00:16:51.375798 waagent[1478]: 2025-11-01T00:16:51.375723Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 Nov 1 00:16:51.387825 waagent[1478]: 2025-11-01T00:16:51.387755Z INFO Daemon Daemon Clean protocol and wireserver endpoint Nov 1 00:16:51.393728 waagent[1478]: 2025-11-01T00:16:51.393659Z INFO Daemon Daemon Running default provisioning handler Nov 1 00:16:51.407074 waagent[1478]: 2025-11-01T00:16:51.406925Z INFO Daemon Daemon Unable to get cloud-init enabled status from systemctl: Command '['systemctl', 'is-enabled', 'cloud-init-local.service']' returned non-zero exit status 1. Nov 1 00:16:51.422304 waagent[1478]: 2025-11-01T00:16:51.422160Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' Nov 1 00:16:51.432322 waagent[1478]: 2025-11-01T00:16:51.432234Z INFO Daemon Daemon cloud-init is enabled: False Nov 1 00:16:51.437537 waagent[1478]: 2025-11-01T00:16:51.437451Z INFO Daemon Daemon Copying ovf-env.xml Nov 1 00:16:51.608052 waagent[1478]: 2025-11-01T00:16:51.607908Z INFO Daemon Daemon Successfully mounted dvd Nov 1 00:16:51.770694 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully. Nov 1 00:16:51.849415 waagent[1478]: 2025-11-01T00:16:51.849266Z INFO Daemon Daemon Detect protocol endpoint Nov 1 00:16:51.854656 waagent[1478]: 2025-11-01T00:16:51.854568Z INFO Daemon Daemon Clean protocol and wireserver endpoint Nov 1 00:16:51.860838 waagent[1478]: 2025-11-01T00:16:51.860722Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler Nov 1 00:16:51.867794 waagent[1478]: 2025-11-01T00:16:51.867717Z INFO Daemon Daemon Test for route to 168.63.129.16 Nov 1 00:16:51.873515 waagent[1478]: 2025-11-01T00:16:51.873427Z INFO Daemon Daemon Route to 168.63.129.16 exists Nov 1 00:16:51.878902 waagent[1478]: 2025-11-01T00:16:51.878833Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 Nov 1 00:16:52.084682 waagent[1478]: 2025-11-01T00:16:52.084604Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 Nov 1 00:16:52.092623 waagent[1478]: 2025-11-01T00:16:52.092573Z INFO Daemon Daemon Wire protocol version:2012-11-30 Nov 1 00:16:52.098415 waagent[1478]: 2025-11-01T00:16:52.098341Z INFO Daemon Daemon Server preferred version:2015-04-05 Nov 1 00:16:52.776174 waagent[1478]: 2025-11-01T00:16:52.776015Z INFO Daemon Daemon Initializing goal state during protocol detection Nov 1 00:16:52.789115 waagent[1478]: 2025-11-01T00:16:52.789033Z INFO Daemon Daemon Forcing an update of the goal state.. Nov 1 00:16:52.795161 waagent[1478]: 2025-11-01T00:16:52.795085Z INFO Daemon Daemon Fetching goal state [incarnation 1] Nov 1 00:16:52.878276 waagent[1478]: 2025-11-01T00:16:52.878107Z INFO Daemon Daemon Found private key matching thumbprint 8666A484BF2972EFBD3DA22FA0727CBE2864DB2D Nov 1 00:16:52.887083 waagent[1478]: 2025-11-01T00:16:52.886998Z INFO Daemon Daemon Fetch goal state completed Nov 1 00:16:52.915135 waagent[1478]: 2025-11-01T00:16:52.915073Z INFO Daemon Daemon Fetched new vmSettings [correlation ID: 0e7c85d4-6336-483a-a11b-d1e54df92049 New eTag: 15145665199935494881] Nov 1 00:16:52.926119 waagent[1478]: 2025-11-01T00:16:52.926035Z INFO Daemon Daemon Status Blob type 'None' is not valid, assuming BlockBlob Nov 1 00:16:52.942599 waagent[1478]: 2025-11-01T00:16:52.942524Z INFO Daemon Daemon Starting provisioning Nov 1 00:16:52.947664 waagent[1478]: 2025-11-01T00:16:52.947587Z INFO Daemon Daemon Handle ovf-env.xml. Nov 1 00:16:52.952401 waagent[1478]: 2025-11-01T00:16:52.952332Z INFO Daemon Daemon Set hostname [ci-3510.3.8-n-26178e8619] Nov 1 00:16:53.026963 waagent[1478]: 2025-11-01T00:16:53.026827Z INFO Daemon Daemon Publish hostname [ci-3510.3.8-n-26178e8619] Nov 1 00:16:53.033596 waagent[1478]: 2025-11-01T00:16:53.033509Z INFO Daemon Daemon Examine /proc/net/route for primary interface Nov 1 00:16:53.040183 waagent[1478]: 2025-11-01T00:16:53.040114Z INFO Daemon Daemon Primary interface is [eth0] Nov 1 00:16:53.056392 systemd[1]: systemd-networkd-wait-online.service: Deactivated successfully. Nov 1 00:16:53.056588 systemd[1]: Stopped systemd-networkd-wait-online.service. Nov 1 00:16:53.056645 systemd[1]: Stopping systemd-networkd-wait-online.service... Nov 1 00:16:53.056911 systemd[1]: Stopping systemd-networkd.service... Nov 1 00:16:53.060509 systemd-networkd[1250]: eth0: DHCPv6 lease lost Nov 1 00:16:53.062807 systemd[1]: systemd-networkd.service: Deactivated successfully. Nov 1 00:16:53.062983 systemd[1]: Stopped systemd-networkd.service. Nov 1 00:16:53.065192 systemd[1]: Starting systemd-networkd.service... Nov 1 00:16:53.094713 systemd-networkd[1526]: enP33989s1: Link UP Nov 1 00:16:53.094723 systemd-networkd[1526]: enP33989s1: Gained carrier Nov 1 00:16:53.095793 systemd-networkd[1526]: eth0: Link UP Nov 1 00:16:53.095803 systemd-networkd[1526]: eth0: Gained carrier Nov 1 00:16:53.096156 systemd-networkd[1526]: lo: Link UP Nov 1 00:16:53.096165 systemd-networkd[1526]: lo: Gained carrier Nov 1 00:16:53.096417 systemd-networkd[1526]: eth0: Gained IPv6LL Nov 1 00:16:53.097667 systemd-networkd[1526]: Enumeration completed Nov 1 00:16:53.097793 systemd[1]: Started systemd-networkd.service. Nov 1 00:16:53.099520 systemd-networkd[1526]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Nov 1 00:16:53.099591 systemd[1]: Starting systemd-networkd-wait-online.service... Nov 1 00:16:53.103804 waagent[1478]: 2025-11-01T00:16:53.103510Z INFO Daemon Daemon Create user account if not exists Nov 1 00:16:53.112753 waagent[1478]: 2025-11-01T00:16:53.111741Z INFO Daemon Daemon User core already exists, skip useradd Nov 1 00:16:53.118579 systemd-networkd[1526]: eth0: DHCPv4 address 10.200.20.39/24, gateway 10.200.20.1 acquired from 168.63.129.16 Nov 1 00:16:53.118749 waagent[1478]: 2025-11-01T00:16:53.118593Z INFO Daemon Daemon Configure sudoer Nov 1 00:16:53.124703 systemd[1]: Finished systemd-networkd-wait-online.service. Nov 1 00:16:53.164092 waagent[1478]: 2025-11-01T00:16:53.163988Z INFO Daemon Daemon Configure sshd Nov 1 00:16:53.168714 waagent[1478]: 2025-11-01T00:16:53.168633Z INFO Daemon Daemon Deploy ssh public key. Nov 1 00:16:54.423224 waagent[1478]: 2025-11-01T00:16:54.423136Z INFO Daemon Daemon Provisioning complete Nov 1 00:16:54.440989 waagent[1478]: 2025-11-01T00:16:54.440922Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping Nov 1 00:16:54.447753 waagent[1478]: 2025-11-01T00:16:54.447681Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. Nov 1 00:16:54.459327 waagent[1478]: 2025-11-01T00:16:54.459249Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.6.0.2 is the most current agent Nov 1 00:16:54.772498 waagent[1532]: 2025-11-01T00:16:54.772326Z INFO ExtHandler ExtHandler Agent WALinuxAgent-2.6.0.2 is running as the goal state agent Nov 1 00:16:54.773648 waagent[1532]: 2025-11-01T00:16:54.773581Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Nov 1 00:16:54.773897 waagent[1532]: 2025-11-01T00:16:54.773850Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16 Nov 1 00:16:54.787778 waagent[1532]: 2025-11-01T00:16:54.787675Z INFO ExtHandler ExtHandler Forcing an update of the goal state.. Nov 1 00:16:54.788136 waagent[1532]: 2025-11-01T00:16:54.788086Z INFO ExtHandler ExtHandler Fetching goal state [incarnation 1] Nov 1 00:16:54.849888 waagent[1532]: 2025-11-01T00:16:54.849756Z INFO ExtHandler ExtHandler Found private key matching thumbprint 8666A484BF2972EFBD3DA22FA0727CBE2864DB2D Nov 1 00:16:54.850338 waagent[1532]: 2025-11-01T00:16:54.850286Z INFO ExtHandler ExtHandler Fetch goal state completed Nov 1 00:16:54.868363 waagent[1532]: 2025-11-01T00:16:54.868302Z INFO ExtHandler ExtHandler Fetched new vmSettings [correlation ID: cde5cd21-0ada-425a-b0fc-5040717c6d9b New eTag: 15145665199935494881] Nov 1 00:16:54.869189 waagent[1532]: 2025-11-01T00:16:54.869126Z INFO ExtHandler ExtHandler Status Blob type 'None' is not valid, assuming BlockBlob Nov 1 00:16:55.014799 waagent[1532]: 2025-11-01T00:16:55.014659Z INFO ExtHandler ExtHandler Distro: flatcar-3510.3.8; OSUtil: CoreOSUtil; AgentService: waagent; Python: 3.9.16; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.20.1; Nov 1 00:16:55.042066 waagent[1532]: 2025-11-01T00:16:55.041975Z INFO ExtHandler ExtHandler WALinuxAgent-2.6.0.2 running as process 1532 Nov 1 00:16:55.046088 waagent[1532]: 2025-11-01T00:16:55.046015Z INFO ExtHandler ExtHandler Cgroup monitoring is not supported on ['flatcar', '3510.3.8', '', 'Flatcar Container Linux by Kinvolk'] Nov 1 00:16:55.047529 waagent[1532]: 2025-11-01T00:16:55.047452Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules Nov 1 00:16:55.216567 waagent[1532]: 2025-11-01T00:16:55.216504Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service Nov 1 00:16:55.217175 waagent[1532]: 2025-11-01T00:16:55.217120Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup Nov 1 00:16:55.224951 waagent[1532]: 2025-11-01T00:16:55.224889Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now Nov 1 00:16:55.225483 waagent[1532]: 2025-11-01T00:16:55.225405Z ERROR ExtHandler ExtHandler Unable to setup the persistent firewall rules: [Errno 30] Read-only file system: '/lib/systemd/system/waagent-network-setup.service' Nov 1 00:16:55.226694 waagent[1532]: 2025-11-01T00:16:55.226624Z INFO ExtHandler ExtHandler Checking if log collection is allowed at this time [False]. All three conditions must be met: configuration enabled [False], cgroups enabled [False], python supported: [True] Nov 1 00:16:55.228088 waagent[1532]: 2025-11-01T00:16:55.228014Z INFO ExtHandler ExtHandler Starting env monitor service. Nov 1 00:16:55.228762 waagent[1532]: 2025-11-01T00:16:55.228703Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Nov 1 00:16:55.229026 waagent[1532]: 2025-11-01T00:16:55.228976Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16 Nov 1 00:16:55.229697 waagent[1532]: 2025-11-01T00:16:55.229632Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled. Nov 1 00:16:55.230428 waagent[1532]: 2025-11-01T00:16:55.230354Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Nov 1 00:16:55.230727 waagent[1532]: 2025-11-01T00:16:55.230661Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16 Nov 1 00:16:55.230943 waagent[1532]: 2025-11-01T00:16:55.230882Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service. Nov 1 00:16:55.231136 waagent[1532]: 2025-11-01T00:16:55.231065Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route: Nov 1 00:16:55.231136 waagent[1532]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT Nov 1 00:16:55.231136 waagent[1532]: eth0 00000000 0114C80A 0003 0 0 1024 00000000 0 0 0 Nov 1 00:16:55.231136 waagent[1532]: eth0 0014C80A 00000000 0001 0 0 1024 00FFFFFF 0 0 0 Nov 1 00:16:55.231136 waagent[1532]: eth0 0114C80A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0 Nov 1 00:16:55.231136 waagent[1532]: eth0 10813FA8 0114C80A 0007 0 0 1024 FFFFFFFF 0 0 0 Nov 1 00:16:55.231136 waagent[1532]: eth0 FEA9FEA9 0114C80A 0007 0 0 1024 FFFFFFFF 0 0 0 Nov 1 00:16:55.232127 waagent[1532]: 2025-11-01T00:16:55.232068Z INFO EnvHandler ExtHandler Configure routes Nov 1 00:16:55.232268 waagent[1532]: 2025-11-01T00:16:55.231723Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread Nov 1 00:16:55.232523 waagent[1532]: 2025-11-01T00:16:55.232433Z INFO EnvHandler ExtHandler Gateway:None Nov 1 00:16:55.232855 waagent[1532]: 2025-11-01T00:16:55.232792Z INFO ExtHandler ExtHandler Start Extension Telemetry service. Nov 1 00:16:55.234860 waagent[1532]: 2025-11-01T00:16:55.234731Z INFO EnvHandler ExtHandler Routes:None Nov 1 00:16:55.235329 waagent[1532]: 2025-11-01T00:16:55.235250Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True Nov 1 00:16:55.236625 waagent[1532]: 2025-11-01T00:16:55.236556Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread Nov 1 00:16:55.236832 waagent[1532]: 2025-11-01T00:16:55.236757Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status. Nov 1 00:16:55.247851 waagent[1532]: 2025-11-01T00:16:55.247776Z INFO ExtHandler ExtHandler Checking for agent updates (family: Prod) Nov 1 00:16:55.249368 waagent[1532]: 2025-11-01T00:16:55.249295Z WARNING ExtHandler ExtHandler Fetch failed: [HttpError] HTTPS is unavailable and required Nov 1 00:16:55.250782 waagent[1532]: 2025-11-01T00:16:55.250717Z INFO ExtHandler ExtHandler [PERIODIC] Request failed using the direct channel. Error: 'NoneType' object has no attribute 'getheaders' Nov 1 00:16:55.294060 waagent[1532]: 2025-11-01T00:16:55.293956Z INFO ExtHandler ExtHandler Default channel changed to HostGA channel. Nov 1 00:16:55.309587 waagent[1532]: 2025-11-01T00:16:55.309477Z ERROR EnvHandler ExtHandler Failed to get the PID of the DHCP client: invalid literal for int() with base 10: 'MainPID=1526' Nov 1 00:16:55.447094 waagent[1532]: 2025-11-01T00:16:55.446962Z INFO MonitorHandler ExtHandler Network interfaces: Nov 1 00:16:55.447094 waagent[1532]: Executing ['ip', '-a', '-o', 'link']: Nov 1 00:16:55.447094 waagent[1532]: 1: lo: mtu 65536 qdisc noqueue state UNKNOWN mode DEFAULT group default qlen 1000\ link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00 Nov 1 00:16:55.447094 waagent[1532]: 2: eth0: mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 00:0d:3a:07:7e:b4 brd ff:ff:ff:ff:ff:ff Nov 1 00:16:55.447094 waagent[1532]: 3: enP33989s1: mtu 1500 qdisc mq master eth0 state UP mode DEFAULT group default qlen 1000\ link/ether 00:0d:3a:07:7e:b4 brd ff:ff:ff:ff:ff:ff\ altname enP33989p0s2 Nov 1 00:16:55.447094 waagent[1532]: Executing ['ip', '-4', '-a', '-o', 'address']: Nov 1 00:16:55.447094 waagent[1532]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever Nov 1 00:16:55.447094 waagent[1532]: 2: eth0 inet 10.200.20.39/24 metric 1024 brd 10.200.20.255 scope global eth0\ valid_lft forever preferred_lft forever Nov 1 00:16:55.447094 waagent[1532]: Executing ['ip', '-6', '-a', '-o', 'address']: Nov 1 00:16:55.447094 waagent[1532]: 1: lo inet6 ::1/128 scope host \ valid_lft forever preferred_lft forever Nov 1 00:16:55.447094 waagent[1532]: 2: eth0 inet6 fe80::20d:3aff:fe07:7eb4/64 scope link \ valid_lft forever preferred_lft forever Nov 1 00:16:55.778733 waagent[1532]: 2025-11-01T00:16:55.778671Z INFO ExtHandler ExtHandler Agent WALinuxAgent-2.6.0.2 discovered update WALinuxAgent-2.15.0.1 -- exiting Nov 1 00:16:56.463833 waagent[1478]: 2025-11-01T00:16:56.463713Z INFO Daemon Daemon Agent WALinuxAgent-2.6.0.2 launched with command '/usr/share/oem/python/bin/python -u /usr/share/oem/bin/waagent -run-exthandlers' is successfully running Nov 1 00:16:56.470134 waagent[1478]: 2025-11-01T00:16:56.470074Z INFO Daemon Daemon Determined Agent WALinuxAgent-2.15.0.1 to be the latest agent Nov 1 00:16:57.829867 waagent[1561]: 2025-11-01T00:16:57.829769Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.15.0.1) Nov 1 00:16:57.830586 waagent[1561]: 2025-11-01T00:16:57.830524Z INFO ExtHandler ExtHandler OS: flatcar 3510.3.8 Nov 1 00:16:57.830737 waagent[1561]: 2025-11-01T00:16:57.830690Z INFO ExtHandler ExtHandler Python: 3.9.16 Nov 1 00:16:57.830876 waagent[1561]: 2025-11-01T00:16:57.830832Z INFO ExtHandler ExtHandler CPU Arch: aarch64 Nov 1 00:16:57.844746 waagent[1561]: 2025-11-01T00:16:57.844625Z INFO ExtHandler ExtHandler Distro: flatcar-3510.3.8; OSUtil: CoreOSUtil; AgentService: waagent; Python: 3.9.16; Arch: aarch64; systemd: True; systemd_version: systemd 252 (252); LISDrivers: Absent; logrotate: logrotate 3.20.1; Nov 1 00:16:57.845191 waagent[1561]: 2025-11-01T00:16:57.845135Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Nov 1 00:16:57.845358 waagent[1561]: 2025-11-01T00:16:57.845309Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16 Nov 1 00:16:57.845619 waagent[1561]: 2025-11-01T00:16:57.845568Z INFO ExtHandler ExtHandler Initializing the goal state... Nov 1 00:16:57.859508 waagent[1561]: 2025-11-01T00:16:57.859423Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1] Nov 1 00:16:57.873157 waagent[1561]: 2025-11-01T00:16:57.873098Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.177 Nov 1 00:16:57.874278 waagent[1561]: 2025-11-01T00:16:57.874219Z INFO ExtHandler Nov 1 00:16:57.874448 waagent[1561]: 2025-11-01T00:16:57.874400Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: ab193d70-f6e0-48dc-8578-edbac28dca7e eTag: 15145665199935494881 source: Fabric] Nov 1 00:16:57.875246 waagent[1561]: 2025-11-01T00:16:57.875186Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. Nov 1 00:16:57.876541 waagent[1561]: 2025-11-01T00:16:57.876482Z INFO ExtHandler Nov 1 00:16:57.876696 waagent[1561]: 2025-11-01T00:16:57.876651Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1] Nov 1 00:16:57.886428 waagent[1561]: 2025-11-01T00:16:57.886372Z INFO ExtHandler ExtHandler Downloading artifacts profile blob Nov 1 00:16:57.886986 waagent[1561]: 2025-11-01T00:16:57.886934Z WARNING ExtHandler ExtHandler Fetch failed: [HttpError] HTTPS is unavailable and required Nov 1 00:16:57.906553 waagent[1561]: 2025-11-01T00:16:57.906493Z INFO ExtHandler ExtHandler Default channel changed to HostGAPlugin channel. Nov 1 00:16:57.970948 waagent[1561]: 2025-11-01T00:16:57.970813Z INFO ExtHandler Downloaded certificate {'thumbprint': '8666A484BF2972EFBD3DA22FA0727CBE2864DB2D', 'hasPrivateKey': True} Nov 1 00:16:57.972356 waagent[1561]: 2025-11-01T00:16:57.972294Z INFO ExtHandler Fetch goal state from WireServer completed Nov 1 00:16:57.973301 waagent[1561]: 2025-11-01T00:16:57.973242Z INFO ExtHandler ExtHandler Goal state initialization completed. Nov 1 00:16:57.991581 waagent[1561]: 2025-11-01T00:16:57.991438Z INFO ExtHandler ExtHandler OpenSSL version: OpenSSL 3.0.15 3 Sep 2024 (Library: OpenSSL 3.0.15 3 Sep 2024) Nov 1 00:16:58.000522 waagent[1561]: 2025-11-01T00:16:58.000380Z INFO ExtHandler ExtHandler Using iptables [version 1.8.8] to manage firewall rules Nov 1 00:16:58.004646 waagent[1561]: 2025-11-01T00:16:58.004488Z INFO ExtHandler ExtHandler Did not find a legacy firewall rule: ['iptables', '-w', '-t', 'security', '-C', 'OUTPUT', '-d', '168.63.129.16', '-p', 'tcp', '-m', 'conntrack', '--ctstate', 'INVALID,NEW', '-j', 'ACCEPT'] Nov 1 00:16:58.004980 waagent[1561]: 2025-11-01T00:16:58.004909Z INFO ExtHandler ExtHandler Checking state of the firewall Nov 1 00:16:58.266272 waagent[1561]: 2025-11-01T00:16:58.266085Z INFO ExtHandler ExtHandler Created firewall rules for Azure Fabric: Nov 1 00:16:58.266272 waagent[1561]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Nov 1 00:16:58.266272 waagent[1561]: pkts bytes target prot opt in out source destination Nov 1 00:16:58.266272 waagent[1561]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Nov 1 00:16:58.266272 waagent[1561]: pkts bytes target prot opt in out source destination Nov 1 00:16:58.266272 waagent[1561]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes) Nov 1 00:16:58.266272 waagent[1561]: pkts bytes target prot opt in out source destination Nov 1 00:16:58.266272 waagent[1561]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Nov 1 00:16:58.266272 waagent[1561]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Nov 1 00:16:58.266272 waagent[1561]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Nov 1 00:16:58.267446 waagent[1561]: 2025-11-01T00:16:58.267374Z INFO ExtHandler ExtHandler Setting up persistent firewall rules Nov 1 00:16:58.270468 waagent[1561]: 2025-11-01T00:16:58.270329Z INFO ExtHandler ExtHandler The firewalld service is not present on the system Nov 1 00:16:58.270953 waagent[1561]: 2025-11-01T00:16:58.270895Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up /lib/systemd/system/waagent-network-setup.service Nov 1 00:16:58.271377 waagent[1561]: 2025-11-01T00:16:58.271317Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup Nov 1 00:16:58.279342 waagent[1561]: 2025-11-01T00:16:58.279272Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now Nov 1 00:16:58.279982 waagent[1561]: 2025-11-01T00:16:58.279920Z ERROR ExtHandler ExtHandler Unable to setup the persistent firewall rules: [Errno 30] Read-only file system: '/lib/systemd/system/waagent-network-setup.service' Nov 1 00:16:58.288524 waagent[1561]: 2025-11-01T00:16:58.288425Z INFO ExtHandler ExtHandler WALinuxAgent-2.15.0.1 running as process 1561 Nov 1 00:16:58.292014 waagent[1561]: 2025-11-01T00:16:58.291937Z INFO ExtHandler ExtHandler [CGI] Cgroups is not currently supported on ['flatcar', '3510.3.8', '', 'Flatcar Container Linux by Kinvolk'] Nov 1 00:16:58.292928 waagent[1561]: 2025-11-01T00:16:58.292869Z INFO ExtHandler ExtHandler [CGI] Agent will reset the quotas in case cgroup usage went from enabled to disabled Nov 1 00:16:58.293871 waagent[1561]: 2025-11-01T00:16:58.293816Z INFO ExtHandler ExtHandler [CGI] Agent cgroups enabled: False Nov 1 00:16:58.296772 waagent[1561]: 2025-11-01T00:16:58.296714Z INFO ExtHandler ExtHandler Signing certificate written to /var/lib/waagent/microsoft_root_certificate.pem Nov 1 00:16:58.297128 waagent[1561]: 2025-11-01T00:16:58.297075Z INFO ExtHandler ExtHandler Checking if log collection is allowed at this time [False]. All three conditions must be met: 1. configuration enabled [True], 2. cgroups v1 enabled [False] OR cgroups v2 is in use and v2 resource limiting configuration enabled [False], 3. python supported: [True] Nov 1 00:16:58.298952 waagent[1561]: 2025-11-01T00:16:58.298882Z INFO ExtHandler ExtHandler Starting env monitor service. Nov 1 00:16:58.299666 waagent[1561]: 2025-11-01T00:16:58.299608Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Nov 1 00:16:58.299958 waagent[1561]: 2025-11-01T00:16:58.299909Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16 Nov 1 00:16:58.300652 waagent[1561]: 2025-11-01T00:16:58.300598Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled. Nov 1 00:16:58.301120 waagent[1561]: 2025-11-01T00:16:58.301065Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route: Nov 1 00:16:58.301120 waagent[1561]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT Nov 1 00:16:58.301120 waagent[1561]: eth0 00000000 0114C80A 0003 0 0 1024 00000000 0 0 0 Nov 1 00:16:58.301120 waagent[1561]: eth0 0014C80A 00000000 0001 0 0 1024 00FFFFFF 0 0 0 Nov 1 00:16:58.301120 waagent[1561]: eth0 0114C80A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0 Nov 1 00:16:58.301120 waagent[1561]: eth0 10813FA8 0114C80A 0007 0 0 1024 FFFFFFFF 0 0 0 Nov 1 00:16:58.301120 waagent[1561]: eth0 FEA9FEA9 0114C80A 0007 0 0 1024 FFFFFFFF 0 0 0 Nov 1 00:16:58.303861 waagent[1561]: 2025-11-01T00:16:58.303678Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service. Nov 1 00:16:58.304448 waagent[1561]: 2025-11-01T00:16:58.304377Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Nov 1 00:16:58.305325 waagent[1561]: 2025-11-01T00:16:58.305256Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16 Nov 1 00:16:58.305926 waagent[1561]: 2025-11-01T00:16:58.305860Z INFO EnvHandler ExtHandler Configure routes Nov 1 00:16:58.306184 waagent[1561]: 2025-11-01T00:16:58.306122Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread Nov 1 00:16:58.306437 waagent[1561]: 2025-11-01T00:16:58.306375Z INFO ExtHandler ExtHandler Start Extension Telemetry service. Nov 1 00:16:58.306748 waagent[1561]: 2025-11-01T00:16:58.306680Z INFO EnvHandler ExtHandler Gateway:None Nov 1 00:16:58.307280 waagent[1561]: 2025-11-01T00:16:58.307218Z INFO EnvHandler ExtHandler Routes:None Nov 1 00:16:58.310846 waagent[1561]: 2025-11-01T00:16:58.310730Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True Nov 1 00:16:58.311185 waagent[1561]: 2025-11-01T00:16:58.311100Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status. Nov 1 00:16:58.311374 waagent[1561]: 2025-11-01T00:16:58.311304Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread Nov 1 00:16:58.328265 waagent[1561]: 2025-11-01T00:16:58.328181Z INFO MonitorHandler ExtHandler Network interfaces: Nov 1 00:16:58.328265 waagent[1561]: Executing ['ip', '-a', '-o', 'link']: Nov 1 00:16:58.328265 waagent[1561]: 1: lo: mtu 65536 qdisc noqueue state UNKNOWN mode DEFAULT group default qlen 1000\ link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00 Nov 1 00:16:58.328265 waagent[1561]: 2: eth0: mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 00:0d:3a:07:7e:b4 brd ff:ff:ff:ff:ff:ff Nov 1 00:16:58.328265 waagent[1561]: 3: enP33989s1: mtu 1500 qdisc mq master eth0 state UP mode DEFAULT group default qlen 1000\ link/ether 00:0d:3a:07:7e:b4 brd ff:ff:ff:ff:ff:ff\ altname enP33989p0s2 Nov 1 00:16:58.328265 waagent[1561]: Executing ['ip', '-4', '-a', '-o', 'address']: Nov 1 00:16:58.328265 waagent[1561]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever Nov 1 00:16:58.328265 waagent[1561]: 2: eth0 inet 10.200.20.39/24 metric 1024 brd 10.200.20.255 scope global eth0\ valid_lft forever preferred_lft forever Nov 1 00:16:58.328265 waagent[1561]: Executing ['ip', '-6', '-a', '-o', 'address']: Nov 1 00:16:58.328265 waagent[1561]: 1: lo inet6 ::1/128 scope host \ valid_lft forever preferred_lft forever Nov 1 00:16:58.328265 waagent[1561]: 2: eth0 inet6 fe80::20d:3aff:fe07:7eb4/64 scope link \ valid_lft forever preferred_lft forever Nov 1 00:16:58.336035 waagent[1561]: 2025-11-01T00:16:58.335846Z INFO ExtHandler ExtHandler Downloading agent manifest Nov 1 00:16:58.352432 waagent[1561]: 2025-11-01T00:16:58.352356Z INFO ExtHandler ExtHandler Nov 1 00:16:58.353470 waagent[1561]: 2025-11-01T00:16:58.353393Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: 80f603fc-0fe5-4fea-8052-c03ae8473f36 correlation 176ede75-d5be-48d2-8dfa-acf7c5cff15a created: 2025-11-01T00:14:56.507111Z] Nov 1 00:16:58.358847 waagent[1561]: 2025-11-01T00:16:58.358779Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. Nov 1 00:16:58.365346 waagent[1561]: 2025-11-01T00:16:58.365283Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 12 ms] Nov 1 00:16:58.391335 waagent[1561]: 2025-11-01T00:16:58.391269Z INFO ExtHandler ExtHandler Looking for existing remote access users. Nov 1 00:16:58.393968 waagent[1561]: 2025-11-01T00:16:58.393889Z INFO EnvHandler ExtHandler Using iptables [version 1.8.8] to manage firewall rules Nov 1 00:16:58.396009 waagent[1561]: 2025-11-01T00:16:58.395930Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.15.0.1 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: A648125B-AA1C-4C8E-9A98-096782034A58;UpdateGSErrors: 0;AutoUpdate: 1;UpdateMode: SelfUpdate;] Nov 1 00:16:58.406948 waagent[1561]: 2025-11-01T00:16:58.406881Z INFO EnvHandler ExtHandler Set block dev timeout: sda with timeout: 300 Nov 1 00:17:12.197092 kernel: hv_balloon: Max. dynamic memory size: 4096 MB Nov 1 00:17:12.819479 systemd[1]: Created slice system-sshd.slice. Nov 1 00:17:12.820533 systemd[1]: Started sshd@0-10.200.20.39:22-10.200.16.10:53456.service. Nov 1 00:17:15.796765 sshd[1608]: Accepted publickey for core from 10.200.16.10 port 53456 ssh2: RSA SHA256:JyxYDfrWcSc3T/AgB8prmyzM4mqcWmvKVj9wIAiMWXI Nov 1 00:17:15.843212 sshd[1608]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 1 00:17:15.846967 systemd-logind[1365]: New session 3 of user core. Nov 1 00:17:15.847808 systemd[1]: Started session-3.scope. Nov 1 00:17:16.181350 systemd[1]: Started sshd@1-10.200.20.39:22-10.200.16.10:53462.service. Nov 1 00:17:16.637147 sshd[1613]: Accepted publickey for core from 10.200.16.10 port 53462 ssh2: RSA SHA256:JyxYDfrWcSc3T/AgB8prmyzM4mqcWmvKVj9wIAiMWXI Nov 1 00:17:16.638438 sshd[1613]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 1 00:17:16.642330 systemd-logind[1365]: New session 4 of user core. Nov 1 00:17:16.642710 systemd[1]: Started session-4.scope. Nov 1 00:17:16.995720 sshd[1613]: pam_unix(sshd:session): session closed for user core Nov 1 00:17:16.998086 systemd[1]: sshd@1-10.200.20.39:22-10.200.16.10:53462.service: Deactivated successfully. Nov 1 00:17:16.998797 systemd[1]: session-4.scope: Deactivated successfully. Nov 1 00:17:16.999333 systemd-logind[1365]: Session 4 logged out. Waiting for processes to exit. Nov 1 00:17:17.000152 systemd-logind[1365]: Removed session 4. Nov 1 00:17:17.072331 systemd[1]: Started sshd@2-10.200.20.39:22-10.200.16.10:53476.service. Nov 1 00:17:17.604035 sshd[1619]: Accepted publickey for core from 10.200.16.10 port 53476 ssh2: RSA SHA256:JyxYDfrWcSc3T/AgB8prmyzM4mqcWmvKVj9wIAiMWXI Nov 1 00:17:17.605622 sshd[1619]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 1 00:17:17.609642 systemd[1]: Started session-5.scope. Nov 1 00:17:17.610182 systemd-logind[1365]: New session 5 of user core. Nov 1 00:17:17.937440 sshd[1619]: pam_unix(sshd:session): session closed for user core Nov 1 00:17:17.939860 systemd[1]: sshd@2-10.200.20.39:22-10.200.16.10:53476.service: Deactivated successfully. Nov 1 00:17:17.940546 systemd[1]: session-5.scope: Deactivated successfully. Nov 1 00:17:17.941046 systemd-logind[1365]: Session 5 logged out. Waiting for processes to exit. Nov 1 00:17:17.941852 systemd-logind[1365]: Removed session 5. Nov 1 00:17:18.014853 systemd[1]: Started sshd@3-10.200.20.39:22-10.200.16.10:53486.service. Nov 1 00:17:18.470599 sshd[1625]: Accepted publickey for core from 10.200.16.10 port 53486 ssh2: RSA SHA256:JyxYDfrWcSc3T/AgB8prmyzM4mqcWmvKVj9wIAiMWXI Nov 1 00:17:18.471902 sshd[1625]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 1 00:17:18.476415 systemd[1]: Started session-6.scope. Nov 1 00:17:18.476734 systemd-logind[1365]: New session 6 of user core. Nov 1 00:17:18.805691 sshd[1625]: pam_unix(sshd:session): session closed for user core Nov 1 00:17:18.808192 systemd[1]: sshd@3-10.200.20.39:22-10.200.16.10:53486.service: Deactivated successfully. Nov 1 00:17:18.808870 systemd[1]: session-6.scope: Deactivated successfully. Nov 1 00:17:18.809393 systemd-logind[1365]: Session 6 logged out. Waiting for processes to exit. Nov 1 00:17:18.810180 systemd-logind[1365]: Removed session 6. Nov 1 00:17:18.870948 systemd[1]: Started sshd@4-10.200.20.39:22-10.200.16.10:53500.service. Nov 1 00:17:19.299257 sshd[1631]: Accepted publickey for core from 10.200.16.10 port 53500 ssh2: RSA SHA256:JyxYDfrWcSc3T/AgB8prmyzM4mqcWmvKVj9wIAiMWXI Nov 1 00:17:19.300811 sshd[1631]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 1 00:17:19.304331 systemd-logind[1365]: New session 7 of user core. Nov 1 00:17:19.304784 systemd[1]: Started session-7.scope. Nov 1 00:17:19.963551 sudo[1634]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Nov 1 00:17:19.963761 sudo[1634]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 1 00:17:20.028638 dbus-daemon[1358]: avc: received setenforce notice (enforcing=1) Nov 1 00:17:20.030427 sudo[1634]: pam_unix(sudo:session): session closed for user root Nov 1 00:17:20.202491 systemd[1]: Started sshd@5-10.200.20.39:22-10.200.16.10:45596.service. Nov 1 00:17:20.408095 sshd[1631]: pam_unix(sshd:session): session closed for user core Nov 1 00:17:20.410409 systemd[1]: sshd@4-10.200.20.39:22-10.200.16.10:53500.service: Deactivated successfully. Nov 1 00:17:20.411175 systemd[1]: session-7.scope: Deactivated successfully. Nov 1 00:17:20.411804 systemd-logind[1365]: Session 7 logged out. Waiting for processes to exit. Nov 1 00:17:20.412796 systemd-logind[1365]: Removed session 7. Nov 1 00:17:20.639156 sshd[1637]: Accepted publickey for core from 10.200.16.10 port 45596 ssh2: RSA SHA256:JyxYDfrWcSc3T/AgB8prmyzM4mqcWmvKVj9wIAiMWXI Nov 1 00:17:20.640515 sshd[1637]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 1 00:17:20.644178 systemd-logind[1365]: New session 8 of user core. Nov 1 00:17:20.644608 systemd[1]: Started session-8.scope. Nov 1 00:17:20.885014 sudo[1642]: 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 Nov 1 00:17:20.885219 sudo[1642]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 1 00:17:20.887788 sudo[1642]: pam_unix(sudo:session): session closed for user root Nov 1 00:17:20.892239 sudo[1641]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules Nov 1 00:17:20.892718 sudo[1641]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 1 00:17:20.901505 systemd[1]: Stopping audit-rules.service... Nov 1 00:17:20.902000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Nov 1 00:17:20.902946 auditctl[1645]: No rules Nov 1 00:17:20.906755 kernel: kauditd_printk_skb: 10 callbacks suppressed Nov 1 00:17:20.906829 kernel: audit: type=1305 audit(1761956240.902:173): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Nov 1 00:17:20.907173 systemd[1]: audit-rules.service: Deactivated successfully. Nov 1 00:17:20.907370 systemd[1]: Stopped audit-rules.service. Nov 1 00:17:20.909197 systemd[1]: Starting audit-rules.service... Nov 1 00:17:20.902000 audit[1645]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=fffff1f6ee10 a2=420 a3=0 items=0 ppid=1 pid=1645 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) Nov 1 00:17:20.930686 augenrules[1662]: No rules Nov 1 00:17:20.931784 systemd[1]: Finished audit-rules.service. Nov 1 00:17:20.943520 kernel: audit: type=1300 audit(1761956240.902:173): arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=fffff1f6ee10 a2=420 a3=0 items=0 ppid=1 pid=1645 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) Nov 1 00:17:20.902000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D44 Nov 1 00:17:20.943839 sudo[1641]: pam_unix(sudo:session): session closed for user root Nov 1 00:17:20.951589 kernel: audit: type=1327 audit(1761956240.902:173): proctitle=2F7362696E2F617564697463746C002D44 Nov 1 00:17:20.951720 kernel: audit: type=1131 audit(1761956240.906:174): 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' Nov 1 00:17:20.906000 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' Nov 1 00:17:20.930000 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' Nov 1 00:17:20.984579 kernel: audit: type=1130 audit(1761956240.930:175): 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' Nov 1 00:17:20.984720 kernel: audit: type=1106 audit(1761956240.943:176): pid=1641 uid=500 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Nov 1 00:17:20.943000 audit[1641]: USER_END pid=1641 uid=500 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Nov 1 00:17:20.943000 audit[1641]: CRED_DISP pid=1641 uid=500 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Nov 1 00:17:21.022200 kernel: audit: type=1104 audit(1761956240.943:177): pid=1641 uid=500 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Nov 1 00:17:21.030961 sshd[1637]: pam_unix(sshd:session): session closed for user core Nov 1 00:17:21.031000 audit[1637]: USER_END pid=1637 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success' Nov 1 00:17:21.031000 audit[1637]: CRED_DISP pid=1637 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success' Nov 1 00:17:21.056171 systemd[1]: sshd@5-10.200.20.39:22-10.200.16.10:45596.service: Deactivated successfully. Nov 1 00:17:21.057013 systemd[1]: session-8.scope: Deactivated successfully. Nov 1 00:17:21.081208 kernel: audit: type=1106 audit(1761956241.031:178): pid=1637 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success' Nov 1 00:17:21.081324 kernel: audit: type=1104 audit(1761956241.031:179): pid=1637 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success' Nov 1 00:17:21.055000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-10.200.20.39:22-10.200.16.10:45596 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:17:21.081974 systemd-logind[1365]: Session 8 logged out. Waiting for processes to exit. Nov 1 00:17:21.102572 kernel: audit: type=1131 audit(1761956241.055:180): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-10.200.20.39:22-10.200.16.10:45596 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:17:21.103122 systemd-logind[1365]: Removed session 8. Nov 1 00:17:21.108845 systemd[1]: Started sshd@6-10.200.20.39:22-10.200.16.10:45600.service. Nov 1 00:17:21.108000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-10.200.20.39:22-10.200.16.10:45600 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:17:21.574000 audit[1668]: USER_ACCT pid=1668 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_access,pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/sbin/sshd" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success' Nov 1 00:17:21.575207 sshd[1668]: Accepted publickey for core from 10.200.16.10 port 45600 ssh2: RSA SHA256:JyxYDfrWcSc3T/AgB8prmyzM4mqcWmvKVj9wIAiMWXI Nov 1 00:17:21.575000 audit[1668]: CRED_ACQ pid=1668 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success' Nov 1 00:17:21.575000 audit[1668]: SYSCALL arch=c00000b7 syscall=64 success=yes exit=3 a0=5 a1=ffffceb93420 a2=3 a3=1 items=0 ppid=1 pid=1668 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) Nov 1 00:17:21.575000 audit: PROCTITLE proctitle=737368643A20636F7265205B707269765D Nov 1 00:17:21.576770 sshd[1668]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 1 00:17:21.580962 systemd[1]: Started session-9.scope. Nov 1 00:17:21.582041 systemd-logind[1365]: New session 9 of user core. Nov 1 00:17:21.585000 audit[1668]: USER_START pid=1668 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success' Nov 1 00:17:21.586000 audit[1670]: CRED_ACQ pid=1670 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success' Nov 1 00:17:21.906547 sshd[1668]: pam_unix(sshd:session): session closed for user core Nov 1 00:17:21.907000 audit[1668]: USER_END pid=1668 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success' Nov 1 00:17:21.907000 audit[1668]: CRED_DISP pid=1668 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success' Nov 1 00:17:21.909162 systemd[1]: sshd@6-10.200.20.39:22-10.200.16.10:45600.service: Deactivated successfully. Nov 1 00:17:21.908000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-10.200.20.39:22-10.200.16.10:45600 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:17:21.909861 systemd[1]: session-9.scope: Deactivated successfully. Nov 1 00:17:21.910357 systemd-logind[1365]: Session 9 logged out. Waiting for processes to exit. Nov 1 00:17:21.911086 systemd-logind[1365]: Removed session 9.