Jul 2 01:50:58.011234 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]
Jul 2 01:50:58.011253 kernel: Linux version 5.15.161-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 11.3.1_p20221209 p3) 11.3.1 20221209, GNU ld (Gentoo 2.39 p5) 2.39.0) #1 SMP PREEMPT Mon Jul 1 23:37:37 -00 2024
Jul 2 01:50:58.011261 kernel: earlycon: pl11 at MMIO 0x00000000effec000 (options '')
Jul 2 01:50:58.011268 kernel: printk: bootconsole [pl11] enabled
Jul 2 01:50:58.011273 kernel: efi: EFI v2.70 by EDK II
Jul 2 01:50:58.011279 kernel: efi: ACPI 2.0=0x3fd89018 SMBIOS=0x3fd66000 SMBIOS 3.0=0x3fd64000 MEMATTR=0x3ef3c198 RNG=0x3fd89998 MEMRESERVE=0x37b33f98
Jul 2 01:50:58.011285 kernel: random: crng init done
Jul 2 01:50:58.011290 kernel: ACPI: Early table checksum verification disabled
Jul 2 01:50:58.011296 kernel: ACPI: RSDP 0x000000003FD89018 000024 (v02 VRTUAL)
Jul 2 01:50:58.011301 kernel: ACPI: XSDT 0x000000003FD89F18 00006C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
Jul 2 01:50:58.011307 kernel: ACPI: FACP 0x000000003FD89C18 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001)
Jul 2 01:50:58.011313 kernel: ACPI: DSDT 0x000000003EBD2018 01DEC0 (v02 MSFTVM DSDT01 00000001 MSFT 05000000)
Jul 2 01:50:58.011319 kernel: ACPI: DBG2 0x000000003FD89B18 000072 (v00 VRTUAL MICROSFT 00000001 MSFT 00000001)
Jul 2 01:50:58.011324 kernel: ACPI: GTDT 0x000000003FD89D98 000060 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001)
Jul 2 01:50:58.011331 kernel: ACPI: OEM0 0x000000003FD89098 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
Jul 2 01:50:58.011337 kernel: ACPI: SPCR 0x000000003FD89A98 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001)
Jul 2 01:50:58.011343 kernel: ACPI: APIC 0x000000003FD89818 0000FC (v04 VRTUAL MICROSFT 00000001 MSFT 00000001)
Jul 2 01:50:58.011349 kernel: ACPI: SRAT 0x000000003FD89198 000234 (v03 VRTUAL MICROSFT 00000001 MSFT 00000001)
Jul 2 01:50:58.011355 kernel: ACPI: PPTT 0x000000003FD89418 000120 (v01 VRTUAL MICROSFT 00000000 MSFT 00000000)
Jul 2 01:50:58.011361 kernel: ACPI: BGRT 0x000000003FD89E98 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
Jul 2 01:50:58.011366 kernel: ACPI: SPCR: console: pl011,mmio32,0xeffec000,115200
Jul 2 01:50:58.011372 kernel: NUMA: Failed to initialise from firmware
Jul 2 01:50:58.011378 kernel: NUMA: Faking a node at [mem 0x0000000000000000-0x00000001bfffffff]
Jul 2 01:50:58.011383 kernel: NUMA: NODE_DATA [mem 0x1bf7f2900-0x1bf7f7fff]
Jul 2 01:50:58.011389 kernel: Zone ranges:
Jul 2 01:50:58.011395 kernel: DMA [mem 0x0000000000000000-0x00000000ffffffff]
Jul 2 01:50:58.011400 kernel: DMA32 empty
Jul 2 01:50:58.011407 kernel: Normal [mem 0x0000000100000000-0x00000001bfffffff]
Jul 2 01:50:58.011413 kernel: Movable zone start for each node
Jul 2 01:50:58.011419 kernel: Early memory node ranges
Jul 2 01:50:58.011424 kernel: node 0: [mem 0x0000000000000000-0x00000000007fffff]
Jul 2 01:50:58.011430 kernel: node 0: [mem 0x0000000000824000-0x000000003ec80fff]
Jul 2 01:50:58.011435 kernel: node 0: [mem 0x000000003ec81000-0x000000003eca9fff]
Jul 2 01:50:58.011441 kernel: node 0: [mem 0x000000003ecaa000-0x000000003fd29fff]
Jul 2 01:50:58.011446 kernel: node 0: [mem 0x000000003fd2a000-0x000000003fd7dfff]
Jul 2 01:50:58.011452 kernel: node 0: [mem 0x000000003fd7e000-0x000000003fd89fff]
Jul 2 01:50:58.011458 kernel: node 0: [mem 0x000000003fd8a000-0x000000003fd8dfff]
Jul 2 01:50:58.011463 kernel: node 0: [mem 0x000000003fd8e000-0x000000003fffffff]
Jul 2 01:50:58.011469 kernel: node 0: [mem 0x0000000100000000-0x00000001bfffffff]
Jul 2 01:50:58.011476 kernel: Initmem setup node 0 [mem 0x0000000000000000-0x00000001bfffffff]
Jul 2 01:50:58.011484 kernel: On node 0, zone DMA: 36 pages in unavailable ranges
Jul 2 01:50:58.011490 kernel: psci: probing for conduit method from ACPI.
Jul 2 01:50:58.011497 kernel: psci: PSCIv1.1 detected in firmware.
Jul 2 01:50:58.011503 kernel: psci: Using standard PSCI v0.2 function IDs
Jul 2 01:50:58.011509 kernel: psci: MIGRATE_INFO_TYPE not supported.
Jul 2 01:50:58.011516 kernel: psci: SMC Calling Convention v1.4
Jul 2 01:50:58.011521 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x0 -> Node -1
Jul 2 01:50:58.011527 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x1 -> Node -1
Jul 2 01:50:58.011533 kernel: percpu: Embedded 30 pages/cpu s83032 r8192 d31656 u122880
Jul 2 01:50:58.011539 kernel: pcpu-alloc: s83032 r8192 d31656 u122880 alloc=30*4096
Jul 2 01:50:58.011546 kernel: pcpu-alloc: [0] 0 [0] 1
Jul 2 01:50:58.011552 kernel: Detected PIPT I-cache on CPU0
Jul 2 01:50:58.011558 kernel: CPU features: detected: GIC system register CPU interface
Jul 2 01:50:58.011564 kernel: CPU features: detected: Hardware dirty bit management
Jul 2 01:50:58.011570 kernel: CPU features: detected: Spectre-BHB
Jul 2 01:50:58.011576 kernel: CPU features: kernel page table isolation forced ON by KASLR
Jul 2 01:50:58.011583 kernel: CPU features: detected: Kernel page table isolation (KPTI)
Jul 2 01:50:58.011589 kernel: CPU features: detected: ARM erratum 1418040
Jul 2 01:50:58.011595 kernel: CPU features: detected: ARM erratum 1542419 (kernel portion)
Jul 2 01:50:58.011602 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1032156
Jul 2 01:50:58.011608 kernel: Policy zone: Normal
Jul 2 01:50:58.011615 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=7b86ecfcd4701bdf4668db795601b20c118ac0b117c34a9b3836e0a5236b73b0
Jul 2 01:50:58.011622 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space.
Jul 2 01:50:58.011628 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
Jul 2 01:50:58.011634 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
Jul 2 01:50:58.011640 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off
Jul 2 01:50:58.011647 kernel: software IO TLB: mapped [mem 0x000000003abd2000-0x000000003ebd2000] (64MB)
Jul 2 01:50:58.011653 kernel: Memory: 3990264K/4194160K available (9792K kernel code, 2092K rwdata, 7572K rodata, 36352K init, 777K bss, 203896K reserved, 0K cma-reserved)
Jul 2 01:50:58.011659 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
Jul 2 01:50:58.011665 kernel: trace event string verifier disabled
Jul 2 01:50:58.011671 kernel: rcu: Preemptible hierarchical RCU implementation.
Jul 2 01:50:58.011678 kernel: rcu: RCU event tracing is enabled.
Jul 2 01:50:58.011684 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2.
Jul 2 01:50:58.011690 kernel: Trampoline variant of Tasks RCU enabled.
Jul 2 01:50:58.011696 kernel: Tracing variant of Tasks RCU enabled.
Jul 2 01:50:58.011702 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.
Jul 2 01:50:58.011708 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
Jul 2 01:50:58.011715 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
Jul 2 01:50:58.011721 kernel: GICv3: 960 SPIs implemented
Jul 2 01:50:58.011727 kernel: GICv3: 0 Extended SPIs implemented
Jul 2 01:50:58.011733 kernel: GICv3: Distributor has no Range Selector support
Jul 2 01:50:58.011739 kernel: Root IRQ handler: gic_handle_irq
Jul 2 01:50:58.011745 kernel: GICv3: 16 PPIs implemented
Jul 2 01:50:58.011751 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000effee000
Jul 2 01:50:58.011756 kernel: ITS: No ITS available, not enabling LPIs
Jul 2 01:50:58.011763 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040
Jul 2 01:50:58.011769 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt).
Jul 2 01:50:58.011775 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns
Jul 2 01:50:58.011781 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns
Jul 2 01:50:58.011788 kernel: Console: colour dummy device 80x25
Jul 2 01:50:58.011795 kernel: printk: console [tty1] enabled
Jul 2 01:50:58.011801 kernel: ACPI: Core revision 20210730
Jul 2 01:50:58.011808 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000)
Jul 2 01:50:58.011814 kernel: pid_max: default: 32768 minimum: 301
Jul 2 01:50:58.011820 kernel: LSM: Security Framework initializing
Jul 2 01:50:58.011826 kernel: SELinux: Initializing.
Jul 2 01:50:58.011833 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
Jul 2 01:50:58.011839 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
Jul 2 01:50:58.011846 kernel: Hyper-V: privilege flags low 0x2e7f, high 0x3a8030, hints 0xe, misc 0x31e1
Jul 2 01:50:58.011852 kernel: Hyper-V: Host Build 10.0.22477.1369-1-0
Jul 2 01:50:58.011859 kernel: rcu: Hierarchical SRCU implementation.
Jul 2 01:50:58.011865 kernel: Remapping and enabling EFI services.
Jul 2 01:50:58.011871 kernel: smp: Bringing up secondary CPUs ...
Jul 2 01:50:58.011877 kernel: Detected PIPT I-cache on CPU1
Jul 2 01:50:58.011883 kernel: GICv3: CPU1: found redistributor 1 region 1:0x00000000f000e000
Jul 2 01:50:58.011889 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040
Jul 2 01:50:58.011896 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1]
Jul 2 01:50:58.011903 kernel: smp: Brought up 1 node, 2 CPUs
Jul 2 01:50:58.011910 kernel: SMP: Total of 2 processors activated.
Jul 2 01:50:58.011916 kernel: CPU features: detected: 32-bit EL0 Support
Jul 2 01:50:58.011922 kernel: CPU features: detected: Instruction cache invalidation not required for I/D coherence
Jul 2 01:50:58.011929 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence
Jul 2 01:50:58.011946 kernel: CPU features: detected: CRC32 instructions
Jul 2 01:50:58.011953 kernel: CPU features: detected: RCpc load-acquire (LDAPR)
Jul 2 01:50:58.011960 kernel: CPU features: detected: LSE atomic instructions
Jul 2 01:50:58.011966 kernel: CPU features: detected: Privileged Access Never
Jul 2 01:50:58.011974 kernel: CPU: All CPU(s) started at EL1
Jul 2 01:50:58.011980 kernel: alternatives: patching kernel code
Jul 2 01:50:58.011990 kernel: devtmpfs: initialized
Jul 2 01:50:58.011998 kernel: KASLR enabled
Jul 2 01:50:58.012004 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
Jul 2 01:50:58.012011 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear)
Jul 2 01:50:58.012017 kernel: pinctrl core: initialized pinctrl subsystem
Jul 2 01:50:58.012024 kernel: SMBIOS 3.1.0 present.
Jul 2 01:50:58.012031 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 11/28/2023
Jul 2 01:50:58.012038 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family
Jul 2 01:50:58.012045 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations
Jul 2 01:50:58.012052 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
Jul 2 01:50:58.012059 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
Jul 2 01:50:58.012065 kernel: audit: initializing netlink subsys (disabled)
Jul 2 01:50:58.012072 kernel: audit: type=2000 audit(0.089:1): state=initialized audit_enabled=0 res=1
Jul 2 01:50:58.012078 kernel: thermal_sys: Registered thermal governor 'step_wise'
Jul 2 01:50:58.012085 kernel: cpuidle: using governor menu
Jul 2 01:50:58.012093 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
Jul 2 01:50:58.012099 kernel: ASID allocator initialised with 32768 entries
Jul 2 01:50:58.012105 kernel: ACPI: bus type PCI registered
Jul 2 01:50:58.012112 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
Jul 2 01:50:58.012119 kernel: Serial: AMBA PL011 UART driver
Jul 2 01:50:58.012125 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages
Jul 2 01:50:58.012132 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages
Jul 2 01:50:58.012138 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
Jul 2 01:50:58.012145 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages
Jul 2 01:50:58.012153 kernel: cryptd: max_cpu_qlen set to 1000
Jul 2 01:50:58.012159 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng)
Jul 2 01:50:58.012166 kernel: ACPI: Added _OSI(Module Device)
Jul 2 01:50:58.012172 kernel: ACPI: Added _OSI(Processor Device)
Jul 2 01:50:58.012179 kernel: ACPI: Added _OSI(3.0 _SCP Extensions)
Jul 2 01:50:58.012185 kernel: ACPI: Added _OSI(Processor Aggregator Device)
Jul 2 01:50:58.012192 kernel: ACPI: Added _OSI(Linux-Dell-Video)
Jul 2 01:50:58.012198 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio)
Jul 2 01:50:58.012205 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics)
Jul 2 01:50:58.012213 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded
Jul 2 01:50:58.012219 kernel: ACPI: Interpreter enabled
Jul 2 01:50:58.012226 kernel: ACPI: Using GIC for interrupt routing
Jul 2 01:50:58.012232 kernel: ARMH0011:00: ttyAMA0 at MMIO 0xeffec000 (irq = 12, base_baud = 0) is a SBSA
Jul 2 01:50:58.012239 kernel: printk: console [ttyAMA0] enabled
Jul 2 01:50:58.012245 kernel: printk: bootconsole [pl11] disabled
Jul 2 01:50:58.012252 kernel: ARMH0011:01: ttyAMA1 at MMIO 0xeffeb000 (irq = 13, base_baud = 0) is a SBSA
Jul 2 01:50:58.012258 kernel: iommu: Default domain type: Translated
Jul 2 01:50:58.012265 kernel: iommu: DMA domain TLB invalidation policy: strict mode
Jul 2 01:50:58.012272 kernel: vgaarb: loaded
Jul 2 01:50:58.012279 kernel: pps_core: LinuxPPS API ver. 1 registered
Jul 2 01:50:58.012285 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
Jul 2 01:50:58.012292 kernel: PTP clock support registered
Jul 2 01:50:58.012298 kernel: Registered efivars operations
Jul 2 01:50:58.012305 kernel: No ACPI PMU IRQ for CPU0
Jul 2 01:50:58.012311 kernel: No ACPI PMU IRQ for CPU1
Jul 2 01:50:58.012317 kernel: clocksource: Switched to clocksource arch_sys_counter
Jul 2 01:50:58.012324 kernel: VFS: Disk quotas dquot_6.6.0
Jul 2 01:50:58.012332 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
Jul 2 01:50:58.012338 kernel: pnp: PnP ACPI init
Jul 2 01:50:58.012345 kernel: pnp: PnP ACPI: found 0 devices
Jul 2 01:50:58.012351 kernel: NET: Registered PF_INET protocol family
Jul 2 01:50:58.012358 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)
Jul 2 01:50:58.012365 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)
Jul 2 01:50:58.012371 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
Jul 2 01:50:58.012378 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)
Jul 2 01:50:58.012384 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear)
Jul 2 01:50:58.012392 kernel: TCP: Hash tables configured (established 32768 bind 32768)
Jul 2 01:50:58.012399 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear)
Jul 2 01:50:58.012405 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear)
Jul 2 01:50:58.012412 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family
Jul 2 01:50:58.012418 kernel: PCI: CLS 0 bytes, default 64
Jul 2 01:50:58.012425 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 1 counters available
Jul 2 01:50:58.012431 kernel: kvm [1]: HYP mode not available
Jul 2 01:50:58.012438 kernel: Initialise system trusted keyrings
Jul 2 01:50:58.012444 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0
Jul 2 01:50:58.012452 kernel: Key type asymmetric registered
Jul 2 01:50:58.012458 kernel: Asymmetric key parser 'x509' registered
Jul 2 01:50:58.012465 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
Jul 2 01:50:58.012471 kernel: io scheduler mq-deadline registered
Jul 2 01:50:58.012478 kernel: io scheduler kyber registered
Jul 2 01:50:58.012484 kernel: io scheduler bfq registered
Jul 2 01:50:58.012491 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
Jul 2 01:50:58.012497 kernel: thunder_xcv, ver 1.0
Jul 2 01:50:58.012504 kernel: thunder_bgx, ver 1.0
Jul 2 01:50:58.012511 kernel: nicpf, ver 1.0
Jul 2 01:50:58.012518 kernel: nicvf, ver 1.0
Jul 2 01:50:58.012628 kernel: rtc-efi rtc-efi.0: registered as rtc0
Jul 2 01:50:58.012690 kernel: rtc-efi rtc-efi.0: setting system clock to 2024-07-02T01:50:57 UTC (1719885057)
Jul 2 01:50:58.012699 kernel: efifb: probing for efifb
Jul 2 01:50:58.012706 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k
Jul 2 01:50:58.012713 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1
Jul 2 01:50:58.012719 kernel: efifb: scrolling: redraw
Jul 2 01:50:58.012727 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0
Jul 2 01:50:58.012734 kernel: Console: switching to colour frame buffer device 128x48
Jul 2 01:50:58.012740 kernel: fb0: EFI VGA frame buffer device
Jul 2 01:50:58.012747 kernel: SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping ....
Jul 2 01:50:58.012754 kernel: hid: raw HID events driver (C) Jiri Kosina
Jul 2 01:50:58.012760 kernel: NET: Registered PF_INET6 protocol family
Jul 2 01:50:58.012766 kernel: Segment Routing with IPv6
Jul 2 01:50:58.012773 kernel: In-situ OAM (IOAM) with IPv6
Jul 2 01:50:58.012779 kernel: NET: Registered PF_PACKET protocol family
Jul 2 01:50:58.012787 kernel: Key type dns_resolver registered
Jul 2 01:50:58.012793 kernel: registered taskstats version 1
Jul 2 01:50:58.012800 kernel: Loading compiled-in X.509 certificates
Jul 2 01:50:58.012807 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.15.161-flatcar: c418313b450e4055b23e41c11cb6dc415de0265d'
Jul 2 01:50:58.012813 kernel: Key type .fscrypt registered
Jul 2 01:50:58.012819 kernel: Key type fscrypt-provisioning registered
Jul 2 01:50:58.012826 kernel: ima: No TPM chip found, activating TPM-bypass!
Jul 2 01:50:58.012833 kernel: ima: Allocated hash algorithm: sha1
Jul 2 01:50:58.012839 kernel: ima: No architecture policies found
Jul 2 01:50:58.012847 kernel: clk: Disabling unused clocks
Jul 2 01:50:58.012853 kernel: Freeing unused kernel memory: 36352K
Jul 2 01:50:58.012860 kernel: Run /init as init process
Jul 2 01:50:58.012866 kernel: with arguments:
Jul 2 01:50:58.012873 kernel: /init
Jul 2 01:50:58.012879 kernel: with environment:
Jul 2 01:50:58.012885 kernel: HOME=/
Jul 2 01:50:58.012891 kernel: TERM=linux
Jul 2 01:50:58.012898 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a
Jul 2 01:50:58.012908 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)
Jul 2 01:50:58.012916 systemd[1]: Detected virtualization microsoft.
Jul 2 01:50:58.012924 systemd[1]: Detected architecture arm64.
Jul 2 01:50:58.012930 systemd[1]: Running in initrd.
Jul 2 01:50:58.012945 systemd[1]: No hostname configured, using default hostname.
Jul 2 01:50:58.012952 systemd[1]: Hostname set to <localhost>.
Jul 2 01:50:58.012960 systemd[1]: Initializing machine ID from random generator.
Jul 2 01:50:58.012968 systemd[1]: Queued start job for default target initrd.target.
Jul 2 01:50:58.012975 systemd[1]: Started systemd-ask-password-console.path.
Jul 2 01:50:58.012982 systemd[1]: Reached target cryptsetup.target.
Jul 2 01:50:58.012989 systemd[1]: Reached target paths.target.
Jul 2 01:50:58.012996 systemd[1]: Reached target slices.target.
Jul 2 01:50:58.013003 systemd[1]: Reached target swap.target.
Jul 2 01:50:58.013010 systemd[1]: Reached target timers.target.
Jul 2 01:50:58.013017 systemd[1]: Listening on iscsid.socket.
Jul 2 01:50:58.013026 systemd[1]: Listening on iscsiuio.socket.
Jul 2 01:50:58.013033 systemd[1]: Listening on systemd-journald-audit.socket.
Jul 2 01:50:58.013040 systemd[1]: Listening on systemd-journald-dev-log.socket.
Jul 2 01:50:58.013047 systemd[1]: Listening on systemd-journald.socket.
Jul 2 01:50:58.013054 systemd[1]: Listening on systemd-networkd.socket.
Jul 2 01:50:58.013061 systemd[1]: Listening on systemd-udevd-control.socket.
Jul 2 01:50:58.013068 systemd[1]: Listening on systemd-udevd-kernel.socket.
Jul 2 01:50:58.013075 systemd[1]: Reached target sockets.target.
Jul 2 01:50:58.013082 systemd[1]: Starting kmod-static-nodes.service...
Jul 2 01:50:58.013091 systemd[1]: Finished network-cleanup.service.
Jul 2 01:50:58.013098 systemd[1]: Starting systemd-fsck-usr.service...
Jul 2 01:50:58.013105 systemd[1]: Starting systemd-journald.service...
Jul 2 01:50:58.013112 systemd[1]: Starting systemd-modules-load.service...
Jul 2 01:50:58.013119 systemd[1]: Starting systemd-resolved.service...
Jul 2 01:50:58.013126 systemd[1]: Starting systemd-vconsole-setup.service...
Jul 2 01:50:58.013136 systemd-journald[276]: Journal started
Jul 2 01:50:58.013172 systemd-journald[276]: Runtime Journal (/run/log/journal/e3cabe8574eb41848e845577b33f35f6) is 8.0M, max 78.6M, 70.6M free.
Jul 2 01:50:57.997345 systemd-modules-load[277]: Inserted module 'overlay'
Jul 2 01:50:58.039671 systemd-resolved[278]: Positive Trust Anchors:
Jul 2 01:50:58.053713 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this.
Jul 2 01:50:58.053734 systemd[1]: Started systemd-journald.service.
Jul 2 01:50:58.053746 kernel: Bridge firewalling registered
Jul 2 01:50:58.039690 systemd-resolved[278]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
Jul 2 01:50:58.086605 kernel: audit: type=1130 audit(1719885058.063: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'
Jul 2 01:50:58.063000 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'
Jul 2 01:50:58.039717 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
Jul 2 01:50:58.159341 kernel: audit: type=1130 audit(1719885058.090: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'
Jul 2 01:50:58.159365 kernel: SCSI subsystem initialized
Jul 2 01:50:58.159374 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
Jul 2 01:50:58.090000 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'
Jul 2 01:50:58.041787 systemd-resolved[278]: Defaulting to hostname 'linux'.
Jul 2 01:50:58.192511 kernel: device-mapper: uevent: version 1.0.3
Jul 2 01:50:58.192533 kernel: audit: type=1130 audit(1719885058.164: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'
Jul 2 01:50:58.192544 kernel: device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com
Jul 2 01:50:58.164000 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'
Jul 2 01:50:58.057560 systemd-modules-load[277]: Inserted module 'br_netfilter'
Jul 2 01:50:58.218914 kernel: audit: type=1130 audit(1719885058.197: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'
Jul 2 01:50:58.197000 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'
Jul 2 01:50:58.086603 systemd[1]: Started systemd-resolved.service.
Jul 2 01:50:58.248076 kernel: audit: type=1130 audit(1719885058.223:6): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Jul 2 01:50:58.223000 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'
Jul 2 01:50:58.091031 systemd[1]: Finished kmod-static-nodes.service.
Jul 2 01:50:58.277835 kernel: audit: type=1130 audit(1719885058.252:7): 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'
Jul 2 01:50:58.252000 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'
Jul 2 01:50:58.183025 systemd[1]: Finished systemd-fsck-usr.service.
Jul 2 01:50:58.197228 systemd-modules-load[277]: Inserted module 'dm_multipath'
Jul 2 01:50:58.198226 systemd[1]: Finished systemd-modules-load.service.
Jul 2 01:50:58.223546 systemd[1]: Finished systemd-vconsole-setup.service.
Jul 2 01:50:58.252316 systemd[1]: Reached target nss-lookup.target.
Jul 2 01:50:58.292361 systemd[1]: Starting dracut-cmdline-ask.service...
Jul 2 01:50:58.297551 systemd[1]: Starting systemd-sysctl.service...
Jul 2 01:50:58.314042 systemd[1]: Starting systemd-tmpfiles-setup-dev.service...
Jul 2 01:50:58.336187 systemd[1]: Finished systemd-sysctl.service.
Jul 2 01:50:58.339000 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'
Jul 2 01:50:58.359722 systemd[1]: Finished dracut-cmdline-ask.service.
Jul 2 01:50:58.364304 systemd[1]: Finished systemd-tmpfiles-setup-dev.service.
Jul 2 01:50:58.363000 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'
Jul 2 01:50:58.391930 kernel: audit: type=1130 audit(1719885058.339: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'
Jul 2 01:50:58.391973 kernel: audit: type=1130 audit(1719885058.363:9): 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'
Jul 2 01:50:58.392830 systemd[1]: Starting dracut-cmdline.service...
Jul 2 01:50:58.416408 kernel: audit: type=1130 audit(1719885058.372:10): 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'
Jul 2 01:50:58.372000 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'
Jul 2 01:50:58.421609 dracut-cmdline[298]: dracut-dracut-053
Jul 2 01:50:58.427383 dracut-cmdline[298]: 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=7b86ecfcd4701bdf4668db795601b20c118ac0b117c34a9b3836e0a5236b73b0
Jul 2 01:50:58.509965 kernel: Loading iSCSI transport class v2.0-870.
Jul 2 01:50:58.524964 kernel: iscsi: registered transport (tcp)
Jul 2 01:50:58.544994 kernel: iscsi: registered transport (qla4xxx)
Jul 2 01:50:58.545048 kernel: QLogic iSCSI HBA Driver
Jul 2 01:50:58.574582 systemd[1]: Finished dracut-cmdline.service.
Jul 2 01:50:58.582000 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'
Jul 2 01:50:58.583728 systemd[1]: Starting dracut-pre-udev.service...
Jul 2 01:50:58.632955 kernel: raid6: neonx8 gen() 13832 MB/s
Jul 2 01:50:58.651948 kernel: raid6: neonx8 xor() 10845 MB/s
Jul 2 01:50:58.671946 kernel: raid6: neonx4 gen() 13555 MB/s
Jul 2 01:50:58.692946 kernel: raid6: neonx4 xor() 11200 MB/s
Jul 2 01:50:58.712945 kernel: raid6: neonx2 gen() 12969 MB/s
Jul 2 01:50:58.732945 kernel: raid6: neonx2 xor() 10467 MB/s
Jul 2 01:50:58.753946 kernel: raid6: neonx1 gen() 10567 MB/s
Jul 2 01:50:58.773945 kernel: raid6: neonx1 xor() 8793 MB/s
Jul 2 01:50:58.793945 kernel: raid6: int64x8 gen() 6278 MB/s
Jul 2 01:50:58.814945 kernel: raid6: int64x8 xor() 3544 MB/s
Jul 2 01:50:58.834945 kernel: raid6: int64x4 gen() 7224 MB/s
Jul 2 01:50:58.854949 kernel: raid6: int64x4 xor() 3847 MB/s
Jul 2 01:50:58.875945 kernel: raid6: int64x2 gen() 6155 MB/s
Jul 2 01:50:58.895944 kernel: raid6: int64x2 xor() 3325 MB/s
Jul 2 01:50:58.915948 kernel: raid6: int64x1 gen() 5044 MB/s
Jul 2 01:50:58.940885 kernel: raid6: int64x1 xor() 2646 MB/s
Jul 2 01:50:58.940896 kernel: raid6: using algorithm neonx8 gen() 13832 MB/s
Jul 2 01:50:58.940904 kernel: raid6: .... xor() 10845 MB/s, rmw enabled
Jul 2 01:50:58.948568 kernel: raid6: using neon recovery algorithm
Jul 2 01:50:58.965388 kernel: xor: measuring software checksum speed
Jul 2 01:50:58.965410 kernel: 8regs : 17300 MB/sec
Jul 2 01:50:58.969339 kernel: 32regs : 20749 MB/sec
Jul 2 01:50:58.973098 kernel: arm64_neon : 27892 MB/sec
Jul 2 01:50:58.973110 kernel: xor: using function: arm64_neon (27892 MB/sec)
Jul 2 01:50:59.032951 kernel: Btrfs loaded, crc32c=crc32c-generic, zoned=no, fsverity=no
Jul 2 01:50:59.041567 systemd[1]: Finished dracut-pre-udev.service.
Jul 2 01:50:59.045000 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'
Jul 2 01:50:59.049000 audit: BPF prog-id=7 op=LOAD
Jul 2 01:50:59.049000 audit: BPF prog-id=8 op=LOAD
Jul 2 01:50:59.050124 systemd[1]: Starting systemd-udevd.service...
Jul 2 01:50:59.067459 systemd-udevd[475]: Using default interface naming scheme 'v252'.
Jul 2 01:50:59.073311 systemd[1]: Started systemd-udevd.service.
Jul 2 01:50:59.077000 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'
Jul 2 01:50:59.083379 systemd[1]: Starting dracut-pre-trigger.service...
Jul 2 01:50:59.095475 dracut-pre-trigger[496]: rd.md=0: removing MD RAID activation
Jul 2 01:50:59.123270 systemd[1]: Finished dracut-pre-trigger.service.
Jul 2 01:50:59.127000 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'
Jul 2 01:50:59.128436 systemd[1]: Starting systemd-udev-trigger.service...
Jul 2 01:50:59.170464 systemd[1]: Finished systemd-udev-trigger.service.
Jul 2 01:50:59.174000 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'
Jul 2 01:50:59.222128 kernel: hv_vmbus: Vmbus version:5.3
Jul 2 01:50:59.229956 kernel: hv_vmbus: registering driver hid_hyperv
Jul 2 01:50:59.247507 kernel: hv_vmbus: registering driver hyperv_keyboard
Jul 2 01:50:59.247556 kernel: hv_vmbus: registering driver hv_netvsc
Jul 2 01:50:59.260944 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input0
Jul 2 01:50:59.292951 kernel: hid-generic 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on
Jul 2 01:50:59.293109 kernel: input: AT Translated Set 2 keyboard as /devices/LNXSYSTM:00/LNXSYBUS:00/ACPI0004:00/VMBUS:00/d34b2567-b9b6-42b9-8778-0a4ec0b955bf/serio0/input/input1
Jul 2 01:50:59.299955 kernel: hv_vmbus: registering driver hv_storvsc
Jul 2 01:50:59.303959 kernel: scsi host0: storvsc_host_t
Jul 2 01:50:59.304118 kernel: scsi host1: storvsc_host_t
Jul 2 01:50:59.313145 kernel: scsi 0:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5
Jul 2 01:50:59.319719 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 0
Jul 2 01:50:59.333957 kernel: hv_netvsc 002248bc-655d-0022-48bc-655d002248bc eth0: VF slot 1 added
Jul 2 01:50:59.348501 kernel: sd 0:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB)
Jul 2 01:50:59.348692 kernel: hv_vmbus: registering driver hv_pci
Jul 2 01:50:59.348703 kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks
Jul 2 01:50:59.363294 kernel: hv_pci e19024ba-29e6-4143-94dc-5e9cb7017f7a: PCI VMBus probing: Using version 0x10004
Jul 2 01:50:59.363483 kernel: sd 0:0:0:0: [sda] Write Protect is off
Jul 2 01:50:59.370043 kernel: hv_pci e19024ba-29e6-4143-94dc-5e9cb7017f7a: PCI host bridge to bus 29e6:00
Jul 2 01:50:59.370198 kernel: sd 0:0:0:0: [sda] Mode Sense: 0f 00 10 00
Jul 2 01:50:59.376211 kernel: pci_bus 29e6:00: root bus resource [mem 0xfc0000000-0xfc00fffff window]
Jul 2 01:50:59.376350 kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA
Jul 2 01:50:59.383965 kernel: pci_bus 29e6:00: No busn resource found for root bus, will use [bus 00-ff]
Jul 2 01:50:59.394522 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9
Jul 2 01:50:59.394552 kernel: pci 29e6:00:02.0: [15b3:1018] type 00 class 0x020000
Jul 2 01:50:59.403709 kernel: sd 0:0:0:0: [sda] Attached SCSI disk
Jul 2 01:50:59.420121 kernel: pci 29e6:00:02.0: reg 0x10: [mem 0xfc0000000-0xfc00fffff 64bit pref]
Jul 2 01:50:59.420204 kernel: sr 0:0:0:2: [sr0] scsi-1 drive
Jul 2 01:50:59.420367 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20
Jul 2 01:50:59.422952 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0
Jul 2 01:50:59.444146 kernel: pci 29e6:00:02.0: enabling Extended Tags
Jul 2 01:50:59.461983 kernel: pci 29e6:00:02.0: 0.000 Gb/s available PCIe bandwidth, limited by Unknown x0 link at 29e6:00:02.0 (capable of 126.016 Gb/s with 8.0 GT/s PCIe x16 link)
Jul 2 01:50:59.475177 kernel: pci_bus 29e6:00: busn_res: [bus 00-ff] end is updated to 00
Jul 2 01:50:59.475352 kernel: pci 29e6:00:02.0: BAR 0: assigned [mem 0xfc0000000-0xfc00fffff 64bit pref]
Jul 2 01:50:59.516966 kernel: mlx5_core 29e6:00:02.0: firmware version: 16.30.1284
Jul 2 01:50:59.669952 kernel: mlx5_core 29e6:00:02.0: MLX5E: StrdRq(1) RqSz(8) StrdSz(2048) RxCqeCmprss(0)
Jul 2 01:50:59.728424 kernel: hv_netvsc 002248bc-655d-0022-48bc-655d002248bc eth0: VF registering: eth1
Jul 2 01:50:59.728603 kernel: mlx5_core 29e6:00:02.0 eth1: joined to eth0
Jul 2 01:50:59.739958 kernel: mlx5_core 29e6:00:02.0 enP10726s1: renamed from eth1
Jul 2 01:50:59.812664 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device.
Jul 2 01:50:59.851962 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/sda6 scanned by (udev-worker) (528)
Jul 2 01:50:59.864751 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device.
Jul 2 01:51:00.011843 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device.
Jul 2 01:51:00.017587 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device.
Jul 2 01:51:00.042331 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device.
Jul 2 01:51:00.059825 systemd[1]: Starting disk-uuid.service...
Jul 2 01:51:00.075970 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9
Jul 2 01:51:01.093960 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9
Jul 2 01:51:01.094451 disk-uuid[604]: The operation has completed successfully.
Jul 2 01:51:01.149089 systemd[1]: disk-uuid.service: Deactivated successfully.
Jul 2 01:51:01.153000 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'
Jul 2 01:51:01.153000 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'
Jul 2 01:51:01.149178 systemd[1]: Finished disk-uuid.service.
Jul 2 01:51:01.158265 systemd[1]: Starting verity-setup.service...
Jul 2 01:51:01.200975 kernel: device-mapper: verity: sha256 using implementation "sha256-ce"
Jul 2 01:51:01.383150 systemd[1]: Found device dev-mapper-usr.device.
Jul 2 01:51:01.388427 systemd[1]: Mounting sysusr-usr.mount...
Jul 2 01:51:01.399000 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'
Jul 2 01:51:01.395760 systemd[1]: Finished verity-setup.service.
Jul 2 01:51:01.455962 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: norecovery. Quota mode: none.
Jul 2 01:51:01.455924 systemd[1]: Mounted sysusr-usr.mount.
Jul 2 01:51:01.459710 systemd[1]: afterburn-network-kargs.service was skipped because no trigger condition checks were met.
Jul 2 01:51:01.460453 systemd[1]: Starting ignition-setup.service...
Jul 2 01:51:01.475335 systemd[1]: Starting parse-ip-for-networkd.service...
Jul 2 01:51:01.513926 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm
Jul 2 01:51:01.513989 kernel: BTRFS info (device sda6): using free space tree
Jul 2 01:51:01.518745 kernel: BTRFS info (device sda6): has skinny extents
Jul 2 01:51:01.564236 systemd[1]: Finished parse-ip-for-networkd.service.
Jul 2 01:51:01.568000 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'
Jul 2 01:51:01.572000 audit: BPF prog-id=9 op=LOAD
Jul 2 01:51:01.573351 systemd[1]: Starting systemd-networkd.service...
Jul 2 01:51:01.594049 systemd-networkd[871]: lo: Link UP
Jul 2 01:51:01.594062 systemd-networkd[871]: lo: Gained carrier
Jul 2 01:51:01.602000 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'
Jul 2 01:51:01.594458 systemd-networkd[871]: Enumeration completed
Jul 2 01:51:01.597866 systemd[1]: Started systemd-networkd.service.
Jul 2 01:51:01.598426 systemd-networkd[871]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
Jul 2 01:51:01.603324 systemd[1]: Reached target network.target.
Jul 2 01:51:01.634000 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'
Jul 2 01:51:01.608681 systemd[1]: Starting iscsiuio.service...
Jul 2 01:51:01.642905 iscsid[880]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi
Jul 2 01:51:01.642905 iscsid[880]: 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
Jul 2 01:51:01.642905 iscsid[880]: into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.<reversed domain name>[:identifier].
Jul 2 01:51:01.642905 iscsid[880]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6.
Jul 2 01:51:01.642905 iscsid[880]: If using hardware iscsi like qla4xxx this message can be ignored.
Jul 2 01:51:01.642905 iscsid[880]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi
Jul 2 01:51:01.642905 iscsid[880]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf
Jul 2 01:51:01.656000 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'
Jul 2 01:51:01.706000 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'
Jul 2 01:51:01.623625 systemd[1]: mnt-oem.mount: Deactivated successfully.
Jul 2 01:51:01.623989 systemd[1]: Started iscsiuio.service.
Jul 2 01:51:01.638530 systemd[1]: Starting iscsid.service...
Jul 2 01:51:01.653639 systemd[1]: Started iscsid.service.
Jul 2 01:51:01.674109 systemd[1]: Starting dracut-initqueue.service...
Jul 2 01:51:01.702667 systemd[1]: Finished dracut-initqueue.service.
Jul 2 01:51:01.767000 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'
Jul 2 01:51:01.707112 systemd[1]: Reached target remote-fs-pre.target.
Jul 2 01:51:01.718220 systemd[1]: Reached target remote-cryptsetup.target.
Jul 2 01:51:01.723996 systemd[1]: Reached target remote-fs.target.
Jul 2 01:51:01.734487 systemd[1]: Starting dracut-pre-mount.service...
Jul 2 01:51:01.759140 systemd[1]: Finished dracut-pre-mount.service.
Jul 2 01:51:01.797083 kernel: mlx5_core 29e6:00:02.0 enP10726s1: Link up
Jul 2 01:51:01.796290 systemd[1]: Finished ignition-setup.service.
Jul 2 01:51:01.800000 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'
Jul 2 01:51:01.802185 systemd[1]: Starting ignition-fetch-offline.service...
Jul 2 01:51:01.846451 kernel: hv_netvsc 002248bc-655d-0022-48bc-655d002248bc eth0: Data path switched to VF: enP10726s1
Jul 2 01:51:01.846621 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
Jul 2 01:51:01.847134 systemd-networkd[871]: enP10726s1: Link UP
Jul 2 01:51:01.847332 systemd-networkd[871]: eth0: Link UP
Jul 2 01:51:01.847678 systemd-networkd[871]: eth0: Gained carrier
Jul 2 01:51:01.861394 systemd-networkd[871]: enP10726s1: Gained carrier
Jul 2 01:51:01.872994 systemd-networkd[871]: eth0: DHCPv4 address 10.200.20.20/24, gateway 10.200.20.1 acquired from 168.63.129.16
Jul 2 01:51:03.551239 systemd-networkd[871]: eth0: Gained IPv6LL
Jul 2 01:51:04.448547 ignition[895]: Ignition 2.14.0
Jul 2 01:51:04.448561 ignition[895]: Stage: fetch-offline
Jul 2 01:51:04.448631 ignition[895]: reading system config file "/usr/lib/ignition/base.d/base.ign"
Jul 2 01:51:04.448655 ignition[895]: parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63
Jul 2 01:51:04.502058 ignition[895]: no config dir at "/usr/lib/ignition/base.platform.d/azure"
Jul 2 01:51:04.502225 ignition[895]: parsed url from cmdline: ""
Jul 2 01:51:04.502229 ignition[895]: no config URL provided
Jul 2 01:51:04.502233 ignition[895]: reading system config file "/usr/lib/ignition/user.ign"
Jul 2 01:51:04.523000 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'
Jul 2 01:51:04.514667 systemd[1]: Finished ignition-fetch-offline.service.
Jul 2 01:51:04.558377 kernel: kauditd_printk_skb: 18 callbacks suppressed
Jul 2 01:51:04.558412 kernel: audit: type=1130 audit(1719885064.523: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'
Jul 2 01:51:04.502242 ignition[895]: no config at "/usr/lib/ignition/user.ign"
Jul 2 01:51:04.524059 systemd[1]: Starting ignition-fetch.service...
Jul 2 01:51:04.502247 ignition[895]: failed to fetch config: resource requires networking
Jul 2 01:51:04.502688 ignition[895]: Ignition finished successfully
Jul 2 01:51:04.554181 ignition[902]: Ignition 2.14.0
Jul 2 01:51:04.554188 ignition[902]: Stage: fetch
Jul 2 01:51:04.554296 ignition[902]: reading system config file "/usr/lib/ignition/base.d/base.ign"
Jul 2 01:51:04.554322 ignition[902]: parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63
Jul 2 01:51:04.557638 ignition[902]: no config dir at "/usr/lib/ignition/base.platform.d/azure"
Jul 2 01:51:04.557803 ignition[902]: parsed url from cmdline: ""
Jul 2 01:51:04.557806 ignition[902]: no config URL provided
Jul 2 01:51:04.557814 ignition[902]: reading system config file "/usr/lib/ignition/user.ign"
Jul 2 01:51:04.557822 ignition[902]: no config at "/usr/lib/ignition/user.ign"
Jul 2 01:51:04.557855 ignition[902]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1
Jul 2 01:51:04.655699 ignition[902]: GET result: OK
Jul 2 01:51:04.655755 ignition[902]: config has been read from IMDS userdata
Jul 2 01:51:04.663000 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'
Jul 2 01:51:04.658419 unknown[902]: fetched base config from "system"
Jul 2 01:51:04.689009 kernel: audit: type=1130 audit(1719885064.663: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'
Jul 2 01:51:04.655773 ignition[902]: parsing config with SHA512: b546bfd2cccb43acaa552f1a7108f4062da9ef13e4e7daf0ff81fac78dfcd9bb3fb88abaed4127409d8c457e35bb0625d60ca7477651d7a2a35a2b040e39c492
Jul 2 01:51:04.658426 unknown[902]: fetched base config from "system"
Jul 2 01:51:04.658723 ignition[902]: fetch: fetch complete
Jul 2 01:51:04.658431 unknown[902]: fetched user config from "azure"
Jul 2 01:51:04.658727 ignition[902]: fetch: fetch passed
Jul 2 01:51:04.659915 systemd[1]: Finished ignition-fetch.service.
Jul 2 01:51:04.712000 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'
Jul 2 01:51:04.658767 ignition[902]: Ignition finished successfully
Jul 2 01:51:04.741066 kernel: audit: type=1130 audit(1719885064.712: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'
Jul 2 01:51:04.664801 systemd[1]: Starting ignition-kargs.service...
Jul 2 01:51:04.696280 ignition[908]: Ignition 2.14.0
Jul 2 01:51:04.705808 systemd[1]: Finished ignition-kargs.service.
Jul 2 01:51:04.696286 ignition[908]: Stage: kargs
Jul 2 01:51:04.732587 systemd[1]: Starting ignition-disks.service...
Jul 2 01:51:04.758000 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'
Jul 2 01:51:04.696392 ignition[908]: reading system config file "/usr/lib/ignition/base.d/base.ign"
Jul 2 01:51:04.793053 kernel: audit: type=1130 audit(1719885064.758: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'
Jul 2 01:51:04.754904 systemd[1]: Finished ignition-disks.service.
Jul 2 01:51:04.696410 ignition[908]: parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63
Jul 2 01:51:04.776819 systemd[1]: Reached target initrd-root-device.target.
Jul 2 01:51:04.698991 ignition[908]: no config dir at "/usr/lib/ignition/base.platform.d/azure"
Jul 2 01:51:04.783319 systemd[1]: Reached target local-fs-pre.target.
Jul 2 01:51:04.702264 ignition[908]: kargs: kargs passed
Jul 2 01:51:04.792880 systemd[1]: Reached target local-fs.target.
Jul 2 01:51:04.702309 ignition[908]: Ignition finished successfully
Jul 2 01:51:04.796960 systemd[1]: Reached target sysinit.target.
Jul 2 01:51:04.742510 ignition[914]: Ignition 2.14.0
Jul 2 01:51:04.804523 systemd[1]: Reached target basic.target.
Jul 2 01:51:04.742515 ignition[914]: Stage: disks
Jul 2 01:51:04.818112 systemd[1]: Starting systemd-fsck-root.service...
Jul 2 01:51:04.742621 ignition[914]: reading system config file "/usr/lib/ignition/base.d/base.ign"
Jul 2 01:51:04.742638 ignition[914]: parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63
Jul 2 01:51:04.745226 ignition[914]: no config dir at "/usr/lib/ignition/base.platform.d/azure"
Jul 2 01:51:04.751707 ignition[914]: disks: disks passed
Jul 2 01:51:04.751760 ignition[914]: Ignition finished successfully
Jul 2 01:51:04.882348 systemd-fsck[922]: ROOT: clean, 614/7326000 files, 481075/7359488 blocks
Jul 2 01:51:04.891574 systemd[1]: Finished systemd-fsck-root.service.
Jul 2 01:51:04.896000 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'
Jul 2 01:51:04.917564 systemd[1]: Mounting sysroot.mount...
Jul 2 01:51:04.926392 kernel: audit: type=1130 audit(1719885064.896: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'
Jul 2 01:51:04.936951 kernel: EXT4-fs (sda9): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none.
Jul 2 01:51:04.937617 systemd[1]: Mounted sysroot.mount.
Jul 2 01:51:04.941766 systemd[1]: Reached target initrd-root-fs.target.
Jul 2 01:51:04.978455 systemd[1]: Mounting sysroot-usr.mount...
Jul 2 01:51:04.982832 systemd[1]: Starting flatcar-metadata-hostname.service...
Jul 2 01:51:04.990530 systemd[1]: ignition-remount-sysroot.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot).
Jul 2 01:51:04.990562 systemd[1]: Reached target ignition-diskful.target.
Jul 2 01:51:04.996178 systemd[1]: Mounted sysroot-usr.mount.
Jul 2 01:51:05.073295 systemd[1]: Mounting sysroot-usr-share-oem.mount...
Jul 2 01:51:05.078029 systemd[1]: Starting initrd-setup-root.service...
Jul 2 01:51:05.100967 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/sda6 scanned by mount (933)
Jul 2 01:51:05.107584 initrd-setup-root[938]: cut: /sysroot/etc/passwd: No such file or directory
Jul 2 01:51:05.118985 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm
Jul 2 01:51:05.119010 kernel: BTRFS info (device sda6): using free space tree
Jul 2 01:51:05.119025 kernel: BTRFS info (device sda6): has skinny extents
Jul 2 01:51:05.126610 systemd[1]: Mounted sysroot-usr-share-oem.mount.
Jul 2 01:51:05.138264 initrd-setup-root[964]: cut: /sysroot/etc/group: No such file or directory
Jul 2 01:51:05.161668 initrd-setup-root[972]: cut: /sysroot/etc/shadow: No such file or directory
Jul 2 01:51:05.170625 initrd-setup-root[980]: cut: /sysroot/etc/gshadow: No such file or directory
Jul 2 01:51:05.707976 systemd[1]: Finished initrd-setup-root.service.
Jul 2 01:51:05.712000 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'
Jul 2 01:51:05.713283 systemd[1]: Starting ignition-mount.service...
Jul 2 01:51:05.745269 kernel: audit: type=1130 audit(1719885065.712: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'
Jul 2 01:51:05.735208 systemd[1]: Starting sysroot-boot.service...
Jul 2 01:51:05.744343 systemd[1]: sysusr-usr-share-oem.mount: Deactivated successfully.
Jul 2 01:51:05.744457 systemd[1]: sysroot-usr-share-oem.mount: Deactivated successfully.
Jul 2 01:51:05.772053 systemd[1]: Finished sysroot-boot.service.
Jul 2 01:51:05.775000 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'
Jul 2 01:51:05.797066 kernel: audit: type=1130 audit(1719885065.775: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'
Jul 2 01:51:05.800226 ignition[1003]: INFO : Ignition 2.14.0
Jul 2 01:51:05.804185 ignition[1003]: INFO : Stage: mount
Jul 2 01:51:05.804185 ignition[1003]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign"
Jul 2 01:51:05.804185 ignition[1003]: DEBUG : parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63
Jul 2 01:51:05.831850 ignition[1003]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure"
Jul 2 01:51:05.831850 ignition[1003]: INFO : mount: mount passed
Jul 2 01:51:05.831850 ignition[1003]: INFO : Ignition finished successfully
Jul 2 01:51:05.862422 kernel: audit: type=1130 audit(1719885065.831:36): 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'
Jul 2 01:51:05.831000 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'
Jul 2 01:51:05.827407 systemd[1]: Finished ignition-mount.service.
Jul 2 01:51:06.355833 coreos-metadata[932]: Jul 02 01:51:06.355 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1
Jul 2 01:51:06.365359 coreos-metadata[932]: Jul 02 01:51:06.365 INFO Fetch successful
Jul 2 01:51:06.400313 coreos-metadata[932]: Jul 02 01:51:06.400 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1
Jul 2 01:51:06.420707 coreos-metadata[932]: Jul 02 01:51:06.420 INFO Fetch successful
Jul 2 01:51:06.436483 coreos-metadata[932]: Jul 02 01:51:06.436 INFO wrote hostname ci-3510.3.5-a-aa92461ff3 to /sysroot/etc/hostname
Jul 2 01:51:06.444699 systemd[1]: Finished flatcar-metadata-hostname.service.
Jul 2 01:51:06.449000 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'
Jul 2 01:51:06.469530 systemd[1]: Starting ignition-files.service...
Jul 2 01:51:06.478120 kernel: audit: type=1130 audit(1719885066.449:37): 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'
Jul 2 01:51:06.480314 systemd[1]: Mounting sysroot-usr-share-oem.mount...
Jul 2 01:51:06.498029 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/sda6 scanned by mount (1012)
Jul 2 01:51:06.510358 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm
Jul 2 01:51:06.510389 kernel: BTRFS info (device sda6): using free space tree
Jul 2 01:51:06.510399 kernel: BTRFS info (device sda6): has skinny extents
Jul 2 01:51:06.536591 systemd[1]: Mounted sysroot-usr-share-oem.mount.
Jul 2 01:51:06.553756 ignition[1031]: INFO : Ignition 2.14.0
Jul 2 01:51:06.557621 ignition[1031]: INFO : Stage: files
Jul 2 01:51:06.562012 ignition[1031]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign"
Jul 2 01:51:06.562012 ignition[1031]: DEBUG : parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63
Jul 2 01:51:06.584120 ignition[1031]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure"
Jul 2 01:51:06.584120 ignition[1031]: DEBUG : files: compiled without relabeling support, skipping
Jul 2 01:51:06.584120 ignition[1031]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core"
Jul 2 01:51:06.584120 ignition[1031]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core"
Jul 2 01:51:06.664198 ignition[1031]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core"
Jul 2 01:51:06.671669 ignition[1031]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core"
Jul 2 01:51:06.680865 ignition[1031]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core"
Jul 2 01:51:06.680865 ignition[1031]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf"
Jul 2 01:51:06.680865 ignition[1031]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf"
Jul 2 01:51:06.680865 ignition[1031]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/systemd/system/waagent.service"
Jul 2 01:51:06.680865 ignition[1031]: INFO : files: createFilesystemsFiles: createFiles: op(4): oem config not found in "/usr/share/oem", looking on oem partition
Jul 2 01:51:06.737399 kernel: BTRFS info: devid 1 device path /dev/sda6 changed to /dev/disk/by-label/OEM scanned by ignition (1036)
Jul 2 01:51:06.671773 unknown[1031]: wrote ssh authorized keys file for user: core
Jul 2 01:51:06.742685 ignition[1031]: INFO : files: createFilesystemsFiles: createFiles: op(4): op(5): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3914883898"
Jul 2 01:51:06.742685 ignition[1031]: CRITICAL : files: createFilesystemsFiles: createFiles: op(4): op(5): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3914883898": device or resource busy
Jul 2 01:51:06.742685 ignition[1031]: ERROR : files: createFilesystemsFiles: createFiles: op(4): failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem3914883898", trying btrfs: device or resource busy
Jul 2 01:51:06.742685 ignition[1031]: INFO : files: createFilesystemsFiles: createFiles: op(4): op(6): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3914883898"
Jul 2 01:51:06.742685 ignition[1031]: INFO : files: createFilesystemsFiles: createFiles: op(4): op(6): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3914883898"
Jul 2 01:51:06.742685 ignition[1031]: INFO : files: createFilesystemsFiles: createFiles: op(4): op(7): [started] unmounting "/mnt/oem3914883898"
Jul 2 01:51:06.742685 ignition[1031]: INFO : files: createFilesystemsFiles: createFiles: op(4): op(7): [finished] unmounting "/mnt/oem3914883898"
Jul 2 01:51:06.742685 ignition[1031]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/systemd/system/waagent.service"
Jul 2 01:51:06.742685 ignition[1031]: INFO : files: createFilesystemsFiles: createFiles: op(8): [started] writing file "/sysroot/etc/systemd/system/nvidia.service"
Jul 2 01:51:06.742685 ignition[1031]: INFO : files: createFilesystemsFiles: createFiles: op(8): oem config not found in "/usr/share/oem", looking on oem partition
Jul 2 01:51:06.924183 kernel: audit: type=1130 audit(1719885066.782: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'
Jul 2 01:51:06.782000 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'
Jul 2 01:51:06.842000 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'
Jul 2 01:51:06.842000 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'
Jul 2 01:51:06.864000 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'
Jul 2 01:51:06.729628 systemd[1]: mnt-oem3914883898.mount: Deactivated successfully.
Jul 2 01:51:06.939759 ignition[1031]: INFO : files: createFilesystemsFiles: createFiles: op(8): op(9): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1161868303"
Jul 2 01:51:06.939759 ignition[1031]: CRITICAL : files: createFilesystemsFiles: createFiles: op(8): op(9): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1161868303": device or resource busy
Jul 2 01:51:06.939759 ignition[1031]: ERROR : files: createFilesystemsFiles: createFiles: op(8): failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem1161868303", trying btrfs: device or resource busy
Jul 2 01:51:06.939759 ignition[1031]: INFO : files: createFilesystemsFiles: createFiles: op(8): op(a): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1161868303"
Jul 2 01:51:06.939759 ignition[1031]: INFO : files: createFilesystemsFiles: createFiles: op(8): op(a): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1161868303"
Jul 2 01:51:06.939759 ignition[1031]: INFO : files: createFilesystemsFiles: createFiles: op(8): op(b): [started] unmounting "/mnt/oem1161868303"
Jul 2 01:51:06.939759 ignition[1031]: INFO : files: createFilesystemsFiles: createFiles: op(8): op(b): [finished] unmounting "/mnt/oem1161868303"
Jul 2 01:51:06.939759 ignition[1031]: INFO : files: createFilesystemsFiles: createFiles: op(8): [finished] writing file "/sysroot/etc/systemd/system/nvidia.service"
Jul 2 01:51:06.939759 ignition[1031]: INFO : files: op(c): [started] processing unit "waagent.service"
Jul 2 01:51:06.939759 ignition[1031]: INFO : files: op(c): [finished] processing unit "waagent.service"
Jul 2 01:51:06.939759 ignition[1031]: INFO : files: op(d): [started] processing unit "nvidia.service"
Jul 2 01:51:06.939759 ignition[1031]: INFO : files: op(d): [finished] processing unit "nvidia.service"
Jul 2 01:51:06.939759 ignition[1031]: INFO : files: op(e): [started] setting preset to enabled for "waagent.service"
Jul 2 01:51:06.939759 ignition[1031]: INFO : files: op(e): [finished] setting preset to enabled for "waagent.service"
Jul 2 01:51:06.939759 ignition[1031]: INFO : files: op(f): [started] setting preset to enabled for "nvidia.service"
Jul 2 01:51:06.939759 ignition[1031]: INFO : files: op(f): [finished] setting preset to enabled for "nvidia.service"
Jul 2 01:51:06.939759 ignition[1031]: INFO : files: createResultFile: createFiles: op(10): [started] writing file "/sysroot/etc/.ignition-result.json"
Jul 2 01:51:06.939759 ignition[1031]: INFO : files: createResultFile: createFiles: op(10): [finished] writing file "/sysroot/etc/.ignition-result.json"
Jul 2 01:51:06.939759 ignition[1031]: INFO : files: files passed
Jul 2 01:51:06.939759 ignition[1031]: INFO : Ignition finished successfully
Jul 2 01:51:06.977000 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'
Jul 2 01:51:06.977000 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'
Jul 2 01:51:07.074000 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'
Jul 2 01:51:07.145000 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'
Jul 2 01:51:06.756682 systemd[1]: mnt-oem1161868303.mount: Deactivated successfully.
Jul 2 01:51:06.769427 systemd[1]: Finished ignition-files.service.
Jul 2 01:51:07.175417 initrd-setup-root-after-ignition[1056]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory
Jul 2 01:51:06.783989 systemd[1]: Starting initrd-setup-root-after-ignition.service...
Jul 2 01:51:06.812192 systemd[1]: torcx-profile-populate.service was skipped because of an unmet condition check (ConditionPathExists=/sysroot/etc/torcx/next-profile).
Jul 2 01:51:06.813026 systemd[1]: Starting ignition-quench.service...
Jul 2 01:51:06.837874 systemd[1]: ignition-quench.service: Deactivated successfully.
Jul 2 01:51:06.838000 systemd[1]: Finished ignition-quench.service.
Jul 2 01:51:06.843526 systemd[1]: Finished initrd-setup-root-after-ignition.service.
Jul 2 01:51:06.865270 systemd[1]: Reached target ignition-complete.target.
Jul 2 01:51:06.906509 systemd[1]: Starting initrd-parse-etc.service...
Jul 2 01:51:07.255000 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'
Jul 2 01:51:06.963099 systemd[1]: initrd-parse-etc.service: Deactivated successfully.
Jul 2 01:51:06.963321 systemd[1]: Finished initrd-parse-etc.service.
Jul 2 01:51:07.272000 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'
Jul 2 01:51:06.977787 systemd[1]: Reached target initrd-fs.target.
Jul 2 01:51:07.281000 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'
Jul 2 01:51:06.994128 systemd[1]: Reached target initrd.target.
Jul 2 01:51:07.288000 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'
Jul 2 01:51:07.007993 systemd[1]: dracut-mount.service was skipped because no trigger condition checks were met.
Jul 2 01:51:07.296000 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'
Jul 2 01:51:07.008850 systemd[1]: Starting dracut-pre-pivot.service...
Jul 2 01:51:07.064435 systemd[1]: Finished dracut-pre-pivot.service.
Jul 2 01:51:07.315000 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'
Jul 2 01:51:07.075285 systemd[1]: Starting initrd-cleanup.service...
Jul 2 01:51:07.335000 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'
Jul 2 01:51:07.340500 ignition[1069]: INFO : Ignition 2.14.0
Jul 2 01:51:07.340500 ignition[1069]: INFO : Stage: umount
Jul 2 01:51:07.340500 ignition[1069]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign"
Jul 2 01:51:07.340500 ignition[1069]: DEBUG : parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63
Jul 2 01:51:07.340500 ignition[1069]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure"
Jul 2 01:51:07.340500 ignition[1069]: INFO : umount: umount passed
Jul 2 01:51:07.340500 ignition[1069]: INFO : Ignition finished successfully
Jul 2 01:51:07.344000 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'
Jul 2 01:51:07.352000 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'
Jul 2 01:51:07.352000 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'
Jul 2 01:51:07.361000 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'
Jul 2 01:51:07.371000 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'
Jul 2 01:51:07.388000 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'
Jul 2 01:51:07.098546 systemd[1]: Stopped target nss-lookup.target.
Jul 2 01:51:07.407000 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'
Jul 2 01:51:07.109013 systemd[1]: Stopped target remote-cryptsetup.target.
Jul 2 01:51:07.120681 systemd[1]: Stopped target timers.target.
Jul 2 01:51:07.423000 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'
Jul 2 01:51:07.133295 systemd[1]: dracut-pre-pivot.service: Deactivated successfully.
Jul 2 01:51:07.133356 systemd[1]: Stopped dracut-pre-pivot.service.
Jul 2 01:51:07.146037 systemd[1]: Stopped target initrd.target.
Jul 2 01:51:07.154086 systemd[1]: Stopped target basic.target.
Jul 2 01:51:07.162237 systemd[1]: Stopped target ignition-complete.target.
Jul 2 01:51:07.171793 systemd[1]: Stopped target ignition-diskful.target.
Jul 2 01:51:07.179780 systemd[1]: Stopped target initrd-root-device.target.
Jul 2 01:51:07.192497 systemd[1]: Stopped target remote-fs.target.
Jul 2 01:51:07.482000 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'
Jul 2 01:51:07.201456 systemd[1]: Stopped target remote-fs-pre.target.
Jul 2 01:51:07.215374 systemd[1]: Stopped target sysinit.target.
Jul 2 01:51:07.222957 systemd[1]: Stopped target local-fs.target.
Jul 2 01:51:07.506000 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'
Jul 2 01:51:07.231860 systemd[1]: Stopped target local-fs-pre.target.
Jul 2 01:51:07.514000 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'
Jul 2 01:51:07.239646 systemd[1]: Stopped target swap.target.
Jul 2 01:51:07.248116 systemd[1]: dracut-pre-mount.service: Deactivated successfully.
Jul 2 01:51:07.530000 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'
Jul 2 01:51:07.248174 systemd[1]: Stopped dracut-pre-mount.service.
Jul 2 01:51:07.256168 systemd[1]: Stopped target cryptsetup.target.
Jul 2 01:51:07.263986 systemd[1]: dracut-initqueue.service: Deactivated successfully.
Jul 2 01:51:07.551000 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'
Jul 2 01:51:07.264030 systemd[1]: Stopped dracut-initqueue.service.
Jul 2 01:51:07.560000 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'
Jul 2 01:51:07.272731 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully.
Jul 2 01:51:07.568000 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'
Jul 2 01:51:07.272768 systemd[1]: Stopped initrd-setup-root-after-ignition.service.
Jul 2 01:51:07.281477 systemd[1]: ignition-files.service: Deactivated successfully.
Jul 2 01:51:07.281513 systemd[1]: Stopped ignition-files.service.
Jul 2 01:51:07.591000 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'
Jul 2 01:51:07.288953 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully.
Jul 2 01:51:07.600000 audit: BPF prog-id=6 op=UNLOAD
Jul 2 01:51:07.600000 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'
Jul 2 01:51:07.288991 systemd[1]: Stopped flatcar-metadata-hostname.service.
Jul 2 01:51:07.297731 systemd[1]: Stopping ignition-mount.service...
Jul 2 01:51:07.306781 systemd[1]: kmod-static-nodes.service: Deactivated successfully.
Jul 2 01:51:07.627000 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'
Jul 2 01:51:07.306853 systemd[1]: Stopped kmod-static-nodes.service.
Jul 2 01:51:07.636000 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'
Jul 2 01:51:07.316167 systemd[1]: Stopping sysroot-boot.service...
Jul 2 01:51:07.643000 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'
Jul 2 01:51:07.319748 systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
Jul 2 01:51:07.666408 kernel: hv_netvsc 002248bc-655d-0022-48bc-655d002248bc eth0: Data path switched from VF: enP10726s1
Jul 2 01:51:07.319858 systemd[1]: Stopped systemd-udev-trigger.service.
Jul 2 01:51:07.670000 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'
Jul 2 01:51:07.336378 systemd[1]: dracut-pre-trigger.service: Deactivated successfully.
Jul 2 01:51:07.679000 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'
Jul 2 01:51:07.679000 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'
Jul 2 01:51:07.336433 systemd[1]: Stopped dracut-pre-trigger.service.
Jul 2 01:51:07.345371 systemd[1]: initrd-cleanup.service: Deactivated successfully.
Jul 2 01:51:07.345469 systemd[1]: Finished initrd-cleanup.service.
Jul 2 01:51:07.353367 systemd[1]: ignition-mount.service: Deactivated successfully.
Jul 2 01:51:07.353464 systemd[1]: Stopped ignition-mount.service.
Jul 2 01:51:07.706000 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'
Jul 2 01:51:07.361561 systemd[1]: ignition-disks.service: Deactivated successfully.
Jul 2 01:51:07.361613 systemd[1]: Stopped ignition-disks.service.
Jul 2 01:51:07.372905 systemd[1]: ignition-kargs.service: Deactivated successfully.
Jul 2 01:51:07.372963 systemd[1]: Stopped ignition-kargs.service.
Jul 2 01:51:07.388885 systemd[1]: ignition-fetch.service: Deactivated successfully.
Jul 2 01:51:07.388924 systemd[1]: Stopped ignition-fetch.service.
Jul 2 01:51:07.407574 systemd[1]: Stopped target network.target.
Jul 2 01:51:07.415167 systemd[1]: ignition-fetch-offline.service: Deactivated successfully.
Jul 2 01:51:07.415230 systemd[1]: Stopped ignition-fetch-offline.service.
Jul 2 01:51:07.424027 systemd[1]: Stopped target paths.target.
Jul 2 01:51:07.431176 systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
Jul 2 01:51:07.777358 systemd-journald[276]: Received SIGTERM from PID 1 (n/a).
Jul 2 01:51:07.777392 iscsid[880]: iscsid shutting down.
Jul 2 01:51:07.439958 systemd[1]: Stopped systemd-ask-password-console.path.
Jul 2 01:51:07.444721 systemd[1]: Stopped target slices.target.
Jul 2 01:51:07.452365 systemd[1]: Stopped target sockets.target.
Jul 2 01:51:07.459652 systemd[1]: iscsid.socket: Deactivated successfully.
Jul 2 01:51:07.459688 systemd[1]: Closed iscsid.socket.
Jul 2 01:51:07.467312 systemd[1]: iscsiuio.socket: Deactivated successfully.
Jul 2 01:51:07.467338 systemd[1]: Closed iscsiuio.socket.
Jul 2 01:51:07.474762 systemd[1]: ignition-setup.service: Deactivated successfully.
Jul 2 01:51:07.474806 systemd[1]: Stopped ignition-setup.service.
Jul 2 01:51:07.483228 systemd[1]: Stopping systemd-networkd.service...
Jul 2 01:51:07.490465 systemd[1]: Stopping systemd-resolved.service...
Jul 2 01:51:07.497964 systemd-networkd[871]: eth0: DHCPv6 lease lost
Jul 2 01:51:07.777000 audit: BPF prog-id=9 op=UNLOAD
Jul 2 01:51:07.499053 systemd[1]: sysroot-boot.service: Deactivated successfully.
Jul 2 01:51:07.499156 systemd[1]: Stopped sysroot-boot.service.
Jul 2 01:51:07.506588 systemd[1]: systemd-networkd.service: Deactivated successfully.
Jul 2 01:51:07.506677 systemd[1]: Stopped systemd-networkd.service.
Jul 2 01:51:07.515483 systemd[1]: systemd-networkd.socket: Deactivated successfully.
Jul 2 01:51:07.515515 systemd[1]: Closed systemd-networkd.socket.
Jul 2 01:51:07.522995 systemd[1]: initrd-setup-root.service: Deactivated successfully.
Jul 2 01:51:07.523037 systemd[1]: Stopped initrd-setup-root.service.
Jul 2 01:51:07.535465 systemd[1]: Stopping network-cleanup.service...
Jul 2 01:51:07.543691 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully.
Jul 2 01:51:07.543755 systemd[1]: Stopped parse-ip-for-networkd.service.
Jul 2 01:51:07.552009 systemd[1]: systemd-sysctl.service: Deactivated successfully.
Jul 2 01:51:07.552078 systemd[1]: Stopped systemd-sysctl.service.
Jul 2 01:51:07.564562 systemd[1]: systemd-modules-load.service: Deactivated successfully.
Jul 2 01:51:07.564601 systemd[1]: Stopped systemd-modules-load.service.
Jul 2 01:51:07.569069 systemd[1]: Stopping systemd-udevd.service...
Jul 2 01:51:07.584064 systemd[1]: sysroot-boot.mount: Deactivated successfully.
Jul 2 01:51:07.584147 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully.
Jul 2 01:51:07.584697 systemd[1]: systemd-resolved.service: Deactivated successfully.
Jul 2 01:51:07.584787 systemd[1]: Stopped systemd-resolved.service.
Jul 2 01:51:07.593124 systemd[1]: systemd-udevd.service: Deactivated successfully.
Jul 2 01:51:07.593300 systemd[1]: Stopped systemd-udevd.service.
Jul 2 01:51:07.601139 systemd[1]: systemd-udevd-control.socket: Deactivated successfully.
Jul 2 01:51:07.601200 systemd[1]: Closed systemd-udevd-control.socket.
Jul 2 01:51:07.610899 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully.
Jul 2 01:51:07.610943 systemd[1]: Closed systemd-udevd-kernel.socket.
Jul 2 01:51:07.619464 systemd[1]: dracut-pre-udev.service: Deactivated successfully.
Jul 2 01:51:07.619500 systemd[1]: Stopped dracut-pre-udev.service.
Jul 2 01:51:07.627543 systemd[1]: dracut-cmdline.service: Deactivated successfully.
Jul 2 01:51:07.627578 systemd[1]: Stopped dracut-cmdline.service.
Jul 2 01:51:07.636511 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully.
Jul 2 01:51:07.636544 systemd[1]: Stopped dracut-cmdline-ask.service.
Jul 2 01:51:07.645024 systemd[1]: Starting initrd-udevadm-cleanup-db.service...
Jul 2 01:51:07.661493 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
Jul 2 01:51:07.661551 systemd[1]: Stopped systemd-vconsole-setup.service.
Jul 2 01:51:07.671523 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
Jul 2 01:51:07.671616 systemd[1]: Finished initrd-udevadm-cleanup-db.service.
Jul 2 01:51:07.698505 systemd[1]: network-cleanup.service: Deactivated successfully.
Jul 2 01:51:07.698612 systemd[1]: Stopped network-cleanup.service.
Jul 2 01:51:07.707212 systemd[1]: Reached target initrd-switch-root.target.
Jul 2 01:51:07.715765 systemd[1]: Starting initrd-switch-root.service...
Jul 2 01:51:07.732046 systemd[1]: Switching root.
Jul 2 01:51:07.778819 systemd-journald[276]: Journal stopped
Jul 2 01:51:18.851077 kernel: SELinux: Class mctp_socket not defined in policy.
Jul 2 01:51:18.851098 kernel: SELinux: Class anon_inode not defined in policy.
Jul 2 01:51:18.851109 kernel: SELinux: the above unknown classes and permissions will be allowed
Jul 2 01:51:18.851119 kernel: SELinux: policy capability network_peer_controls=1
Jul 2 01:51:18.851127 kernel: SELinux: policy capability open_perms=1
Jul 2 01:51:18.851135 kernel: SELinux: policy capability extended_socket_class=1
Jul 2 01:51:18.851144 kernel: SELinux: policy capability always_check_network=0
Jul 2 01:51:18.851153 kernel: SELinux: policy capability cgroup_seclabel=1
Jul 2 01:51:18.851161 kernel: SELinux: policy capability nnp_nosuid_transition=1
Jul 2 01:51:18.851169 kernel: SELinux: policy capability genfs_seclabel_symlinks=0
Jul 2 01:51:18.851178 kernel: SELinux: policy capability ioctl_skip_cloexec=0
Jul 2 01:51:18.851186 kernel: kauditd_printk_skb: 40 callbacks suppressed
Jul 2 01:51:18.851196 kernel: audit: type=1403 audit(1719885070.064:79): auid=4294967295 ses=4294967295 lsm=selinux res=1
Jul 2 01:51:18.851207 systemd[1]: Successfully loaded SELinux policy in 284ms.
Jul 2 01:51:18.851218 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 25.051ms.
Jul 2 01:51:18.851229 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)
Jul 2 01:51:18.851238 systemd[1]: Detected virtualization microsoft.
Jul 2 01:51:18.851247 systemd[1]: Detected architecture arm64.
Jul 2 01:51:18.851256 systemd[1]: Detected first boot.
Jul 2 01:51:18.851266 systemd[1]: Hostname set to <ci-3510.3.5-a-aa92461ff3>.
Jul 2 01:51:18.851299 systemd[1]: Initializing machine ID from random generator.
Jul 2 01:51:18.851311 kernel: audit: type=1400 audit(1719885070.748:80): 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
Jul 2 01:51:18.851398 kernel: audit: type=1400 audit(1719885070.748:81): 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
Jul 2 01:51:18.851410 kernel: audit: type=1334 audit(1719885070.766:82): prog-id=10 op=LOAD
Jul 2 01:51:18.851419 kernel: audit: type=1334 audit(1719885070.766:83): prog-id=10 op=UNLOAD
Jul 2 01:51:18.851428 kernel: audit: type=1334 audit(1719885070.785:84): prog-id=11 op=LOAD
Jul 2 01:51:18.851437 kernel: audit: type=1334 audit(1719885070.785:85): prog-id=11 op=UNLOAD
Jul 2 01:51:18.851445 kernel: SELinux: Context system_u:object_r:container_file_t:s0:c1022,c1023 is not valid (left unmapped).
Jul 2 01:51:18.851455 kernel: audit: type=1400 audit(1719885072.165:86): avc: denied { associate } for pid=1103 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"
Jul 2 01:51:18.851466 kernel: audit: type=1300 audit(1719885072.165:86): arch=c00000b7 syscall=5 success=yes exit=0 a0=4000145354 a1=40000c6690 a2=40000ccb80 a3=32 items=0 ppid=1086 pid=1103 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)
Jul 2 01:51:18.851476 kernel: audit: type=1327 audit(1719885072.165:86): proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61
Jul 2 01:51:18.851485 systemd[1]: Populated /etc with preset unit settings.
Jul 2 01:51:18.851494 systemd[1]: /usr/lib/systemd/system/locksmithd.service:8: Unit uses CPUShares=; please use CPUWeight= instead. Support for CPUShares= will be removed soon.
Jul 2 01:51:18.851506 systemd[1]: /usr/lib/systemd/system/locksmithd.service:9: Unit uses MemoryLimit=; please use MemoryMax= instead. Support for MemoryLimit= will be removed soon.
Jul 2 01:51:18.851516 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.
Jul 2 01:51:18.851526 kernel: kauditd_printk_skb: 6 callbacks suppressed
Jul 2 01:51:18.851535 kernel: audit: type=1334 audit(1719885078.184:88): prog-id=12 op=LOAD
Jul 2 01:51:18.851543 kernel: audit: type=1334 audit(1719885078.184:89): prog-id=3 op=UNLOAD
Jul 2 01:51:18.851552 kernel: audit: type=1334 audit(1719885078.189:90): prog-id=13 op=LOAD
Jul 2 01:51:18.851560 kernel: audit: type=1334 audit(1719885078.195:91): prog-id=14 op=LOAD
Jul 2 01:51:18.851571 kernel: audit: type=1334 audit(1719885078.195:92): prog-id=4 op=UNLOAD
Jul 2 01:51:18.851580 kernel: audit: type=1334 audit(1719885078.195:93): prog-id=5 op=UNLOAD
Jul 2 01:51:18.851589 kernel: audit: type=1334 audit(1719885078.201:94): prog-id=15 op=LOAD
Jul 2 01:51:18.851598 systemd[1]: iscsiuio.service: Deactivated successfully.
Jul 2 01:51:18.851608 kernel: audit: type=1334 audit(1719885078.201:95): prog-id=12 op=UNLOAD
Jul 2 01:51:18.851617 systemd[1]: Stopped iscsiuio.service.
Jul 2 01:51:18.851626 kernel: audit: type=1334 audit(1719885078.206:96): prog-id=16 op=LOAD
Jul 2 01:51:18.851635 kernel: audit: type=1334 audit(1719885078.206:97): prog-id=17 op=LOAD
Jul 2 01:51:18.851644 systemd[1]: iscsid.service: Deactivated successfully.
Jul 2 01:51:18.851653 systemd[1]: Stopped iscsid.service.
Jul 2 01:51:18.851662 systemd[1]: initrd-switch-root.service: Deactivated successfully.
Jul 2 01:51:18.851673 systemd[1]: Stopped initrd-switch-root.service.
Jul 2 01:51:18.851682 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
Jul 2 01:51:18.851692 systemd[1]: Created slice system-addon\x2dconfig.slice.
Jul 2 01:51:18.851703 systemd[1]: Created slice system-addon\x2drun.slice.
Jul 2 01:51:18.851712 systemd[1]: Created slice system-getty.slice.
Jul 2 01:51:18.851721 systemd[1]: Created slice system-modprobe.slice.
Jul 2 01:51:18.851731 systemd[1]: Created slice system-serial\x2dgetty.slice.
Jul 2 01:51:18.851740 systemd[1]: Created slice system-system\x2dcloudinit.slice.
Jul 2 01:51:18.851750 systemd[1]: Created slice system-systemd\x2dfsck.slice.
Jul 2 01:51:18.851760 systemd[1]: Created slice user.slice.
Jul 2 01:51:18.851770 systemd[1]: Started systemd-ask-password-console.path.
Jul 2 01:51:18.851779 systemd[1]: Started systemd-ask-password-wall.path.
Jul 2 01:51:18.851788 systemd[1]: Set up automount boot.automount.
Jul 2 01:51:18.851798 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount.
Jul 2 01:51:18.851807 systemd[1]: Stopped target initrd-switch-root.target.
Jul 2 01:51:18.851816 systemd[1]: Stopped target initrd-fs.target.
Jul 2 01:51:18.851826 systemd[1]: Stopped target initrd-root-fs.target.
Jul 2 01:51:18.851836 systemd[1]: Reached target integritysetup.target.
Jul 2 01:51:18.851845 systemd[1]: Reached target remote-cryptsetup.target.
Jul 2 01:51:18.851854 systemd[1]: Reached target remote-fs.target.
Jul 2 01:51:18.851864 systemd[1]: Reached target slices.target.
Jul 2 01:51:18.851873 systemd[1]: Reached target swap.target.
Jul 2 01:51:18.851882 systemd[1]: Reached target torcx.target.
Jul 2 01:51:18.851893 systemd[1]: Reached target veritysetup.target.
Jul 2 01:51:18.851903 systemd[1]: Listening on systemd-coredump.socket.
Jul 2 01:51:18.851913 systemd[1]: Listening on systemd-initctl.socket.
Jul 2 01:51:18.851922 systemd[1]: Listening on systemd-networkd.socket.
Jul 2 01:51:18.851931 systemd[1]: Listening on systemd-udevd-control.socket.
Jul 2 01:51:18.851963 systemd[1]: Listening on systemd-udevd-kernel.socket.
Jul 2 01:51:18.851974 systemd[1]: Listening on systemd-userdbd.socket.
Jul 2 01:51:18.851986 systemd[1]: Mounting dev-hugepages.mount...
Jul 2 01:51:18.851996 systemd[1]: Mounting dev-mqueue.mount...
Jul 2 01:51:18.852005 systemd[1]: Mounting media.mount...
Jul 2 01:51:18.852014 systemd[1]: Mounting sys-kernel-debug.mount...
Jul 2 01:51:18.852024 systemd[1]: Mounting sys-kernel-tracing.mount...
Jul 2 01:51:18.852033 systemd[1]: Mounting tmp.mount...
Jul 2 01:51:18.852043 systemd[1]: Starting flatcar-tmpfiles.service...
Jul 2 01:51:18.852052 systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met.
Jul 2 01:51:18.852062 systemd[1]: Starting kmod-static-nodes.service...
Jul 2 01:51:18.852072 systemd[1]: Starting modprobe@configfs.service...
Jul 2 01:51:18.852082 systemd[1]: Starting modprobe@dm_mod.service...
Jul 2 01:51:18.852091 systemd[1]: Starting modprobe@drm.service...
Jul 2 01:51:18.852100 systemd[1]: Starting modprobe@efi_pstore.service...
Jul 2 01:51:18.852110 systemd[1]: Starting modprobe@fuse.service...
Jul 2 01:51:18.852119 systemd[1]: Starting modprobe@loop.service...
Jul 2 01:51:18.852130 systemd[1]: setup-nsswitch.service was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf).
Jul 2 01:51:18.852140 systemd[1]: systemd-fsck-root.service: Deactivated successfully.
Jul 2 01:51:18.852149 systemd[1]: Stopped systemd-fsck-root.service.
Jul 2 01:51:18.852160 systemd[1]: systemd-fsck-usr.service: Deactivated successfully.
Jul 2 01:51:18.852169 systemd[1]: Stopped systemd-fsck-usr.service.
Jul 2 01:51:18.852179 systemd[1]: Stopped systemd-journald.service.
Jul 2 01:51:18.852189 systemd[1]: systemd-journald.service: Consumed 2.346s CPU time.
Jul 2 01:51:18.852198 systemd[1]: Starting systemd-journald.service...
Jul 2 01:51:18.852207 kernel: loop: module loaded
Jul 2 01:51:18.852216 systemd[1]: Starting systemd-modules-load.service...
Jul 2 01:51:18.852225 kernel: fuse: init (API version 7.34)
Jul 2 01:51:18.852234 systemd[1]: Starting systemd-network-generator.service...
Jul 2 01:51:18.852248 systemd[1]: Starting systemd-remount-fs.service...
Jul 2 01:51:18.852258 systemd[1]: Starting systemd-udev-trigger.service...
Jul 2 01:51:18.852267 systemd[1]: verity-setup.service: Deactivated successfully.
Jul 2 01:51:18.852276 systemd[1]: Stopped verity-setup.service.
Jul 2 01:51:18.852286 systemd[1]: Mounted dev-hugepages.mount.
Jul 2 01:51:18.852298 systemd-journald[1209]: Journal started
Jul 2 01:51:18.852339 systemd-journald[1209]: Runtime Journal (/run/log/journal/76ee25f1206041618146cdb953328c1d) is 8.0M, max 78.6M, 70.6M free.
Jul 2 01:51:10.064000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1
Jul 2 01:51:10.748000 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
Jul 2 01:51:10.748000 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
Jul 2 01:51:10.766000 audit: BPF prog-id=10 op=LOAD
Jul 2 01:51:10.766000 audit: BPF prog-id=10 op=UNLOAD
Jul 2 01:51:10.785000 audit: BPF prog-id=11 op=LOAD
Jul 2 01:51:10.785000 audit: BPF prog-id=11 op=UNLOAD
Jul 2 01:51:12.165000 audit[1103]: AVC avc: denied { associate } for pid=1103 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"
Jul 2 01:51:12.165000 audit[1103]: SYSCALL arch=c00000b7 syscall=5 success=yes exit=0 a0=4000145354 a1=40000c6690 a2=40000ccb80 a3=32 items=0 ppid=1086 pid=1103 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)
Jul 2 01:51:12.165000 audit: PROCTITLE proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61
Jul 2 01:51:12.174000 audit[1103]: AVC avc: denied { associate } for pid=1103 comm="torcx-generator" name="lib" scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1
Jul 2 01:51:12.174000 audit[1103]: SYSCALL arch=c00000b7 syscall=34 success=yes exit=0 a0=ffffffffffffff9c a1=4000145439 a2=1ed a3=0 items=2 ppid=1086 pid=1103 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)
Jul 2 01:51:12.174000 audit: CWD cwd="/"
Jul 2 01:51:12.174000 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
Jul 2 01:51:12.174000 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
Jul 2 01:51:12.174000 audit: PROCTITLE proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61
Jul 2 01:51:18.184000 audit: BPF prog-id=12 op=LOAD
Jul 2 01:51:18.184000 audit: BPF prog-id=3 op=UNLOAD
Jul 2 01:51:18.189000 audit: BPF prog-id=13 op=LOAD
Jul 2 01:51:18.195000 audit: BPF prog-id=14 op=LOAD
Jul 2 01:51:18.195000 audit: BPF prog-id=4 op=UNLOAD
Jul 2 01:51:18.195000 audit: BPF prog-id=5 op=UNLOAD
Jul 2 01:51:18.201000 audit: BPF prog-id=15 op=LOAD
Jul 2 01:51:18.201000 audit: BPF prog-id=12 op=UNLOAD
Jul 2 01:51:18.206000 audit: BPF prog-id=16 op=LOAD
Jul 2 01:51:18.206000 audit: BPF prog-id=17 op=LOAD
Jul 2 01:51:18.206000 audit: BPF prog-id=13 op=UNLOAD
Jul 2 01:51:18.206000 audit: BPF prog-id=14 op=UNLOAD
Jul 2 01:51:18.212000 audit: BPF prog-id=18 op=LOAD
Jul 2 01:51:18.212000 audit: BPF prog-id=15 op=UNLOAD
Jul 2 01:51:18.217000 audit: BPF prog-id=19 op=LOAD
Jul 2 01:51:18.222000 audit: BPF prog-id=20 op=LOAD
Jul 2 01:51:18.222000 audit: BPF prog-id=16 op=UNLOAD
Jul 2 01:51:18.222000 audit: BPF prog-id=17 op=UNLOAD
Jul 2 01:51:18.223000 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'
Jul 2 01:51:18.245000 audit: BPF prog-id=18 op=UNLOAD
Jul 2 01:51:18.258000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=iscsiuio comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Jul 2 01:51:18.270000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=iscsid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Jul 2 01:51:18.286000 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'
Jul 2 01:51:18.286000 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'
Jul 2 01:51:18.720000 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'
Jul 2 01:51:18.734000 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'
Jul 2 01:51:18.743000 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'
Jul 2 01:51:18.743000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Jul 2 01:51:18.749000 audit: BPF prog-id=21 op=LOAD
Jul 2 01:51:18.749000 audit: BPF prog-id=22 op=LOAD
Jul 2 01:51:18.749000 audit: BPF prog-id=23 op=LOAD
Jul 2 01:51:18.749000 audit: BPF prog-id=19 op=UNLOAD
Jul 2 01:51:18.749000 audit: BPF prog-id=20 op=UNLOAD
Jul 2 01:51:18.843000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1
Jul 2 01:51:18.843000 audit[1209]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=60 a0=3 a1=fffff545d870 a2=4000 a3=1 items=0 ppid=1 pid=1209 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)
Jul 2 01:51:18.843000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald"
Jul 2 01:51:18.849000 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'
Jul 2 01:51:18.184067 systemd[1]: Queued start job for default target multi-user.target.
Jul 2 01:51:12.097984 /usr/lib/systemd/system-generators/torcx-generator[1103]: time="2024-07-02T01:51:12Z" 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.5 /usr/share/oem/torcx/store /var/lib/torcx/store/3510.3.5 /var/lib/torcx/store]"
Jul 2 01:51:18.224297 systemd[1]: systemd-journald.service: Deactivated successfully.
Jul 2 01:51:12.113021 /usr/lib/systemd/system-generators/torcx-generator[1103]: time="2024-07-02T01:51:12Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json
Jul 2 01:51:18.224656 systemd[1]: systemd-journald.service: Consumed 2.346s CPU time.
Jul 2 01:51:12.113040 /usr/lib/systemd/system-generators/torcx-generator[1103]: time="2024-07-02T01:51:12Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json
Jul 2 01:51:12.113077 /usr/lib/systemd/system-generators/torcx-generator[1103]: time="2024-07-02T01:51:12Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12"
Jul 2 01:51:12.113087 /usr/lib/systemd/system-generators/torcx-generator[1103]: time="2024-07-02T01:51:12Z" level=debug msg="skipped missing lower profile" missing profile=oem
Jul 2 01:51:12.113124 /usr/lib/systemd/system-generators/torcx-generator[1103]: time="2024-07-02T01:51:12Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory"
Jul 2 01:51:12.113136 /usr/lib/systemd/system-generators/torcx-generator[1103]: time="2024-07-02T01:51:12Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)=
Jul 2 01:51:12.113335 /usr/lib/systemd/system-generators/torcx-generator[1103]: time="2024-07-02T01:51:12Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack
Jul 2 01:51:12.113364 /usr/lib/systemd/system-generators/torcx-generator[1103]: time="2024-07-02T01:51:12Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json
Jul 2 01:51:12.113375 /usr/lib/systemd/system-generators/torcx-generator[1103]: time="2024-07-02T01:51:12Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json
Jul 2 01:51:12.149560 /usr/lib/systemd/system-generators/torcx-generator[1103]: time="2024-07-02T01:51:12Z" 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
Jul 2 01:51:12.149658 /usr/lib/systemd/system-generators/torcx-generator[1103]: time="2024-07-02T01:51:12Z" 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
Jul 2 01:51:12.149710 /usr/lib/systemd/system-generators/torcx-generator[1103]: time="2024-07-02T01:51:12Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store/3510.3.5: no such file or directory" path=/usr/share/oem/torcx/store/3510.3.5
Jul 2 01:51:12.149737 /usr/lib/systemd/system-generators/torcx-generator[1103]: time="2024-07-02T01:51:12Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store
Jul 2 01:51:12.149771 /usr/lib/systemd/system-generators/torcx-generator[1103]: time="2024-07-02T01:51:12Z" level=info msg="store skipped" err="open /var/lib/torcx/store/3510.3.5: no such file or directory" path=/var/lib/torcx/store/3510.3.5
Jul 2 01:51:12.149795 /usr/lib/systemd/system-generators/torcx-generator[1103]: time="2024-07-02T01:51:12Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store
Jul 2 01:51:17.273545 /usr/lib/systemd/system-generators/torcx-generator[1103]: time="2024-07-02T01:51:17Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl
Jul 2 01:51:17.273800 /usr/lib/systemd/system-generators/torcx-generator[1103]: time="2024-07-02T01:51:17Z" 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
Jul 2 01:51:17.273899 /usr/lib/systemd/system-generators/torcx-generator[1103]: time="2024-07-02T01:51:17Z" 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
Jul 2 01:51:17.274075 /usr/lib/systemd/system-generators/torcx-generator[1103]: time="2024-07-02T01:51:17Z" 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
Jul 2 01:51:17.274124 /usr/lib/systemd/system-generators/torcx-generator[1103]: time="2024-07-02T01:51:17Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile=
Jul 2 01:51:17.274177 /usr/lib/systemd/system-generators/torcx-generator[1103]: time="2024-07-02T01:51:17Z" 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
Jul 2 01:51:18.867872 systemd[1]: Started systemd-journald.service.
Jul 2 01:51:18.867000 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'
Jul 2 01:51:18.868546 systemd[1]: Mounted dev-mqueue.mount.
Jul 2 01:51:18.872331 systemd[1]: Mounted media.mount.
Jul 2 01:51:18.875840 systemd[1]: Mounted sys-kernel-debug.mount.
Jul 2 01:51:18.879974 systemd[1]: Mounted sys-kernel-tracing.mount.
Jul 2 01:51:18.884100 systemd[1]: Mounted tmp.mount.
Jul 2 01:51:18.887571 systemd[1]: Finished flatcar-tmpfiles.service.
Jul 2 01:51:18.891000 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'
Jul 2 01:51:18.892443 systemd[1]: Finished kmod-static-nodes.service.
Jul 2 01:51:18.896000 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'
Jul 2 01:51:18.897298 systemd[1]: modprobe@configfs.service: Deactivated successfully.
Jul 2 01:51:18.897421 systemd[1]: Finished modprobe@configfs.service.
Jul 2 01:51:18.900000 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'
Jul 2 01:51:18.900000 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'
Jul 2 01:51:18.902271 systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
Jul 2 01:51:18.902388 systemd[1]: Finished modprobe@dm_mod.service.
Jul 2 01:51:18.905000 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'
Jul 2 01:51:18.905000 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'
Jul 2 01:51:18.906985 systemd[1]: modprobe@drm.service: Deactivated successfully.
Jul 2 01:51:18.907103 systemd[1]: Finished modprobe@drm.service.
Jul 2 01:51:18.910000 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'
Jul 2 01:51:18.910000 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'
Jul 2 01:51:18.911445 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
Jul 2 01:51:18.911559 systemd[1]: Finished modprobe@efi_pstore.service.
Jul 2 01:51:18.915000 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'
Jul 2 01:51:18.915000 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'
Jul 2 01:51:18.916519 systemd[1]: modprobe@fuse.service: Deactivated successfully.
Jul 2 01:51:18.916666 systemd[1]: Finished modprobe@fuse.service.
Jul 2 01:51:18.919000 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'
Jul 2 01:51:18.919000 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'
Jul 2 01:51:18.921096 systemd[1]: modprobe@loop.service: Deactivated successfully.
Jul 2 01:51:18.921218 systemd[1]: Finished modprobe@loop.service.
Jul 2 01:51:18.924000 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'
Jul 2 01:51:18.924000 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'
Jul 2 01:51:18.925728 systemd[1]: Finished systemd-modules-load.service.
Jul 2 01:51:18.929000 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'
Jul 2 01:51:18.930701 systemd[1]: Finished systemd-network-generator.service.
Jul 2 01:51:18.934000 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'
Jul 2 01:51:18.936109 systemd[1]: Finished systemd-remount-fs.service.
Jul 2 01:51:18.939000 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'
Jul 2 01:51:18.941318 systemd[1]: Reached target network-pre.target.
Jul 2 01:51:18.946965 systemd[1]: Mounting sys-fs-fuse-connections.mount...
Jul 2 01:51:18.952318 systemd[1]: Mounting sys-kernel-config.mount...
Jul 2 01:51:18.956325 systemd[1]: remount-root.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/).
Jul 2 01:51:18.957627 systemd[1]: Starting systemd-hwdb-update.service...
Jul 2 01:51:18.962763 systemd[1]: Starting systemd-journal-flush.service...
Jul 2 01:51:18.967096 systemd[1]: systemd-pstore.service was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
Jul 2 01:51:18.968103 systemd[1]: Starting systemd-random-seed.service...
Jul 2 01:51:18.972483 systemd[1]: systemd-repart.service was skipped because no trigger condition checks were met.
Jul 2 01:51:18.973488 systemd[1]: Starting systemd-sysctl.service...
Jul 2 01:51:18.978600 systemd[1]: Starting systemd-sysusers.service...
Jul 2 01:51:18.984338 systemd[1]: Finished systemd-udev-trigger.service.
Jul 2 01:51:18.988000 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'
Jul 2 01:51:18.989872 systemd[1]: Mounted sys-fs-fuse-connections.mount.
Jul 2 01:51:18.995061 systemd[1]: Mounted sys-kernel-config.mount.
Jul 2 01:51:19.000910 systemd[1]: Starting systemd-udev-settle.service...
Jul 2 01:51:19.009736 udevadm[1223]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in.
Jul 2 01:51:19.014042 systemd-journald[1209]: Time spent on flushing to /var/log/journal/76ee25f1206041618146cdb953328c1d is 13.437ms for 1070 entries.
Jul 2 01:51:19.014042 systemd-journald[1209]: System Journal (/var/log/journal/76ee25f1206041618146cdb953328c1d) is 8.0M, max 2.6G, 2.6G free.
Jul 2 01:51:19.238992 systemd-journald[1209]: Received client request to flush runtime journal.
Jul 2 01:51:19.048000 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'
Jul 2 01:51:19.060000 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'
Jul 2 01:51:19.044045 systemd[1]: Finished systemd-random-seed.service.
Jul 2 01:51:19.049181 systemd[1]: Reached target first-boot-complete.target.
Jul 2 01:51:19.056689 systemd[1]: Finished systemd-sysctl.service.
Jul 2 01:51:19.240037 systemd[1]: Finished systemd-journal-flush.service.
Jul 2 01:51:19.243000 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'
Jul 2 01:51:19.645103 systemd[1]: Finished systemd-sysusers.service.
Jul 2 01:51:19.648000 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'
Jul 2 01:51:20.298107 systemd[1]: Finished systemd-hwdb-update.service.
Jul 2 01:51:20.301000 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'
Jul 2 01:51:20.302000 audit: BPF prog-id=24 op=LOAD
Jul 2 01:51:20.302000 audit: BPF prog-id=25 op=LOAD
Jul 2 01:51:20.302000 audit: BPF prog-id=7 op=UNLOAD
Jul 2 01:51:20.302000 audit: BPF prog-id=8 op=UNLOAD
Jul 2 01:51:20.303728 systemd[1]: Starting systemd-udevd.service...
Jul 2 01:51:20.321254 systemd-udevd[1226]: Using default interface naming scheme 'v252'.
Jul 2 01:51:20.650093 systemd[1]: Started systemd-udevd.service.
Jul 2 01:51:20.657000 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'
Jul 2 01:51:20.658000 audit: BPF prog-id=26 op=LOAD
Jul 2 01:51:20.661304 systemd[1]: Starting systemd-networkd.service...
Jul 2 01:51:20.685458 systemd[1]: Condition check resulted in dev-ttyAMA0.device being skipped.
Jul 2 01:51:20.728000 audit: BPF prog-id=27 op=LOAD
Jul 2 01:51:20.729000 audit: BPF prog-id=28 op=LOAD
Jul 2 01:51:20.729000 audit: BPF prog-id=29 op=LOAD
Jul 2 01:51:20.730730 systemd[1]: Starting systemd-userdbd.service...
Jul 2 01:51:20.756962 kernel: mousedev: PS/2 mouse device common for all mice
Jul 2 01:51:20.778726 systemd[1]: Started systemd-userdbd.service.
Jul 2 01:51:20.783000 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'
Jul 2 01:51:20.784000 audit[1232]: AVC avc: denied { confidentiality } for pid=1232 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
Jul 2 01:51:20.789950 kernel: hv_vmbus: registering driver hyperv_fb
Jul 2 01:51:20.790003 kernel: hv_vmbus: registering driver hv_balloon
Jul 2 01:51:20.797926 kernel: hyperv_fb: Synthvid Version major 3, minor 5
Jul 2 01:51:20.811948 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608
Jul 2 01:51:20.811992 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0
Jul 2 01:51:20.812016 kernel: hv_balloon: Memory hot add disabled on ARM64
Jul 2 01:51:20.819236 kernel: Console: switching to colour dummy device 80x25
Jul 2 01:51:20.828175 kernel: Console: switching to colour frame buffer device 128x48
Jul 2 01:51:20.784000 audit[1232]: SYSCALL arch=c00000b7 syscall=105 success=yes exit=0 a0=aaaafd2e99e0 a1=aa2c a2=ffff8c5a24b0 a3=aaaafd045010 items=12 ppid=1226 pid=1232 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)
Jul 2 01:51:20.784000 audit: CWD cwd="/"
Jul 2 01:51:20.784000 audit: PATH item=0 name=(null) inode=5899 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
Jul 2 01:51:20.784000 audit: PATH item=1 name=(null) inode=11189 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
Jul 2 01:51:20.784000 audit: PATH item=2 name=(null) inode=11189 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
Jul 2 01:51:20.784000 audit: PATH item=3 name=(null) inode=11190 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
Jul 2 01:51:20.784000 audit: PATH item=4 name=(null) inode=11189 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
Jul 2 01:51:20.784000 audit: PATH item=5 name=(null) inode=11191 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
Jul 2 01:51:20.784000 audit: PATH item=6 name=(null) inode=11189 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
Jul 2 01:51:20.784000 audit: PATH item=7 name=(null) inode=11192 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
Jul 2 01:51:20.784000 audit: PATH item=8 name=(null) inode=11189 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
Jul 2 01:51:20.784000 audit: PATH item=9 name=(null) inode=11193 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
Jul 2 01:51:20.784000 audit: PATH item=10 name=(null) inode=11189 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
Jul 2 01:51:20.784000 audit: PATH item=11 name=(null) inode=11194 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
Jul 2 01:51:20.784000 audit: PROCTITLE proctitle="(udev-worker)"
Jul 2 01:51:20.859299 kernel: hv_utils: Registering HyperV Utility Driver
Jul 2 01:51:20.859413 kernel: hv_vmbus: registering driver hv_utils
Jul 2 01:51:20.862312 kernel: hv_utils: Shutdown IC version 3.2
Jul 2 01:51:20.862391 kernel: hv_utils: Heartbeat IC version 3.0
Jul 2 01:51:20.862424 kernel: hv_utils: TimeSync IC version 4.0
Jul 2 01:51:21.038707 systemd-networkd[1245]: lo: Link UP
Jul 2 01:51:21.039001 systemd-networkd[1245]: lo: Gained carrier
Jul 2 01:51:21.039474 systemd-networkd[1245]: Enumeration completed
Jul 2 01:51:21.039654 systemd[1]: Started systemd-networkd.service.
Jul 2 01:51:21.043000 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'
Jul 2 01:51:21.045676 systemd[1]: Starting systemd-networkd-wait-online.service...
Jul 2 01:51:21.074830 kernel: BTRFS info: devid 1 device path /dev/disk/by-label/OEM changed to /dev/sda6 scanned by (udev-worker) (1232)
Jul 2 01:51:21.084179 systemd-networkd[1245]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
Jul 2 01:51:21.099141 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device.
Jul 2 01:51:21.109141 systemd[1]: Finished systemd-udev-settle.service.
Jul 2 01:51:21.113000 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'
Jul 2 01:51:21.115065 systemd[1]: Starting lvm2-activation-early.service...
Jul 2 01:51:21.145726 kernel: mlx5_core 29e6:00:02.0 enP10726s1: Link up
Jul 2 01:51:21.170728 kernel: hv_netvsc 002248bc-655d-0022-48bc-655d002248bc eth0: Data path switched to VF: enP10726s1
Jul 2 01:51:21.172390 systemd-networkd[1245]: enP10726s1: Link UP
Jul 2 01:51:21.172874 systemd-networkd[1245]: eth0: Link UP
Jul 2 01:51:21.172956 systemd-networkd[1245]: eth0: Gained carrier
Jul 2 01:51:21.181161 systemd-networkd[1245]: enP10726s1: Gained carrier
Jul 2 01:51:21.188820 systemd-networkd[1245]: eth0: DHCPv4 address 10.200.20.20/24, gateway 10.200.20.1 acquired from 168.63.129.16
Jul 2 01:51:21.380205 lvm[1303]: WARNING: Failed to connect to lvmetad. Falling back to device scanning.
Jul 2 01:51:21.423636 systemd[1]: Finished lvm2-activation-early.service.
Jul 2 01:51:21.428000 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'
Jul 2 01:51:21.428864 systemd[1]: Reached target cryptsetup.target.
Jul 2 01:51:21.434095 systemd[1]: Starting lvm2-activation.service...
Jul 2 01:51:21.438242 lvm[1304]: WARNING: Failed to connect to lvmetad. Falling back to device scanning.
Jul 2 01:51:21.460689 systemd[1]: Finished lvm2-activation.service.
Jul 2 01:51:21.464000 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'
Jul 2 01:51:21.464974 systemd[1]: Reached target local-fs-pre.target.
Jul 2 01:51:21.469297 systemd[1]: var-lib-machines.mount was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw).
Jul 2 01:51:21.469329 systemd[1]: Reached target local-fs.target.
Jul 2 01:51:21.473324 systemd[1]: Reached target machines.target.
Jul 2 01:51:21.478514 systemd[1]: Starting ldconfig.service...
Jul 2 01:51:21.495622 systemd[1]: systemd-binfmt.service was skipped because no trigger condition checks were met.
Jul 2 01:51:21.495681 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).
Jul 2 01:51:21.496765 systemd[1]: Starting systemd-boot-update.service...
Jul 2 01:51:21.501612 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service...
Jul 2 01:51:21.507636 systemd[1]: Starting systemd-machine-id-commit.service...
Jul 2 01:51:21.512045 systemd[1]: systemd-sysext.service was skipped because no trigger condition checks were met.
Jul 2 01:51:21.512095 systemd[1]: ensure-sysext.service was skipped because no trigger condition checks were met.
Jul 2 01:51:21.513030 systemd[1]: Starting systemd-tmpfiles-setup.service...
Jul 2 01:51:21.532014 systemd[1]: boot.automount: Got automount request for /boot, triggered by 1306 (bootctl)
Jul 2 01:51:21.533038 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service...
Jul 2 01:51:21.611163 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
Jul 2 01:51:21.611763 systemd[1]: Finished systemd-machine-id-commit.service.
Jul 2 01:51:21.615000 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'
Jul 2 01:51:21.631368 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service.
Jul 2 01:51:21.637000 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'
Jul 2 01:51:21.705799 systemd-tmpfiles[1309]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring.
Jul 2 01:51:21.822747 systemd-fsck[1314]: fsck.fat 4.2 (2021-01-31)
Jul 2 01:51:21.822747 systemd-fsck[1314]: /dev/sda1: 236 files, 117047/258078 clusters
Jul 2 01:51:21.825166 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service.
Jul 2 01:51:21.830000 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'
Jul 2 01:51:21.832123 systemd[1]: Mounting boot.mount...
Jul 2 01:51:21.843029 systemd[1]: Mounted boot.mount.
Jul 2 01:51:21.852509 systemd[1]: Finished systemd-boot-update.service.
Jul 2 01:51:21.856000 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'
Jul 2 01:51:21.857606 systemd-tmpfiles[1309]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring.
Jul 2 01:51:21.914199 systemd-tmpfiles[1309]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring.
Jul 2 01:51:22.401081 systemd[1]: Finished systemd-tmpfiles-setup.service.
Jul 2 01:51:22.405000 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'
Jul 2 01:51:22.407438 systemd[1]: Starting audit-rules.service...
Jul 2 01:51:22.412239 systemd[1]: Starting clean-ca-certificates.service...
Jul 2 01:51:22.417296 systemd[1]: Starting systemd-journal-catalog-update.service...
Jul 2 01:51:22.422000 audit: BPF prog-id=30 op=LOAD
Jul 2 01:51:22.423850 systemd[1]: Starting systemd-resolved.service...
Jul 2 01:51:22.427000 audit: BPF prog-id=31 op=LOAD
Jul 2 01:51:22.429325 systemd[1]: Starting systemd-timesyncd.service...
Jul 2 01:51:22.435424 systemd[1]: Starting systemd-update-utmp.service...
Jul 2 01:51:22.468000 audit[1326]: SYSTEM_BOOT pid=1326 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'
Jul 2 01:51:22.472066 systemd[1]: Finished systemd-update-utmp.service.
Jul 2 01:51:22.476000 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'
Jul 2 01:51:22.503412 systemd[1]: Finished clean-ca-certificates.service.
Jul 2 01:51:22.508000 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'
Jul 2 01:51:22.508491 systemd[1]: update-ca-certificates.service was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt).
Jul 2 01:51:22.517565 systemd[1]: Started systemd-timesyncd.service.
Jul 2 01:51:22.521000 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'
Jul 2 01:51:22.522216 systemd[1]: Reached target time-set.target.
Jul 2 01:51:22.556421 systemd-resolved[1323]: Positive Trust Anchors:
Jul 2 01:51:22.556436 systemd-resolved[1323]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
Jul 2 01:51:22.556465 systemd-resolved[1323]: 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
Jul 2 01:51:22.560570 systemd-resolved[1323]: Using system hostname 'ci-3510.3.5-a-aa92461ff3'.
Jul 2 01:51:22.562066 systemd[1]: Started systemd-resolved.service.
Jul 2 01:51:22.565000 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'
Jul 2 01:51:22.566736 systemd[1]: Reached target network.target.
Jul 2 01:51:22.571052 systemd[1]: Reached target nss-lookup.target.
Jul 2 01:51:22.720903 systemd-networkd[1245]: eth0: Gained IPv6LL
Jul 2 01:51:22.722939 systemd[1]: Finished systemd-networkd-wait-online.service.
Jul 2 01:51:22.727000 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'
Jul 2 01:51:22.728127 systemd[1]: Reached target network-online.target.
Jul 2 01:51:22.732811 systemd[1]: Finished systemd-journal-catalog-update.service.
Jul 2 01:51:22.737000 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'
Jul 2 01:51:22.831000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1
Jul 2 01:51:22.831000 audit[1341]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffc13c3610 a2=420 a3=0 items=0 ppid=1320 pid=1341 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)
Jul 2 01:51:22.831000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573
Jul 2 01:51:22.860945 systemd-timesyncd[1324]: Contacted time server 104.167.215.195:123 (0.flatcar.pool.ntp.org).
Jul 2 01:51:22.861015 systemd-timesyncd[1324]: Initial clock synchronization to Tue 2024-07-02 01:51:22.846321 UTC.
Jul 2 01:51:22.868937 augenrules[1341]: No rules
Jul 2 01:51:22.869792 systemd[1]: Finished audit-rules.service.
Jul 2 01:51:29.266180 ldconfig[1305]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start.
Jul 2 01:51:29.277226 systemd[1]: Finished ldconfig.service.
Jul 2 01:51:29.284411 systemd[1]: Starting systemd-update-done.service...
Jul 2 01:51:29.308886 systemd[1]: Finished systemd-update-done.service.
Jul 2 01:51:29.313685 systemd[1]: Reached target sysinit.target.
Jul 2 01:51:29.317834 systemd[1]: Started motdgen.path.
Jul 2 01:51:29.321302 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path.
Jul 2 01:51:29.327186 systemd[1]: Started logrotate.timer.
Jul 2 01:51:29.331161 systemd[1]: Started mdadm.timer.
Jul 2 01:51:29.334654 systemd[1]: Started systemd-tmpfiles-clean.timer.
Jul 2 01:51:29.339209 systemd[1]: update-engine-stub.timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate).
Jul 2 01:51:29.339238 systemd[1]: Reached target paths.target.
Jul 2 01:51:29.343149 systemd[1]: Reached target timers.target.
Jul 2 01:51:29.347792 systemd[1]: Listening on dbus.socket.
Jul 2 01:51:29.352608 systemd[1]: Starting docker.socket...
Jul 2 01:51:29.358084 systemd[1]: Listening on sshd.socket.
Jul 2 01:51:29.362686 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).
Jul 2 01:51:29.363115 systemd[1]: Listening on docker.socket.
Jul 2 01:51:29.367150 systemd[1]: Reached target sockets.target.
Jul 2 01:51:29.371212 systemd[1]: Reached target basic.target.
Jul 2 01:51:29.375151 systemd[1]: addon-config@usr-share-oem.service was skipped because no trigger condition checks were met.
Jul 2 01:51:29.375178 systemd[1]: addon-run@usr-share-oem.service was skipped because no trigger condition checks were met.
Jul 2 01:51:29.376113 systemd[1]: Starting containerd.service...
Jul 2 01:51:29.380581 systemd[1]: Starting dbus.service...
Jul 2 01:51:29.384626 systemd[1]: Starting enable-oem-cloudinit.service...
Jul 2 01:51:29.389773 systemd[1]: Starting extend-filesystems.service...
Jul 2 01:51:29.394278 systemd[1]: flatcar-setup-environment.service was skipped because of an unmet condition check (ConditionPathExists=/usr/share/oem/bin/flatcar-setup-environment).
Jul 2 01:51:29.395398 systemd[1]: Starting motdgen.service...
Jul 2 01:51:29.399877 systemd[1]: Started nvidia.service.
Jul 2 01:51:29.404556 systemd[1]: Starting ssh-key-proc-cmdline.service...
Jul 2 01:51:29.412399 systemd[1]: Starting sshd-keygen.service...
Jul 2 01:51:29.417902 systemd[1]: Starting systemd-logind.service...
Jul 2 01:51:29.421604 systemd[1]: systemd-pcrphase.service was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/StubPcrKernelImage-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f).
Jul 2 01:51:29.421661 systemd[1]: tcsd.service was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0).
Jul 2 01:51:29.422040 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details.
Jul 2 01:51:29.422629 systemd[1]: Starting update-engine.service...
Jul 2 01:51:29.427501 systemd[1]: Starting update-ssh-keys-after-ignition.service...
Jul 2 01:51:29.455208 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully.
Jul 2 01:51:29.455368 systemd[1]: Finished ssh-key-proc-cmdline.service.
Jul 2 01:51:29.466216 jq[1361]: true
Jul 2 01:51:29.466653 jq[1351]: false
Jul 2 01:51:29.517592 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'.
Jul 2 01:51:29.517770 systemd[1]: Condition check resulted in enable-oem-cloudinit.service being skipped.
Jul 2 01:51:29.524592 systemd[1]: motdgen.service: Deactivated successfully.
Jul 2 01:51:29.524781 systemd[1]: Finished motdgen.service.
Jul 2 01:51:29.537998 systemd-logind[1359]: Watching system buttons on /dev/input/event1 (AT Translated Set 2 keyboard)
Jul 2 01:51:29.538170 systemd-logind[1359]: New seat seat0.
Jul 2 01:51:29.546965 extend-filesystems[1352]: Found sda
Jul 2 01:51:29.551627 extend-filesystems[1352]: Found sda1
Jul 2 01:51:29.551627 extend-filesystems[1352]: Found sda2
Jul 2 01:51:29.551627 extend-filesystems[1352]: Found sda3
Jul 2 01:51:29.551627 extend-filesystems[1352]: Found usr
Jul 2 01:51:29.551627 extend-filesystems[1352]: Found sda4
Jul 2 01:51:29.551627 extend-filesystems[1352]: Found sda6
Jul 2 01:51:29.551627 extend-filesystems[1352]: Found sda7
Jul 2 01:51:29.551627 extend-filesystems[1352]: Found sda9
Jul 2 01:51:29.551627 extend-filesystems[1352]: Checking size of /dev/sda9
Jul 2 01:51:29.596245 jq[1371]: true
Jul 2 01:51:29.612718 env[1369]: time="2024-07-02T01:51:29.601594770Z" level=info msg="starting containerd" revision=92b3a9d6f1b3bcc6dc74875cfdea653fe39f09c2 version=1.6.16
Jul 2 01:51:29.625472 env[1369]: time="2024-07-02T01:51:29.625432082Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1
Jul 2 01:51:29.625591 env[1369]: time="2024-07-02T01:51:29.625569438Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1
Jul 2 01:51:29.626873 env[1369]: time="2024-07-02T01:51:29.626840335Z" 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.161-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1
Jul 2 01:51:29.626873 env[1369]: time="2024-07-02T01:51:29.626871955Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1
Jul 2 01:51:29.627075 env[1369]: time="2024-07-02T01:51:29.627047367Z" 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
Jul 2 01:51:29.627075 env[1369]: time="2024-07-02T01:51:29.627071872Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1
Jul 2 01:51:29.627131 env[1369]: time="2024-07-02T01:51:29.627087263Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured"
Jul 2 01:51:29.627131 env[1369]: time="2024-07-02T01:51:29.627097576Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1
Jul 2 01:51:29.627187 env[1369]: time="2024-07-02T01:51:29.627167533Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1
Jul 2 01:51:29.627386 env[1369]: time="2024-07-02T01:51:29.627364372Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1
Jul 2 01:51:29.627563 env[1369]: time="2024-07-02T01:51:29.627504965Z" 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
Jul 2 01:51:29.627563 env[1369]: time="2024-07-02T01:51:29.627526112Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1
Jul 2 01:51:29.627630 env[1369]: time="2024-07-02T01:51:29.627579439Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured"
Jul 2 01:51:29.627630 env[1369]: time="2024-07-02T01:51:29.627590513Z" level=info msg="metadata content store policy set" policy=shared
Jul 2 01:51:29.641084 extend-filesystems[1352]: Old size kept for /dev/sda9
Jul 2 01:51:29.641084 extend-filesystems[1352]: Found sr0
Jul 2 01:51:29.646073 systemd[1]: extend-filesystems.service: Deactivated successfully.
Jul 2 01:51:29.646242 systemd[1]: Finished extend-filesystems.service.
Jul 2 01:51:29.658889 env[1369]: time="2024-07-02T01:51:29.656784604Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1
Jul 2 01:51:29.658889 env[1369]: time="2024-07-02T01:51:29.656820542Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1
Jul 2 01:51:29.658889 env[1369]: time="2024-07-02T01:51:29.656834014Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1
Jul 2 01:51:29.658889 env[1369]: time="2024-07-02T01:51:29.656866794Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1
Jul 2 01:51:29.658889 env[1369]: time="2024-07-02T01:51:29.656882504Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1
Jul 2 01:51:29.658889 env[1369]: time="2024-07-02T01:51:29.656896456Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1
Jul 2 01:51:29.658889 env[1369]: time="2024-07-02T01:51:29.656910007Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1
Jul 2 01:51:29.658889 env[1369]: time="2024-07-02T01:51:29.657244321Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1
Jul 2 01:51:29.658889 env[1369]: time="2024-07-02T01:51:29.657259632Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1
Jul 2 01:51:29.658889 env[1369]: time="2024-07-02T01:51:29.657271904Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1
Jul 2 01:51:29.658889 env[1369]: time="2024-07-02T01:51:29.657284177Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1
Jul 2 01:51:29.658889 env[1369]: time="2024-07-02T01:51:29.657297888Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1
Jul 2 01:51:29.658889 env[1369]: time="2024-07-02T01:51:29.657419373Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2
Jul 2 01:51:29.658889 env[1369]: time="2024-07-02T01:51:29.657488611Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1
Jul 2 01:51:29.659209 env[1369]: time="2024-07-02T01:51:29.657694004Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1
Jul 2 01:51:29.659209 env[1369]: time="2024-07-02T01:51:29.657734019Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1
Jul 2 01:51:29.659209 env[1369]: time="2024-07-02T01:51:29.657749970Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1
Jul 2 01:51:29.659209 env[1369]: time="2024-07-02T01:51:29.657807894Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1
Jul 2 01:51:29.659209 env[1369]: time="2024-07-02T01:51:29.657821006Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1
Jul 2 01:51:29.659209 env[1369]: time="2024-07-02T01:51:29.657833518Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1
Jul 2 01:51:29.659209 env[1369]: time="2024-07-02T01:51:29.657844551Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1
Jul 2 01:51:29.659209 env[1369]: time="2024-07-02T01:51:29.657855864Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1
Jul 2 01:51:29.659209 env[1369]: time="2024-07-02T01:51:29.657868736Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1
Jul 2 01:51:29.659209 env[1369]: time="2024-07-02T01:51:29.657880529Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1
Jul 2 01:51:29.659209 env[1369]: time="2024-07-02T01:51:29.657894041Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1
Jul 2 01:51:29.659209 env[1369]: time="2024-07-02T01:51:29.657907473Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1
Jul 2 01:51:29.659209 env[1369]: time="2024-07-02T01:51:29.658023761Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1
Jul 2 01:51:29.659209 env[1369]: time="2024-07-02T01:51:29.658039991Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1
Jul 2 01:51:29.659209 env[1369]: time="2024-07-02T01:51:29.658055062Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1
Jul 2 01:51:29.659513 env[1369]: time="2024-07-02T01:51:29.658066495Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1
Jul 2 01:51:29.659513 env[1369]: time="2024-07-02T01:51:29.658080406Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="no OpenTelemetry endpoint: skip plugin" type=io.containerd.tracing.processor.v1
Jul 2 01:51:29.659513 env[1369]: time="2024-07-02T01:51:29.658090760Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1
Jul 2 01:51:29.659513 env[1369]: time="2024-07-02T01:51:29.658107949Z" level=error msg="failed to initialize a tracing processor \"otlp\"" error="no OpenTelemetry endpoint: skip plugin"
Jul 2 01:51:29.659513 env[1369]: time="2024-07-02T01:51:29.658140569Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1
Jul 2 01:51:29.659615 env[1369]: time="2024-07-02T01:51:29.658323896Z" 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}"
Jul 2 01:51:29.659615 env[1369]: time="2024-07-02T01:51:29.658375744Z" level=info msg="Connect containerd service"
Jul 2 01:51:29.659615 env[1369]: time="2024-07-02T01:51:29.658405846Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\""
Jul 2 01:51:29.694126 env[1369]: time="2024-07-02T01:51:29.660047114Z" 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"
Jul 2 01:51:29.694126 env[1369]: time="2024-07-02T01:51:29.660135020Z" level=info msg="Start subscribing containerd event"
Jul 2 01:51:29.694126 env[1369]: time="2024-07-02T01:51:29.660189946Z" level=info msg="Start recovering state"
Jul 2 01:51:29.694126 env[1369]: time="2024-07-02T01:51:29.660273575Z" level=info msg="Start event monitor"
Jul 2 01:51:29.694126 env[1369]: time="2024-07-02T01:51:29.660294762Z" level=info msg="Start snapshots syncer"
Jul 2 01:51:29.694126 env[1369]: time="2024-07-02T01:51:29.660304716Z" level=info msg="Start cni network conf syncer for default"
Jul 2 01:51:29.694126 env[1369]: time="2024-07-02T01:51:29.660313030Z" level=info msg="Start streaming server"
Jul 2 01:51:29.694126 env[1369]: time="2024-07-02T01:51:29.660278772Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc
Jul 2 01:51:29.694126 env[1369]: time="2024-07-02T01:51:29.660436674Z" level=info msg=serving... address=/run/containerd/containerd.sock
Jul 2 01:51:29.694126 env[1369]: time="2024-07-02T01:51:29.674546420Z" level=info msg="containerd successfully booted in 0.073597s"
Jul 2 01:51:29.660531 systemd[1]: Started containerd.service.
Jul 2 01:51:29.709745 bash[1409]: Updated "/home/core/.ssh/authorized_keys"
Jul 2 01:51:29.710576 systemd[1]: Finished update-ssh-keys-after-ignition.service.
Jul 2 01:51:29.795030 systemd[1]: nvidia.service: Deactivated successfully.
Jul 2 01:51:29.894818 dbus-daemon[1350]: [system] SELinux support is enabled
Jul 2 01:51:29.894967 systemd[1]: Started dbus.service.
Jul 2 01:51:29.900366 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).
Jul 2 01:51:29.900394 systemd[1]: Reached target system-config.target.
Jul 2 01:51:29.906808 systemd[1]: user-cloudinit-proc-cmdline.service was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url).
Jul 2 01:51:29.906829 systemd[1]: Reached target user-config.target.
Jul 2 01:51:29.912062 dbus-daemon[1350]: [system] Successfully activated service 'org.freedesktop.systemd1'
Jul 2 01:51:29.912174 systemd[1]: Started systemd-logind.service.
Jul 2 01:51:30.172065 update_engine[1360]: I0702 01:51:30.158382 1360 main.cc:92] Flatcar Update Engine starting
Jul 2 01:51:30.207310 systemd[1]: Started update-engine.service.
Jul 2 01:51:30.207563 update_engine[1360]: I0702 01:51:30.207340 1360 update_check_scheduler.cc:74] Next update check in 11m10s
Jul 2 01:51:30.217015 systemd[1]: Started locksmithd.service.
Jul 2 01:51:31.292745 sshd_keygen[1366]: ssh-keygen: generating new host keys: RSA ECDSA ED25519
Jul 2 01:51:31.308915 systemd[1]: Finished sshd-keygen.service.
Jul 2 01:51:31.314574 systemd[1]: Starting issuegen.service...
Jul 2 01:51:31.318886 systemd[1]: Started waagent.service.
Jul 2 01:51:31.323266 systemd[1]: issuegen.service: Deactivated successfully.
Jul 2 01:51:31.323413 systemd[1]: Finished issuegen.service.
Jul 2 01:51:31.328341 systemd[1]: Starting systemd-user-sessions.service...
Jul 2 01:51:31.361771 systemd[1]: Finished systemd-user-sessions.service.
Jul 2 01:51:31.367706 systemd[1]: Started getty@tty1.service.
Jul 2 01:51:31.372754 systemd[1]: Started serial-getty@ttyAMA0.service.
Jul 2 01:51:31.377804 systemd[1]: Reached target getty.target.
Jul 2 01:51:31.381841 systemd[1]: Reached target multi-user.target.
Jul 2 01:51:31.387394 systemd[1]: Starting systemd-update-utmp-runlevel.service...
Jul 2 01:51:31.398565 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully.
Jul 2 01:51:31.398736 systemd[1]: Finished systemd-update-utmp-runlevel.service.
Jul 2 01:51:31.404076 systemd[1]: Startup finished in 713ms (kernel) + 11.957s (initrd) + 21.900s (userspace) = 34.571s.
Jul 2 01:51:31.482117 locksmithd[1448]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot"
Jul 2 01:51:31.930786 login[1466]: pam_lastlog(login:session): file /var/log/lastlog is locked/write
Jul 2 01:51:31.945045 login[1467]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0)
Jul 2 01:51:31.981508 systemd[1]: Created slice user-500.slice.
Jul 2 01:51:31.982547 systemd[1]: Starting user-runtime-dir@500.service...
Jul 2 01:51:31.985196 systemd-logind[1359]: New session 2 of user core.
Jul 2 01:51:32.005725 systemd[1]: Finished user-runtime-dir@500.service.
Jul 2 01:51:32.006956 systemd[1]: Starting user@500.service...
Jul 2 01:51:32.041663 (systemd)[1470]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0)
Jul 2 01:51:32.247052 systemd[1470]: Queued start job for default target default.target.
Jul 2 01:51:32.247894 systemd[1470]: Reached target paths.target.
Jul 2 01:51:32.247920 systemd[1470]: Reached target sockets.target.
Jul 2 01:51:32.247931 systemd[1470]: Reached target timers.target.
Jul 2 01:51:32.247941 systemd[1470]: Reached target basic.target.
Jul 2 01:51:32.248038 systemd[1]: Started user@500.service.
Jul 2 01:51:32.248777 systemd[1470]: Reached target default.target.
Jul 2 01:51:32.248818 systemd[1470]: Startup finished in 201ms.
Jul 2 01:51:32.248826 systemd[1]: Started session-2.scope.
Jul 2 01:51:32.931510 login[1466]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0)
Jul 2 01:51:32.935560 systemd[1]: Started session-1.scope.
Jul 2 01:51:32.936808 systemd-logind[1359]: New session 1 of user core.
Jul 2 01:51:36.635206 waagent[1463]: 2024-07-02T01:51:36.635094Z INFO Daemon Daemon Azure Linux Agent Version:2.6.0.2
Jul 2 01:51:36.641601 waagent[1463]: 2024-07-02T01:51:36.641536Z INFO Daemon Daemon OS: flatcar 3510.3.5
Jul 2 01:51:36.645963 waagent[1463]: 2024-07-02T01:51:36.645906Z INFO Daemon Daemon Python: 3.9.16
Jul 2 01:51:36.650685 waagent[1463]: 2024-07-02T01:51:36.650594Z INFO Daemon Daemon Run daemon
Jul 2 01:51:36.654866 waagent[1463]: 2024-07-02T01:51:36.654810Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='3510.3.5'
Jul 2 01:51:36.671214 waagent[1463]: 2024-07-02T01:51:36.671098Z 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.
Jul 2 01:51:36.685993 waagent[1463]: 2024-07-02T01:51:36.685877Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service'
Jul 2 01:51:36.695478 waagent[1463]: 2024-07-02T01:51:36.695418Z INFO Daemon Daemon cloud-init is enabled: False
Jul 2 01:51:36.701283 waagent[1463]: 2024-07-02T01:51:36.701225Z INFO Daemon Daemon Using waagent for provisioning
Jul 2 01:51:36.706887 waagent[1463]: 2024-07-02T01:51:36.706830Z INFO Daemon Daemon Activate resource disk
Jul 2 01:51:36.711490 waagent[1463]: 2024-07-02T01:51:36.711431Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb
Jul 2 01:51:36.726582 waagent[1463]: 2024-07-02T01:51:36.726523Z INFO Daemon Daemon Found device: None
Jul 2 01:51:36.731424 waagent[1463]: 2024-07-02T01:51:36.731366Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology
Jul 2 01:51:36.739644 waagent[1463]: 2024-07-02T01:51:36.739583Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0
Jul 2 01:51:36.751550 waagent[1463]: 2024-07-02T01:51:36.751487Z INFO Daemon Daemon Clean protocol and wireserver endpoint
Jul 2 01:51:36.757244 waagent[1463]: 2024-07-02T01:51:36.757187Z INFO Daemon Daemon Running default provisioning handler
Jul 2 01:51:36.770718 waagent[1463]: 2024-07-02T01:51:36.770593Z 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.
Jul 2 01:51:36.785287 waagent[1463]: 2024-07-02T01:51:36.785170Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service'
Jul 2 01:51:36.794924 waagent[1463]: 2024-07-02T01:51:36.794860Z INFO Daemon Daemon cloud-init is enabled: False
Jul 2 01:51:36.799820 waagent[1463]: 2024-07-02T01:51:36.799763Z INFO Daemon Daemon Copying ovf-env.xml
Jul 2 01:51:36.855669 waagent[1463]: 2024-07-02T01:51:36.855421Z INFO Daemon Daemon Successfully mounted dvd
Jul 2 01:51:36.952003 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully.
Jul 2 01:51:36.986132 waagent[1463]: 2024-07-02T01:51:36.986004Z INFO Daemon Daemon Detect protocol endpoint
Jul 2 01:51:36.990972 waagent[1463]: 2024-07-02T01:51:36.990912Z INFO Daemon Daemon Clean protocol and wireserver endpoint
Jul 2 01:51:36.996588 waagent[1463]: 2024-07-02T01:51:36.996528Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler
Jul 2 01:51:37.002903 waagent[1463]: 2024-07-02T01:51:37.002846Z INFO Daemon Daemon Test for route to 168.63.129.16
Jul 2 01:51:37.008160 waagent[1463]: 2024-07-02T01:51:37.008105Z INFO Daemon Daemon Route to 168.63.129.16 exists
Jul 2 01:51:37.013188 waagent[1463]: 2024-07-02T01:51:37.013132Z INFO Daemon Daemon Wire server endpoint:168.63.129.16
Jul 2 01:51:37.164173 waagent[1463]: 2024-07-02T01:51:37.164107Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05
Jul 2 01:51:37.171216 waagent[1463]: 2024-07-02T01:51:37.171172Z INFO Daemon Daemon Wire protocol version:2012-11-30
Jul 2 01:51:37.176378 waagent[1463]: 2024-07-02T01:51:37.176323Z INFO Daemon Daemon Server preferred version:2015-04-05
Jul 2 01:51:38.253087 waagent[1463]: 2024-07-02T01:51:38.252930Z INFO Daemon Daemon Initializing goal state during protocol detection
Jul 2 01:51:38.268242 waagent[1463]: 2024-07-02T01:51:38.268173Z INFO Daemon Daemon Forcing an update of the goal state..
Jul 2 01:51:38.274028 waagent[1463]: 2024-07-02T01:51:38.273969Z INFO Daemon Daemon Fetching goal state [incarnation 1]
Jul 2 01:51:38.344902 waagent[1463]: 2024-07-02T01:51:38.344776Z INFO Daemon Daemon Found private key matching thumbprint 9B1BA36CE36E0654B2BEF1800B1FB72AE71A2F52
Jul 2 01:51:38.353304 waagent[1463]: 2024-07-02T01:51:38.353238Z INFO Daemon Daemon Certificate with thumbprint BFFF1869133C6542C40A6E46159E000F4F0F2D93 has no matching private key.
Jul 2 01:51:38.362813 waagent[1463]: 2024-07-02T01:51:38.362751Z INFO Daemon Daemon Fetch goal state completed
Jul 2 01:51:38.408605 waagent[1463]: 2024-07-02T01:51:38.408540Z INFO Daemon Daemon Fetched new vmSettings [correlation ID: c99f3e63-2d20-4f0b-9a84-1aaebc0246d1 New eTag: 4065947515453883802]
Jul 2 01:51:38.419228 waagent[1463]: 2024-07-02T01:51:38.419149Z INFO Daemon Daemon Status Blob type 'None' is not valid, assuming BlockBlob
Jul 2 01:51:38.434538 waagent[1463]: 2024-07-02T01:51:38.434455Z INFO Daemon Daemon Starting provisioning
Jul 2 01:51:38.439512 waagent[1463]: 2024-07-02T01:51:38.439452Z INFO Daemon Daemon Handle ovf-env.xml.
Jul 2 01:51:38.444121 waagent[1463]: 2024-07-02T01:51:38.444069Z INFO Daemon Daemon Set hostname [ci-3510.3.5-a-aa92461ff3]
Jul 2 01:51:38.497809 waagent[1463]: 2024-07-02T01:51:38.497658Z INFO Daemon Daemon Publish hostname [ci-3510.3.5-a-aa92461ff3]
Jul 2 01:51:38.504569 waagent[1463]: 2024-07-02T01:51:38.504465Z INFO Daemon Daemon Examine /proc/net/route for primary interface
Jul 2 01:51:38.511118 waagent[1463]: 2024-07-02T01:51:38.511061Z INFO Daemon Daemon Primary interface is [eth0]
Jul 2 01:51:38.527207 systemd[1]: systemd-networkd-wait-online.service: Deactivated successfully.
Jul 2 01:51:38.527358 systemd[1]: Stopped systemd-networkd-wait-online.service.
Jul 2 01:51:38.527413 systemd[1]: Stopping systemd-networkd-wait-online.service...
Jul 2 01:51:38.527685 systemd[1]: Stopping systemd-networkd.service...
Jul 2 01:51:38.530752 systemd-networkd[1245]: eth0: DHCPv6 lease lost
Jul 2 01:51:38.531950 systemd[1]: systemd-networkd.service: Deactivated successfully.
Jul 2 01:51:38.532121 systemd[1]: Stopped systemd-networkd.service.
Jul 2 01:51:38.534072 systemd[1]: Starting systemd-networkd.service...
Jul 2 01:51:38.560788 systemd-networkd[1514]: enP10726s1: Link UP
Jul 2 01:51:38.560796 systemd-networkd[1514]: enP10726s1: Gained carrier
Jul 2 01:51:38.561640 systemd-networkd[1514]: eth0: Link UP
Jul 2 01:51:38.561651 systemd-networkd[1514]: eth0: Gained carrier
Jul 2 01:51:38.562168 systemd-networkd[1514]: lo: Link UP
Jul 2 01:51:38.562179 systemd-networkd[1514]: lo: Gained carrier
Jul 2 01:51:38.562402 systemd-networkd[1514]: eth0: Gained IPv6LL
Jul 2 01:51:38.562596 systemd-networkd[1514]: Enumeration completed
Jul 2 01:51:38.562689 systemd[1]: Started systemd-networkd.service.
Jul 2 01:51:38.563175 systemd-networkd[1514]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
Jul 2 01:51:38.564367 systemd[1]: Starting systemd-networkd-wait-online.service...
Jul 2 01:51:38.567795 waagent[1463]: 2024-07-02T01:51:38.567617Z INFO Daemon Daemon Create user account if not exists
Jul 2 01:51:38.573662 waagent[1463]: 2024-07-02T01:51:38.573578Z INFO Daemon Daemon User core already exists, skip useradd
Jul 2 01:51:38.579985 waagent[1463]: 2024-07-02T01:51:38.579905Z INFO Daemon Daemon Configure sudoer
Jul 2 01:51:38.585138 waagent[1463]: 2024-07-02T01:51:38.585066Z INFO Daemon Daemon Configure sshd
Jul 2 01:51:38.589802 systemd-networkd[1514]: eth0: DHCPv4 address 10.200.20.20/24, gateway 10.200.20.1 acquired from 168.63.129.16
Jul 2 01:51:38.589906 waagent[1463]: 2024-07-02T01:51:38.589832Z INFO Daemon Daemon Deploy ssh public key.
Jul 2 01:51:38.600682 systemd[1]: Finished systemd-networkd-wait-online.service.
Jul 2 01:51:39.861547 waagent[1463]: 2024-07-02T01:51:39.861470Z INFO Daemon Daemon Provisioning complete
Jul 2 01:51:39.879768 waagent[1463]: 2024-07-02T01:51:39.879685Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping
Jul 2 01:51:39.886264 waagent[1463]: 2024-07-02T01:51:39.886199Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions.
Jul 2 01:51:39.896786 waagent[1463]: 2024-07-02T01:51:39.896724Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.6.0.2 is the most current agent
Jul 2 01:51:40.189913 waagent[1523]: 2024-07-02T01:51:40.189763Z INFO ExtHandler ExtHandler Agent WALinuxAgent-2.6.0.2 is running as the goal state agent
Jul 2 01:51:40.190984 waagent[1523]: 2024-07-02T01:51:40.190925Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file
Jul 2 01:51:40.191217 waagent[1523]: 2024-07-02T01:51:40.191168Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16
Jul 2 01:51:40.203156 waagent[1523]: 2024-07-02T01:51:40.203084Z INFO ExtHandler ExtHandler Forcing an update of the goal state..
Jul 2 01:51:40.203433 waagent[1523]: 2024-07-02T01:51:40.203383Z INFO ExtHandler ExtHandler Fetching goal state [incarnation 1]
Jul 2 01:51:40.271267 waagent[1523]: 2024-07-02T01:51:40.271136Z INFO ExtHandler ExtHandler Found private key matching thumbprint 9B1BA36CE36E0654B2BEF1800B1FB72AE71A2F52
Jul 2 01:51:40.271612 waagent[1523]: 2024-07-02T01:51:40.271561Z INFO ExtHandler ExtHandler Certificate with thumbprint BFFF1869133C6542C40A6E46159E000F4F0F2D93 has no matching private key.
Jul 2 01:51:40.271999 waagent[1523]: 2024-07-02T01:51:40.271947Z INFO ExtHandler ExtHandler Fetch goal state completed
Jul 2 01:51:40.285191 waagent[1523]: 2024-07-02T01:51:40.285143Z INFO ExtHandler ExtHandler Fetched new vmSettings [correlation ID: 21bb8922-0af1-4733-abdc-77757983c566 New eTag: 4065947515453883802]
Jul 2 01:51:40.285819 waagent[1523]: 2024-07-02T01:51:40.285763Z INFO ExtHandler ExtHandler Status Blob type 'None' is not valid, assuming BlockBlob
Jul 2 01:51:40.354425 waagent[1523]: 2024-07-02T01:51:40.354288Z INFO ExtHandler ExtHandler Distro: flatcar-3510.3.5; OSUtil: CoreOSUtil; AgentService: waagent; Python: 3.9.16; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.20.1;
Jul 2 01:51:40.364653 waagent[1523]: 2024-07-02T01:51:40.364584Z INFO ExtHandler ExtHandler WALinuxAgent-2.6.0.2 running as process 1523
Jul 2 01:51:40.368406 waagent[1523]: 2024-07-02T01:51:40.368348Z INFO ExtHandler ExtHandler Cgroup monitoring is not supported on ['flatcar', '3510.3.5', '', 'Flatcar Container Linux by Kinvolk']
Jul 2 01:51:40.369810 waagent[1523]: 2024-07-02T01:51:40.369752Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules
Jul 2 01:51:40.498819 waagent[1523]: 2024-07-02T01:51:40.498690Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service
Jul 2 01:51:40.499373 waagent[1523]: 2024-07-02T01:51:40.499316Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup
Jul 2 01:51:40.507221 waagent[1523]: 2024-07-02T01:51:40.507173Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now
Jul 2 01:51:40.507822 waagent[1523]: 2024-07-02T01:51:40.507763Z ERROR ExtHandler ExtHandler Unable to setup the persistent firewall rules: [Errno 30] Read-only file system: '/lib/systemd/system/waagent-network-setup.service'
Jul 2 01:51:40.509036 waagent[1523]: 2024-07-02T01:51:40.508972Z 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]
Jul 2 01:51:40.510461 waagent[1523]: 2024-07-02T01:51:40.510391Z INFO ExtHandler ExtHandler Starting env monitor service.
Jul 2 01:51:40.510886 waagent[1523]: 2024-07-02T01:51:40.510809Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file
Jul 2 01:51:40.511319 waagent[1523]: 2024-07-02T01:51:40.511254Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16
Jul 2 01:51:40.511941 waagent[1523]: 2024-07-02T01:51:40.511869Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled.
Jul 2 01:51:40.512395 waagent[1523]: 2024-07-02T01:51:40.512331Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service.
Jul 2 01:51:40.513122 waagent[1523]: 2024-07-02T01:51:40.512939Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread
Jul 2 01:51:40.513263 waagent[1523]: 2024-07-02T01:51:40.513108Z INFO ExtHandler ExtHandler Start Extension Telemetry service.
Jul 2 01:51:40.513495 waagent[1523]: 2024-07-02T01:51:40.513429Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route:
Jul 2 01:51:40.513495 waagent[1523]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT
Jul 2 01:51:40.513495 waagent[1523]: eth0 00000000 0114C80A 0003 0 0 1024 00000000 0 0 0
Jul 2 01:51:40.513495 waagent[1523]: eth0 0014C80A 00000000 0001 0 0 1024 00FFFFFF 0 0 0
Jul 2 01:51:40.513495 waagent[1523]: eth0 0114C80A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0
Jul 2 01:51:40.513495 waagent[1523]: eth0 10813FA8 0114C80A 0007 0 0 1024 FFFFFFFF 0 0 0
Jul 2 01:51:40.513495 waagent[1523]: eth0 FEA9FEA9 0114C80A 0007 0 0 1024 FFFFFFFF 0 0 0
Jul 2 01:51:40.514930 waagent[1523]: 2024-07-02T01:51:40.514849Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True
Jul 2 01:51:40.515153 waagent[1523]: 2024-07-02T01:51:40.515088Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file
Jul 2 01:51:40.516562 waagent[1523]: 2024-07-02T01:51:40.516351Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status.
Jul 2 01:51:40.517257 waagent[1523]: 2024-07-02T01:51:40.517185Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16
Jul 2 01:51:40.517580 waagent[1523]: 2024-07-02T01:51:40.517511Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread
Jul 2 01:51:40.518873 waagent[1523]: 2024-07-02T01:51:40.518795Z INFO EnvHandler ExtHandler Configure routes
Jul 2 01:51:40.521169 waagent[1523]: 2024-07-02T01:51:40.521093Z INFO EnvHandler ExtHandler Gateway:None
Jul 2 01:51:40.523985 waagent[1523]: 2024-07-02T01:51:40.523916Z INFO EnvHandler ExtHandler Routes:None
Jul 2 01:51:40.532439 waagent[1523]: 2024-07-02T01:51:40.532384Z INFO ExtHandler ExtHandler Checking for agent updates (family: Prod)
Jul 2 01:51:40.533181 waagent[1523]: 2024-07-02T01:51:40.533132Z WARNING ExtHandler ExtHandler Fetch failed: [HttpError] HTTPS is unavailable and required
Jul 2 01:51:40.534225 waagent[1523]: 2024-07-02T01:51:40.534168Z INFO ExtHandler ExtHandler [PERIODIC] Request failed using the direct channel. Error: 'NoneType' object has no attribute 'getheaders'
Jul 2 01:51:40.573823 waagent[1523]: 2024-07-02T01:51:40.573760Z INFO ExtHandler ExtHandler Default channel changed to HostGA channel.
Jul 2 01:51:40.593986 waagent[1523]: 2024-07-02T01:51:40.593876Z ERROR EnvHandler ExtHandler Failed to get the PID of the DHCP client: invalid literal for int() with base 10: 'MainPID=1514'
Jul 2 01:51:40.702621 waagent[1523]: 2024-07-02T01:51:40.702479Z INFO MonitorHandler ExtHandler Network interfaces:
Jul 2 01:51:40.702621 waagent[1523]: Executing ['ip', '-a', '-o', 'link']:
Jul 2 01:51:40.702621 waagent[1523]: 1: lo: <LOOPBACK,UP,LOWER_UP> mtu 65536 qdisc noqueue state UNKNOWN mode DEFAULT group default qlen 1000\ link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00
Jul 2 01:51:40.702621 waagent[1523]: 2: eth0: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 00:22:48:bc:65:5d brd ff:ff:ff:ff:ff:ff
Jul 2 01:51:40.702621 waagent[1523]: 3: enP10726s1: <BROADCAST,MULTICAST,SLAVE,UP,LOWER_UP> mtu 1500 qdisc mq master eth0 state UP mode DEFAULT group default qlen 1000\ link/ether 00:22:48:bc:65:5d brd ff:ff:ff:ff:ff:ff\ altname enP10726p0s2
Jul 2 01:51:40.702621 waagent[1523]: Executing ['ip', '-4', '-a', '-o', 'address']:
Jul 2 01:51:40.702621 waagent[1523]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever
Jul 2 01:51:40.702621 waagent[1523]: 2: eth0 inet 10.200.20.20/24 metric 1024 brd 10.200.20.255 scope global eth0\ valid_lft forever preferred_lft forever
Jul 2 01:51:40.702621 waagent[1523]: Executing ['ip', '-6', '-a', '-o', 'address']:
Jul 2 01:51:40.702621 waagent[1523]: 1: lo inet6 ::1/128 scope host \ valid_lft forever preferred_lft forever
Jul 2 01:51:40.702621 waagent[1523]: 2: eth0 inet6 fe80::222:48ff:febc:655d/64 scope link \ valid_lft forever preferred_lft forever
Jul 2 01:51:40.842476 waagent[1523]: 2024-07-02T01:51:40.842378Z INFO ExtHandler ExtHandler Agent WALinuxAgent-2.6.0.2 discovered update WALinuxAgent-2.11.1.4 -- exiting
Jul 2 01:51:40.900042 waagent[1463]: 2024-07-02T01:51:40.899911Z 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
Jul 2 01:51:40.904539 waagent[1463]: 2024-07-02T01:51:40.904482Z INFO Daemon Daemon Determined Agent WALinuxAgent-2.11.1.4 to be the latest agent
Jul 2 01:51:42.067565 waagent[1552]: 2024-07-02T01:51:42.067471Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.11.1.4)
Jul 2 01:51:42.068605 waagent[1552]: 2024-07-02T01:51:42.068551Z INFO ExtHandler ExtHandler OS: flatcar 3510.3.5
Jul 2 01:51:42.068848 waagent[1552]: 2024-07-02T01:51:42.068798Z INFO ExtHandler ExtHandler Python: 3.9.16
Jul 2 01:51:42.069058 waagent[1552]: 2024-07-02T01:51:42.069013Z INFO ExtHandler ExtHandler CPU Arch: aarch64
Jul 2 01:51:42.076945 waagent[1552]: 2024-07-02T01:51:42.076845Z INFO ExtHandler ExtHandler Distro: flatcar-3510.3.5; OSUtil: CoreOSUtil; AgentService: waagent; Python: 3.9.16; Arch: aarch64; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.20.1;
Jul 2 01:51:42.077432 waagent[1552]: 2024-07-02T01:51:42.077379Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file
Jul 2 01:51:42.077672 waagent[1552]: 2024-07-02T01:51:42.077624Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16
Jul 2 01:51:42.090672 waagent[1552]: 2024-07-02T01:51:42.090604Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1]
Jul 2 01:51:42.099388 waagent[1552]: 2024-07-02T01:51:42.099338Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.151
Jul 2 01:51:42.100473 waagent[1552]: 2024-07-02T01:51:42.100417Z INFO ExtHandler
Jul 2 01:51:42.100733 waagent[1552]: 2024-07-02T01:51:42.100665Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: eeb11d32-913b-4f6c-9f1f-a7cad22a9ad9 eTag: 4065947515453883802 source: Fabric]
Jul 2 01:51:42.101567 waagent[1552]: 2024-07-02T01:51:42.101510Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them.
Jul 2 01:51:42.102931 waagent[1552]: 2024-07-02T01:51:42.102870Z INFO ExtHandler
Jul 2 01:51:42.103156 waagent[1552]: 2024-07-02T01:51:42.103108Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1]
Jul 2 01:51:42.109805 waagent[1552]: 2024-07-02T01:51:42.109757Z INFO ExtHandler ExtHandler Downloading artifacts profile blob
Jul 2 01:51:42.110329 waagent[1552]: 2024-07-02T01:51:42.110284Z WARNING ExtHandler ExtHandler Fetch failed: [HttpError] HTTPS is unavailable and required
Jul 2 01:51:42.128164 waagent[1552]: 2024-07-02T01:51:42.128113Z INFO ExtHandler ExtHandler Default channel changed to HostGAPlugin channel.
Jul 2 01:51:42.194610 waagent[1552]: 2024-07-02T01:51:42.194483Z INFO ExtHandler Downloaded certificate {'thumbprint': 'BFFF1869133C6542C40A6E46159E000F4F0F2D93', 'hasPrivateKey': False}
Jul 2 01:51:42.195863 waagent[1552]: 2024-07-02T01:51:42.195803Z INFO ExtHandler Downloaded certificate {'thumbprint': '9B1BA36CE36E0654B2BEF1800B1FB72AE71A2F52', 'hasPrivateKey': True}
Jul 2 01:51:42.197022 waagent[1552]: 2024-07-02T01:51:42.196960Z INFO ExtHandler Fetch goal state completed
Jul 2 01:51:42.216833 waagent[1552]: 2024-07-02T01:51:42.216746Z INFO ExtHandler ExtHandler OpenSSL version: OpenSSL 3.0.7 1 Nov 2022 (Library: OpenSSL 3.0.7 1 Nov 2022)
Jul 2 01:51:42.228576 waagent[1552]: 2024-07-02T01:51:42.228500Z INFO ExtHandler ExtHandler WALinuxAgent-2.11.1.4 running as process 1552
Jul 2 01:51:42.232229 waagent[1552]: 2024-07-02T01:51:42.232171Z INFO ExtHandler ExtHandler Cgroup monitoring is not supported on ['flatcar', '3510.3.5', '', 'Flatcar Container Linux by Kinvolk']
Jul 2 01:51:42.233853 waagent[1552]: 2024-07-02T01:51:42.233795Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules
Jul 2 01:51:42.238503 waagent[1552]: 2024-07-02T01:51:42.238455Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service
Jul 2 01:51:42.239029 waagent[1552]: 2024-07-02T01:51:42.238972Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup
Jul 2 01:51:42.246949 waagent[1552]: 2024-07-02T01:51:42.246899Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now
Jul 2 01:51:42.247492 waagent[1552]: 2024-07-02T01:51:42.247438Z ERROR ExtHandler ExtHandler Unable to setup the persistent firewall rules: [Errno 30] Read-only file system: '/lib/systemd/system/waagent-network-setup.service'
Jul 2 01:51:42.253284 waagent[1552]: 2024-07-02T01:51:42.253191Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up.
Jul 2 01:51:42.254446 waagent[1552]: 2024-07-02T01:51:42.254383Z INFO ExtHandler ExtHandler Checking if log collection is allowed at this time [False]. All three conditions must be met: configuration enabled [True], cgroups enabled [False], python supported: [True]
Jul 2 01:51:42.256114 waagent[1552]: 2024-07-02T01:51:42.256044Z INFO ExtHandler ExtHandler Starting env monitor service.
Jul 2 01:51:42.256397 waagent[1552]: 2024-07-02T01:51:42.256324Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file
Jul 2 01:51:42.256973 waagent[1552]: 2024-07-02T01:51:42.256905Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16
Jul 2 01:51:42.257564 waagent[1552]: 2024-07-02T01:51:42.257497Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled.
Jul 2 01:51:42.258114 waagent[1552]: 2024-07-02T01:51:42.258041Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service.
Jul 2 01:51:42.258394 waagent[1552]: 2024-07-02T01:51:42.258319Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route:
Jul 2 01:51:42.258394 waagent[1552]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT
Jul 2 01:51:42.258394 waagent[1552]: eth0 00000000 0114C80A 0003 0 0 1024 00000000 0 0 0
Jul 2 01:51:42.258394 waagent[1552]: eth0 0014C80A 00000000 0001 0 0 1024 00FFFFFF 0 0 0
Jul 2 01:51:42.258394 waagent[1552]: eth0 0114C80A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0
Jul 2 01:51:42.258394 waagent[1552]: eth0 10813FA8 0114C80A 0007 0 0 1024 FFFFFFFF 0 0 0
Jul 2 01:51:42.258394 waagent[1552]: eth0 FEA9FEA9 0114C80A 0007 0 0 1024 FFFFFFFF 0 0 0
Jul 2 01:51:42.260281 waagent[1552]: 2024-07-02T01:51:42.260096Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file
Jul 2 01:51:42.261265 waagent[1552]: 2024-07-02T01:51:42.261185Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread
Jul 2 01:51:42.261661 waagent[1552]: 2024-07-02T01:51:42.261588Z INFO ExtHandler ExtHandler Start Extension Telemetry service.
Jul 2 01:51:42.262038 waagent[1552]: 2024-07-02T01:51:42.261959Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16
Jul 2 01:51:42.262905 waagent[1552]: 2024-07-02T01:51:42.262829Z INFO EnvHandler ExtHandler Configure routes
Jul 2 01:51:42.263656 waagent[1552]: 2024-07-02T01:51:42.263596Z INFO EnvHandler ExtHandler Gateway:None
Jul 2 01:51:42.264204 waagent[1552]: 2024-07-02T01:51:42.264045Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True
Jul 2 01:51:42.264416 waagent[1552]: 2024-07-02T01:51:42.264355Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status.
Jul 2 01:51:42.267977 waagent[1552]: 2024-07-02T01:51:42.267904Z INFO EnvHandler ExtHandler Routes:None
Jul 2 01:51:42.268295 waagent[1552]: 2024-07-02T01:51:42.268229Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread
Jul 2 01:51:42.278092 waagent[1552]: 2024-07-02T01:51:42.278020Z INFO ExtHandler ExtHandler Downloading agent manifest
Jul 2 01:51:42.285140 waagent[1552]: 2024-07-02T01:51:42.285056Z INFO MonitorHandler ExtHandler Network interfaces:
Jul 2 01:51:42.285140 waagent[1552]: Executing ['ip', '-a', '-o', 'link']:
Jul 2 01:51:42.285140 waagent[1552]: 1: lo: <LOOPBACK,UP,LOWER_UP> mtu 65536 qdisc noqueue state UNKNOWN mode DEFAULT group default qlen 1000\ link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00
Jul 2 01:51:42.285140 waagent[1552]: 2: eth0: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 00:22:48:bc:65:5d brd ff:ff:ff:ff:ff:ff
Jul 2 01:51:42.285140 waagent[1552]: 3: enP10726s1: <BROADCAST,MULTICAST,SLAVE,UP,LOWER_UP> mtu 1500 qdisc mq master eth0 state UP mode DEFAULT group default qlen 1000\ link/ether 00:22:48:bc:65:5d brd ff:ff:ff:ff:ff:ff\ altname enP10726p0s2
Jul 2 01:51:42.285140 waagent[1552]: Executing ['ip', '-4', '-a', '-o', 'address']:
Jul 2 01:51:42.285140 waagent[1552]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever
Jul 2 01:51:42.285140 waagent[1552]: 2: eth0 inet 10.200.20.20/24 metric 1024 brd 10.200.20.255 scope global eth0\ valid_lft forever preferred_lft forever
Jul 2 01:51:42.285140 waagent[1552]: Executing ['ip', '-6', '-a', '-o', 'address']:
Jul 2 01:51:42.285140 waagent[1552]: 1: lo inet6 ::1/128 scope host \ valid_lft forever preferred_lft forever
Jul 2 01:51:42.285140 waagent[1552]: 2: eth0 inet6 fe80::222:48ff:febc:655d/64 scope link \ valid_lft forever preferred_lft forever
Jul 2 01:51:42.322815 waagent[1552]: 2024-07-02T01:51:42.322701Z INFO ExtHandler ExtHandler
Jul 2 01:51:42.323086 waagent[1552]: 2024-07-02T01:51:42.323033Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: 709ddcb5-3f42-47cb-87c3-31b4b43227ae correlation 2d227abc-2548-4076-827c-5c6dd154ae37 created: 2024-07-02T01:50:13.770638Z]
Jul 2 01:51:42.324066 waagent[1552]: 2024-07-02T01:51:42.324009Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything.
Jul 2 01:51:42.326019 waagent[1552]: 2024-07-02T01:51:42.325966Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 3 ms]
Jul 2 01:51:42.348556 waagent[1552]: 2024-07-02T01:51:42.348488Z INFO ExtHandler ExtHandler Looking for existing remote access users.
Jul 2 01:51:42.364123 waagent[1552]: 2024-07-02T01:51:42.364053Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.11.1.4 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: 2664CBE8-FF1E-4301-8C8D-A0890ECF45F6;DroppedPackets: 0;UpdateGSErrors: 0;AutoUpdate: 1]
Jul 2 01:51:42.540313 waagent[1552]: 2024-07-02T01:51:42.540194Z INFO EnvHandler ExtHandler Created firewall rules for the Azure Fabric:
Jul 2 01:51:42.540313 waagent[1552]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes)
Jul 2 01:51:42.540313 waagent[1552]: pkts bytes target prot opt in out source destination
Jul 2 01:51:42.540313 waagent[1552]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes)
Jul 2 01:51:42.540313 waagent[1552]: pkts bytes target prot opt in out source destination
Jul 2 01:51:42.540313 waagent[1552]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes)
Jul 2 01:51:42.540313 waagent[1552]: pkts bytes target prot opt in out source destination
Jul 2 01:51:42.540313 waagent[1552]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53
Jul 2 01:51:42.540313 waagent[1552]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0
Jul 2 01:51:42.540313 waagent[1552]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW
Jul 2 01:51:42.547764 waagent[1552]: 2024-07-02T01:51:42.547638Z INFO EnvHandler ExtHandler Current Firewall rules:
Jul 2 01:51:42.547764 waagent[1552]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes)
Jul 2 01:51:42.547764 waagent[1552]: pkts bytes target prot opt in out source destination
Jul 2 01:51:42.547764 waagent[1552]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes)
Jul 2 01:51:42.547764 waagent[1552]: pkts bytes target prot opt in out source destination
Jul 2 01:51:42.547764 waagent[1552]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes)
Jul 2 01:51:42.547764 waagent[1552]: pkts bytes target prot opt in out source destination
Jul 2 01:51:42.547764 waagent[1552]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53
Jul 2 01:51:42.547764 waagent[1552]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0
Jul 2 01:51:42.547764 waagent[1552]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW
Jul 2 01:51:42.548521 waagent[1552]: 2024-07-02T01:51:42.548472Z INFO EnvHandler ExtHandler Set block dev timeout: sda with timeout: 300
Jul 2 01:52:08.848481 kernel: hv_balloon: Max. dynamic memory size: 4096 MB
Jul 2 01:52:15.855795 update_engine[1360]: I0702 01:52:15.855751 1360 update_attempter.cc:509] Updating boot flags...
Jul 2 01:52:20.807632 systemd[1]: Created slice system-sshd.slice.
Jul 2 01:52:20.808699 systemd[1]: Started sshd@0-10.200.20.20:22-10.200.16.10:52774.service.
Jul 2 01:52:21.479250 sshd[1676]: Accepted publickey for core from 10.200.16.10 port 52774 ssh2: RSA SHA256:dIfkHgYeMkxYvU2An9TnjkrclLrmoTNY/YaaZP40c9o
Jul 2 01:52:21.496694 sshd[1676]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Jul 2 01:52:21.500498 systemd-logind[1359]: New session 3 of user core.
Jul 2 01:52:21.501244 systemd[1]: Started session-3.scope.
Jul 2 01:52:21.893006 systemd[1]: Started sshd@1-10.200.20.20:22-10.200.16.10:52790.service.
Jul 2 01:52:22.324020 sshd[1681]: Accepted publickey for core from 10.200.16.10 port 52790 ssh2: RSA SHA256:dIfkHgYeMkxYvU2An9TnjkrclLrmoTNY/YaaZP40c9o
Jul 2 01:52:22.324557 sshd[1681]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Jul 2 01:52:22.328148 systemd-logind[1359]: New session 4 of user core.
Jul 2 01:52:22.328529 systemd[1]: Started session-4.scope.
Jul 2 01:52:22.654649 sshd[1681]: pam_unix(sshd:session): session closed for user core
Jul 2 01:52:22.657455 systemd-logind[1359]: Session 4 logged out. Waiting for processes to exit.
Jul 2 01:52:22.658693 systemd[1]: session-4.scope: Deactivated successfully.
Jul 2 01:52:22.659690 systemd-logind[1359]: Removed session 4.
Jul 2 01:52:22.660255 systemd[1]: sshd@1-10.200.20.20:22-10.200.16.10:52790.service: Deactivated successfully.
Jul 2 01:52:22.725489 systemd[1]: Started sshd@2-10.200.20.20:22-10.200.16.10:52798.service.
Jul 2 01:52:23.150593 sshd[1687]: Accepted publickey for core from 10.200.16.10 port 52798 ssh2: RSA SHA256:dIfkHgYeMkxYvU2An9TnjkrclLrmoTNY/YaaZP40c9o
Jul 2 01:52:23.151867 sshd[1687]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Jul 2 01:52:23.155510 systemd-logind[1359]: New session 5 of user core.
Jul 2 01:52:23.155957 systemd[1]: Started session-5.scope.
Jul 2 01:52:23.470122 sshd[1687]: pam_unix(sshd:session): session closed for user core
Jul 2 01:52:23.473069 systemd[1]: sshd@2-10.200.20.20:22-10.200.16.10:52798.service: Deactivated successfully.
Jul 2 01:52:23.473724 systemd[1]: session-5.scope: Deactivated successfully.
Jul 2 01:52:23.474208 systemd-logind[1359]: Session 5 logged out. Waiting for processes to exit.
Jul 2 01:52:23.474983 systemd-logind[1359]: Removed session 5.
Jul 2 01:52:23.541548 systemd[1]: Started sshd@3-10.200.20.20:22-10.200.16.10:52812.service.
Jul 2 01:52:23.972254 sshd[1693]: Accepted publickey for core from 10.200.16.10 port 52812 ssh2: RSA SHA256:dIfkHgYeMkxYvU2An9TnjkrclLrmoTNY/YaaZP40c9o
Jul 2 01:52:23.973455 sshd[1693]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Jul 2 01:52:23.976756 systemd-logind[1359]: New session 6 of user core.
Jul 2 01:52:23.977502 systemd[1]: Started session-6.scope.
Jul 2 01:52:24.303376 sshd[1693]: pam_unix(sshd:session): session closed for user core
Jul 2 01:52:24.306002 systemd[1]: sshd@3-10.200.20.20:22-10.200.16.10:52812.service: Deactivated successfully.
Jul 2 01:52:24.306657 systemd[1]: session-6.scope: Deactivated successfully.
Jul 2 01:52:24.307211 systemd-logind[1359]: Session 6 logged out. Waiting for processes to exit.
Jul 2 01:52:24.308069 systemd-logind[1359]: Removed session 6.
Jul 2 01:52:24.379843 systemd[1]: Started sshd@4-10.200.20.20:22-10.200.16.10:52826.service.
Jul 2 01:52:24.839788 sshd[1699]: Accepted publickey for core from 10.200.16.10 port 52826 ssh2: RSA SHA256:dIfkHgYeMkxYvU2An9TnjkrclLrmoTNY/YaaZP40c9o
Jul 2 01:52:24.841022 sshd[1699]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Jul 2 01:52:24.844751 systemd-logind[1359]: New session 7 of user core.
Jul 2 01:52:24.845147 systemd[1]: Started session-7.scope.
Jul 2 01:52:25.329393 sudo[1702]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1
Jul 2 01:52:25.329606 sudo[1702]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500)
Jul 2 01:52:25.387605 dbus-daemon[1350]: avc: received setenforce notice (enforcing=1)
Jul 2 01:52:25.387775 sudo[1702]: pam_unix(sudo:session): session closed for user root
Jul 2 01:52:25.486416 sshd[1699]: pam_unix(sshd:session): session closed for user core
Jul 2 01:52:25.489207 systemd[1]: sshd@4-10.200.20.20:22-10.200.16.10:52826.service: Deactivated successfully.
Jul 2 01:52:25.490003 systemd[1]: session-7.scope: Deactivated successfully.
Jul 2 01:52:25.490581 systemd-logind[1359]: Session 7 logged out. Waiting for processes to exit.
Jul 2 01:52:25.491469 systemd-logind[1359]: Removed session 7.
Jul 2 01:52:25.556869 systemd[1]: Started sshd@5-10.200.20.20:22-10.200.16.10:52832.service.
Jul 2 01:52:25.981701 sshd[1706]: Accepted publickey for core from 10.200.16.10 port 52832 ssh2: RSA SHA256:dIfkHgYeMkxYvU2An9TnjkrclLrmoTNY/YaaZP40c9o
Jul 2 01:52:25.983863 sshd[1706]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Jul 2 01:52:25.987988 systemd[1]: Started session-8.scope.
Jul 2 01:52:25.988524 systemd-logind[1359]: New session 8 of user core.
Jul 2 01:52:26.225863 sudo[1710]: 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
Jul 2 01:52:26.226358 sudo[1710]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500)
Jul 2 01:52:26.228953 sudo[1710]: pam_unix(sudo:session): session closed for user root
Jul 2 01:52:26.232961 sudo[1709]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules
Jul 2 01:52:26.233151 sudo[1709]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500)
Jul 2 01:52:26.242228 systemd[1]: Stopping audit-rules.service...
Jul 2 01:52:26.241000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1
Jul 2 01:52:26.243290 auditctl[1713]: No rules
Jul 2 01:52:26.247802 kernel: kauditd_printk_skb: 98 callbacks suppressed
Jul 2 01:52:26.247882 kernel: audit: type=1305 audit(1719885146.241:177): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1
Jul 2 01:52:26.243688 systemd[1]: audit-rules.service: Deactivated successfully.
Jul 2 01:52:26.243856 systemd[1]: Stopped audit-rules.service.
Jul 2 01:52:26.245364 systemd[1]: Starting audit-rules.service...
Jul 2 01:52:26.241000 audit[1713]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffcddfd660 a2=420 a3=0 items=0 ppid=1 pid=1713 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)
Jul 2 01:52:26.277532 augenrules[1730]: No rules
Jul 2 01:52:26.278478 systemd[1]: Finished audit-rules.service.
Jul 2 01:52:26.283866 kernel: audit: type=1300 audit(1719885146.241:177): arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffcddfd660 a2=420 a3=0 items=0 ppid=1 pid=1713 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)
Jul 2 01:52:26.284635 sudo[1709]: pam_unix(sudo:session): session closed for user root
Jul 2 01:52:26.241000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D44
Jul 2 01:52:26.292554 kernel: audit: type=1327 audit(1719885146.241:177): proctitle=2F7362696E2F617564697463746C002D44
Jul 2 01:52:26.242000 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'
Jul 2 01:52:26.310683 kernel: audit: type=1131 audit(1719885146.242:178): 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'
Jul 2 01:52:26.276000 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'
Jul 2 01:52:26.328892 kernel: audit: type=1130 audit(1719885146.276:179): 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'
Jul 2 01:52:26.282000 audit[1709]: USER_END pid=1709 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'
Jul 2 01:52:26.349381 kernel: audit: type=1106 audit(1719885146.282:180): pid=1709 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'
Jul 2 01:52:26.349507 kernel: audit: type=1104 audit(1719885146.283:181): pid=1709 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'
Jul 2 01:52:26.283000 audit[1709]: CRED_DISP pid=1709 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'
Jul 2 01:52:26.376922 sshd[1706]: pam_unix(sshd:session): session closed for user core
Jul 2 01:52:26.376000 audit[1706]: USER_END pid=1706 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'
Jul 2 01:52:26.379439 systemd[1]: sshd@5-10.200.20.20:22-10.200.16.10:52832.service: Deactivated successfully.
Jul 2 01:52:26.380177 systemd[1]: session-8.scope: Deactivated successfully.
Jul 2 01:52:26.376000 audit[1706]: CRED_DISP pid=1706 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'
Jul 2 01:52:26.423822 kernel: audit: type=1106 audit(1719885146.376:182): pid=1706 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'
Jul 2 01:52:26.423943 kernel: audit: type=1104 audit(1719885146.376:183): pid=1706 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'
Jul 2 01:52:26.424010 kernel: audit: type=1131 audit(1719885146.377:184): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-10.200.20.20:22-10.200.16.10:52832 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Jul 2 01:52:26.377000 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.20:22-10.200.16.10:52832 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Jul 2 01:52:26.424224 systemd-logind[1359]: Session 8 logged out. Waiting for processes to exit.
Jul 2 01:52:26.444012 systemd-logind[1359]: Removed session 8.
Jul 2 01:52:26.451874 systemd[1]: Started sshd@6-10.200.20.20:22-10.200.16.10:52834.service.
Jul 2 01:52:26.450000 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.20:22-10.200.16.10:52834 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Jul 2 01:52:26.875000 audit[1736]: USER_ACCT pid=1736 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'
Jul 2 01:52:26.877403 sshd[1736]: Accepted publickey for core from 10.200.16.10 port 52834 ssh2: RSA SHA256:dIfkHgYeMkxYvU2An9TnjkrclLrmoTNY/YaaZP40c9o
Jul 2 01:52:26.876000 audit[1736]: CRED_ACQ pid=1736 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'
Jul 2 01:52:26.876000 audit[1736]: SYSCALL arch=c00000b7 syscall=64 success=yes exit=3 a0=5 a1=ffffd1f75640 a2=3 a3=1 items=0 ppid=1 pid=1736 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)
Jul 2 01:52:26.876000 audit: PROCTITLE proctitle=737368643A20636F7265205B707269765D
Jul 2 01:52:26.878978 sshd[1736]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Jul 2 01:52:26.882951 systemd[1]: Started session-9.scope.
Jul 2 01:52:26.883756 systemd-logind[1359]: New session 9 of user core.
Jul 2 01:52:26.886000 audit[1736]: USER_START pid=1736 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'
Jul 2 01:52:26.887000 audit[1738]: CRED_ACQ pid=1738 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'
Jul 2 01:52:27.119000 audit[1739]: USER_ACCT pid=1739 uid=500 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success'
Jul 2 01:52:27.121788 sudo[1739]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/mkdir -p .
Jul 2 01:52:27.120000 audit[1739]: CRED_REFR pid=1739 uid=500 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success'
Jul 2 01:52:27.121992 sudo[1739]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500)
Jul 2 01:52:27.121000 audit[1739]: USER_START pid=1739 uid=500 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success'
Jul 2 01:52:27.124506 sudo[1739]: pam_unix(sudo:session): session closed for user root
Jul 2 01:52:27.122000 audit[1739]: USER_END pid=1739 uid=500 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success'
Jul 2 01:52:27.122000 audit[1739]: CRED_DISP pid=1739 uid=500 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success'
Jul 2 01:52:27.209054 sshd[1736]: pam_unix(sshd:session): session closed for user core
Jul 2 01:52:27.208000 audit[1736]: USER_END pid=1736 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'
Jul 2 01:52:27.208000 audit[1736]: CRED_DISP pid=1736 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'
Jul 2 01:52:27.211983 systemd-logind[1359]: Session 9 logged out. Waiting for processes to exit.
Jul 2 01:52:27.212153 systemd[1]: sshd@6-10.200.20.20:22-10.200.16.10:52834.service: Deactivated successfully.
Jul 2 01:52:27.210000 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.20:22-10.200.16.10:52834 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Jul 2 01:52:27.212785 systemd[1]: session-9.scope: Deactivated successfully.
Jul 2 01:52:27.213401 systemd-logind[1359]: Removed session 9.
Jul 2 01:52:27.283000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@7-10.200.20.20:22-10.200.16.10:52848 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Jul 2 01:52:27.285360 systemd[1]: Started sshd@7-10.200.20.20:22-10.200.16.10:52848.service.
Jul 2 01:52:27.743000 audit[1743]: USER_ACCT pid=1743 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'
Jul 2 01:52:27.745332 sshd[1743]: Accepted publickey for core from 10.200.16.10 port 52848 ssh2: RSA SHA256:dIfkHgYeMkxYvU2An9TnjkrclLrmoTNY/YaaZP40c9o
Jul 2 01:52:27.744000 audit[1743]: CRED_ACQ pid=1743 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'
Jul 2 01:52:27.744000 audit[1743]: SYSCALL arch=c00000b7 syscall=64 success=yes exit=3 a0=5 a1=ffffc9570200 a2=3 a3=1 items=0 ppid=1 pid=1743 auid=500 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=10 comm="sshd" exe="/usr/sbin/sshd" subj=system_u:system_r:kernel_t:s0 key=(null)
Jul 2 01:52:27.744000 audit: PROCTITLE proctitle=737368643A20636F7265205B707269765D
Jul 2 01:52:27.746906 sshd[1743]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Jul 2 01:52:27.750600 systemd-logind[1359]: New session 10 of user core.
Jul 2 01:52:27.751043 systemd[1]: Started session-10.scope.
Jul 2 01:52:27.753000 audit[1743]: USER_START pid=1743 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success'
Jul 2 01:52:27.754000 audit[1745]: CRED_ACQ pid=1745 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success'
Jul 2 01:52:28.004000 audit[1746]: USER_ACCT pid=1746 uid=500 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success'
Jul 2 01:52:28.004000 audit[1746]: CRED_REFR pid=1746 uid=500 auid=500 ses=10 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'
Jul 2 01:52:28.006500 sudo[1746]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/install -m 0755 /dev/stdin kolet
Jul 2 01:52:28.006694 sudo[1746]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500)
Jul 2 01:52:28.006000 audit[1746]: USER_START pid=1746 uid=500 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success'
Jul 2 01:52:34.384567 sudo[1746]: pam_unix(sudo:session): session closed for user root
Jul 2 01:52:34.383000 audit[1746]: USER_END pid=1746 uid=500 auid=500 ses=10 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'
Jul 2 01:52:34.388583 kernel: kauditd_printk_skb: 27 callbacks suppressed
Jul 2 01:52:34.388641 kernel: audit: type=1106 audit(1719885154.383:208): pid=1746 uid=500 auid=500 ses=10 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'
Jul 2 01:52:34.385000 audit[1746]: CRED_DISP pid=1746 uid=500 auid=500 ses=10 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'
Jul 2 01:52:34.422574 kernel: audit: type=1104 audit(1719885154.385:209): pid=1746 uid=500 auid=500 ses=10 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'
Jul 2 01:52:34.475023 sshd[1743]: pam_unix(sshd:session): session closed for user core
Jul 2 01:52:34.475000 audit[1743]: USER_END pid=1743 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success'
Jul 2 01:52:34.475000 audit[1743]: CRED_DISP pid=1743 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success'
Jul 2 01:52:34.521225 kernel: audit: type=1106 audit(1719885154.475:210): pid=1743 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success'
Jul 2 01:52:34.521284 kernel: audit: type=1104 audit(1719885154.475:211): pid=1743 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success'
Jul 2 01:52:34.506007 systemd[1]: sshd@7-10.200.20.20:22-10.200.16.10:52848.service: Deactivated successfully.
Jul 2 01:52:34.506668 systemd[1]: session-10.scope: Deactivated successfully.
Jul 2 01:52:34.507518 systemd-logind[1359]: Session 10 logged out. Waiting for processes to exit.
Jul 2 01:52:34.508233 systemd-logind[1359]: Removed session 10.
Jul 2 01:52:34.505000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@7-10.200.20.20:22-10.200.16.10:52848 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Jul 2 01:52:34.541770 kernel: audit: type=1131 audit(1719885154.505:212): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@7-10.200.20.20:22-10.200.16.10:52848 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Jul 2 01:52:34.552622 systemd[1]: Started sshd@8-10.200.20.20:22-10.200.16.10:54446.service.
Jul 2 01:52:34.552000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@8-10.200.20.20:22-10.200.16.10:54446 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Jul 2 01:52:34.574740 kernel: audit: type=1130 audit(1719885154.552:213): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@8-10.200.20.20:22-10.200.16.10:54446 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Jul 2 01:52:35.011000 audit[1750]: USER_ACCT pid=1750 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'
Jul 2 01:52:35.012458 sshd[1750]: Accepted publickey for core from 10.200.16.10 port 54446 ssh2: RSA SHA256:dIfkHgYeMkxYvU2An9TnjkrclLrmoTNY/YaaZP40c9o
Jul 2 01:52:35.035673 sshd[1750]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Jul 2 01:52:35.034000 audit[1750]: CRED_ACQ pid=1750 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'
Jul 2 01:52:35.058147 kernel: audit: type=1101 audit(1719885155.011:214): pid=1750 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'
Jul 2 01:52:35.058240 kernel: audit: type=1103 audit(1719885155.034:215): pid=1750 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'
Jul 2 01:52:35.072404 kernel: audit: type=1006 audit(1719885155.034:216): pid=1750 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=11 res=1
Jul 2 01:52:35.034000 audit[1750]: SYSCALL arch=c00000b7 syscall=64 success=yes exit=3 a0=5 a1=ffffdbf37570 a2=3 a3=1 items=0 ppid=1 pid=1750 auid=500 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=11 comm="sshd" exe="/usr/sbin/sshd" subj=system_u:system_r:kernel_t:s0 key=(null)
Jul 2 01:52:35.095574 kernel: audit: type=1300 audit(1719885155.034:216): arch=c00000b7 syscall=64 success=yes exit=3 a0=5 a1=ffffdbf37570 a2=3 a3=1 items=0 ppid=1 pid=1750 auid=500 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=11 comm="sshd" exe="/usr/sbin/sshd" subj=system_u:system_r:kernel_t:s0 key=(null)
Jul 2 01:52:35.034000 audit: PROCTITLE proctitle=737368643A20636F7265205B707269765D
Jul 2 01:52:35.096181 systemd-logind[1359]: New session 11 of user core.
Jul 2 01:52:35.096994 systemd[1]: Started session-11.scope.
Jul 2 01:52:35.100000 audit[1750]: USER_START pid=1750 uid=0 auid=500 ses=11 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'
Jul 2 01:52:35.102000 audit[1752]: CRED_ACQ pid=1752 uid=0 auid=500 ses=11 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'
Jul 2 01:52:35.291000 audit[1753]: USER_ACCT pid=1753 uid=500 auid=500 ses=11 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success'
Jul 2 01:52:35.292910 sudo[1753]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemd-run --quiet ./kolet run coreos.ignition.resource.local Serve
Jul 2 01:52:35.293131 sudo[1753]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500)
Jul 2 01:52:35.292000 audit[1753]: CRED_REFR pid=1753 uid=500 auid=500 ses=11 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'
Jul 2 01:52:35.293000 audit[1753]: USER_START pid=1753 uid=500 auid=500 ses=11 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success'
Jul 2 01:52:35.368682 sudo[1753]: pam_unix(sudo:session): session closed for user root
Jul 2 01:52:35.365000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=run-rcc42c6046a4a49be803cf0e64f39f8c2 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Jul 2 01:52:35.367000 audit[1753]: USER_END pid=1753 uid=500 auid=500 ses=11 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'
Jul 2 01:52:35.367000 audit[1753]: CRED_DISP pid=1753 uid=500 auid=500 ses=11 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'
Jul 2 01:52:35.366990 systemd[1]: Started run-rcc42c6046a4a49be803cf0e64f39f8c2.service.
Jul 2 01:52:35.452915 sshd[1750]: pam_unix(sshd:session): session closed for user core
Jul 2 01:52:35.452000 audit[1750]: USER_END pid=1750 uid=0 auid=500 ses=11 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'
Jul 2 01:52:35.452000 audit[1750]: CRED_DISP pid=1750 uid=0 auid=500 ses=11 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'
Jul 2 01:52:35.453000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@8-10.200.20.20:22-10.200.16.10:54446 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Jul 2 01:52:35.455364 systemd[1]: sshd@8-10.200.20.20:22-10.200.16.10:54446.service: Deactivated successfully.
Jul 2 01:52:35.456058 systemd[1]: session-11.scope: Deactivated successfully.
Jul 2 01:52:35.456587 systemd-logind[1359]: Session 11 logged out. Waiting for processes to exit.
Jul 2 01:52:35.457314 systemd-logind[1359]: Removed session 11.