Nov 12 17:46:51.796455 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]
Nov 12 17:46:51.796488 kernel: Linux version 6.6.60-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p17) 13.3.1 20240614, GNU ld (Gentoo 2.42 p3) 2.42.0) #1 SMP PREEMPT Tue Nov 12 16:24:35 -00 2024
Nov 12 17:46:51.796498 kernel: KASLR enabled
Nov 12 17:46:51.796503 kernel: earlycon: pl11 at MMIO 0x00000000effec000 (options '')
Nov 12 17:46:51.796512 kernel: printk: bootconsole [pl11] enabled
Nov 12 17:46:51.796518 kernel: efi: EFI v2.7 by EDK II
Nov 12 17:46:51.796525 kernel: efi: ACPI 2.0=0x3fd5f018 SMBIOS=0x3e580000 SMBIOS 3.0=0x3e560000 MEMATTR=0x3f214018 RNG=0x3fd5f998 MEMRESERVE=0x3e44ee18
Nov 12 17:46:51.796531 kernel: random: crng init done
Nov 12 17:46:51.796537 kernel: ACPI: Early table checksum verification disabled
Nov 12 17:46:51.796543 kernel: ACPI: RSDP 0x000000003FD5F018 000024 (v02 VRTUAL)
Nov 12 17:46:51.796549 kernel: ACPI: XSDT 0x000000003FD5FF18 00006C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
Nov 12 17:46:51.796555 kernel: ACPI: FACP 0x000000003FD5FC18 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001)
Nov 12 17:46:51.796563 kernel: ACPI: DSDT 0x000000003FD41018 01DFCD (v02 MSFTVM DSDT01 00000001 INTL 20230628)
Nov 12 17:46:51.796569 kernel: ACPI: DBG2 0x000000003FD5FB18 000072 (v00 VRTUAL MICROSFT 00000001 MSFT 00000001)
Nov 12 17:46:51.796576 kernel: ACPI: GTDT 0x000000003FD5FD98 000060 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001)
Nov 12 17:46:51.796583 kernel: ACPI: OEM0 0x000000003FD5F098 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
Nov 12 17:46:51.796589 kernel: ACPI: SPCR 0x000000003FD5FA98 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001)
Nov 12 17:46:51.796597 kernel: ACPI: APIC 0x000000003FD5F818 0000FC (v04 VRTUAL MICROSFT 00000001 MSFT 00000001)
Nov 12 17:46:51.796603 kernel: ACPI: SRAT 0x000000003FD5F198 000234 (v03 VRTUAL MICROSFT 00000001 MSFT 00000001)
Nov 12 17:46:51.796610 kernel: ACPI: PPTT 0x000000003FD5F418 000120 (v01 VRTUAL MICROSFT 00000000 MSFT 00000000)
Nov 12 17:46:51.796617 kernel: ACPI: BGRT 0x000000003FD5FE98 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
Nov 12 17:46:51.796623 kernel: ACPI: SPCR: console: pl011,mmio32,0xeffec000,115200
Nov 12 17:46:51.796629 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff]
Nov 12 17:46:51.796635 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x1bfffffff]
Nov 12 17:46:51.796642 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1c0000000-0xfbfffffff]
Nov 12 17:46:51.796648 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1000000000-0xffffffffff]
Nov 12 17:46:51.796662 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x10000000000-0x1ffffffffff]
Nov 12 17:46:51.796669 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x20000000000-0x3ffffffffff]
Nov 12 17:46:51.796677 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x40000000000-0x7ffffffffff]
Nov 12 17:46:51.796684 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x80000000000-0xfffffffffff]
Nov 12 17:46:51.796690 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000000-0x1fffffffffff]
Nov 12 17:46:51.796697 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x200000000000-0x3fffffffffff]
Nov 12 17:46:51.796703 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x400000000000-0x7fffffffffff]
Nov 12 17:46:51.796709 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x800000000000-0xffffffffffff]
Nov 12 17:46:51.796716 kernel: NUMA: NODE_DATA [mem 0x1bf7ee800-0x1bf7f3fff]
Nov 12 17:46:51.796722 kernel: Zone ranges:
Nov 12 17:46:51.796728 kernel: DMA [mem 0x0000000000000000-0x00000000ffffffff]
Nov 12 17:46:51.796735 kernel: DMA32 empty
Nov 12 17:46:51.796741 kernel: Normal [mem 0x0000000100000000-0x00000001bfffffff]
Nov 12 17:46:51.796747 kernel: Movable zone start for each node
Nov 12 17:46:51.796758 kernel: Early memory node ranges
Nov 12 17:46:51.796765 kernel: node 0: [mem 0x0000000000000000-0x00000000007fffff]
Nov 12 17:46:51.796772 kernel: node 0: [mem 0x0000000000824000-0x000000003e54ffff]
Nov 12 17:46:51.796778 kernel: node 0: [mem 0x000000003e550000-0x000000003e87ffff]
Nov 12 17:46:51.796785 kernel: node 0: [mem 0x000000003e880000-0x000000003fc7ffff]
Nov 12 17:46:51.796793 kernel: node 0: [mem 0x000000003fc80000-0x000000003fcfffff]
Nov 12 17:46:51.796800 kernel: node 0: [mem 0x000000003fd00000-0x000000003fffffff]
Nov 12 17:46:51.796807 kernel: node 0: [mem 0x0000000100000000-0x00000001bfffffff]
Nov 12 17:46:51.796813 kernel: Initmem setup node 0 [mem 0x0000000000000000-0x00000001bfffffff]
Nov 12 17:46:51.796820 kernel: On node 0, zone DMA: 36 pages in unavailable ranges
Nov 12 17:46:51.796827 kernel: psci: probing for conduit method from ACPI.
Nov 12 17:46:51.796834 kernel: psci: PSCIv1.1 detected in firmware.
Nov 12 17:46:51.796840 kernel: psci: Using standard PSCI v0.2 function IDs
Nov 12 17:46:51.796847 kernel: psci: MIGRATE_INFO_TYPE not supported.
Nov 12 17:46:51.796854 kernel: psci: SMC Calling Convention v1.4
Nov 12 17:46:51.796860 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x0 -> Node 0
Nov 12 17:46:51.796867 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x1 -> Node 0
Nov 12 17:46:51.796875 kernel: percpu: Embedded 31 pages/cpu s86696 r8192 d32088 u126976
Nov 12 17:46:51.796882 kernel: pcpu-alloc: s86696 r8192 d32088 u126976 alloc=31*4096
Nov 12 17:46:51.796889 kernel: pcpu-alloc: [0] 0 [0] 1
Nov 12 17:46:51.796896 kernel: Detected PIPT I-cache on CPU0
Nov 12 17:46:51.796902 kernel: CPU features: detected: GIC system register CPU interface
Nov 12 17:46:51.796909 kernel: CPU features: detected: Hardware dirty bit management
Nov 12 17:46:51.796916 kernel: CPU features: detected: Spectre-BHB
Nov 12 17:46:51.796923 kernel: CPU features: kernel page table isolation forced ON by KASLR
Nov 12 17:46:51.796929 kernel: CPU features: detected: Kernel page table isolation (KPTI)
Nov 12 17:46:51.796936 kernel: CPU features: detected: ARM erratum 1418040
Nov 12 17:46:51.796943 kernel: CPU features: detected: ARM erratum 1542419 (kernel portion)
Nov 12 17:46:51.796952 kernel: CPU features: detected: SSBS not fully self-synchronizing
Nov 12 17:46:51.796959 kernel: alternatives: applying boot alternatives
Nov 12 17:46:51.796968 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 quiet verity.usrhash=8c276c03cfeb31103ba0b5f1af613bdc698463ad3d29e6750e34154929bf187e
Nov 12 17:46:51.796975 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space.
Nov 12 17:46:51.796982 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
Nov 12 17:46:51.796989 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
Nov 12 17:46:51.796995 kernel: Fallback order for Node 0: 0
Nov 12 17:46:51.797002 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1032156
Nov 12 17:46:51.797009 kernel: Policy zone: Normal
Nov 12 17:46:51.797015 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off
Nov 12 17:46:51.797051 kernel: software IO TLB: area num 2.
Nov 12 17:46:51.797061 kernel: software IO TLB: mapped [mem 0x000000003a44e000-0x000000003e44e000] (64MB)
Nov 12 17:46:51.797068 kernel: Memory: 3982752K/4194160K available (10240K kernel code, 2184K rwdata, 8096K rodata, 39360K init, 897K bss, 211408K reserved, 0K cma-reserved)
Nov 12 17:46:51.797075 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
Nov 12 17:46:51.797081 kernel: trace event string verifier disabled
Nov 12 17:46:51.797088 kernel: rcu: Preemptible hierarchical RCU implementation.
Nov 12 17:46:51.797096 kernel: rcu: RCU event tracing is enabled.
Nov 12 17:46:51.797103 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2.
Nov 12 17:46:51.797110 kernel: Trampoline variant of Tasks RCU enabled.
Nov 12 17:46:51.797117 kernel: Tracing variant of Tasks RCU enabled.
Nov 12 17:46:51.797123 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.
Nov 12 17:46:51.797130 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
Nov 12 17:46:51.797139 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
Nov 12 17:46:51.797145 kernel: GICv3: 960 SPIs implemented
Nov 12 17:46:51.797152 kernel: GICv3: 0 Extended SPIs implemented
Nov 12 17:46:51.797159 kernel: Root IRQ handler: gic_handle_irq
Nov 12 17:46:51.797166 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI
Nov 12 17:46:51.797172 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000effee000
Nov 12 17:46:51.797179 kernel: ITS: No ITS available, not enabling LPIs
Nov 12 17:46:51.797186 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention.
Nov 12 17:46:51.797193 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040
Nov 12 17:46:51.797200 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt).
Nov 12 17:46:51.797207 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns
Nov 12 17:46:51.797214 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns
Nov 12 17:46:51.797222 kernel: Console: colour dummy device 80x25
Nov 12 17:46:51.797230 kernel: printk: console [tty1] enabled
Nov 12 17:46:51.797236 kernel: ACPI: Core revision 20230628
Nov 12 17:46:51.797244 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000)
Nov 12 17:46:51.797252 kernel: pid_max: default: 32768 minimum: 301
Nov 12 17:46:51.797259 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity
Nov 12 17:46:51.797266 kernel: landlock: Up and running.
Nov 12 17:46:51.797272 kernel: SELinux: Initializing.
Nov 12 17:46:51.797279 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
Nov 12 17:46:51.797288 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
Nov 12 17:46:51.797295 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.
Nov 12 17:46:51.797302 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.
Nov 12 17:46:51.797309 kernel: Hyper-V: privilege flags low 0x2e7f, high 0x3a8030, hints 0xe, misc 0x31e1
Nov 12 17:46:51.797316 kernel: Hyper-V: Host Build 10.0.22477.1369-1-0
Nov 12 17:46:51.797323 kernel: Hyper-V: enabling crash_kexec_post_notifiers
Nov 12 17:46:51.797330 kernel: rcu: Hierarchical SRCU implementation.
Nov 12 17:46:51.797344 kernel: rcu: Max phase no-delay instances is 400.
Nov 12 17:46:51.797351 kernel: Remapping and enabling EFI services.
Nov 12 17:46:51.797359 kernel: smp: Bringing up secondary CPUs ...
Nov 12 17:46:51.797366 kernel: Detected PIPT I-cache on CPU1
Nov 12 17:46:51.797374 kernel: GICv3: CPU1: found redistributor 1 region 1:0x00000000f000e000
Nov 12 17:46:51.797383 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040
Nov 12 17:46:51.797390 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1]
Nov 12 17:46:51.797398 kernel: smp: Brought up 1 node, 2 CPUs
Nov 12 17:46:51.797405 kernel: SMP: Total of 2 processors activated.
Nov 12 17:46:51.797426 kernel: CPU features: detected: 32-bit EL0 Support
Nov 12 17:46:51.797436 kernel: CPU features: detected: Instruction cache invalidation not required for I/D coherence
Nov 12 17:46:51.797443 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence
Nov 12 17:46:51.797452 kernel: CPU features: detected: CRC32 instructions
Nov 12 17:46:51.797459 kernel: CPU features: detected: RCpc load-acquire (LDAPR)
Nov 12 17:46:51.797466 kernel: CPU features: detected: LSE atomic instructions
Nov 12 17:46:51.797474 kernel: CPU features: detected: Privileged Access Never
Nov 12 17:46:51.797481 kernel: CPU: All CPU(s) started at EL1
Nov 12 17:46:51.797488 kernel: alternatives: applying system-wide alternatives
Nov 12 17:46:51.797496 kernel: devtmpfs: initialized
Nov 12 17:46:51.797505 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
Nov 12 17:46:51.797513 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear)
Nov 12 17:46:51.797521 kernel: pinctrl core: initialized pinctrl subsystem
Nov 12 17:46:51.797528 kernel: SMBIOS 3.1.0 present.
Nov 12 17:46:51.797536 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 09/28/2024
Nov 12 17:46:51.797544 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family
Nov 12 17:46:51.797551 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations
Nov 12 17:46:51.797558 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
Nov 12 17:46:51.797566 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
Nov 12 17:46:51.797575 kernel: audit: initializing netlink subsys (disabled)
Nov 12 17:46:51.797583 kernel: audit: type=2000 audit(0.003:1): state=initialized audit_enabled=0 res=1
Nov 12 17:46:51.797590 kernel: thermal_sys: Registered thermal governor 'step_wise'
Nov 12 17:46:51.797597 kernel: cpuidle: using governor menu
Nov 12 17:46:51.797605 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
Nov 12 17:46:51.797612 kernel: ASID allocator initialised with 32768 entries
Nov 12 17:46:51.797619 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
Nov 12 17:46:51.797627 kernel: Serial: AMBA PL011 UART driver
Nov 12 17:46:51.797635 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL
Nov 12 17:46:51.797644 kernel: Modules: 0 pages in range for non-PLT usage
Nov 12 17:46:51.797651 kernel: Modules: 509040 pages in range for PLT usage
Nov 12 17:46:51.797658 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
Nov 12 17:46:51.797666 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page
Nov 12 17:46:51.797673 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages
Nov 12 17:46:51.797680 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page
Nov 12 17:46:51.797688 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
Nov 12 17:46:51.797695 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page
Nov 12 17:46:51.797702 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages
Nov 12 17:46:51.797711 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page
Nov 12 17:46:51.797718 kernel: ACPI: Added _OSI(Module Device)
Nov 12 17:46:51.797726 kernel: ACPI: Added _OSI(Processor Device)
Nov 12 17:46:51.797733 kernel: ACPI: Added _OSI(3.0 _SCP Extensions)
Nov 12 17:46:51.797740 kernel: ACPI: Added _OSI(Processor Aggregator Device)
Nov 12 17:46:51.797748 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded
Nov 12 17:46:51.797755 kernel: ACPI: Interpreter enabled
Nov 12 17:46:51.797762 kernel: ACPI: Using GIC for interrupt routing
Nov 12 17:46:51.797770 kernel: ARMH0011:00: ttyAMA0 at MMIO 0xeffec000 (irq = 12, base_baud = 0) is a SBSA
Nov 12 17:46:51.797777 kernel: printk: console [ttyAMA0] enabled
Nov 12 17:46:51.797786 kernel: printk: bootconsole [pl11] disabled
Nov 12 17:46:51.797794 kernel: ARMH0011:01: ttyAMA1 at MMIO 0xeffeb000 (irq = 13, base_baud = 0) is a SBSA
Nov 12 17:46:51.797801 kernel: iommu: Default domain type: Translated
Nov 12 17:46:51.797808 kernel: iommu: DMA domain TLB invalidation policy: strict mode
Nov 12 17:46:51.797815 kernel: efivars: Registered efivars operations
Nov 12 17:46:51.797823 kernel: vgaarb: loaded
Nov 12 17:46:51.797830 kernel: clocksource: Switched to clocksource arch_sys_counter
Nov 12 17:46:51.797838 kernel: VFS: Disk quotas dquot_6.6.0
Nov 12 17:46:51.797845 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
Nov 12 17:46:51.797854 kernel: pnp: PnP ACPI init
Nov 12 17:46:51.797862 kernel: pnp: PnP ACPI: found 0 devices
Nov 12 17:46:51.797869 kernel: NET: Registered PF_INET protocol family
Nov 12 17:46:51.797876 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)
Nov 12 17:46:51.797884 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)
Nov 12 17:46:51.797891 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
Nov 12 17:46:51.797899 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)
Nov 12 17:46:51.797906 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)
Nov 12 17:46:51.797913 kernel: TCP: Hash tables configured (established 32768 bind 32768)
Nov 12 17:46:51.797922 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear)
Nov 12 17:46:51.797930 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear)
Nov 12 17:46:51.797937 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family
Nov 12 17:46:51.797944 kernel: PCI: CLS 0 bytes, default 64
Nov 12 17:46:51.797951 kernel: kvm [1]: HYP mode not available
Nov 12 17:46:51.797959 kernel: Initialise system trusted keyrings
Nov 12 17:46:51.797966 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0
Nov 12 17:46:51.797973 kernel: Key type asymmetric registered
Nov 12 17:46:51.797980 kernel: Asymmetric key parser 'x509' registered
Nov 12 17:46:51.797989 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
Nov 12 17:46:51.797997 kernel: io scheduler mq-deadline registered
Nov 12 17:46:51.798004 kernel: io scheduler kyber registered
Nov 12 17:46:51.798012 kernel: io scheduler bfq registered
Nov 12 17:46:51.798036 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
Nov 12 17:46:51.798441 kernel: thunder_xcv, ver 1.0
Nov 12 17:46:51.798452 kernel: thunder_bgx, ver 1.0
Nov 12 17:46:51.798459 kernel: nicpf, ver 1.0
Nov 12 17:46:51.798466 kernel: nicvf, ver 1.0
Nov 12 17:46:51.798618 kernel: rtc-efi rtc-efi.0: registered as rtc0
Nov 12 17:46:51.798689 kernel: rtc-efi rtc-efi.0: setting system clock to 2024-11-12T17:46:51 UTC (1731433611)
Nov 12 17:46:51.798700 kernel: efifb: probing for efifb
Nov 12 17:46:51.798707 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k
Nov 12 17:46:51.798715 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1
Nov 12 17:46:51.798722 kernel: efifb: scrolling: redraw
Nov 12 17:46:51.798729 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0
Nov 12 17:46:51.798737 kernel: Console: switching to colour frame buffer device 128x48
Nov 12 17:46:51.798747 kernel: fb0: EFI VGA frame buffer device
Nov 12 17:46:51.798754 kernel: SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping ....
Nov 12 17:46:51.798762 kernel: hid: raw HID events driver (C) Jiri Kosina
Nov 12 17:46:51.798769 kernel: No ACPI PMU IRQ for CPU0
Nov 12 17:46:51.798777 kernel: No ACPI PMU IRQ for CPU1
Nov 12 17:46:51.798784 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 1 counters available
Nov 12 17:46:51.798791 kernel: watchdog: Delayed init of the lockup detector failed: -19
Nov 12 17:46:51.798799 kernel: watchdog: Hard watchdog permanently disabled
Nov 12 17:46:51.798806 kernel: NET: Registered PF_INET6 protocol family
Nov 12 17:46:51.798815 kernel: Segment Routing with IPv6
Nov 12 17:46:51.798822 kernel: In-situ OAM (IOAM) with IPv6
Nov 12 17:46:51.798830 kernel: NET: Registered PF_PACKET protocol family
Nov 12 17:46:51.798837 kernel: Key type dns_resolver registered
Nov 12 17:46:51.798845 kernel: registered taskstats version 1
Nov 12 17:46:51.798852 kernel: Loading compiled-in X.509 certificates
Nov 12 17:46:51.798860 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.60-flatcar: 277bea35d8d47c9841f307ab609d4271c3622dcb'
Nov 12 17:46:51.798867 kernel: Key type .fscrypt registered
Nov 12 17:46:51.798874 kernel: Key type fscrypt-provisioning registered
Nov 12 17:46:51.798883 kernel: ima: No TPM chip found, activating TPM-bypass!
Nov 12 17:46:51.798890 kernel: ima: Allocated hash algorithm: sha1
Nov 12 17:46:51.798898 kernel: ima: No architecture policies found
Nov 12 17:46:51.798905 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng)
Nov 12 17:46:51.798912 kernel: clk: Disabling unused clocks
Nov 12 17:46:51.798920 kernel: Freeing unused kernel memory: 39360K
Nov 12 17:46:51.798927 kernel: Run /init as init process
Nov 12 17:46:51.798934 kernel: with arguments:
Nov 12 17:46:51.798941 kernel: /init
Nov 12 17:46:51.798950 kernel: with environment:
Nov 12 17:46:51.798957 kernel: HOME=/
Nov 12 17:46:51.798964 kernel: TERM=linux
Nov 12 17:46:51.798971 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a
Nov 12 17:46:51.798981 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified)
Nov 12 17:46:51.798993 systemd[1]: Detected virtualization microsoft.
Nov 12 17:46:51.799001 systemd[1]: Detected architecture arm64.
Nov 12 17:46:51.799010 systemd[1]: Running in initrd.
Nov 12 17:46:51.799035 systemd[1]: No hostname configured, using default hostname.
Nov 12 17:46:51.799068 systemd[1]: Hostname set to <localhost>.
Nov 12 17:46:51.799077 systemd[1]: Initializing machine ID from random generator.
Nov 12 17:46:51.799085 systemd[1]: Queued start job for default target initrd.target.
Nov 12 17:46:51.799093 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch.
Nov 12 17:46:51.799101 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
Nov 12 17:46:51.799110 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM...
Nov 12 17:46:51.799120 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM...
Nov 12 17:46:51.799128 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT...
Nov 12 17:46:51.799136 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A...
Nov 12 17:46:51.799146 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132...
Nov 12 17:46:51.799154 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr...
Nov 12 17:46:51.799163 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre).
Nov 12 17:46:51.799170 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes.
Nov 12 17:46:51.799180 systemd[1]: Reached target paths.target - Path Units.
Nov 12 17:46:51.799188 systemd[1]: Reached target slices.target - Slice Units.
Nov 12 17:46:51.799196 systemd[1]: Reached target swap.target - Swaps.
Nov 12 17:46:51.799204 systemd[1]: Reached target timers.target - Timer Units.
Nov 12 17:46:51.799212 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket.
Nov 12 17:46:51.799220 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket.
Nov 12 17:46:51.799228 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log).
Nov 12 17:46:51.799236 systemd[1]: Listening on systemd-journald.socket - Journal Socket.
Nov 12 17:46:51.799244 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket.
Nov 12 17:46:51.799253 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket.
Nov 12 17:46:51.799261 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket.
Nov 12 17:46:51.799269 systemd[1]: Reached target sockets.target - Socket Units.
Nov 12 17:46:51.799277 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup...
Nov 12 17:46:51.799285 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes...
Nov 12 17:46:51.799293 systemd[1]: Finished network-cleanup.service - Network Cleanup.
Nov 12 17:46:51.799301 systemd[1]: Starting systemd-fsck-usr.service...
Nov 12 17:46:51.799309 systemd[1]: Starting systemd-journald.service - Journal Service...
Nov 12 17:46:51.799318 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules...
Nov 12 17:46:51.799326 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
Nov 12 17:46:51.799334 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes.
Nov 12 17:46:51.799342 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully...
Nov 12 17:46:51.799350 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup.
Nov 12 17:46:51.799359 systemd[1]: Finished systemd-fsck-usr.service.
Nov 12 17:46:51.799369 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully.
Nov 12 17:46:51.799396 systemd-journald[214]: Collecting audit messages is disabled.
Nov 12 17:46:51.799416 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev...
Nov 12 17:46:51.799426 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this.
Nov 12 17:46:51.799434 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup.
Nov 12 17:46:51.799442 kernel: Bridge firewalling registered
Nov 12 17:46:51.799449 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters...
Nov 12 17:46:51.799458 systemd-journald[214]: Journal started
Nov 12 17:46:51.799476 systemd-journald[214]: Runtime Journal (/run/log/journal/649c4ecf2e2842f18a2d46e297a10441) is 8.0M, max 78.5M, 70.5M free.
Nov 12 17:46:51.800203 systemd[1]: Started systemd-journald.service - Journal Service.
Nov 12 17:46:51.776803 systemd-modules-load[215]: Inserted module 'overlay'
Nov 12 17:46:51.796004 systemd-modules-load[215]: Inserted module 'br_netfilter'
Nov 12 17:46:51.812202 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories...
Nov 12 17:46:51.812542 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules.
Nov 12 17:46:51.812702 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev.
Nov 12 17:46:51.835374 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables...
Nov 12 17:46:51.835618 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories.
Nov 12 17:46:51.850837 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
Nov 12 17:46:51.852238 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook...
Nov 12 17:46:51.870059 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables.
Nov 12 17:46:51.874210 systemd[1]: Starting systemd-resolved.service - Network Name Resolution...
Nov 12 17:46:51.885863 dracut-cmdline[251]: dracut-dracut-053
Nov 12 17:46:51.891685 dracut-cmdline[251]: 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 quiet verity.usrhash=8c276c03cfeb31103ba0b5f1af613bdc698463ad3d29e6750e34154929bf187e
Nov 12 17:46:51.934930 systemd-resolved[256]: Positive Trust Anchors:
Nov 12 17:46:51.934954 systemd-resolved[256]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
Nov 12 17:46:51.934987 systemd-resolved[256]: 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 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test
Nov 12 17:46:51.937426 systemd-resolved[256]: Defaulting to hostname 'linux'.
Nov 12 17:46:51.942146 systemd[1]: Started systemd-resolved.service - Network Name Resolution.
Nov 12 17:46:51.942246 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups.
Nov 12 17:46:52.037050 kernel: SCSI subsystem initialized
Nov 12 17:46:52.039037 kernel: Loading iSCSI transport class v2.0-870.
Nov 12 17:46:52.046065 kernel: iscsi: registered transport (tcp)
Nov 12 17:46:52.058044 kernel: iscsi: registered transport (qla4xxx)
Nov 12 17:46:52.058108 kernel: QLogic iSCSI HBA Driver
Nov 12 17:46:52.095072 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook.
Nov 12 17:46:52.103198 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook...
Nov 12 17:46:52.117044 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
Nov 12 17:46:52.117111 kernel: device-mapper: uevent: version 1.0.3
Nov 12 17:46:52.117123 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com
Nov 12 17:46:52.162049 kernel: raid6: neonx8 gen() 15789 MB/s
Nov 12 17:46:52.179030 kernel: raid6: neonx4 gen() 15675 MB/s
Nov 12 17:46:52.196028 kernel: raid6: neonx2 gen() 13243 MB/s
Nov 12 17:46:52.213032 kernel: raid6: neonx1 gen() 10486 MB/s
Nov 12 17:46:52.230029 kernel: raid6: int64x8 gen() 6981 MB/s
Nov 12 17:46:52.247032 kernel: raid6: int64x4 gen() 7359 MB/s
Nov 12 17:46:52.264027 kernel: raid6: int64x2 gen() 6131 MB/s
Nov 12 17:46:52.281032 kernel: raid6: int64x1 gen() 5061 MB/s
Nov 12 17:46:52.281054 kernel: raid6: using algorithm neonx8 gen() 15789 MB/s
Nov 12 17:46:52.298038 kernel: raid6: .... xor() 11937 MB/s, rmw enabled
Nov 12 17:46:52.298051 kernel: raid6: using neon recovery algorithm
Nov 12 17:46:52.301031 kernel: xor: measuring software checksum speed
Nov 12 17:46:52.302031 kernel: 8regs : 18573 MB/sec
Nov 12 17:46:52.302042 kernel: 32regs : 19674 MB/sec
Nov 12 17:46:52.302051 kernel: arm64_neon : 27105 MB/sec
Nov 12 17:46:52.302063 kernel: xor: using function: arm64_neon (27105 MB/sec)
Nov 12 17:46:52.347041 kernel: Btrfs loaded, zoned=no, fsverity=no
Nov 12 17:46:52.356758 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook.
Nov 12 17:46:52.368161 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files...
Nov 12 17:46:52.385397 systemd-udevd[436]: Using default interface naming scheme 'v255'.
Nov 12 17:46:52.394448 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files.
Nov 12 17:46:52.411264 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook...
Nov 12 17:46:52.422215 dracut-pre-trigger[438]: rd.md=0: removing MD RAID activation
Nov 12 17:46:52.448780 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook.
Nov 12 17:46:52.456354 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices...
Nov 12 17:46:52.492623 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices.
Nov 12 17:46:52.501275 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook...
Nov 12 17:46:52.517938 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook.
Nov 12 17:46:52.523884 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems.
Nov 12 17:46:52.523899 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes.
Nov 12 17:46:52.523910 systemd[1]: Reached target remote-fs.target - Remote File Systems.
Nov 12 17:46:52.534274 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook...
Nov 12 17:46:52.572893 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook.
Nov 12 17:46:52.589481 kernel: hv_vmbus: Vmbus version:5.3
Nov 12 17:46:52.594045 kernel: pps_core: LinuxPPS API ver. 1 registered
Nov 12 17:46:52.594092 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
Nov 12 17:46:52.600042 kernel: PTP clock support registered
Nov 12 17:46:52.608041 kernel: hv_vmbus: registering driver hyperv_keyboard
Nov 12 17:46:52.608097 kernel: input: AT Translated Set 2 keyboard as /devices/LNXSYSTM:00/LNXSYBUS:00/ACPI0004:00/MSFT1000:00/d34b2567-b9b6-42b9-8778-0a4ec0b955bf/serio0/input/input0
Nov 12 17:46:52.608109 kernel: hv_utils: Registering HyperV Utility Driver
Nov 12 17:46:52.608118 kernel: hv_vmbus: registering driver hv_utils
Nov 12 17:46:52.608127 kernel: hv_utils: Shutdown IC version 3.2
Nov 12 17:46:52.608136 kernel: hv_utils: TimeSync IC version 4.0
Nov 12 17:46:52.948101 systemd-resolved[256]: Clock change detected. Flushing caches.
Nov 12 17:46:52.957503 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully.
Nov 12 17:46:52.965227 kernel: hv_vmbus: registering driver hid_hyperv
Nov 12 17:46:52.965250 kernel: hv_vmbus: registering driver hv_netvsc
Nov 12 17:46:52.965259 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input1
Nov 12 17:46:52.965269 kernel: hid-generic 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on
Nov 12 17:46:52.960365 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
Nov 12 17:46:52.975148 kernel: hv_vmbus: registering driver hv_storvsc
Nov 12 17:46:52.975185 kernel: scsi host0: storvsc_host_t
Nov 12 17:46:52.975629 kernel: scsi 0:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5
Nov 12 17:46:52.975659 kernel: scsi host1: storvsc_host_t
Nov 12 17:46:52.965072 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters...
Nov 12 17:46:52.965097 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
Nov 12 17:46:52.990699 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 0
Nov 12 17:46:52.965352 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup.
Nov 12 17:46:52.965397 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup...
Nov 12 17:46:52.984369 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
Nov 12 17:46:53.007883 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup.
Nov 12 17:46:53.009074 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters...
Nov 12 17:46:53.040178 kernel: sr 0:0:0:2: [sr0] scsi-1 drive
Nov 12 17:46:53.041350 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20
Nov 12 17:46:53.041365 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0
Nov 12 17:46:53.047865 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
Nov 12 17:46:53.056972 kernel: sd 0:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB)
Nov 12 17:46:53.058036 kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks
Nov 12 17:46:53.058153 kernel: sd 0:0:0:0: [sda] Write Protect is off
Nov 12 17:46:53.058241 kernel: sd 0:0:0:0: [sda] Mode Sense: 0f 00 10 00
Nov 12 17:46:53.058332 kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA
Nov 12 17:46:53.058420 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9
Nov 12 17:46:53.058431 kernel: sd 0:0:0:0: [sda] Attached SCSI disk
Nov 12 17:46:53.063950 kernel: hv_netvsc 000d3af7-1fed-000d-3af7-1fed000d3af7 eth0: VF slot 1 added
Nov 12 17:46:53.071971 kernel: hv_vmbus: registering driver hv_pci
Nov 12 17:46:53.072955 kernel: hv_pci 88e42e9a-27cd-4818-b021-3076bb7c26ab: PCI VMBus probing: Using version 0x10004
Nov 12 17:46:53.105712 kernel: hv_pci 88e42e9a-27cd-4818-b021-3076bb7c26ab: PCI host bridge to bus 27cd:00
Nov 12 17:46:53.105825 kernel: pci_bus 27cd:00: root bus resource [mem 0xfc0000000-0xfc00fffff window]
Nov 12 17:46:53.105939 kernel: pci_bus 27cd:00: No busn resource found for root bus, will use [bus 00-ff]
Nov 12 17:46:53.106990 kernel: pci 27cd:00:02.0: [15b3:1018] type 00 class 0x020000
Nov 12 17:46:53.107121 kernel: pci 27cd:00:02.0: reg 0x10: [mem 0xfc0000000-0xfc00fffff 64bit pref]
Nov 12 17:46:53.107232 kernel: pci 27cd:00:02.0: enabling Extended Tags
Nov 12 17:46:53.107326 kernel: pci 27cd:00:02.0: 0.000 Gb/s available PCIe bandwidth, limited by Unknown x0 link at 27cd:00:02.0 (capable of 126.016 Gb/s with 8.0 GT/s PCIe x16 link)
Nov 12 17:46:53.107420 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/sda6 scanned by (udev-worker) (481)
Nov 12 17:46:53.107430 kernel: pci_bus 27cd:00: busn_res: [bus 00-ff] end is updated to 00
Nov 12 17:46:53.107513 kernel: pci 27cd:00:02.0: BAR 0: assigned [mem 0xfc0000000-0xfc00fffff 64bit pref]
Nov 12 17:46:53.109955 kernel: BTRFS: device fsid 93a9d474-e751-47b7-a65f-e39ca9abd47a devid 1 transid 40 /dev/sda3 scanned by (udev-worker) (484)
Nov 12 17:46:53.156905 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Virtual_Disk ROOT.
Nov 12 17:46:53.170319 kernel: mlx5_core 27cd:00:02.0: enabling device (0000 -> 0002)
Nov 12 17:46:53.365835 kernel: mlx5_core 27cd:00:02.0: firmware version: 16.30.1284
Nov 12 17:46:53.366018 kernel: device-mapper: verity: sha256 using implementation "sha256-ce"
Nov 12 17:46:53.366031 kernel: BTRFS info (device dm-0): first mount of filesystem 93a9d474-e751-47b7-a65f-e39ca9abd47a
Nov 12 17:46:53.366042 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm
Nov 12 17:46:53.366051 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead
Nov 12 17:46:53.366062 kernel: BTRFS info (device dm-0): disabling log replay at mount time
Nov 12 17:46:53.366071 kernel: BTRFS info (device dm-0): using free space tree
Nov 12 17:46:53.366081 kernel: BTRFS info (device sda6): first mount of filesystem 936a2172-6c61-4af6-a047-e38e0a3ff18b
Nov 12 17:46:53.366094 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm
Nov 12 17:46:53.366104 kernel: BTRFS info (device sda6): using free space tree
Nov 12 17:46:53.366113 kernel: BTRFS info (device sda6): auto enabling async discard
Nov 12 17:46:53.366123 kernel: BTRFS info (device sda6): last unmount of filesystem 936a2172-6c61-4af6-a047-e38e0a3ff18b
Nov 12 17:46:53.366132 kernel: hv_netvsc 000d3af7-1fed-000d-3af7-1fed000d3af7 eth0: VF registering: eth1
Nov 12 17:46:53.366226 kernel: mlx5_core 27cd:00:02.0 eth1: joined to eth0
Nov 12 17:46:53.366321 kernel: mlx5_core 27cd:00:02.0: MLX5E: StrdRq(1) RqSz(8) StrdSz(2048) RxCqeCmprss(0 basic)
Nov 12 17:46:53.168748 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Virtual_Disk EFI-SYSTEM.
Nov 12 17:46:53.173959 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Virtual_Disk USR-A.
Nov 12 17:46:53.388507 kernel: mlx5_core 27cd:00:02.0 enP10189s1: renamed from eth1
Nov 12 17:46:53.173975 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Virtual_Disk USR-A.
Nov 12 17:46:53.179315 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM.
Nov 12 17:46:53.412671 sh[591]: Success
Nov 12 17:46:53.187059 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary...
Nov 12 17:46:53.412410 ignition[684]: Ignition 2.19.0
Nov 12 17:46:53.189407 systemd[1]: disk-uuid.service: Deactivated successfully.
Nov 12 17:46:53.412416 ignition[684]: Stage: fetch-offline
Nov 12 17:46:53.189529 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary.
Nov 12 17:46:53.412467 ignition[684]: no configs at "/usr/lib/ignition/base.d"
Nov 12 17:46:53.194114 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr...
Nov 12 17:46:53.412475 ignition[684]: no config dir at "/usr/lib/ignition/base.platform.d/azure"
Nov 12 17:46:53.252455 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr.
Nov 12 17:46:53.412584 ignition[684]: parsed url from cmdline: ""
Nov 12 17:46:53.268082 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr...
Nov 12 17:46:53.412587 ignition[684]: no config URL provided
Nov 12 17:46:53.280584 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr.
Nov 12 17:46:53.412592 ignition[684]: reading system config file "/usr/lib/ignition/user.ign"
Nov 12 17:46:53.280682 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met.
Nov 12 17:46:53.412599 ignition[684]: no config at "/usr/lib/ignition/user.ign"
Nov 12 17:46:53.286052 systemd[1]: Starting ignition-setup.service - Ignition (setup)...
Nov 12 17:46:53.412604 ignition[684]: failed to fetch config: resource requires networking
Nov 12 17:46:53.291151 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline...
Nov 12 17:46:53.412779 ignition[684]: Ignition finished successfully
Nov 12 17:46:53.294093 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr.
Nov 12 17:46:53.316950 systemd[1]: mnt-oem.mount: Deactivated successfully.
Nov 12 17:46:53.324961 systemd[1]: Finished ignition-setup.service - Ignition (setup).
Nov 12 17:46:53.331133 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)...
Nov 12 17:46:53.416305 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline).
Nov 12 17:46:53.485017 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline.
Nov 12 17:46:53.505275 systemd[1]: Starting systemd-networkd.service - Network Configuration...
Nov 12 17:46:53.550062 systemd-networkd[789]: lo: Link UP
Nov 12 17:46:53.550066 systemd-networkd[789]: lo: Gained carrier
Nov 12 17:46:53.551608 systemd-networkd[789]: Enumeration completed
Nov 12 17:46:53.551708 systemd[1]: Started systemd-networkd.service - Network Configuration.
Nov 12 17:46:53.551815 systemd[1]: Reached target network.target - Network.
Nov 12 17:46:53.595251 ignition[791]: Ignition 2.19.0
Nov 12 17:46:53.553171 systemd-networkd[789]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
Nov 12 17:46:53.619110 kernel: mlx5_core 27cd:00:02.0 enP10189s1: Link up
Nov 12 17:46:53.595258 ignition[791]: Stage: fetch
Nov 12 17:46:53.553174 systemd-networkd[789]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
Nov 12 17:46:53.595508 ignition[791]: no configs at "/usr/lib/ignition/base.d"
Nov 12 17:46:53.578291 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)...
Nov 12 17:46:53.595517 ignition[791]: no config dir at "/usr/lib/ignition/base.platform.d/azure"
Nov 12 17:46:53.595625 ignition[791]: parsed url from cmdline: ""
Nov 12 17:46:53.595628 ignition[791]: no config URL provided
Nov 12 17:46:53.595638 ignition[791]: reading system config file "/usr/lib/ignition/user.ign"
Nov 12 17:46:53.654589 kernel: hv_netvsc 000d3af7-1fed-000d-3af7-1fed000d3af7 eth0: Data path switched to VF: enP10189s1
Nov 12 17:46:53.649983 systemd-networkd[789]: enP10189s1: Link UP
Nov 12 17:46:53.595645 ignition[791]: no config at "/usr/lib/ignition/user.ign"
Nov 12 17:46:53.650211 systemd-networkd[789]: eth0: Link UP
Nov 12 17:46:53.595666 ignition[791]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1
Nov 12 17:46:53.650602 systemd-networkd[789]: eth0: Gained carrier
Nov 12 17:46:53.595826 ignition[791]: GET error: Get "http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text": dial tcp 169.254.169.254:80: connect: network is unreachable
Nov 12 17:46:53.650612 systemd-networkd[789]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
Nov 12 17:46:53.667562 systemd-networkd[789]: enP10189s1: Gained carrier
Nov 12 17:46:53.795962 ignition[791]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #2
Nov 12 17:46:53.796152 ignition[791]: GET error: Get "http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text": dial tcp 169.254.169.254:80: connect: network is unreachable
Nov 12 17:46:54.196723 ignition[791]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #3
Nov 12 17:46:54.196849 ignition[791]: GET error: Get "http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text": dial tcp 169.254.169.254:80: connect: network is unreachable
Nov 12 17:46:54.736303 kernel: hv_utils: Heartbeat IC version 3.0
Nov 12 17:46:54.889082 systemd-networkd[789]: eth0: Gained IPv6LL
Nov 12 17:46:54.953235 systemd-networkd[789]: enP10189s1: Gained IPv6LL
Nov 12 17:46:54.996985 ignition[791]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #4
Nov 12 17:46:54.997093 ignition[791]: GET error: Get "http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text": dial tcp 169.254.169.254:80: connect: network is unreachable
Nov 12 17:46:56.597229 ignition[791]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #5
Nov 12 17:46:56.597380 ignition[791]: GET error: Get "http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text": dial tcp 169.254.169.254:80: connect: network is unreachable
Nov 12 17:46:58.375963 systemd-networkd[789]: eth0: DHCPv4 address 10.200.20.49/24, gateway 10.200.20.1 acquired from 168.63.129.16
Nov 12 17:46:59.797524 ignition[791]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #6
Nov 12 17:46:59.817933 ignition[791]: GET result: OK
Nov 12 17:46:59.817990 ignition[791]: config has been read from IMDS userdata
Nov 12 17:46:59.820518 unknown[791]: fetched base config from "system"
Nov 12 17:46:59.818001 ignition[791]: parsing config with SHA512: 8d66cedae69c1c609d1c5d418abad86683671437a6858b5955d437e946f4b96bf7904e4fcce60e1feff929b1da052bfdf8e08a22b6663c9348b38aa379751fba
Nov 12 17:46:59.820535 unknown[791]: fetched base config from "system"
Nov 12 17:46:59.820731 ignition[791]: fetch: fetch complete
Nov 12 17:46:59.820541 unknown[791]: fetched user config from "azure"
Nov 12 17:46:59.820735 ignition[791]: fetch: fetch passed
Nov 12 17:46:59.823144 systemd[1]: Finished ignition-fetch.service - Ignition (fetch).
Nov 12 17:46:59.820784 ignition[791]: Ignition finished successfully
Nov 12 17:46:59.837199 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)...
Nov 12 17:46:59.853426 ignition[798]: Ignition 2.19.0
Nov 12 17:46:59.853433 ignition[798]: Stage: kargs
Nov 12 17:46:59.853637 ignition[798]: no configs at "/usr/lib/ignition/base.d"
Nov 12 17:46:59.853647 ignition[798]: no config dir at "/usr/lib/ignition/base.platform.d/azure"
Nov 12 17:46:59.854297 ignition[798]: kargs: op(1): [started] updating kernel arguments
Nov 12 17:46:59.885999 kernel: BTRFS: device label OEM devid 1 transid 17 /dev/sda6 scanned by mount (805)
Nov 12 17:46:59.854305 ignition[798]: kargs: op(1): executing: "ignition-kargs-helper" "--should-exist" "quiet"
Nov 12 17:46:59.887946 kernel: BTRFS info (device sda6): first mount of filesystem 936a2172-6c61-4af6-a047-e38e0a3ff18b
Nov 12 17:46:59.887984 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm
Nov 12 17:46:59.887995 kernel: BTRFS info (device sda6): using free space tree
Nov 12 17:46:59.890347 kernel: BTRFS info (device sda6): auto enabling async discard
Nov 12 17:46:59.894455 ignition[798]: kargs: op(1): [finished] updating kernel arguments
Nov 12 17:46:59.894467 ignition[798]: kargs: kargs passed
Nov 12 17:46:59.903441 kernel: BTRFS info (device sda6): last unmount of filesystem 936a2172-6c61-4af6-a047-e38e0a3ff18b
Nov 12 17:46:59.894547 ignition[798]: Ignition finished successfully
Nov 12 17:46:59.908992 systemd[1]: Finished ignition-kargs.service - Ignition (kargs).
Nov 12 17:46:59.918083 systemd[1]: Starting ignition-disks.service - Ignition (disks)...
Nov 12 17:46:59.935525 ignition[833]: Ignition 2.19.0
Nov 12 17:46:59.935536 ignition[833]: Stage: disks
Nov 12 17:46:59.940195 systemd[1]: Finished ignition-disks.service - Ignition (disks).
Nov 12 17:46:59.935725 ignition[833]: no configs at "/usr/lib/ignition/base.d"
Nov 12 17:46:59.940678 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device.
Nov 12 17:46:59.935734 ignition[833]: no config dir at "/usr/lib/ignition/base.platform.d/azure"
Nov 12 17:46:59.940724 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems.
Nov 12 17:46:59.936378 ignition[833]: disks: disks passed
Nov 12 17:46:59.940750 systemd[1]: Reached target local-fs.target - Local File Systems.
Nov 12 17:46:59.936422 ignition[833]: Ignition finished successfully
Nov 12 17:46:59.986794 systemd-fsck[841]: ROOT: clean, 14/7326000 files, 477710/7359488 blocks
Nov 12 17:46:59.940775 systemd[1]: Reached target sysinit.target - System Initialization.
Nov 12 17:46:59.940788 systemd[1]: Reached target basic.target - Basic System.
Nov 12 17:46:59.955087 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT...
Nov 12 17:46:59.983034 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT.
Nov 12 17:46:59.996294 systemd[1]: Mounting sysroot.mount - /sysroot...
Nov 12 17:47:00.052938 kernel: EXT4-fs (sda9): mounted filesystem b3af0fd7-3c7c-4cdc-9b88-dae3d10ea922 r/w with ordered data mode. Quota mode: none.
Nov 12 17:47:00.053786 systemd[1]: Mounted sysroot.mount - /sysroot.
Nov 12 17:47:00.054248 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System.
Nov 12 17:47:00.076021 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem...
Nov 12 17:47:00.083289 kernel: BTRFS: device label OEM devid 1 transid 19 /dev/sda6 scanned by mount (852)
Nov 12 17:47:00.082110 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr...
Nov 12 17:47:00.091267 kernel: BTRFS info (device sda6): first mount of filesystem 936a2172-6c61-4af6-a047-e38e0a3ff18b
Nov 12 17:47:00.091291 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm
Nov 12 17:47:00.091302 kernel: BTRFS info (device sda6): using free space tree
Nov 12 17:47:00.090188 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent...
Nov 12 17:47:00.090233 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot).
Nov 12 17:47:00.090263 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup.
Nov 12 17:47:00.102624 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr.
Nov 12 17:47:00.123937 kernel: BTRFS info (device sda6): auto enabling async discard
Nov 12 17:47:00.105232 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup...
Nov 12 17:47:00.128239 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem.
Nov 12 17:47:00.220564 initrd-setup-root[878]: cut: /sysroot/etc/passwd: No such file or directory
Nov 12 17:47:00.233679 initrd-setup-root[885]: cut: /sysroot/etc/group: No such file or directory
Nov 12 17:47:00.243188 initrd-setup-root[892]: cut: /sysroot/etc/shadow: No such file or directory
Nov 12 17:47:00.252369 initrd-setup-root[899]: cut: /sysroot/etc/gshadow: No such file or directory
Nov 12 17:47:00.375287 coreos-metadata[854]: Nov 12 17:47:00.375 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1
Nov 12 17:47:00.385113 coreos-metadata[854]: Nov 12 17:47:00.385 INFO Fetch successful
Nov 12 17:47:00.390851 coreos-metadata[854]: Nov 12 17:47:00.390 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1
Nov 12 17:47:00.411949 coreos-metadata[854]: Nov 12 17:47:00.411 INFO Fetch successful
Nov 12 17:47:00.411949 coreos-metadata[854]: Nov 12 17:47:00.411 INFO wrote hostname ci-4081.2.0-a-d5417ce23b to /sysroot/etc/hostname
Nov 12 17:47:00.418482 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent.
Nov 12 17:47:00.752621 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup.
Nov 12 17:47:00.761099 systemd[1]: Starting ignition-mount.service - Ignition (mount)...
Nov 12 17:47:00.767855 systemd[1]: Starting sysroot-boot.service - /sysroot/boot...
Nov 12 17:47:00.775982 kernel: BTRFS info (device sda6): last unmount of filesystem 936a2172-6c61-4af6-a047-e38e0a3ff18b
Nov 12 17:47:00.775495 systemd[1]: sysroot-oem.mount: Deactivated successfully.
Nov 12 17:47:00.799938 ignition[971]: INFO : Ignition 2.19.0
Nov 12 17:47:00.799938 ignition[971]: INFO : Stage: mount
Nov 12 17:47:00.808846 ignition[971]: INFO : no configs at "/usr/lib/ignition/base.d"
Nov 12 17:47:00.808846 ignition[971]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure"
Nov 12 17:47:00.808846 ignition[971]: INFO : mount: mount passed
Nov 12 17:47:00.808846 ignition[971]: INFO : Ignition finished successfully
Nov 12 17:47:00.801245 systemd[1]: Finished sysroot-boot.service - /sysroot/boot.
Nov 12 17:47:00.802463 systemd[1]: Finished ignition-mount.service - Ignition (mount).
Nov 12 17:47:00.816025 systemd[1]: Starting ignition-files.service - Ignition (files)...
Nov 12 17:47:01.062147 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem...
Nov 12 17:47:01.070940 kernel: BTRFS: device label OEM devid 1 transid 20 /dev/sda6 scanned by mount (982)
Nov 12 17:47:01.071002 kernel: BTRFS info (device sda6): first mount of filesystem 936a2172-6c61-4af6-a047-e38e0a3ff18b
Nov 12 17:47:01.071025 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm
Nov 12 17:47:01.071035 kernel: BTRFS info (device sda6): using free space tree
Nov 12 17:47:01.071989 kernel: BTRFS info (device sda6): auto enabling async discard
Nov 12 17:47:01.073060 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem.
Nov 12 17:47:01.096954 ignition[1000]: INFO : Ignition 2.19.0
Nov 12 17:47:01.096954 ignition[1000]: INFO : Stage: files
Nov 12 17:47:01.096954 ignition[1000]: INFO : no configs at "/usr/lib/ignition/base.d"
Nov 12 17:47:01.096954 ignition[1000]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure"
Nov 12 17:47:01.119220 ignition[1000]: DEBUG : files: compiled without relabeling support, skipping
Nov 12 17:47:01.119220 ignition[1000]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core"
Nov 12 17:47:01.119220 ignition[1000]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core"
Nov 12 17:47:01.142664 ignition[1000]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core"
Nov 12 17:47:01.142664 ignition[1000]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core"
Nov 12 17:47:01.142664 ignition[1000]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core"
Nov 12 17:47:01.134052 unknown[1000]: wrote ssh authorized keys file for user: core
Nov 12 17:47:01.173114 ignition[1000]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf"
Nov 12 17:47:01.173114 ignition[1000]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf"
Nov 12 17:47:01.173114 ignition[1000]: INFO : files: createResultFile: createFiles: op(4): [started] writing file "/sysroot/etc/.ignition-result.json"
Nov 12 17:47:01.173114 ignition[1000]: INFO : files: createResultFile: createFiles: op(4): [finished] writing file "/sysroot/etc/.ignition-result.json"
Nov 12 17:47:01.173114 ignition[1000]: INFO : files: files passed
Nov 12 17:47:01.173114 ignition[1000]: INFO : Ignition finished successfully
Nov 12 17:47:01.151949 systemd[1]: Finished ignition-files.service - Ignition (files).
Nov 12 17:47:01.173168 systemd[1]: Starting ignition-quench.service - Ignition (record completion)...
Nov 12 17:47:01.177121 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion...
Nov 12 17:47:01.197578 systemd[1]: ignition-quench.service: Deactivated successfully.
Nov 12 17:47:01.253724 initrd-setup-root-after-ignition[1030]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory
Nov 12 17:47:01.197670 systemd[1]: Finished ignition-quench.service - Ignition (record completion).
Nov 12 17:47:01.270267 initrd-setup-root-after-ignition[1026]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory
Nov 12 17:47:01.270267 initrd-setup-root-after-ignition[1026]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory
Nov 12 17:47:01.199041 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion.
Nov 12 17:47:01.199153 systemd[1]: Reached target ignition-complete.target - Ignition Complete.
Nov 12 17:47:01.202139 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root...
Nov 12 17:47:01.236658 systemd[1]: initrd-parse-etc.service: Deactivated successfully.
Nov 12 17:47:01.236771 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root.
Nov 12 17:47:01.236905 systemd[1]: Reached target initrd-fs.target - Initrd File Systems.
Nov 12 17:47:01.236943 systemd[1]: Reached target initrd.target - Initrd Default Target.
Nov 12 17:47:01.237001 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met.
Nov 12 17:47:01.239145 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook...
Nov 12 17:47:01.271259 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook.
Nov 12 17:47:01.289310 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons...
Nov 12 17:47:01.381006 ignition[1050]: INFO : Ignition 2.19.0
Nov 12 17:47:01.381006 ignition[1050]: INFO : Stage: umount
Nov 12 17:47:01.381006 ignition[1050]: INFO : no configs at "/usr/lib/ignition/base.d"
Nov 12 17:47:01.381006 ignition[1050]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure"
Nov 12 17:47:01.381006 ignition[1050]: INFO : umount: umount passed
Nov 12 17:47:01.381006 ignition[1050]: INFO : Ignition finished successfully
Nov 12 17:47:01.307420 systemd[1]: initrd-cleanup.service: Deactivated successfully.
Nov 12 17:47:01.307564 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons.
Nov 12 17:47:01.307812 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups.
Nov 12 17:47:01.307842 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes.
Nov 12 17:47:01.307887 systemd[1]: Stopped target timers.target - Timer Units.
Nov 12 17:47:01.308004 systemd[1]: dracut-pre-pivot.service: Deactivated successfully.
Nov 12 17:47:01.308063 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook.
Nov 12 17:47:01.311077 systemd[1]: Stopped target initrd.target - Initrd Default Target.
Nov 12 17:47:01.311108 systemd[1]: Stopped target basic.target - Basic System.
Nov 12 17:47:01.311126 systemd[1]: Stopped target ignition-complete.target - Ignition Complete.
Nov 12 17:47:01.311139 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup.
Nov 12 17:47:01.311147 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device.
Nov 12 17:47:01.311162 systemd[1]: Stopped target remote-fs.target - Remote File Systems.
Nov 12 17:47:01.311173 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems.
Nov 12 17:47:01.311196 systemd[1]: Stopped target sysinit.target - System Initialization.
Nov 12 17:47:01.503138 kernel: hv_netvsc 000d3af7-1fed-000d-3af7-1fed000d3af7 eth0: Data path switched from VF: enP10189s1
Nov 12 17:47:01.311213 systemd[1]: Stopped target local-fs.target - Local File Systems.
Nov 12 17:47:01.311223 systemd[1]: Stopped target swap.target - Swaps.
Nov 12 17:47:01.311239 systemd[1]: dracut-pre-mount.service: Deactivated successfully.
Nov 12 17:47:01.311282 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook.
Nov 12 17:47:01.311590 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes.
Nov 12 17:47:01.311611 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre).
Nov 12 17:47:01.311621 systemd[1]: clevis-luks-askpass.path: Deactivated successfully.
Nov 12 17:47:01.316979 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch.
Nov 12 17:47:01.317007 systemd[1]: dracut-initqueue.service: Deactivated successfully.
Nov 12 17:47:01.317067 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook.
Nov 12 17:47:01.323763 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully.
Nov 12 17:47:01.323820 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion.
Nov 12 17:47:01.323868 systemd[1]: ignition-files.service: Deactivated successfully.
Nov 12 17:47:01.323900 systemd[1]: Stopped ignition-files.service - Ignition (files).
Nov 12 17:47:01.323981 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully.
Nov 12 17:47:01.324017 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent.
Nov 12 17:47:01.343185 systemd[1]: Stopping ignition-mount.service - Ignition (mount)...
Nov 12 17:47:01.600605 systemd-journald[214]: Received SIGTERM from PID 1 (systemd).
Nov 12 17:47:01.347142 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot...
Nov 12 17:47:01.347278 systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
Nov 12 17:47:01.347418 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices.
Nov 12 17:47:01.347542 systemd[1]: dracut-pre-trigger.service: Deactivated successfully.
Nov 12 17:47:01.347644 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook.
Nov 12 17:47:01.379264 systemd[1]: ignition-mount.service: Deactivated successfully.
Nov 12 17:47:01.379365 systemd[1]: Stopped ignition-mount.service - Ignition (mount).
Nov 12 17:47:01.379513 systemd[1]: ignition-disks.service: Deactivated successfully.
Nov 12 17:47:01.379547 systemd[1]: Stopped ignition-disks.service - Ignition (disks).
Nov 12 17:47:01.379583 systemd[1]: ignition-kargs.service: Deactivated successfully.
Nov 12 17:47:01.379608 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs).
Nov 12 17:47:01.379636 systemd[1]: ignition-fetch.service: Deactivated successfully.
Nov 12 17:47:01.379659 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch).
Nov 12 17:47:01.379688 systemd[1]: Stopped target network.target - Network.
Nov 12 17:47:01.379700 systemd[1]: ignition-fetch-offline.service: Deactivated successfully.
Nov 12 17:47:01.379725 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline).
Nov 12 17:47:01.379754 systemd[1]: Stopped target paths.target - Path Units.
Nov 12 17:47:01.379765 systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
Nov 12 17:47:01.385778 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
Nov 12 17:47:01.385809 systemd[1]: Stopped target slices.target - Slice Units.
Nov 12 17:47:01.385827 systemd[1]: Stopped target sockets.target - Socket Units.
Nov 12 17:47:01.385867 systemd[1]: iscsid.socket: Deactivated successfully.
Nov 12 17:47:01.385902 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket.
Nov 12 17:47:01.385960 systemd[1]: iscsiuio.socket: Deactivated successfully.
Nov 12 17:47:01.385987 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket.
Nov 12 17:47:01.386017 systemd[1]: ignition-setup.service: Deactivated successfully.
Nov 12 17:47:01.386049 systemd[1]: Stopped ignition-setup.service - Ignition (setup).
Nov 12 17:47:01.386088 systemd[1]: ignition-setup-pre.service: Deactivated successfully.
Nov 12 17:47:01.386115 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup.
Nov 12 17:47:01.386247 systemd[1]: Stopping systemd-networkd.service - Network Configuration...
Nov 12 17:47:01.387090 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution...
Nov 12 17:47:01.388241 systemd[1]: sysroot-boot.mount: Deactivated successfully.
Nov 12 17:47:01.390216 systemd-networkd[789]: eth0: DHCPv6 lease lost
Nov 12 17:47:01.397342 systemd[1]: systemd-networkd.service: Deactivated successfully.
Nov 12 17:47:01.397468 systemd[1]: Stopped systemd-networkd.service - Network Configuration.
Nov 12 17:47:01.397675 systemd[1]: systemd-networkd.socket: Deactivated successfully.
Nov 12 17:47:01.397710 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket.
Nov 12 17:47:01.414142 systemd[1]: Stopping network-cleanup.service - Network Cleanup...
Nov 12 17:47:01.414162 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully.
Nov 12 17:47:01.414226 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline.
Nov 12 17:47:01.414371 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files...
Nov 12 17:47:01.414640 systemd[1]: systemd-resolved.service: Deactivated successfully.
Nov 12 17:47:01.416239 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution.
Nov 12 17:47:01.422874 systemd[1]: systemd-sysctl.service: Deactivated successfully.
Nov 12 17:47:01.424036 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables.
Nov 12 17:47:01.424156 systemd[1]: systemd-modules-load.service: Deactivated successfully.
Nov 12 17:47:01.424207 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules.
Nov 12 17:47:01.424258 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
Nov 12 17:47:01.424305 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories.
Nov 12 17:47:01.452212 systemd[1]: sysroot-boot.service: Deactivated successfully.
Nov 12 17:47:01.452392 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot.
Nov 12 17:47:01.452698 systemd[1]: systemd-udevd.service: Deactivated successfully.
Nov 12 17:47:01.452865 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files.
Nov 12 17:47:01.453587 systemd[1]: systemd-udevd-control.socket: Deactivated successfully.
Nov 12 17:47:01.453671 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket.
Nov 12 17:47:01.453731 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully.
Nov 12 17:47:01.453765 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket.
Nov 12 17:47:01.453801 systemd[1]: dracut-pre-udev.service: Deactivated successfully.
Nov 12 17:47:01.453841 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook.
Nov 12 17:47:01.457627 systemd[1]: dracut-cmdline.service: Deactivated successfully.
Nov 12 17:47:01.457692 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook.
Nov 12 17:47:01.462948 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully.
Nov 12 17:47:01.463005 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
Nov 12 17:47:01.467749 systemd[1]: initrd-setup-root.service: Deactivated successfully.
Nov 12 17:47:01.467796 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup.
Nov 12 17:47:01.471191 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database...
Nov 12 17:47:01.471233 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
Nov 12 17:47:01.471293 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev.
Nov 12 17:47:01.471346 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.
Nov 12 17:47:01.471378 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully.
Nov 12 17:47:01.471409 systemd[1]: kmod-static-nodes.service: Deactivated successfully.
Nov 12 17:47:01.471439 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes.
Nov 12 17:47:01.471469 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
Nov 12 17:47:01.471499 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup.
Nov 12 17:47:01.479565 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
Nov 12 17:47:01.479674 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database.
Nov 12 17:47:01.529903 systemd[1]: network-cleanup.service: Deactivated successfully.
Nov 12 17:47:01.530095 systemd[1]: Stopped network-cleanup.service - Network Cleanup.
Nov 12 17:47:01.530364 systemd[1]: Reached target initrd-switch-root.target - Switch Root.
Nov 12 17:47:01.540312 systemd[1]: Starting initrd-switch-root.service - Switch Root...
Nov 12 17:47:01.551405 systemd[1]: Switching root.
Nov 12 17:47:02.035485 systemd-journald[214]: Journal stopped
Nov 12 17:46:51.796455 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]
Nov 12 17:46:51.796488 kernel: Linux version 6.6.60-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p17) 13.3.1 20240614, GNU ld (Gentoo 2.42 p3) 2.42.0) #1 SMP PREEMPT Tue Nov 12 16:24:35 -00 2024
Nov 12 17:46:51.796498 kernel: KASLR enabled
Nov 12 17:46:51.796503 kernel: earlycon: pl11 at MMIO 0x00000000effec000 (options '')
Nov 12 17:46:51.796512 kernel: printk: bootconsole [pl11] enabled
Nov 12 17:46:51.796518 kernel: efi: EFI v2.7 by EDK II
Nov 12 17:46:51.796525 kernel: efi: ACPI 2.0=0x3fd5f018 SMBIOS=0x3e580000 SMBIOS 3.0=0x3e560000 MEMATTR=0x3f214018 RNG=0x3fd5f998 MEMRESERVE=0x3e44ee18
Nov 12 17:46:51.796531 kernel: random: crng init done
Nov 12 17:46:51.796537 kernel: ACPI: Early table checksum verification disabled
Nov 12 17:46:51.796543 kernel: ACPI: RSDP 0x000000003FD5F018 000024 (v02 VRTUAL)
Nov 12 17:46:51.796549 kernel: ACPI: XSDT 0x000000003FD5FF18 00006C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
Nov 12 17:46:51.796555 kernel: ACPI: FACP 0x000000003FD5FC18 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001)
Nov 12 17:46:51.796563 kernel: ACPI: DSDT 0x000000003FD41018 01DFCD (v02 MSFTVM DSDT01 00000001 INTL 20230628)
Nov 12 17:46:51.796569 kernel: ACPI: DBG2 0x000000003FD5FB18 000072 (v00 VRTUAL MICROSFT 00000001 MSFT 00000001)
Nov 12 17:46:51.796576 kernel: ACPI: GTDT 0x000000003FD5FD98 000060 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001)
Nov 12 17:46:51.796583 kernel: ACPI: OEM0 0x000000003FD5F098 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
Nov 12 17:46:51.796589 kernel: ACPI: SPCR 0x000000003FD5FA98 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001)
Nov 12 17:46:51.796597 kernel: ACPI: APIC 0x000000003FD5F818 0000FC (v04 VRTUAL MICROSFT 00000001 MSFT 00000001)
Nov 12 17:46:51.796603 kernel: ACPI: SRAT 0x000000003FD5F198 000234 (v03 VRTUAL MICROSFT 00000001 MSFT 00000001)
Nov 12 17:46:51.796610 kernel: ACPI: PPTT 0x000000003FD5F418 000120 (v01 VRTUAL MICROSFT 00000000 MSFT 00000000)
Nov 12 17:46:51.796617 kernel: ACPI: BGRT 0x000000003FD5FE98 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
Nov 12 17:46:51.796623 kernel: ACPI: SPCR: console: pl011,mmio32,0xeffec000,115200
Nov 12 17:46:51.796629 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff]
Nov 12 17:46:51.796635 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x1bfffffff]
Nov 12 17:46:51.796642 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1c0000000-0xfbfffffff]
Nov 12 17:46:51.796648 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1000000000-0xffffffffff]
Nov 12 17:46:51.796662 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x10000000000-0x1ffffffffff]
Nov 12 17:46:51.796669 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x20000000000-0x3ffffffffff]
Nov 12 17:46:51.796677 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x40000000000-0x7ffffffffff]
Nov 12 17:46:51.796684 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x80000000000-0xfffffffffff]
Nov 12 17:46:51.796690 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000000-0x1fffffffffff]
Nov 12 17:46:51.796697 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x200000000000-0x3fffffffffff]
Nov 12 17:46:51.796703 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x400000000000-0x7fffffffffff]
Nov 12 17:46:51.796709 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x800000000000-0xffffffffffff]
Nov 12 17:46:51.796716 kernel: NUMA: NODE_DATA [mem 0x1bf7ee800-0x1bf7f3fff]
Nov 12 17:46:51.796722 kernel: Zone ranges:
Nov 12 17:46:51.796728 kernel: DMA [mem 0x0000000000000000-0x00000000ffffffff]
Nov 12 17:46:51.796735 kernel: DMA32 empty
Nov 12 17:46:51.796741 kernel: Normal [mem 0x0000000100000000-0x00000001bfffffff]
Nov 12 17:46:51.796747 kernel: Movable zone start for each node
Nov 12 17:46:51.796758 kernel: Early memory node ranges
Nov 12 17:46:51.796765 kernel: node 0: [mem 0x0000000000000000-0x00000000007fffff]
Nov 12 17:46:51.796772 kernel: node 0: [mem 0x0000000000824000-0x000000003e54ffff]
Nov 12 17:46:51.796778 kernel: node 0: [mem 0x000000003e550000-0x000000003e87ffff]
Nov 12 17:46:51.796785 kernel: node 0: [mem 0x000000003e880000-0x000000003fc7ffff]
Nov 12 17:46:51.796793 kernel: node 0: [mem 0x000000003fc80000-0x000000003fcfffff]
Nov 12 17:46:51.796800 kernel: node 0: [mem 0x000000003fd00000-0x000000003fffffff]
Nov 12 17:46:51.796807 kernel: node 0: [mem 0x0000000100000000-0x00000001bfffffff]
Nov 12 17:46:51.796813 kernel: Initmem setup node 0 [mem 0x0000000000000000-0x00000001bfffffff]
Nov 12 17:46:51.796820 kernel: On node 0, zone DMA: 36 pages in unavailable ranges
Nov 12 17:46:51.796827 kernel: psci: probing for conduit method from ACPI.
Nov 12 17:46:51.796834 kernel: psci: PSCIv1.1 detected in firmware.
Nov 12 17:46:51.796840 kernel: psci: Using standard PSCI v0.2 function IDs
Nov 12 17:46:51.796847 kernel: psci: MIGRATE_INFO_TYPE not supported.
Nov 12 17:46:51.796854 kernel: psci: SMC Calling Convention v1.4
Nov 12 17:46:51.796860 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x0 -> Node 0
Nov 12 17:46:51.796867 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x1 -> Node 0
Nov 12 17:46:51.796875 kernel: percpu: Embedded 31 pages/cpu s86696 r8192 d32088 u126976
Nov 12 17:46:51.796882 kernel: pcpu-alloc: s86696 r8192 d32088 u126976 alloc=31*4096
Nov 12 17:46:51.796889 kernel: pcpu-alloc: [0] 0 [0] 1
Nov 12 17:46:51.796896 kernel: Detected PIPT I-cache on CPU0
Nov 12 17:46:51.796902 kernel: CPU features: detected: GIC system register CPU interface
Nov 12 17:46:51.796909 kernel: CPU features: detected: Hardware dirty bit management
Nov 12 17:46:51.796916 kernel: CPU features: detected: Spectre-BHB
Nov 12 17:46:51.796923 kernel: CPU features: kernel page table isolation forced ON by KASLR
Nov 12 17:46:51.796929 kernel: CPU features: detected: Kernel page table isolation (KPTI)
Nov 12 17:46:51.796936 kernel: CPU features: detected: ARM erratum 1418040
Nov 12 17:46:51.796943 kernel: CPU features: detected: ARM erratum 1542419 (kernel portion)
Nov 12 17:46:51.796952 kernel: CPU features: detected: SSBS not fully self-synchronizing
Nov 12 17:46:51.796959 kernel: alternatives: applying boot alternatives
Nov 12 17:46:51.796968 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 quiet verity.usrhash=8c276c03cfeb31103ba0b5f1af613bdc698463ad3d29e6750e34154929bf187e
Nov 12 17:46:51.796975 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space.
Nov 12 17:46:51.796982 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
Nov 12 17:46:51.796989 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
Nov 12 17:46:51.796995 kernel: Fallback order for Node 0: 0
Nov 12 17:46:51.797002 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1032156
Nov 12 17:46:51.797009 kernel: Policy zone: Normal
Nov 12 17:46:51.797015 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off
Nov 12 17:46:51.797051 kernel: software IO TLB: area num 2.
Nov 12 17:46:51.797061 kernel: software IO TLB: mapped [mem 0x000000003a44e000-0x000000003e44e000] (64MB)
Nov 12 17:46:51.797068 kernel: Memory: 3982752K/4194160K available (10240K kernel code, 2184K rwdata, 8096K rodata, 39360K init, 897K bss, 211408K reserved, 0K cma-reserved)
Nov 12 17:46:51.797075 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
Nov 12 17:46:51.797081 kernel: trace event string verifier disabled
Nov 12 17:46:51.797088 kernel: rcu: Preemptible hierarchical RCU implementation.
Nov 12 17:46:51.797096 kernel: rcu: RCU event tracing is enabled.
Nov 12 17:46:51.797103 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2.
Nov 12 17:46:51.797110 kernel: Trampoline variant of Tasks RCU enabled.
Nov 12 17:46:51.797117 kernel: Tracing variant of Tasks RCU enabled.
Nov 12 17:46:51.797123 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.
Nov 12 17:46:51.797130 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
Nov 12 17:46:51.797139 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
Nov 12 17:46:51.797145 kernel: GICv3: 960 SPIs implemented
Nov 12 17:46:51.797152 kernel: GICv3: 0 Extended SPIs implemented
Nov 12 17:46:51.797159 kernel: Root IRQ handler: gic_handle_irq
Nov 12 17:46:51.797166 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI
Nov 12 17:46:51.797172 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000effee000
Nov 12 17:46:51.797179 kernel: ITS: No ITS available, not enabling LPIs
Nov 12 17:46:51.797186 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention.
Nov 12 17:46:51.797193 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040
Nov 12 17:46:51.797200 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt).
Nov 12 17:46:51.797207 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns
Nov 12 17:46:51.797214 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns
Nov 12 17:46:51.797222 kernel: Console: colour dummy device 80x25
Nov 12 17:46:51.797230 kernel: printk: console [tty1] enabled
Nov 12 17:46:51.797236 kernel: ACPI: Core revision 20230628
Nov 12 17:46:51.797244 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000)
Nov 12 17:46:51.797252 kernel: pid_max: default: 32768 minimum: 301
Nov 12 17:46:51.797259 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity
Nov 12 17:46:51.797266 kernel: landlock: Up and running.
Nov 12 17:46:51.797272 kernel: SELinux: Initializing.
Nov 12 17:46:51.797279 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
Nov 12 17:46:51.797288 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
Nov 12 17:46:51.797295 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.
Nov 12 17:46:51.797302 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.
Nov 12 17:46:51.797309 kernel: Hyper-V: privilege flags low 0x2e7f, high 0x3a8030, hints 0xe, misc 0x31e1
Nov 12 17:46:51.797316 kernel: Hyper-V: Host Build 10.0.22477.1369-1-0
Nov 12 17:46:51.797323 kernel: Hyper-V: enabling crash_kexec_post_notifiers
Nov 12 17:46:51.797330 kernel: rcu: Hierarchical SRCU implementation.
Nov 12 17:46:51.797344 kernel: rcu: Max phase no-delay instances is 400.
Nov 12 17:46:51.797351 kernel: Remapping and enabling EFI services.
Nov 12 17:46:51.797359 kernel: smp: Bringing up secondary CPUs ...
Nov 12 17:46:51.797366 kernel: Detected PIPT I-cache on CPU1
Nov 12 17:46:51.797374 kernel: GICv3: CPU1: found redistributor 1 region 1:0x00000000f000e000
Nov 12 17:46:51.797383 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040
Nov 12 17:46:51.797390 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1]
Nov 12 17:46:51.797398 kernel: smp: Brought up 1 node, 2 CPUs
Nov 12 17:46:51.797405 kernel: SMP: Total of 2 processors activated.
Nov 12 17:46:51.797426 kernel: CPU features: detected: 32-bit EL0 Support
Nov 12 17:46:51.797436 kernel: CPU features: detected: Instruction cache invalidation not required for I/D coherence
Nov 12 17:46:51.797443 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence
Nov 12 17:46:51.797452 kernel: CPU features: detected: CRC32 instructions
Nov 12 17:46:51.797459 kernel: CPU features: detected: RCpc load-acquire (LDAPR)
Nov 12 17:46:51.797466 kernel: CPU features: detected: LSE atomic instructions
Nov 12 17:46:51.797474 kernel: CPU features: detected: Privileged Access Never
Nov 12 17:46:51.797481 kernel: CPU: All CPU(s) started at EL1
Nov 12 17:46:51.797488 kernel: alternatives: applying system-wide alternatives
Nov 12 17:46:51.797496 kernel: devtmpfs: initialized
Nov 12 17:46:51.797505 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
Nov 12 17:46:51.797513 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear)
Nov 12 17:46:51.797521 kernel: pinctrl core: initialized pinctrl subsystem
Nov 12 17:46:51.797528 kernel: SMBIOS 3.1.0 present.
Nov 12 17:46:51.797536 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 09/28/2024
Nov 12 17:46:51.797544 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family
Nov 12 17:46:51.797551 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations
Nov 12 17:46:51.797558 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
Nov 12 17:46:51.797566 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
Nov 12 17:46:51.797575 kernel: audit: initializing netlink subsys (disabled)
Nov 12 17:46:51.797583 kernel: audit: type=2000 audit(0.003:1): state=initialized audit_enabled=0 res=1
Nov 12 17:46:51.797590 kernel: thermal_sys: Registered thermal governor 'step_wise'
Nov 12 17:46:51.797597 kernel: cpuidle: using governor menu
Nov 12 17:46:51.797605 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
Nov 12 17:46:51.797612 kernel: ASID allocator initialised with 32768 entries
Nov 12 17:46:51.797619 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
Nov 12 17:46:51.797627 kernel: Serial: AMBA PL011 UART driver
Nov 12 17:46:51.797635 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL
Nov 12 17:46:51.797644 kernel: Modules: 0 pages in range for non-PLT usage
Nov 12 17:46:51.797651 kernel: Modules: 509040 pages in range for PLT usage
Nov 12 17:46:51.797658 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
Nov 12 17:46:51.797666 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page
Nov 12 17:46:51.797673 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages
Nov 12 17:46:51.797680 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page
Nov 12 17:46:51.797688 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
Nov 12 17:46:51.797695 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page
Nov 12 17:46:51.797702 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages
Nov 12 17:46:51.797711 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page
Nov 12 17:46:51.797718 kernel: ACPI: Added _OSI(Module Device)
Nov 12 17:46:51.797726 kernel: ACPI: Added _OSI(Processor Device)
Nov 12 17:46:51.797733 kernel: ACPI: Added _OSI(3.0 _SCP Extensions)
Nov 12 17:46:51.797740 kernel: ACPI: Added _OSI(Processor Aggregator Device)
Nov 12 17:46:51.797748 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded
Nov 12 17:46:51.797755 kernel: ACPI: Interpreter enabled
Nov 12 17:46:51.797762 kernel: ACPI: Using GIC for interrupt routing
Nov 12 17:46:51.797770 kernel: ARMH0011:00: ttyAMA0 at MMIO 0xeffec000 (irq = 12, base_baud = 0) is a SBSA
Nov 12 17:46:51.797777 kernel: printk: console [ttyAMA0] enabled
Nov 12 17:46:51.797786 kernel: printk: bootconsole [pl11] disabled
Nov 12 17:46:51.797794 kernel: ARMH0011:01: ttyAMA1 at MMIO 0xeffeb000 (irq = 13, base_baud = 0) is a SBSA
Nov 12 17:46:51.797801 kernel: iommu: Default domain type: Translated
Nov 12 17:46:51.797808 kernel: iommu: DMA domain TLB invalidation policy: strict mode
Nov 12 17:46:51.797815 kernel: efivars: Registered efivars operations
Nov 12 17:46:51.797823 kernel: vgaarb: loaded
Nov 12 17:46:51.797830 kernel: clocksource: Switched to clocksource arch_sys_counter
Nov 12 17:46:51.797838 kernel: VFS: Disk quotas dquot_6.6.0
Nov 12 17:46:51.797845 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
Nov 12 17:46:51.797854 kernel: pnp: PnP ACPI init
Nov 12 17:46:51.797862 kernel: pnp: PnP ACPI: found 0 devices
Nov 12 17:46:51.797869 kernel: NET: Registered PF_INET protocol family
Nov 12 17:46:51.797876 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)
Nov 12 17:46:51.797884 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)
Nov 12 17:46:51.797891 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
Nov 12 17:46:51.797899 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)
Nov 12 17:46:51.797906 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)
Nov 12 17:46:51.797913 kernel: TCP: Hash tables configured (established 32768 bind 32768)
Nov 12 17:46:51.797922 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear)
Nov 12 17:46:51.797930 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear)
Nov 12 17:46:51.797937 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family
Nov 12 17:46:51.797944 kernel: PCI: CLS 0 bytes, default 64
Nov 12 17:46:51.797951 kernel: kvm [1]: HYP mode not available
Nov 12 17:46:51.797959 kernel: Initialise system trusted keyrings
Nov 12 17:46:51.797966 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0
Nov 12 17:46:51.797973 kernel: Key type asymmetric registered
Nov 12 17:46:51.797980 kernel: Asymmetric key parser 'x509' registered
Nov 12 17:46:51.797989 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
Nov 12 17:46:51.797997 kernel: io scheduler mq-deadline registered
Nov 12 17:46:51.798004 kernel: io scheduler kyber registered
Nov 12 17:46:51.798012 kernel: io scheduler bfq registered
Nov 12 17:46:51.798036 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
Nov 12 17:46:51.798441 kernel: thunder_xcv, ver 1.0
Nov 12 17:46:51.798452 kernel: thunder_bgx, ver 1.0
Nov 12 17:46:51.798459 kernel: nicpf, ver 1.0
Nov 12 17:46:51.798466 kernel: nicvf, ver 1.0
Nov 12 17:46:51.798618 kernel: rtc-efi rtc-efi.0: registered as rtc0
Nov 12 17:46:51.798689 kernel: rtc-efi rtc-efi.0: setting system clock to 2024-11-12T17:46:51 UTC (1731433611)
Nov 12 17:46:51.798700 kernel: efifb: probing for efifb
Nov 12 17:46:51.798707 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k
Nov 12 17:46:51.798715 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1
Nov 12 17:46:51.798722 kernel: efifb: scrolling: redraw
Nov 12 17:46:51.798729 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0
Nov 12 17:46:51.798737 kernel: Console: switching to colour frame buffer device 128x48
Nov 12 17:46:51.798747 kernel: fb0: EFI VGA frame buffer device
Nov 12 17:46:51.798754 kernel: SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping ....
Nov 12 17:46:51.798762 kernel: hid: raw HID events driver (C) Jiri Kosina
Nov 12 17:46:51.798769 kernel: No ACPI PMU IRQ for CPU0
Nov 12 17:46:51.798777 kernel: No ACPI PMU IRQ for CPU1
Nov 12 17:46:51.798784 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 1 counters available
Nov 12 17:46:51.798791 kernel: watchdog: Delayed init of the lockup detector failed: -19
Nov 12 17:46:51.798799 kernel: watchdog: Hard watchdog permanently disabled
Nov 12 17:46:51.798806 kernel: NET: Registered PF_INET6 protocol family
Nov 12 17:46:51.798815 kernel: Segment Routing with IPv6
Nov 12 17:46:51.798822 kernel: In-situ OAM (IOAM) with IPv6
Nov 12 17:46:51.798830 kernel: NET: Registered PF_PACKET protocol family
Nov 12 17:46:51.798837 kernel: Key type dns_resolver registered
Nov 12 17:46:51.798845 kernel: registered taskstats version 1
Nov 12 17:46:51.798852 kernel: Loading compiled-in X.509 certificates
Nov 12 17:46:51.798860 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.60-flatcar: 277bea35d8d47c9841f307ab609d4271c3622dcb'
Nov 12 17:46:51.798867 kernel: Key type .fscrypt registered
Nov 12 17:46:51.798874 kernel: Key type fscrypt-provisioning registered
Nov 12 17:46:51.798883 kernel: ima: No TPM chip found, activating TPM-bypass!
Nov 12 17:46:51.798890 kernel: ima: Allocated hash algorithm: sha1
Nov 12 17:46:51.798898 kernel: ima: No architecture policies found
Nov 12 17:46:51.798905 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng)
Nov 12 17:46:51.798912 kernel: clk: Disabling unused clocks
Nov 12 17:46:51.798920 kernel: Freeing unused kernel memory: 39360K
Nov 12 17:46:51.798927 kernel: Run /init as init process
Nov 12 17:46:51.798934 kernel: with arguments:
Nov 12 17:46:51.798941 kernel: /init
Nov 12 17:46:51.798950 kernel: with environment:
Nov 12 17:46:51.798957 kernel: HOME=/
Nov 12 17:46:51.798964 kernel: TERM=linux
Nov 12 17:46:51.798971 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a
Nov 12 17:46:51.798981 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified)
Nov 12 17:46:51.798993 systemd[1]: Detected virtualization microsoft.
Nov 12 17:46:51.799001 systemd[1]: Detected architecture arm64.
Nov 12 17:46:51.799010 systemd[1]: Running in initrd.
Nov 12 17:46:51.799035 systemd[1]: No hostname configured, using default hostname.
Nov 12 17:46:51.799068 systemd[1]: Hostname set to <localhost>.
Nov 12 17:46:51.799077 systemd[1]: Initializing machine ID from random generator.
Nov 12 17:46:51.799085 systemd[1]: Queued start job for default target initrd.target.
Nov 12 17:46:51.799093 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch.
Nov 12 17:46:51.799101 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
Nov 12 17:46:51.799110 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM...
Nov 12 17:46:51.799120 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM...
Nov 12 17:46:51.799128 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT...
Nov 12 17:46:51.799136 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A...
Nov 12 17:46:51.799146 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132...
Nov 12 17:46:51.799154 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr...
Nov 12 17:46:51.799163 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre).
Nov 12 17:46:51.799170 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes.
Nov 12 17:46:51.799180 systemd[1]: Reached target paths.target - Path Units.
Nov 12 17:46:51.799188 systemd[1]: Reached target slices.target - Slice Units.
Nov 12 17:46:51.799196 systemd[1]: Reached target swap.target - Swaps.
Nov 12 17:46:51.799204 systemd[1]: Reached target timers.target - Timer Units.
Nov 12 17:46:51.799212 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket.
Nov 12 17:46:51.799220 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket.
Nov 12 17:46:51.799228 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log).
Nov 12 17:46:51.799236 systemd[1]: Listening on systemd-journald.socket - Journal Socket.
Nov 12 17:46:51.799244 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket.
Nov 12 17:46:51.799253 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket.
Nov 12 17:46:51.799261 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket.
Nov 12 17:46:51.799269 systemd[1]: Reached target sockets.target - Socket Units.
Nov 12 17:46:51.799277 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup...
Nov 12 17:46:51.799285 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes...
Nov 12 17:46:51.799293 systemd[1]: Finished network-cleanup.service - Network Cleanup.
Nov 12 17:46:51.799301 systemd[1]: Starting systemd-fsck-usr.service...
Nov 12 17:46:51.799309 systemd[1]: Starting systemd-journald.service - Journal Service...
Nov 12 17:46:51.799318 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules...
Nov 12 17:46:51.799326 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
Nov 12 17:46:51.799334 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes.
Nov 12 17:46:51.799342 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully...
Nov 12 17:46:51.799350 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup.
Nov 12 17:46:51.799359 systemd[1]: Finished systemd-fsck-usr.service.
Nov 12 17:46:51.799369 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully.
Nov 12 17:46:51.799396 systemd-journald[214]: Collecting audit messages is disabled.
Nov 12 17:46:51.799416 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev...
Nov 12 17:46:51.799426 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this.
Nov 12 17:46:51.799434 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup.
Nov 12 17:46:51.799442 kernel: Bridge firewalling registered
Nov 12 17:46:51.799449 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters...
Nov 12 17:46:51.799458 systemd-journald[214]: Journal started
Nov 12 17:46:51.799476 systemd-journald[214]: Runtime Journal (/run/log/journal/649c4ecf2e2842f18a2d46e297a10441) is 8.0M, max 78.5M, 70.5M free.
Nov 12 17:46:51.800203 systemd[1]: Started systemd-journald.service - Journal Service.
Nov 12 17:46:51.776803 systemd-modules-load[215]: Inserted module 'overlay'
Nov 12 17:46:51.796004 systemd-modules-load[215]: Inserted module 'br_netfilter'
Nov 12 17:46:51.812202 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories...
Nov 12 17:46:51.812542 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules.
Nov 12 17:46:51.812702 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev.
Nov 12 17:46:51.835374 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables...
Nov 12 17:46:51.835618 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories.
Nov 12 17:46:51.850837 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
Nov 12 17:46:51.852238 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook...
Nov 12 17:46:51.870059 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables.
Nov 12 17:46:51.874210 systemd[1]: Starting systemd-resolved.service - Network Name Resolution...
Nov 12 17:46:51.885863 dracut-cmdline[251]: dracut-dracut-053
Nov 12 17:46:51.891685 dracut-cmdline[251]: 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 quiet verity.usrhash=8c276c03cfeb31103ba0b5f1af613bdc698463ad3d29e6750e34154929bf187e
Nov 12 17:46:51.934930 systemd-resolved[256]: Positive Trust Anchors:
Nov 12 17:46:51.934954 systemd-resolved[256]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
Nov 12 17:46:51.934987 systemd-resolved[256]: 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 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test
Nov 12 17:46:51.937426 systemd-resolved[256]: Defaulting to hostname 'linux'.
Nov 12 17:46:51.942146 systemd[1]: Started systemd-resolved.service - Network Name Resolution.
Nov 12 17:46:51.942246 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups.
Nov 12 17:46:52.037050 kernel: SCSI subsystem initialized
Nov 12 17:46:52.039037 kernel: Loading iSCSI transport class v2.0-870.
Nov 12 17:46:52.046065 kernel: iscsi: registered transport (tcp)
Nov 12 17:46:52.058044 kernel: iscsi: registered transport (qla4xxx)
Nov 12 17:46:52.058108 kernel: QLogic iSCSI HBA Driver
Nov 12 17:46:52.095072 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook.
Nov 12 17:46:52.103198 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook...
Nov 12 17:46:52.117044 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
Nov 12 17:46:52.117111 kernel: device-mapper: uevent: version 1.0.3
Nov 12 17:46:52.117123 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com
Nov 12 17:46:52.162049 kernel: raid6: neonx8 gen() 15789 MB/s
Nov 12 17:46:52.179030 kernel: raid6: neonx4 gen() 15675 MB/s
Nov 12 17:46:52.196028 kernel: raid6: neonx2 gen() 13243 MB/s
Nov 12 17:46:52.213032 kernel: raid6: neonx1 gen() 10486 MB/s
Nov 12 17:46:52.230029 kernel: raid6: int64x8 gen() 6981 MB/s
Nov 12 17:46:52.247032 kernel: raid6: int64x4 gen() 7359 MB/s
Nov 12 17:46:52.264027 kernel: raid6: int64x2 gen() 6131 MB/s
Nov 12 17:46:52.281032 kernel: raid6: int64x1 gen() 5061 MB/s
Nov 12 17:46:52.281054 kernel: raid6: using algorithm neonx8 gen() 15789 MB/s
Nov 12 17:46:52.298038 kernel: raid6: .... xor() 11937 MB/s, rmw enabled
Nov 12 17:46:52.298051 kernel: raid6: using neon recovery algorithm
Nov 12 17:46:52.301031 kernel: xor: measuring software checksum speed
Nov 12 17:46:52.302031 kernel: 8regs : 18573 MB/sec
Nov 12 17:46:52.302042 kernel: 32regs : 19674 MB/sec
Nov 12 17:46:52.302051 kernel: arm64_neon : 27105 MB/sec
Nov 12 17:46:52.302063 kernel: xor: using function: arm64_neon (27105 MB/sec)
Nov 12 17:46:52.347041 kernel: Btrfs loaded, zoned=no, fsverity=no
Nov 12 17:46:52.356758 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook.
Nov 12 17:46:52.368161 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files...
Nov 12 17:46:52.385397 systemd-udevd[436]: Using default interface naming scheme 'v255'.
Nov 12 17:46:52.394448 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files.
Nov 12 17:46:52.411264 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook...
Nov 12 17:46:52.422215 dracut-pre-trigger[438]: rd.md=0: removing MD RAID activation
Nov 12 17:46:52.448780 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook.
Nov 12 17:46:52.456354 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices...
Nov 12 17:46:52.492623 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices.
Nov 12 17:46:52.501275 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook...
Nov 12 17:46:52.517938 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook.
Nov 12 17:46:52.523884 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems.
Nov 12 17:46:52.523899 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes.
Nov 12 17:46:52.523910 systemd[1]: Reached target remote-fs.target - Remote File Systems.
Nov 12 17:46:52.534274 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook...
Nov 12 17:46:52.572893 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook.
Nov 12 17:46:52.589481 kernel: hv_vmbus: Vmbus version:5.3
Nov 12 17:46:52.594045 kernel: pps_core: LinuxPPS API ver. 1 registered
Nov 12 17:46:52.594092 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
Nov 12 17:46:52.600042 kernel: PTP clock support registered
Nov 12 17:46:52.608041 kernel: hv_vmbus: registering driver hyperv_keyboard
Nov 12 17:46:52.608097 kernel: input: AT Translated Set 2 keyboard as /devices/LNXSYSTM:00/LNXSYBUS:00/ACPI0004:00/MSFT1000:00/d34b2567-b9b6-42b9-8778-0a4ec0b955bf/serio0/input/input0
Nov 12 17:46:52.608109 kernel: hv_utils: Registering HyperV Utility Driver
Nov 12 17:46:52.608118 kernel: hv_vmbus: registering driver hv_utils
Nov 12 17:46:52.608127 kernel: hv_utils: Shutdown IC version 3.2
Nov 12 17:46:52.608136 kernel: hv_utils: TimeSync IC version 4.0
Nov 12 17:46:52.948101 systemd-resolved[256]: Clock change detected. Flushing caches.
Nov 12 17:46:52.957503 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully.
Nov 12 17:46:52.965227 kernel: hv_vmbus: registering driver hid_hyperv
Nov 12 17:46:52.965250 kernel: hv_vmbus: registering driver hv_netvsc
Nov 12 17:46:52.965259 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input1
Nov 12 17:46:52.965269 kernel: hid-generic 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on
Nov 12 17:46:52.960365 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
Nov 12 17:46:52.975148 kernel: hv_vmbus: registering driver hv_storvsc
Nov 12 17:46:52.975185 kernel: scsi host0: storvsc_host_t
Nov 12 17:46:52.975629 kernel: scsi 0:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5
Nov 12 17:46:52.975659 kernel: scsi host1: storvsc_host_t
Nov 12 17:46:52.965072 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters...
Nov 12 17:46:52.965097 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
Nov 12 17:46:52.990699 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 0
Nov 12 17:46:52.965352 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup.
Nov 12 17:46:52.965397 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup...
Nov 12 17:46:52.984369 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
Nov 12 17:46:53.007883 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup.
Nov 12 17:46:53.009074 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters...
Nov 12 17:46:53.040178 kernel: sr 0:0:0:2: [sr0] scsi-1 drive
Nov 12 17:46:53.041350 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20
Nov 12 17:46:53.041365 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0
Nov 12 17:46:53.047865 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
Nov 12 17:46:53.056972 kernel: sd 0:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB)
Nov 12 17:46:53.058036 kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks
Nov 12 17:46:53.058153 kernel: sd 0:0:0:0: [sda] Write Protect is off
Nov 12 17:46:53.058241 kernel: sd 0:0:0:0: [sda] Mode Sense: 0f 00 10 00
Nov 12 17:46:53.058332 kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA
Nov 12 17:46:53.058420 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9
Nov 12 17:46:53.058431 kernel: sd 0:0:0:0: [sda] Attached SCSI disk
Nov 12 17:46:53.063950 kernel: hv_netvsc 000d3af7-1fed-000d-3af7-1fed000d3af7 eth0: VF slot 1 added
Nov 12 17:46:53.071971 kernel: hv_vmbus: registering driver hv_pci
Nov 12 17:46:53.072955 kernel: hv_pci 88e42e9a-27cd-4818-b021-3076bb7c26ab: PCI VMBus probing: Using version 0x10004
Nov 12 17:46:53.105712 kernel: hv_pci 88e42e9a-27cd-4818-b021-3076bb7c26ab: PCI host bridge to bus 27cd:00
Nov 12 17:46:53.105825 kernel: pci_bus 27cd:00: root bus resource [mem 0xfc0000000-0xfc00fffff window]
Nov 12 17:46:53.105939 kernel: pci_bus 27cd:00: No busn resource found for root bus, will use [bus 00-ff]
Nov 12 17:46:53.106990 kernel: pci 27cd:00:02.0: [15b3:1018] type 00 class 0x020000
Nov 12 17:46:53.107121 kernel: pci 27cd:00:02.0: reg 0x10: [mem 0xfc0000000-0xfc00fffff 64bit pref]
Nov 12 17:46:53.107232 kernel: pci 27cd:00:02.0: enabling Extended Tags
Nov 12 17:46:53.107326 kernel: pci 27cd:00:02.0: 0.000 Gb/s available PCIe bandwidth, limited by Unknown x0 link at 27cd:00:02.0 (capable of 126.016 Gb/s with 8.0 GT/s PCIe x16 link)
Nov 12 17:46:53.107420 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/sda6 scanned by (udev-worker) (481)
Nov 12 17:46:53.107430 kernel: pci_bus 27cd:00: busn_res: [bus 00-ff] end is updated to 00
Nov 12 17:46:53.107513 kernel: pci 27cd:00:02.0: BAR 0: assigned [mem 0xfc0000000-0xfc00fffff 64bit pref]
Nov 12 17:46:53.109955 kernel: BTRFS: device fsid 93a9d474-e751-47b7-a65f-e39ca9abd47a devid 1 transid 40 /dev/sda3 scanned by (udev-worker) (484)
Nov 12 17:46:53.156905 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Virtual_Disk ROOT.
Nov 12 17:46:53.170319 kernel: mlx5_core 27cd:00:02.0: enabling device (0000 -> 0002)
Nov 12 17:46:53.365835 kernel: mlx5_core 27cd:00:02.0: firmware version: 16.30.1284
Nov 12 17:46:53.366018 kernel: device-mapper: verity: sha256 using implementation "sha256-ce"
Nov 12 17:46:53.366031 kernel: BTRFS info (device dm-0): first mount of filesystem 93a9d474-e751-47b7-a65f-e39ca9abd47a
Nov 12 17:46:53.366042 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm
Nov 12 17:46:53.366051 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead
Nov 12 17:46:53.366062 kernel: BTRFS info (device dm-0): disabling log replay at mount time
Nov 12 17:46:53.366071 kernel: BTRFS info (device dm-0): using free space tree
Nov 12 17:46:53.366081 kernel: BTRFS info (device sda6): first mount of filesystem 936a2172-6c61-4af6-a047-e38e0a3ff18b
Nov 12 17:46:53.366094 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm
Nov 12 17:46:53.366104 kernel: BTRFS info (device sda6): using free space tree
Nov 12 17:46:53.366113 kernel: BTRFS info (device sda6): auto enabling async discard
Nov 12 17:46:53.366123 kernel: BTRFS info (device sda6): last unmount of filesystem 936a2172-6c61-4af6-a047-e38e0a3ff18b
Nov 12 17:46:53.366132 kernel: hv_netvsc 000d3af7-1fed-000d-3af7-1fed000d3af7 eth0: VF registering: eth1
Nov 12 17:46:53.366226 kernel: mlx5_core 27cd:00:02.0 eth1: joined to eth0
Nov 12 17:46:53.366321 kernel: mlx5_core 27cd:00:02.0: MLX5E: StrdRq(1) RqSz(8) StrdSz(2048) RxCqeCmprss(0 basic)
Nov 12 17:46:53.168748 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Virtual_Disk EFI-SYSTEM.
Nov 12 17:46:53.173959 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Virtual_Disk USR-A.
Nov 12 17:46:53.388507 kernel: mlx5_core 27cd:00:02.0 enP10189s1: renamed from eth1
Nov 12 17:46:53.173975 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Virtual_Disk USR-A.
Nov 12 17:46:53.179315 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM.
Nov 12 17:46:53.412671 sh[591]: Success
Nov 12 17:46:53.187059 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary...
Nov 12 17:46:53.412410 ignition[684]: Ignition 2.19.0
Nov 12 17:46:53.189407 systemd[1]: disk-uuid.service: Deactivated successfully.
Nov 12 17:46:53.412416 ignition[684]: Stage: fetch-offline
Nov 12 17:46:53.189529 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary.
Nov 12 17:46:53.412467 ignition[684]: no configs at "/usr/lib/ignition/base.d"
Nov 12 17:46:53.194114 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr...
Nov 12 17:46:53.412475 ignition[684]: no config dir at "/usr/lib/ignition/base.platform.d/azure"
Nov 12 17:46:53.252455 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr.
Nov 12 17:46:53.412584 ignition[684]: parsed url from cmdline: ""
Nov 12 17:46:53.268082 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr...
Nov 12 17:46:53.412587 ignition[684]: no config URL provided
Nov 12 17:46:53.280584 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr.
Nov 12 17:46:53.412592 ignition[684]: reading system config file "/usr/lib/ignition/user.ign"
Nov 12 17:46:53.280682 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met.
Nov 12 17:46:53.412599 ignition[684]: no config at "/usr/lib/ignition/user.ign"
Nov 12 17:46:53.286052 systemd[1]: Starting ignition-setup.service - Ignition (setup)...
Nov 12 17:46:53.412604 ignition[684]: failed to fetch config: resource requires networking
Nov 12 17:46:53.291151 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline...
Nov 12 17:46:53.412779 ignition[684]: Ignition finished successfully
Nov 12 17:46:53.294093 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr.
Nov 12 17:46:53.316950 systemd[1]: mnt-oem.mount: Deactivated successfully.
Nov 12 17:46:53.324961 systemd[1]: Finished ignition-setup.service - Ignition (setup).
Nov 12 17:46:53.331133 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)...
Nov 12 17:46:53.416305 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline).
Nov 12 17:46:53.485017 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline.
Nov 12 17:46:53.505275 systemd[1]: Starting systemd-networkd.service - Network Configuration...
Nov 12 17:46:53.550062 systemd-networkd[789]: lo: Link UP
Nov 12 17:46:53.550066 systemd-networkd[789]: lo: Gained carrier
Nov 12 17:46:53.551608 systemd-networkd[789]: Enumeration completed
Nov 12 17:46:53.551708 systemd[1]: Started systemd-networkd.service - Network Configuration.
Nov 12 17:46:53.551815 systemd[1]: Reached target network.target - Network.
Nov 12 17:46:53.595251 ignition[791]: Ignition 2.19.0
Nov 12 17:46:53.553171 systemd-networkd[789]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
Nov 12 17:46:53.619110 kernel: mlx5_core 27cd:00:02.0 enP10189s1: Link up
Nov 12 17:46:53.595258 ignition[791]: Stage: fetch
Nov 12 17:46:53.553174 systemd-networkd[789]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
Nov 12 17:46:53.595508 ignition[791]: no configs at "/usr/lib/ignition/base.d"
Nov 12 17:46:53.578291 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)...
Nov 12 17:46:53.595517 ignition[791]: no config dir at "/usr/lib/ignition/base.platform.d/azure"
Nov 12 17:46:53.595625 ignition[791]: parsed url from cmdline: ""
Nov 12 17:46:53.595628 ignition[791]: no config URL provided
Nov 12 17:46:53.595638 ignition[791]: reading system config file "/usr/lib/ignition/user.ign"
Nov 12 17:46:53.654589 kernel: hv_netvsc 000d3af7-1fed-000d-3af7-1fed000d3af7 eth0: Data path switched to VF: enP10189s1
Nov 12 17:46:53.649983 systemd-networkd[789]: enP10189s1: Link UP
Nov 12 17:46:53.595645 ignition[791]: no config at "/usr/lib/ignition/user.ign"
Nov 12 17:46:53.650211 systemd-networkd[789]: eth0: Link UP
Nov 12 17:46:53.595666 ignition[791]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1
Nov 12 17:46:53.650602 systemd-networkd[789]: eth0: Gained carrier
Nov 12 17:46:53.595826 ignition[791]: GET error: Get "http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text": dial tcp 169.254.169.254:80: connect: network is unreachable
Nov 12 17:46:53.650612 systemd-networkd[789]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
Nov 12 17:46:53.667562 systemd-networkd[789]: enP10189s1: Gained carrier
Nov 12 17:46:53.795962 ignition[791]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #2
Nov 12 17:46:53.796152 ignition[791]: GET error: Get "http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text": dial tcp 169.254.169.254:80: connect: network is unreachable
Nov 12 17:46:54.196723 ignition[791]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #3
Nov 12 17:46:54.196849 ignition[791]: GET error: Get "http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text": dial tcp 169.254.169.254:80: connect: network is unreachable
Nov 12 17:46:54.736303 kernel: hv_utils: Heartbeat IC version 3.0
Nov 12 17:46:54.889082 systemd-networkd[789]: eth0: Gained IPv6LL
Nov 12 17:46:54.953235 systemd-networkd[789]: enP10189s1: Gained IPv6LL
Nov 12 17:46:54.996985 ignition[791]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #4
Nov 12 17:46:54.997093 ignition[791]: GET error: Get "http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text": dial tcp 169.254.169.254:80: connect: network is unreachable
Nov 12 17:46:56.597229 ignition[791]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #5
Nov 12 17:46:56.597380 ignition[791]: GET error: Get "http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text": dial tcp 169.254.169.254:80: connect: network is unreachable
Nov 12 17:46:58.375963 systemd-networkd[789]: eth0: DHCPv4 address 10.200.20.49/24, gateway 10.200.20.1 acquired from 168.63.129.16
Nov 12 17:46:59.797524 ignition[791]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #6
Nov 12 17:46:59.817933 ignition[791]: GET result: OK
Nov 12 17:46:59.817990 ignition[791]: config has been read from IMDS userdata
Nov 12 17:46:59.820518 unknown[791]: fetched base config from "system"
Nov 12 17:46:59.818001 ignition[791]: parsing config with SHA512: 8d66cedae69c1c609d1c5d418abad86683671437a6858b5955d437e946f4b96bf7904e4fcce60e1feff929b1da052bfdf8e08a22b6663c9348b38aa379751fba
Nov 12 17:46:59.820535 unknown[791]: fetched base config from "system"
Nov 12 17:46:59.820731 ignition[791]: fetch: fetch complete
Nov 12 17:46:59.820541 unknown[791]: fetched user config from "azure"
Nov 12 17:46:59.820735 ignition[791]: fetch: fetch passed
Nov 12 17:46:59.823144 systemd[1]: Finished ignition-fetch.service - Ignition (fetch).
Nov 12 17:46:59.820784 ignition[791]: Ignition finished successfully
Nov 12 17:46:59.837199 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)...
Nov 12 17:46:59.853426 ignition[798]: Ignition 2.19.0
Nov 12 17:46:59.853433 ignition[798]: Stage: kargs
Nov 12 17:46:59.853637 ignition[798]: no configs at "/usr/lib/ignition/base.d"
Nov 12 17:46:59.853647 ignition[798]: no config dir at "/usr/lib/ignition/base.platform.d/azure"
Nov 12 17:46:59.854297 ignition[798]: kargs: op(1): [started] updating kernel arguments
Nov 12 17:46:59.885999 kernel: BTRFS: device label OEM devid 1 transid 17 /dev/sda6 scanned by mount (805)
Nov 12 17:46:59.854305 ignition[798]: kargs: op(1): executing: "ignition-kargs-helper" "--should-exist" "quiet"
Nov 12 17:46:59.887946 kernel: BTRFS info (device sda6): first mount of filesystem 936a2172-6c61-4af6-a047-e38e0a3ff18b
Nov 12 17:46:59.887984 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm
Nov 12 17:46:59.887995 kernel: BTRFS info (device sda6): using free space tree
Nov 12 17:46:59.890347 kernel: BTRFS info (device sda6): auto enabling async discard
Nov 12 17:46:59.894455 ignition[798]: kargs: op(1): [finished] updating kernel arguments
Nov 12 17:46:59.894467 ignition[798]: kargs: kargs passed
Nov 12 17:46:59.903441 kernel: BTRFS info (device sda6): last unmount of filesystem 936a2172-6c61-4af6-a047-e38e0a3ff18b
Nov 12 17:46:59.894547 ignition[798]: Ignition finished successfully
Nov 12 17:46:59.908992 systemd[1]: Finished ignition-kargs.service - Ignition (kargs).
Nov 12 17:46:59.918083 systemd[1]: Starting ignition-disks.service - Ignition (disks)...
Nov 12 17:46:59.935525 ignition[833]: Ignition 2.19.0
Nov 12 17:46:59.935536 ignition[833]: Stage: disks
Nov 12 17:46:59.940195 systemd[1]: Finished ignition-disks.service - Ignition (disks).
Nov 12 17:46:59.935725 ignition[833]: no configs at "/usr/lib/ignition/base.d"
Nov 12 17:46:59.940678 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device.
Nov 12 17:46:59.935734 ignition[833]: no config dir at "/usr/lib/ignition/base.platform.d/azure"
Nov 12 17:46:59.940724 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems.
Nov 12 17:46:59.936378 ignition[833]: disks: disks passed
Nov 12 17:46:59.940750 systemd[1]: Reached target local-fs.target - Local File Systems.
Nov 12 17:46:59.936422 ignition[833]: Ignition finished successfully
Nov 12 17:46:59.986794 systemd-fsck[841]: ROOT: clean, 14/7326000 files, 477710/7359488 blocks
Nov 12 17:46:59.940775 systemd[1]: Reached target sysinit.target - System Initialization.
Nov 12 17:46:59.940788 systemd[1]: Reached target basic.target - Basic System.
Nov 12 17:46:59.955087 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT...
Nov 12 17:46:59.983034 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT.
Nov 12 17:46:59.996294 systemd[1]: Mounting sysroot.mount - /sysroot...
Nov 12 17:47:00.052938 kernel: EXT4-fs (sda9): mounted filesystem b3af0fd7-3c7c-4cdc-9b88-dae3d10ea922 r/w with ordered data mode. Quota mode: none.
Nov 12 17:47:00.053786 systemd[1]: Mounted sysroot.mount - /sysroot.
Nov 12 17:47:00.054248 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System.
Nov 12 17:47:00.076021 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem...
Nov 12 17:47:00.083289 kernel: BTRFS: device label OEM devid 1 transid 19 /dev/sda6 scanned by mount (852)
Nov 12 17:47:00.082110 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr...
Nov 12 17:47:00.091267 kernel: BTRFS info (device sda6): first mount of filesystem 936a2172-6c61-4af6-a047-e38e0a3ff18b
Nov 12 17:47:00.091291 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm
Nov 12 17:47:00.091302 kernel: BTRFS info (device sda6): using free space tree
Nov 12 17:47:00.090188 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent...
Nov 12 17:47:00.090233 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot).
Nov 12 17:47:00.090263 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup.
Nov 12 17:47:00.102624 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr.
Nov 12 17:47:00.123937 kernel: BTRFS info (device sda6): auto enabling async discard
Nov 12 17:47:00.105232 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup...
Nov 12 17:47:00.128239 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem.
Nov 12 17:47:00.220564 initrd-setup-root[878]: cut: /sysroot/etc/passwd: No such file or directory
Nov 12 17:47:00.233679 initrd-setup-root[885]: cut: /sysroot/etc/group: No such file or directory
Nov 12 17:47:00.243188 initrd-setup-root[892]: cut: /sysroot/etc/shadow: No such file or directory
Nov 12 17:47:00.252369 initrd-setup-root[899]: cut: /sysroot/etc/gshadow: No such file or directory
Nov 12 17:47:00.375287 coreos-metadata[854]: Nov 12 17:47:00.375 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1
Nov 12 17:47:00.385113 coreos-metadata[854]: Nov 12 17:47:00.385 INFO Fetch successful
Nov 12 17:47:00.390851 coreos-metadata[854]: Nov 12 17:47:00.390 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1
Nov 12 17:47:00.411949 coreos-metadata[854]: Nov 12 17:47:00.411 INFO Fetch successful
Nov 12 17:47:00.411949 coreos-metadata[854]: Nov 12 17:47:00.411 INFO wrote hostname ci-4081.2.0-a-d5417ce23b to /sysroot/etc/hostname
Nov 12 17:47:00.418482 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent.
Nov 12 17:47:00.752621 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup.
Nov 12 17:47:00.761099 systemd[1]: Starting ignition-mount.service - Ignition (mount)...
Nov 12 17:47:00.767855 systemd[1]: Starting sysroot-boot.service - /sysroot/boot...
Nov 12 17:47:00.775982 kernel: BTRFS info (device sda6): last unmount of filesystem 936a2172-6c61-4af6-a047-e38e0a3ff18b
Nov 12 17:47:00.775495 systemd[1]: sysroot-oem.mount: Deactivated successfully.
Nov 12 17:47:00.799938 ignition[971]: INFO : Ignition 2.19.0
Nov 12 17:47:00.799938 ignition[971]: INFO : Stage: mount
Nov 12 17:47:00.808846 ignition[971]: INFO : no configs at "/usr/lib/ignition/base.d"
Nov 12 17:47:00.808846 ignition[971]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure"
Nov 12 17:47:00.808846 ignition[971]: INFO : mount: mount passed
Nov 12 17:47:00.808846 ignition[971]: INFO : Ignition finished successfully
Nov 12 17:47:00.801245 systemd[1]: Finished sysroot-boot.service - /sysroot/boot.
Nov 12 17:47:00.802463 systemd[1]: Finished ignition-mount.service - Ignition (mount).
Nov 12 17:47:00.816025 systemd[1]: Starting ignition-files.service - Ignition (files)...
Nov 12 17:47:01.062147 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem...
Nov 12 17:47:01.070940 kernel: BTRFS: device label OEM devid 1 transid 20 /dev/sda6 scanned by mount (982)
Nov 12 17:47:01.071002 kernel: BTRFS info (device sda6): first mount of filesystem 936a2172-6c61-4af6-a047-e38e0a3ff18b
Nov 12 17:47:01.071025 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm
Nov 12 17:47:01.071035 kernel: BTRFS info (device sda6): using free space tree
Nov 12 17:47:01.071989 kernel: BTRFS info (device sda6): auto enabling async discard
Nov 12 17:47:01.073060 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem.
Nov 12 17:47:01.096954 ignition[1000]: INFO : Ignition 2.19.0
Nov 12 17:47:01.096954 ignition[1000]: INFO : Stage: files
Nov 12 17:47:01.096954 ignition[1000]: INFO : no configs at "/usr/lib/ignition/base.d"
Nov 12 17:47:01.096954 ignition[1000]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure"
Nov 12 17:47:01.119220 ignition[1000]: DEBUG : files: compiled without relabeling support, skipping
Nov 12 17:47:01.119220 ignition[1000]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core"
Nov 12 17:47:01.119220 ignition[1000]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core"
Nov 12 17:47:01.142664 ignition[1000]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core"
Nov 12 17:47:01.142664 ignition[1000]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core"
Nov 12 17:47:01.142664 ignition[1000]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core"
Nov 12 17:47:01.134052 unknown[1000]: wrote ssh authorized keys file for user: core
Nov 12 17:47:01.173114 ignition[1000]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf"
Nov 12 17:47:01.173114 ignition[1000]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf"
Nov 12 17:47:01.173114 ignition[1000]: INFO : files: createResultFile: createFiles: op(4): [started] writing file "/sysroot/etc/.ignition-result.json"
Nov 12 17:47:01.173114 ignition[1000]: INFO : files: createResultFile: createFiles: op(4): [finished] writing file "/sysroot/etc/.ignition-result.json"
Nov 12 17:47:01.173114 ignition[1000]: INFO : files: files passed
Nov 12 17:47:01.173114 ignition[1000]: INFO : Ignition finished successfully
Nov 12 17:47:01.151949 systemd[1]: Finished ignition-files.service - Ignition (files).
Nov 12 17:47:01.173168 systemd[1]: Starting ignition-quench.service - Ignition (record completion)...
Nov 12 17:47:01.177121 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion...
Nov 12 17:47:01.197578 systemd[1]: ignition-quench.service: Deactivated successfully.
Nov 12 17:47:01.253724 initrd-setup-root-after-ignition[1030]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory
Nov 12 17:47:01.197670 systemd[1]: Finished ignition-quench.service - Ignition (record completion).
Nov 12 17:47:01.270267 initrd-setup-root-after-ignition[1026]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory
Nov 12 17:47:01.270267 initrd-setup-root-after-ignition[1026]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory
Nov 12 17:47:01.199041 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion.
Nov 12 17:47:01.199153 systemd[1]: Reached target ignition-complete.target - Ignition Complete.
Nov 12 17:47:01.202139 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root...
Nov 12 17:47:01.236658 systemd[1]: initrd-parse-etc.service: Deactivated successfully.
Nov 12 17:47:01.236771 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root.
Nov 12 17:47:01.236905 systemd[1]: Reached target initrd-fs.target - Initrd File Systems.
Nov 12 17:47:01.236943 systemd[1]: Reached target initrd.target - Initrd Default Target.
Nov 12 17:47:01.237001 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met.
Nov 12 17:47:01.239145 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook...
Nov 12 17:47:01.271259 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook.
Nov 12 17:47:01.289310 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons...
Nov 12 17:47:01.381006 ignition[1050]: INFO : Ignition 2.19.0
Nov 12 17:47:01.381006 ignition[1050]: INFO : Stage: umount
Nov 12 17:47:01.381006 ignition[1050]: INFO : no configs at "/usr/lib/ignition/base.d"
Nov 12 17:47:01.381006 ignition[1050]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure"
Nov 12 17:47:01.381006 ignition[1050]: INFO : umount: umount passed
Nov 12 17:47:01.381006 ignition[1050]: INFO : Ignition finished successfully
Nov 12 17:47:01.307420 systemd[1]: initrd-cleanup.service: Deactivated successfully.
Nov 12 17:47:01.307564 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons.
Nov 12 17:47:01.307812 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups.
Nov 12 17:47:01.307842 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes.
Nov 12 17:47:01.307887 systemd[1]: Stopped target timers.target - Timer Units.
Nov 12 17:47:01.308004 systemd[1]: dracut-pre-pivot.service: Deactivated successfully.
Nov 12 17:47:01.308063 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook.
Nov 12 17:47:01.311077 systemd[1]: Stopped target initrd.target - Initrd Default Target.
Nov 12 17:47:01.311108 systemd[1]: Stopped target basic.target - Basic System.
Nov 12 17:47:01.311126 systemd[1]: Stopped target ignition-complete.target - Ignition Complete.
Nov 12 17:47:01.311139 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup.
Nov 12 17:47:01.311147 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device.
Nov 12 17:47:01.311162 systemd[1]: Stopped target remote-fs.target - Remote File Systems.
Nov 12 17:47:01.311173 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems.
Nov 12 17:47:01.311196 systemd[1]: Stopped target sysinit.target - System Initialization.
Nov 12 17:47:01.503138 kernel: hv_netvsc 000d3af7-1fed-000d-3af7-1fed000d3af7 eth0: Data path switched from VF: enP10189s1
Nov 12 17:47:01.311213 systemd[1]: Stopped target local-fs.target - Local File Systems.
Nov 12 17:47:01.311223 systemd[1]: Stopped target swap.target - Swaps.
Nov 12 17:47:01.311239 systemd[1]: dracut-pre-mount.service: Deactivated successfully.
Nov 12 17:47:01.311282 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook.
Nov 12 17:47:01.311590 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes.
Nov 12 17:47:01.311611 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre).
Nov 12 17:47:01.311621 systemd[1]: clevis-luks-askpass.path: Deactivated successfully.
Nov 12 17:47:01.316979 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch.
Nov 12 17:47:01.317007 systemd[1]: dracut-initqueue.service: Deactivated successfully.
Nov 12 17:47:01.317067 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook.
Nov 12 17:47:01.323763 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully.
Nov 12 17:47:01.323820 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion.
Nov 12 17:47:01.323868 systemd[1]: ignition-files.service: Deactivated successfully.
Nov 12 17:47:01.323900 systemd[1]: Stopped ignition-files.service - Ignition (files).
Nov 12 17:47:01.323981 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully.
Nov 12 17:47:01.324017 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent.
Nov 12 17:47:01.343185 systemd[1]: Stopping ignition-mount.service - Ignition (mount)...
Nov 12 17:47:01.600605 systemd-journald[214]: Received SIGTERM from PID 1 (systemd).
Nov 12 17:47:01.347142 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot...
Nov 12 17:47:01.347278 systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
Nov 12 17:47:01.347418 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices.
Nov 12 17:47:01.347542 systemd[1]: dracut-pre-trigger.service: Deactivated successfully.
Nov 12 17:47:01.347644 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook.
Nov 12 17:47:01.379264 systemd[1]: ignition-mount.service: Deactivated successfully.
Nov 12 17:47:01.379365 systemd[1]: Stopped ignition-mount.service - Ignition (mount).
Nov 12 17:47:01.379513 systemd[1]: ignition-disks.service: Deactivated successfully.
Nov 12 17:47:01.379547 systemd[1]: Stopped ignition-disks.service - Ignition (disks).
Nov 12 17:47:01.379583 systemd[1]: ignition-kargs.service: Deactivated successfully.
Nov 12 17:47:01.379608 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs).
Nov 12 17:47:01.379636 systemd[1]: ignition-fetch.service: Deactivated successfully.
Nov 12 17:47:01.379659 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch).
Nov 12 17:47:01.379688 systemd[1]: Stopped target network.target - Network.
Nov 12 17:47:01.379700 systemd[1]: ignition-fetch-offline.service: Deactivated successfully.
Nov 12 17:47:01.379725 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline).
Nov 12 17:47:01.379754 systemd[1]: Stopped target paths.target - Path Units.
Nov 12 17:47:01.379765 systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
Nov 12 17:47:01.385778 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
Nov 12 17:47:01.385809 systemd[1]: Stopped target slices.target - Slice Units.
Nov 12 17:47:01.385827 systemd[1]: Stopped target sockets.target - Socket Units.
Nov 12 17:47:01.385867 systemd[1]: iscsid.socket: Deactivated successfully.
Nov 12 17:47:01.385902 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket.
Nov 12 17:47:01.385960 systemd[1]: iscsiuio.socket: Deactivated successfully.
Nov 12 17:47:01.385987 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket.
Nov 12 17:47:01.386017 systemd[1]: ignition-setup.service: Deactivated successfully.
Nov 12 17:47:01.386049 systemd[1]: Stopped ignition-setup.service - Ignition (setup).
Nov 12 17:47:01.386088 systemd[1]: ignition-setup-pre.service: Deactivated successfully.
Nov 12 17:47:01.386115 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup.
Nov 12 17:47:01.386247 systemd[1]: Stopping systemd-networkd.service - Network Configuration...
Nov 12 17:47:01.387090 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution...
Nov 12 17:47:01.388241 systemd[1]: sysroot-boot.mount: Deactivated successfully.
Nov 12 17:47:01.390216 systemd-networkd[789]: eth0: DHCPv6 lease lost
Nov 12 17:47:01.397342 systemd[1]: systemd-networkd.service: Deactivated successfully.
Nov 12 17:47:01.397468 systemd[1]: Stopped systemd-networkd.service - Network Configuration.
Nov 12 17:47:01.397675 systemd[1]: systemd-networkd.socket: Deactivated successfully.
Nov 12 17:47:01.397710 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket.
Nov 12 17:47:01.414142 systemd[1]: Stopping network-cleanup.service - Network Cleanup...
Nov 12 17:47:01.414162 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully.
Nov 12 17:47:01.414226 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline.
Nov 12 17:47:01.414371 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files...
Nov 12 17:47:01.414640 systemd[1]: systemd-resolved.service: Deactivated successfully.
Nov 12 17:47:01.416239 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution.
Nov 12 17:47:01.422874 systemd[1]: systemd-sysctl.service: Deactivated successfully.
Nov 12 17:47:01.424036 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables.
Nov 12 17:47:01.424156 systemd[1]: systemd-modules-load.service: Deactivated successfully.
Nov 12 17:47:01.424207 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules.
Nov 12 17:47:01.424258 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
Nov 12 17:47:01.424305 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories.
Nov 12 17:47:01.452212 systemd[1]: sysroot-boot.service: Deactivated successfully.
Nov 12 17:47:01.452392 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot.
Nov 12 17:47:01.452698 systemd[1]: systemd-udevd.service: Deactivated successfully.
Nov 12 17:47:01.452865 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files.
Nov 12 17:47:01.453587 systemd[1]: systemd-udevd-control.socket: Deactivated successfully.
Nov 12 17:47:01.453671 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket.
Nov 12 17:47:01.453731 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully.
Nov 12 17:47:01.453765 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket.
Nov 12 17:47:01.453801 systemd[1]: dracut-pre-udev.service: Deactivated successfully.
Nov 12 17:47:01.453841 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook.
Nov 12 17:47:01.457627 systemd[1]: dracut-cmdline.service: Deactivated successfully.
Nov 12 17:47:01.457692 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook.
Nov 12 17:47:01.462948 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully.
Nov 12 17:47:01.463005 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
Nov 12 17:47:01.467749 systemd[1]: initrd-setup-root.service: Deactivated successfully.
Nov 12 17:47:01.467796 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup.
Nov 12 17:47:01.471191 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database...
Nov 12 17:47:01.471233 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
Nov 12 17:47:01.471293 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev.
Nov 12 17:47:01.471346 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.
Nov 12 17:47:01.471378 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully.
Nov 12 17:47:01.471409 systemd[1]: kmod-static-nodes.service: Deactivated successfully.
Nov 12 17:47:01.471439 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes.
Nov 12 17:47:01.471469 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
Nov 12 17:47:01.471499 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup.
Nov 12 17:47:01.479565 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
Nov 12 17:47:01.479674 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database.
Nov 12 17:47:01.529903 systemd[1]: network-cleanup.service: Deactivated successfully.
Nov 12 17:47:01.530095 systemd[1]: Stopped network-cleanup.service - Network Cleanup.
Nov 12 17:47:01.530364 systemd[1]: Reached target initrd-switch-root.target - Switch Root.
Nov 12 17:47:01.540312 systemd[1]: Starting initrd-switch-root.service - Switch Root...
Nov 12 17:47:01.551405 systemd[1]: Switching root.
Nov 12 17:47:02.035485 systemd-journald[214]: Journal stopped
Nov 12 17:47:04.672580 kernel: SELinux: policy capability network_peer_controls=1
Nov 12 17:47:04.672604 kernel: SELinux: policy capability open_perms=1
Nov 12 17:47:04.672614 kernel: SELinux: policy capability extended_socket_class=1
Nov 12 17:47:04.672622 kernel: SELinux: policy capability always_check_network=0
Nov 12 17:47:04.672632 kernel: SELinux: policy capability cgroup_seclabel=1
Nov 12 17:47:04.672640 kernel: SELinux: policy capability nnp_nosuid_transition=1
Nov 12 17:47:04.672649 kernel: SELinux: policy capability genfs_seclabel_symlinks=0
Nov 12 17:47:04.672657 kernel: SELinux: policy capability ioctl_skip_cloexec=0
Nov 12 17:47:04.672667 systemd[1]: Successfully loaded SELinux policy in 74.990ms.
Nov 12 17:47:04.672677 kernel: audit: type=1403 audit(1731433622.350:2): auid=4294967295 ses=4294967295 lsm=selinux res=1
Nov 12 17:47:04.672687 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 10.160ms.
Nov 12 17:47:04.672697 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified)
Nov 12 17:47:04.672707 systemd[1]: Detected virtualization microsoft.
Nov 12 17:47:04.672716 systemd[1]: Detected architecture arm64.
Nov 12 17:47:04.672725 systemd[1]: Detected first boot.
Nov 12 17:47:04.672737 systemd[1]: Hostname set to <ci-4081.2.0-a-d5417ce23b>.
Nov 12 17:47:04.672746 systemd[1]: Initializing machine ID from random generator.
Nov 12 17:47:04.672755 zram_generator::config[1092]: No configuration found.
Nov 12 17:47:04.672765 systemd[1]: Populated /etc with preset unit settings.
Nov 12 17:47:04.672774 systemd[1]: initrd-switch-root.service: Deactivated successfully.
Nov 12 17:47:04.672783 systemd[1]: Stopped initrd-switch-root.service - Switch Root.
Nov 12 17:47:04.672793 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
Nov 12 17:47:04.672804 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config.
Nov 12 17:47:04.672814 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run.
Nov 12 17:47:04.672824 systemd[1]: Created slice system-getty.slice - Slice /system/getty.
Nov 12 17:47:04.672833 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe.
Nov 12 17:47:04.672842 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty.
Nov 12 17:47:04.672852 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit.
Nov 12 17:47:04.672862 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck.
Nov 12 17:47:04.672873 systemd[1]: Created slice user.slice - User and Session Slice.
Nov 12 17:47:04.672882 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch.
Nov 12 17:47:04.672892 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
Nov 12 17:47:04.672901 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch.
Nov 12 17:47:04.672910 systemd[1]: Set up automount boot.automount - Boot partition Automount Point.
Nov 12 17:47:04.672938 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point.
Nov 12 17:47:04.672950 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM...
Nov 12 17:47:04.672962 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0...
Nov 12 17:47:04.672974 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre).
Nov 12 17:47:04.672984 systemd[1]: Stopped target initrd-switch-root.target - Switch Root.
Nov 12 17:47:04.672993 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems.
Nov 12 17:47:04.673005 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System.
Nov 12 17:47:04.673014 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes.
Nov 12 17:47:04.673024 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes.
Nov 12 17:47:04.673034 systemd[1]: Reached target remote-fs.target - Remote File Systems.
Nov 12 17:47:04.673043 systemd[1]: Reached target slices.target - Slice Units.
Nov 12 17:47:04.673055 systemd[1]: Reached target swap.target - Swaps.
Nov 12 17:47:04.673064 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes.
Nov 12 17:47:04.673074 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket.
Nov 12 17:47:04.673083 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket.
Nov 12 17:47:04.673093 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket.
Nov 12 17:47:04.673103 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket.
Nov 12 17:47:04.673115 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket.
Nov 12 17:47:04.673124 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System...
Nov 12 17:47:04.673134 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System...
Nov 12 17:47:04.673144 systemd[1]: Mounting media.mount - External Media Directory...
Nov 12 17:47:04.673153 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System...
Nov 12 17:47:04.673163 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System...
Nov 12 17:47:04.673174 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp...
Nov 12 17:47:04.673186 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw).
Nov 12 17:47:04.673195 systemd[1]: Reached target machines.target - Containers.
Nov 12 17:47:04.673205 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files...
Nov 12 17:47:04.673215 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
Nov 12 17:47:04.673225 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes...
Nov 12 17:47:04.673235 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs...
Nov 12 17:47:04.673245 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
Nov 12 17:47:04.673254 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm...
Nov 12 17:47:04.673265 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
Nov 12 17:47:04.673275 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse...
Nov 12 17:47:04.673285 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
Nov 12 17:47:04.673295 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf).
Nov 12 17:47:04.673305 systemd[1]: systemd-fsck-root.service: Deactivated successfully.
Nov 12 17:47:04.673314 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device.
Nov 12 17:47:04.673324 systemd[1]: systemd-fsck-usr.service: Deactivated successfully.
Nov 12 17:47:04.673334 systemd[1]: Stopped systemd-fsck-usr.service.
Nov 12 17:47:04.673345 systemd[1]: Starting systemd-journald.service - Journal Service...
Nov 12 17:47:04.673354 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules...
Nov 12 17:47:04.673364 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line...
Nov 12 17:47:04.673374 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems...
Nov 12 17:47:04.673384 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices...
Nov 12 17:47:04.673394 systemd[1]: verity-setup.service: Deactivated successfully.
Nov 12 17:47:04.673404 systemd[1]: Stopped verity-setup.service.
Nov 12 17:47:04.673414 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System.
Nov 12 17:47:04.673423 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System.
Nov 12 17:47:04.673435 systemd[1]: Mounted media.mount - External Media Directory.
Nov 12 17:47:04.673445 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System.
Nov 12 17:47:04.673454 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System.
Nov 12 17:47:04.673464 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp.
Nov 12 17:47:04.673474 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes.
Nov 12 17:47:04.673483 systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
Nov 12 17:47:04.673493 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
Nov 12 17:47:04.673503 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
Nov 12 17:47:04.673512 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
Nov 12 17:47:04.673523 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully...
Nov 12 17:47:04.673533 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line.
Nov 12 17:47:04.673543 systemd[1]: Reached target network-pre.target - Preparation for Network.
Nov 12 17:47:04.673552 kernel: fuse: init (API version 7.39)
Nov 12 17:47:04.673561 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems.
Nov 12 17:47:04.673571 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/).
Nov 12 17:47:04.673581 systemd[1]: Reached target local-fs.target - Local File Systems.
Nov 12 17:47:04.673591 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink).
Nov 12 17:47:04.673603 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown...
Nov 12 17:47:04.673613 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache...
Nov 12 17:47:04.673623 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
Nov 12 17:47:04.673632 kernel: loop: module loaded
Nov 12 17:47:04.673642 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database...
Nov 12 17:47:04.673652 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
Nov 12 17:47:04.673662 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed...
Nov 12 17:47:04.673672 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/...
Nov 12 17:47:04.673683 systemd[1]: modprobe@configfs.service: Deactivated successfully.
Nov 12 17:47:04.673693 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs.
Nov 12 17:47:04.673702 systemd[1]: modprobe@fuse.service: Deactivated successfully.
Nov 12 17:47:04.673712 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse.
Nov 12 17:47:04.673722 systemd[1]: modprobe@loop.service: Deactivated successfully.
Nov 12 17:47:04.673731 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
Nov 12 17:47:04.673741 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules.
Nov 12 17:47:04.673751 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown.
Nov 12 17:47:04.673761 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System...
Nov 12 17:47:04.673772 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System...
Nov 12 17:47:04.673786 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met.
Nov 12 17:47:04.673797 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables...
Nov 12 17:47:04.673808 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System.
Nov 12 17:47:04.673819 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System.
Nov 12 17:47:04.673846 systemd-journald[1174]: Collecting audit messages is disabled.
Nov 12 17:47:04.673869 systemd-journald[1174]: Journal started
Nov 12 17:47:04.673890 systemd-journald[1174]: Runtime Journal (/run/log/journal/1e85e08dea64493e9b92c0a80df25f29) is 8.0M, max 78.5M, 70.5M free.
Nov 12 17:47:04.246847 systemd[1]: Queued start job for default target multi-user.target.
Nov 12 17:47:04.287709 systemd[1]: Unnecessary job was removed for dev-sda6.device - /dev/sda6.
Nov 12 17:47:04.288078 systemd[1]: systemd-journald.service: Deactivated successfully.
Nov 12 17:47:04.288385 systemd[1]: systemd-journald.service: Consumed 2.135s CPU time.
Nov 12 17:47:04.681480 systemd[1]: Started systemd-journald.service - Journal Service.
Nov 12 17:47:04.682204 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices.
Nov 12 17:47:04.695133 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage...
Nov 12 17:47:04.696972 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization...
Nov 12 17:47:04.708577 udevadm[1213]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in.
Nov 12 17:47:04.812290 systemd-journald[1174]: Time spent on flushing to /var/log/journal/1e85e08dea64493e9b92c0a80df25f29 is 52.732ms for 887 entries.
Nov 12 17:47:04.812290 systemd-journald[1174]: System Journal (/var/log/journal/1e85e08dea64493e9b92c0a80df25f29) is 8.0M, max 2.6G, 2.6G free.
Nov 12 17:47:05.618779 systemd-journald[1174]: Received client request to flush runtime journal.
Nov 12 17:47:05.618821 kernel: ACPI: bus type drm_connector registered
Nov 12 17:47:05.618835 kernel: loop0: detected capacity change from 0 to 114432
Nov 12 17:47:04.931732 systemd[1]: modprobe@drm.service: Deactivated successfully.
Nov 12 17:47:04.931873 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm.
Nov 12 17:47:05.012830 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed.
Nov 12 17:47:05.013393 systemd[1]: Reached target first-boot-complete.target - First Boot Complete.
Nov 12 17:47:05.018914 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk...
Nov 12 17:47:05.065004 systemd-tmpfiles[1179]: ACLs are not supported, ignoring.
Nov 12 17:47:05.065015 systemd-tmpfiles[1179]: ACLs are not supported, ignoring.
Nov 12 17:47:05.065196 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables.
Nov 12 17:47:05.068651 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully.
Nov 12 17:47:05.620867 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage.
Nov 12 17:47:06.167155 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files.
Nov 12 17:47:06.176205 systemd[1]: Starting systemd-sysusers.service - Create System Users...
Nov 12 17:47:06.856092 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
Nov 12 17:47:06.857361 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk.
Nov 12 17:47:06.860934 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher
Nov 12 17:47:06.921947 kernel: loop1: detected capacity change from 0 to 31320
Nov 12 17:47:06.970990 systemd[1]: Finished systemd-sysusers.service - Create System Users.
Nov 12 17:47:06.977096 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev...
Nov 12 17:47:06.990674 systemd-tmpfiles[1251]: ACLs are not supported, ignoring.
Nov 12 17:47:06.990695 systemd-tmpfiles[1251]: ACLs are not supported, ignoring.
Nov 12 17:47:06.994637 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev.
Nov 12 17:47:07.563020 kernel: loop2: detected capacity change from 0 to 114328
Nov 12 17:47:08.299288 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database.
Nov 12 17:47:08.305112 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files...
Nov 12 17:47:08.324976 systemd-udevd[1256]: Using default interface naming scheme 'v255'.
Nov 12 17:47:08.683960 kernel: loop3: detected capacity change from 0 to 114432
Nov 12 17:47:08.689942 kernel: loop4: detected capacity change from 0 to 31320
Nov 12 17:47:08.694953 kernel: loop5: detected capacity change from 0 to 114328
Nov 12 17:47:08.698789 (sd-merge)[1258]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-azure'.
Nov 12 17:47:08.699206 (sd-merge)[1258]: Merged extensions into '/usr'.
Nov 12 17:47:08.702424 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/.
Nov 12 17:47:08.708160 systemd[1]: Starting ensure-sysext.service...
Nov 12 17:47:08.709260 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories...
Nov 12 17:47:08.730542 systemd[1]: Reloading requested from client PID 1260 ('systemctl') (unit ensure-sysext.service)...
Nov 12 17:47:08.730694 systemd[1]: Reloading...
Nov 12 17:47:08.787009 zram_generator::config[1285]: No configuration found.
Nov 12 17:47:08.814861 systemd-tmpfiles[1261]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring.
Nov 12 17:47:08.815211 systemd-tmpfiles[1261]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring.
Nov 12 17:47:08.817019 systemd-tmpfiles[1261]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring.
Nov 12 17:47:08.817334 systemd-tmpfiles[1261]: ACLs are not supported, ignoring.
Nov 12 17:47:08.817389 systemd-tmpfiles[1261]: ACLs are not supported, ignoring.
Nov 12 17:47:08.820972 systemd-tmpfiles[1261]: Detected autofs mount point /boot during canonicalization of boot.
Nov 12 17:47:08.820983 systemd-tmpfiles[1261]: Skipping /boot
Nov 12 17:47:08.829951 systemd-tmpfiles[1261]: Detected autofs mount point /boot during canonicalization of boot.
Nov 12 17:47:08.829962 systemd-tmpfiles[1261]: Skipping /boot
Nov 12 17:47:08.941824 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly.
Nov 12 17:47:08.979587 kernel: BTRFS info: devid 1 device path /dev/mapper/usr changed to /dev/dm-0 scanned by (udev-worker) (1354)
Nov 12 17:47:08.998956 kernel: BTRFS info: devid 1 device path /dev/dm-0 changed to /dev/mapper/usr scanned by (udev-worker) (1354)
Nov 12 17:47:09.021208 systemd[1]: Reloading finished in 290 ms.
Nov 12 17:47:09.045548 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files.
Nov 12 17:47:09.046389 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories.
Nov 12 17:47:09.058881 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped.
Nov 12 17:47:09.065241 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules...
Nov 12 17:47:09.068334 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs...
Nov 12 17:47:09.070727 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog...
Nov 12 17:47:09.073292 systemd[1]: Starting systemd-networkd.service - Network Configuration...
Nov 12 17:47:09.078163 systemd[1]: Starting systemd-resolved.service - Network Name Resolution...
Nov 12 17:47:09.081132 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP...
Nov 12 17:47:09.087002 kernel: hv_vmbus: registering driver hv_balloon
Nov 12 17:47:09.089836 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0
Nov 12 17:47:09.089910 kernel: hv_balloon: Memory hot add disabled on ARM64
Nov 12 17:47:09.089471 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
Nov 12 17:47:09.094352 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
Nov 12 17:47:09.097326 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
Nov 12 17:47:09.100254 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
Nov 12 17:47:09.100370 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
Nov 12 17:47:09.103219 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
Nov 12 17:47:09.103371 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
Nov 12 17:47:09.106796 systemd[1]: Expecting device dev-ptp_hyperv.device - /dev/ptp_hyperv...
Nov 12 17:47:09.107009 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
Nov 12 17:47:09.109776 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm...
Nov 12 17:47:09.109904 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
Nov 12 17:47:09.110074 systemd[1]: Reached target time-set.target - System Time Set.
Nov 12 17:47:09.116012 systemd[1]: Finished ensure-sysext.service.
Nov 12 17:47:09.123347 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP.
Nov 12 17:47:09.142483 systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
Nov 12 17:47:09.143254 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
Nov 12 17:47:09.143611 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
Nov 12 17:47:09.144443 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
Nov 12 17:47:09.144771 systemd[1]: modprobe@loop.service: Deactivated successfully.
Nov 12 17:47:09.145606 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
Nov 12 17:47:09.145869 systemd[1]: modprobe@drm.service: Deactivated successfully.
Nov 12 17:47:09.146302 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm.
Nov 12 17:47:09.147969 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
Nov 12 17:47:09.148053 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met.
Nov 12 17:47:09.167026 kernel: hv_vmbus: registering driver hyperv_fb
Nov 12 17:47:09.167961 kernel: hyperv_fb: Synthvid Version major 3, minor 5
Nov 12 17:47:09.168029 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608
Nov 12 17:47:09.173215 systemd[1]: Starting systemd-userdbd.service - User Database Manager...
Nov 12 17:47:09.196949 kernel: Console: switching to colour dummy device 80x25
Nov 12 17:47:09.200218 kernel: Console: switching to colour frame buffer device 128x48
Nov 12 17:47:09.203290 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
Nov 12 17:47:09.205408 systemd[1]: Condition check resulted in dev-ptp_hyperv.device - /dev/ptp_hyperv being skipped.
Nov 12 17:47:09.208155 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
Nov 12 17:47:09.208355 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup.
Nov 12 17:47:09.212379 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
Nov 12 17:47:09.228442 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
Nov 12 17:47:09.228615 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup.
Nov 12 17:47:09.231161 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
Nov 12 17:47:09.330463 systemd[1]: Started systemd-userdbd.service - User Database Manager.
Nov 12 17:47:09.358422 kernel: BTRFS warning: duplicate device /dev/sda3 devid 1 generation 40 scanned by (udev-worker) (1358)
Nov 12 17:47:09.386959 kernel: mousedev: PS/2 mouse device common for all mice
Nov 12 17:47:09.428107 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM.
Nov 12 17:47:09.438092 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM...
Nov 12 17:47:09.568861 systemd-resolved[1386]: Positive Trust Anchors:
Nov 12 17:47:09.568883 systemd-resolved[1386]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
Nov 12 17:47:09.568916 systemd-resolved[1386]: 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 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test
Nov 12 17:47:09.714507 augenrules[1462]: No rules
Nov 12 17:47:09.715826 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules.
Nov 12 17:47:09.764026 systemd-resolved[1386]: Using system hostname 'ci-4081.2.0-a-d5417ce23b'.
Nov 12 17:47:09.765426 systemd[1]: Started systemd-resolved.service - Network Name Resolution.
Nov 12 17:47:09.765530 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups.
Nov 12 17:47:09.810663 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM.
Nov 12 17:47:09.965298 systemd-networkd[1385]: lo: Link UP
Nov 12 17:47:09.965306 systemd-networkd[1385]: lo: Gained carrier
Nov 12 17:47:09.967168 systemd-networkd[1385]: Enumeration completed
Nov 12 17:47:09.967666 systemd[1]: Started systemd-networkd.service - Network Configuration.
Nov 12 17:47:09.967745 systemd-networkd[1385]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
Nov 12 17:47:09.967749 systemd-networkd[1385]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
Nov 12 17:47:09.968237 systemd[1]: Reached target network.target - Network.
Nov 12 17:47:09.973103 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured...
Nov 12 17:47:10.013942 kernel: mlx5_core 27cd:00:02.0 enP10189s1: Link up
Nov 12 17:47:10.033042 kernel: hv_netvsc 000d3af7-1fed-000d-3af7-1fed000d3af7 eth0: Data path switched to VF: enP10189s1
Nov 12 17:47:10.033624 systemd-networkd[1385]: enP10189s1: Link UP
Nov 12 17:47:10.033855 systemd-networkd[1385]: eth0: Link UP
Nov 12 17:47:10.033861 systemd-networkd[1385]: eth0: Gained carrier
Nov 12 17:47:10.033877 systemd-networkd[1385]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
Nov 12 17:47:10.038214 systemd-networkd[1385]: enP10189s1: Gained carrier
Nov 12 17:47:10.047974 systemd-networkd[1385]: eth0: DHCPv4 address 10.200.20.49/24, gateway 10.200.20.1 acquired from 168.63.129.16
Nov 12 17:47:10.109384 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog.
Nov 12 17:47:10.194895 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization.
Nov 12 17:47:10.200085 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes...
Nov 12 17:47:10.363004 lvm[1479]: WARNING: Failed to connect to lvmetad. Falling back to device scanning.
Nov 12 17:47:10.386956 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes.
Nov 12 17:47:10.387446 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes.
Nov 12 17:47:10.392167 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes...
Nov 12 17:47:10.396398 lvm[1481]: WARNING: Failed to connect to lvmetad. Falling back to device scanning.
Nov 12 17:47:10.415605 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes.
Nov 12 17:47:10.574412 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup.
Nov 12 17:47:11.518776 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs.
Nov 12 17:47:11.519016 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt).
Nov 12 17:47:11.785221 systemd-networkd[1385]: eth0: Gained IPv6LL
Nov 12 17:47:11.787962 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured.
Nov 12 17:47:11.788748 systemd[1]: Reached target network-online.target - Network is Online.
Nov 12 17:47:11.913023 systemd-networkd[1385]: enP10189s1: Gained IPv6LL
Nov 12 17:47:12.639008 ldconfig[1182]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start.
Nov 12 17:47:12.649503 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache.
Nov 12 17:47:12.656156 systemd[1]: Starting systemd-update-done.service - Update is Completed...
Nov 12 17:47:12.664007 systemd[1]: Finished systemd-update-done.service - Update is Completed.
Nov 12 17:47:12.664268 systemd[1]: Reached target sysinit.target - System Initialization.
Nov 12 17:47:12.664392 systemd[1]: Started motdgen.path - Watch for update engine configuration changes.
Nov 12 17:47:12.664447 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data.
Nov 12 17:47:12.664621 systemd[1]: Started logrotate.timer - Daily rotation of log files.
Nov 12 17:47:12.664738 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information..
Nov 12 17:47:12.664764 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories.
Nov 12 17:47:12.664783 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate).
Nov 12 17:47:12.664799 systemd[1]: Reached target paths.target - Path Units.
Nov 12 17:47:12.664812 systemd[1]: Reached target timers.target - Timer Units.
Nov 12 17:47:12.668804 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket.
Nov 12 17:47:12.670170 systemd[1]: Starting docker.socket - Docker Socket for the API...
Nov 12 17:47:12.675483 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket.
Nov 12 17:47:12.676100 systemd[1]: Listening on docker.socket - Docker Socket for the API.
Nov 12 17:47:12.676233 systemd[1]: Reached target sockets.target - Socket Units.
Nov 12 17:47:12.676258 systemd[1]: Reached target basic.target - Basic System.
Nov 12 17:47:12.676343 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met.
Nov 12 17:47:12.676364 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met.
Nov 12 17:47:12.679066 systemd[1]: Starting chronyd.service - NTP client/server...
Nov 12 17:47:12.681045 systemd[1]: Starting containerd.service - containerd container runtime...
Nov 12 17:47:12.685110 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent...
Nov 12 17:47:12.688098 systemd[1]: Starting dbus.service - D-Bus System Message Bus...
Nov 12 17:47:12.690647 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit...
Nov 12 17:47:12.694081 systemd[1]: Starting extend-filesystems.service - Extend Filesystems...
Nov 12 17:47:12.694125 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment).
Nov 12 17:47:12.694159 systemd[1]: hv_fcopy_daemon.service - Hyper-V FCOPY daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/vmbus/hv_fcopy).
Nov 12 17:47:12.696119 systemd[1]: Started hv_kvp_daemon.service - Hyper-V KVP daemon.
Nov 12 17:47:12.696217 systemd[1]: hv_vss_daemon.service - Hyper-V VSS daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/vmbus/hv_vss).
Nov 12 17:47:12.698289 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd...
Nov 12 17:47:12.710814 systemd[1]: Starting nvidia.service - NVIDIA Configure Service...
Nov 12 17:47:12.713787 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline...
Nov 12 17:47:12.716965 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys...
Nov 12 17:47:12.721706 KVP[1499]: KVP starting; pid is:1499
Nov 12 17:47:12.726943 jq[1497]: false
Nov 12 17:47:12.726143 systemd[1]: Starting systemd-logind.service - User Login Management...
Nov 12 17:47:12.726529 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0).
Nov 12 17:47:12.728553 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details.
Nov 12 17:47:12.736162 kernel: hv_utils: KVP IC version 4.0
Nov 12 17:47:12.735685 KVP[1499]: KVP LIC Version: 3.1
Nov 12 17:47:12.736186 systemd[1]: Starting update-engine.service - Update Engine...
Nov 12 17:47:12.738315 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition...
Nov 12 17:47:12.741488 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'.
Nov 12 17:47:12.743666 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped.
Nov 12 17:47:12.767724 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully.
Nov 12 17:47:12.767906 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline.
Nov 12 17:47:12.784499 jq[1511]: true
Nov 12 17:47:12.794949 extend-filesystems[1498]: Found loop3
Nov 12 17:47:12.794949 extend-filesystems[1498]: Found loop4
Nov 12 17:47:12.794949 extend-filesystems[1498]: Found loop5
Nov 12 17:47:12.794949 extend-filesystems[1498]: Found sda
Nov 12 17:47:12.794949 extend-filesystems[1498]: Found sda1
Nov 12 17:47:12.794949 extend-filesystems[1498]: Found sda2
Nov 12 17:47:12.794949 extend-filesystems[1498]: Found sda3
Nov 12 17:47:12.794949 extend-filesystems[1498]: Found usr
Nov 12 17:47:12.794949 extend-filesystems[1498]: Found sda4
Nov 12 17:47:12.794949 extend-filesystems[1498]: Found sda6
Nov 12 17:47:12.794949 extend-filesystems[1498]: Found sda7
Nov 12 17:47:12.794949 extend-filesystems[1498]: Found sda9
Nov 12 17:47:12.794949 extend-filesystems[1498]: Checking size of /dev/sda9
Nov 12 17:47:12.792688 (ntainerd)[1524]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR
Nov 12 17:47:12.785517 dbus-daemon[1496]: [system] SELinux support is enabled
Nov 12 17:47:12.953909 coreos-metadata[1495]: Nov 12 17:47:12.915 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1
Nov 12 17:47:12.953909 coreos-metadata[1495]: Nov 12 17:47:12.922 INFO Fetch successful
Nov 12 17:47:12.953909 coreos-metadata[1495]: Nov 12 17:47:12.922 INFO Fetching http://168.63.129.16/machine/?comp=goalstate: Attempt #1
Nov 12 17:47:12.953909 coreos-metadata[1495]: Nov 12 17:47:12.927 INFO Fetch successful
Nov 12 17:47:12.953909 coreos-metadata[1495]: Nov 12 17:47:12.928 INFO Fetching http://168.63.129.16/machine/90287cc8-c696-4afa-9006-e7f461e7dcb8/38cd9f2e%2D419c%2D422e%2Da095%2D22f98f92c543.%5Fci%2D4081.2.0%2Da%2Dd5417ce23b?comp=config&type=sharedConfig&incarnation=1: Attempt #1
Nov 12 17:47:12.953909 coreos-metadata[1495]: Nov 12 17:47:12.930 INFO Fetch successful
Nov 12 17:47:12.953909 coreos-metadata[1495]: Nov 12 17:47:12.930 INFO Fetching http://169.254.169.254/metadata/instance/compute/vmSize?api-version=2017-08-01&format=text: Attempt #1
Nov 12 17:47:12.954218 update_engine[1508]: I20241112 17:47:12.804248 1508 main.cc:92] Flatcar Update Engine starting
Nov 12 17:47:12.954218 update_engine[1508]: I20241112 17:47:12.813503 1508 update_check_scheduler.cc:74] Next update check in 6m55s
Nov 12 17:47:12.954393 extend-filesystems[1498]: Old size kept for /dev/sda9
Nov 12 17:47:12.954393 extend-filesystems[1498]: Found sr0
Nov 12 17:47:12.793377 systemd[1]: Started dbus.service - D-Bus System Message Bus.
Nov 12 17:47:12.841384 chronyd[1544]: chronyd version 4.5 starting (+CMDMON +NTP +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +ASYNCDNS +NTS +SECHASH +IPV6 -DEBUG)
Nov 12 17:47:12.993906 jq[1532]: true
Nov 12 17:47:12.800058 systemd[1]: motdgen.service: Deactivated successfully.
Nov 12 17:47:12.855999 chronyd[1544]: Timezone right/UTC failed leap second check, ignoring
Nov 12 17:47:12.800227 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd.
Nov 12 17:47:12.856240 chronyd[1544]: Loaded seccomp filter (level 2)
Nov 12 17:47:12.800491 systemd[1]: Finished nvidia.service - NVIDIA Configure Service.
Nov 12 17:47:12.802351 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml).
Nov 12 17:47:12.802394 systemd[1]: Reached target system-config.target - Load system-provided cloud configs.
Nov 12 17:47:12.802476 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url).
Nov 12 17:47:12.802489 systemd[1]: Reached target user-config.target - Load user-provided cloud configs.
Nov 12 17:47:12.807734 (chronyd)[1493]: chronyd.service: Referenced but unset environment variable evaluates to an empty string: OPTIONS
Nov 12 17:47:12.813297 systemd[1]: Started update-engine.service - Update Engine.
Nov 12 17:47:12.823565 systemd[1]: Started locksmithd.service - Cluster reboot manager.
Nov 12 17:47:12.832420 systemd[1]: extend-filesystems.service: Deactivated successfully.
Nov 12 17:47:12.833965 systemd[1]: Finished extend-filesystems.service - Extend Filesystems.
Nov 12 17:47:12.861309 systemd[1]: Started chronyd.service - NTP client/server.
Nov 12 17:47:12.932061 systemd-logind[1506]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)
Nov 12 17:47:12.933266 systemd-logind[1506]: New seat seat0.
Nov 12 17:47:12.938167 systemd[1]: Started systemd-logind.service - User Login Management.
Nov 12 17:47:13.037828 coreos-metadata[1495]: Nov 12 17:47:13.025 INFO Fetch successful
Nov 12 17:47:13.028151 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition.
Nov 12 17:47:13.038256 bash[1566]: Updated "/home/core/.ssh/authorized_keys"
Nov 12 17:47:13.028742 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met.
Nov 12 17:47:13.062995 kernel: BTRFS warning: duplicate device /dev/sda3 devid 1 generation 40 scanned by (udev-worker) (1569)
Nov 12 17:47:13.083193 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent.
Nov 12 17:47:13.083620 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met.
Nov 12 17:47:13.090997 containerd[1524]: time="2024-11-12T17:47:13.089715340Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21
Nov 12 17:47:13.094270 locksmithd[1540]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot"
Nov 12 17:47:13.165933 containerd[1524]: time="2024-11-12T17:47:13.165810460Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1
Nov 12 17:47:13.170339 containerd[1524]: time="2024-11-12T17:47:13.170286580Z" 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/6.6.60-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1
Nov 12 17:47:13.170339 containerd[1524]: time="2024-11-12T17:47:13.170328060Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1
Nov 12 17:47:13.170339 containerd[1524]: time="2024-11-12T17:47:13.170345580Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1
Nov 12 17:47:13.170536 containerd[1524]: time="2024-11-12T17:47:13.170509540Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1
Nov 12 17:47:13.170583 containerd[1524]: time="2024-11-12T17:47:13.170537380Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1
Nov 12 17:47:13.170624 containerd[1524]: time="2024-11-12T17:47:13.170603100Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1
Nov 12 17:47:13.170624 containerd[1524]: time="2024-11-12T17:47:13.170621820Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1
Nov 12 17:47:13.171164 containerd[1524]: time="2024-11-12T17:47:13.171119100Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1
Nov 12 17:47:13.171317 containerd[1524]: time="2024-11-12T17:47:13.171245820Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1
Nov 12 17:47:13.171317 containerd[1524]: time="2024-11-12T17:47:13.171274900Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1
Nov 12 17:47:13.171317 containerd[1524]: time="2024-11-12T17:47:13.171293020Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1
Nov 12 17:47:13.171563 containerd[1524]: time="2024-11-12T17:47:13.171524700Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1
Nov 12 17:47:13.171952 containerd[1524]: time="2024-11-12T17:47:13.171882460Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1
Nov 12 17:47:13.172201 containerd[1524]: time="2024-11-12T17:47:13.172166860Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1
Nov 12 17:47:13.172271 containerd[1524]: time="2024-11-12T17:47:13.172250020Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1
Nov 12 17:47:13.172465 containerd[1524]: time="2024-11-12T17:47:13.172420420Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1
Nov 12 17:47:13.172598 containerd[1524]: time="2024-11-12T17:47:13.172553260Z" level=info msg="metadata content store policy set" policy=shared
Nov 12 17:47:13.186062 containerd[1524]: time="2024-11-12T17:47:13.185991700Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1
Nov 12 17:47:13.186302 containerd[1524]: time="2024-11-12T17:47:13.186204220Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1
Nov 12 17:47:13.186302 containerd[1524]: time="2024-11-12T17:47:13.186230500Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1
Nov 12 17:47:13.186628 containerd[1524]: time="2024-11-12T17:47:13.186386420Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1
Nov 12 17:47:13.186628 containerd[1524]: time="2024-11-12T17:47:13.186411100Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1
Nov 12 17:47:13.186628 containerd[1524]: time="2024-11-12T17:47:13.186577020Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1
Nov 12 17:47:13.186987 containerd[1524]: time="2024-11-12T17:47:13.186963420Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2
Nov 12 17:47:13.187166 containerd[1524]: time="2024-11-12T17:47:13.187146580Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2
Nov 12 17:47:13.187249 containerd[1524]: time="2024-11-12T17:47:13.187234580Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1
Nov 12 17:47:13.187332 containerd[1524]: time="2024-11-12T17:47:13.187317580Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1
Nov 12 17:47:13.187881 containerd[1524]: time="2024-11-12T17:47:13.187377820Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1
Nov 12 17:47:13.187881 containerd[1524]: time="2024-11-12T17:47:13.187401540Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1
Nov 12 17:47:13.187881 containerd[1524]: time="2024-11-12T17:47:13.187418620Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1
Nov 12 17:47:13.187881 containerd[1524]: time="2024-11-12T17:47:13.187432380Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1
Nov 12 17:47:13.187881 containerd[1524]: time="2024-11-12T17:47:13.187447060Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1
Nov 12 17:47:13.187881 containerd[1524]: time="2024-11-12T17:47:13.187461660Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1
Nov 12 17:47:13.187881 containerd[1524]: time="2024-11-12T17:47:13.187475740Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1
Nov 12 17:47:13.187881 containerd[1524]: time="2024-11-12T17:47:13.187487380Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1
Nov 12 17:47:13.187881 containerd[1524]: time="2024-11-12T17:47:13.187508380Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1
Nov 12 17:47:13.187881 containerd[1524]: time="2024-11-12T17:47:13.187521940Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1
Nov 12 17:47:13.187881 containerd[1524]: time="2024-11-12T17:47:13.187533940Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1
Nov 12 17:47:13.187881 containerd[1524]: time="2024-11-12T17:47:13.187552060Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1
Nov 12 17:47:13.187881 containerd[1524]: time="2024-11-12T17:47:13.187565260Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1
Nov 12 17:47:13.187881 containerd[1524]: time="2024-11-12T17:47:13.187579260Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1
Nov 12 17:47:13.188223 containerd[1524]: time="2024-11-12T17:47:13.187594700Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1
Nov 12 17:47:13.188223 containerd[1524]: time="2024-11-12T17:47:13.187607700Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1
Nov 12 17:47:13.188223 containerd[1524]: time="2024-11-12T17:47:13.187620820Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1
Nov 12 17:47:13.188223 containerd[1524]: time="2024-11-12T17:47:13.187635700Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1
Nov 12 17:47:13.188223 containerd[1524]: time="2024-11-12T17:47:13.187647220Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1
Nov 12 17:47:13.188223 containerd[1524]: time="2024-11-12T17:47:13.187658420Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1
Nov 12 17:47:13.188223 containerd[1524]: time="2024-11-12T17:47:13.187670700Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1
Nov 12 17:47:13.188223 containerd[1524]: time="2024-11-12T17:47:13.187686420Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1
Nov 12 17:47:13.188223 containerd[1524]: time="2024-11-12T17:47:13.187710900Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1
Nov 12 17:47:13.188223 containerd[1524]: time="2024-11-12T17:47:13.187722580Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1
Nov 12 17:47:13.188223 containerd[1524]: time="2024-11-12T17:47:13.187734420Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1
Nov 12 17:47:13.188991 containerd[1524]: time="2024-11-12T17:47:13.188965700Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1
Nov 12 17:47:13.189081 containerd[1524]: time="2024-11-12T17:47:13.189064620Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1
Nov 12 17:47:13.189132 containerd[1524]: time="2024-11-12T17:47:13.189119020Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1
Nov 12 17:47:13.189609 containerd[1524]: time="2024-11-12T17:47:13.189171460Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1
Nov 12 17:47:13.189609 containerd[1524]: time="2024-11-12T17:47:13.189187140Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1
Nov 12 17:47:13.189609 containerd[1524]: time="2024-11-12T17:47:13.189203580Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1
Nov 12 17:47:13.189609 containerd[1524]: time="2024-11-12T17:47:13.189214820Z" level=info msg="NRI interface is disabled by configuration."
Nov 12 17:47:13.189609 containerd[1524]: time="2024-11-12T17:47:13.189225140Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1
Nov 12 17:47:13.189745 containerd[1524]: time="2024-11-12T17:47:13.189500940Z" 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 PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false 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.8 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 EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}"
Nov 12 17:47:13.189745 containerd[1524]: time="2024-11-12T17:47:13.189562180Z" level=info msg="Connect containerd service"
Nov 12 17:47:13.189915 containerd[1524]: time="2024-11-12T17:47:13.189897980Z" level=info msg="using legacy CRI server"
Nov 12 17:47:13.190003 containerd[1524]: time="2024-11-12T17:47:13.189989020Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this"
Nov 12 17:47:13.190192 containerd[1524]: time="2024-11-12T17:47:13.190172740Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\""
Nov 12 17:47:13.190971 containerd[1524]: time="2024-11-12T17:47:13.190908540Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config"
Nov 12 17:47:13.191206 containerd[1524]: time="2024-11-12T17:47:13.191181020Z" level=info msg="Start subscribing containerd event"
Nov 12 17:47:13.191284 containerd[1524]: time="2024-11-12T17:47:13.191270220Z" level=info msg="Start recovering state"
Nov 12 17:47:13.191400 containerd[1524]: time="2024-11-12T17:47:13.191386380Z" level=info msg="Start event monitor"
Nov 12 17:47:13.191713 containerd[1524]: time="2024-11-12T17:47:13.191441340Z" level=info msg="Start snapshots syncer"
Nov 12 17:47:13.191713 containerd[1524]: time="2024-11-12T17:47:13.191454340Z" level=info msg="Start cni network conf syncer for default"
Nov 12 17:47:13.191713 containerd[1524]: time="2024-11-12T17:47:13.191462700Z" level=info msg="Start streaming server"
Nov 12 17:47:13.191986 containerd[1524]: time="2024-11-12T17:47:13.191968300Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc
Nov 12 17:47:13.192137 containerd[1524]: time="2024-11-12T17:47:13.192084300Z" level=info msg=serving... address=/run/containerd/containerd.sock
Nov 12 17:47:13.192348 systemd[1]: Started containerd.service - containerd container runtime.
Nov 12 17:47:13.193182 containerd[1524]: time="2024-11-12T17:47:13.192669980Z" level=info msg="containerd successfully booted in 0.104510s"
Nov 12 17:47:14.032801 sshd_keygen[1538]: ssh-keygen: generating new host keys: RSA ECDSA ED25519
Nov 12 17:47:14.052311 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys.
Nov 12 17:47:14.057242 systemd[1]: Starting issuegen.service - Generate /run/issue...
Nov 12 17:47:14.059262 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent...
Nov 12 17:47:14.066035 systemd[1]: issuegen.service: Deactivated successfully.
Nov 12 17:47:14.066254 systemd[1]: Finished issuegen.service - Generate /run/issue.
Nov 12 17:47:14.072236 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions...
Nov 12 17:47:14.085502 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions.
Nov 12 17:47:14.089478 systemd[1]: Started getty@tty1.service - Getty on tty1.
Nov 12 17:47:14.099298 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0.
Nov 12 17:47:14.099479 systemd[1]: Reached target getty.target - Login Prompts.
Nov 12 17:47:14.100911 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent.
Nov 12 17:47:14.102827 systemd[1]: Reached target multi-user.target - Multi-User System.
Nov 12 17:47:14.102988 systemd[1]: Startup finished in 379ms (kernel) + 10.304s (initrd) + 11.826s (userspace) = 22.510s.
Nov 12 17:47:14.211289 login[1635]: pam_unix(login:session): session opened for user core(uid=500) by core(uid=0)
Nov 12 17:47:14.212782 login[1637]: pam_unix(login:session): session opened for user core(uid=500) by core(uid=0)
Nov 12 17:47:14.222091 systemd-logind[1506]: New session 2 of user core.
Nov 12 17:47:14.223612 systemd[1]: Created slice user-500.slice - User Slice of UID 500.
Nov 12 17:47:14.230225 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500...
Nov 12 17:47:14.238345 systemd-logind[1506]: New session 1 of user core.
Nov 12 17:47:14.250880 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500.
Nov 12 17:47:14.261345 systemd[1]: Starting user@500.service - User Manager for UID 500...
Nov 12 17:47:14.268503 (systemd)[1646]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0)
Nov 12 17:47:14.419534 systemd[1646]: Queued start job for default target default.target.
Nov 12 17:47:14.425061 systemd[1646]: Created slice app.slice - User Application Slice.
Nov 12 17:47:14.425089 systemd[1646]: Reached target paths.target - Paths.
Nov 12 17:47:14.425102 systemd[1646]: Reached target timers.target - Timers.
Nov 12 17:47:14.426361 systemd[1646]: Starting dbus.socket - D-Bus User Message Bus Socket...
Nov 12 17:47:14.447409 systemd[1646]: Listening on dbus.socket - D-Bus User Message Bus Socket.
Nov 12 17:47:14.447547 systemd[1646]: Reached target sockets.target - Sockets.
Nov 12 17:47:14.447561 systemd[1646]: Reached target basic.target - Basic System.
Nov 12 17:47:14.447602 systemd[1646]: Reached target default.target - Main User Target.
Nov 12 17:47:14.447628 systemd[1646]: Startup finished in 173ms.
Nov 12 17:47:14.447724 systemd[1]: Started user@500.service - User Manager for UID 500.
Nov 12 17:47:14.457178 systemd[1]: Started session-1.scope - Session 1 of User core.
Nov 12 17:47:14.457915 systemd[1]: Started session-2.scope - Session 2 of User core.
Nov 12 17:47:14.873991 waagent[1638]: 2024-11-12T17:47:14.873235Z INFO Daemon Daemon Azure Linux Agent Version: 2.9.1.1
Nov 12 17:47:14.878782 waagent[1638]: 2024-11-12T17:47:14.878716Z INFO Daemon Daemon OS: flatcar 4081.2.0
Nov 12 17:47:14.883330 waagent[1638]: 2024-11-12T17:47:14.883276Z INFO Daemon Daemon Python: 3.11.9
Nov 12 17:47:14.887627 waagent[1638]: 2024-11-12T17:47:14.887428Z INFO Daemon Daemon Run daemon
Nov 12 17:47:14.891329 waagent[1638]: 2024-11-12T17:47:14.891283Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='4081.2.0'
Nov 12 17:47:14.900309 waagent[1638]: 2024-11-12T17:47:14.900249Z INFO Daemon Daemon Using waagent for provisioning
Nov 12 17:47:14.905381 waagent[1638]: 2024-11-12T17:47:14.905338Z INFO Daemon Daemon Activate resource disk
Nov 12 17:47:14.909817 waagent[1638]: 2024-11-12T17:47:14.909771Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb
Nov 12 17:47:14.920956 waagent[1638]: 2024-11-12T17:47:14.920882Z INFO Daemon Daemon Found device: None
Nov 12 17:47:14.925270 waagent[1638]: 2024-11-12T17:47:14.925222Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology
Nov 12 17:47:14.933377 waagent[1638]: 2024-11-12T17:47:14.933323Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0
Nov 12 17:47:14.945802 waagent[1638]: 2024-11-12T17:47:14.945745Z INFO Daemon Daemon Clean protocol and wireserver endpoint
Nov 12 17:47:14.951501 waagent[1638]: 2024-11-12T17:47:14.951451Z INFO Daemon Daemon Running default provisioning handler
Nov 12 17:47:14.963185 waagent[1638]: 2024-11-12T17:47:14.963105Z 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 4.
Nov 12 17:47:14.976807 waagent[1638]: 2024-11-12T17:47:14.976738Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service'
Nov 12 17:47:14.989228 waagent[1638]: 2024-11-12T17:47:14.989170Z INFO Daemon Daemon cloud-init is enabled: False
Nov 12 17:47:14.994537 waagent[1638]: 2024-11-12T17:47:14.994482Z INFO Daemon Daemon Copying ovf-env.xml
Nov 12 17:47:15.048223 waagent[1638]: 2024-11-12T17:47:15.048124Z INFO Daemon Daemon Successfully mounted dvd
Nov 12 17:47:15.102014 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully.
Nov 12 17:47:15.102884 waagent[1638]: 2024-11-12T17:47:15.102324Z INFO Daemon Daemon Detect protocol endpoint
Nov 12 17:47:15.107691 waagent[1638]: 2024-11-12T17:47:15.107621Z INFO Daemon Daemon Clean protocol and wireserver endpoint
Nov 12 17:47:15.113555 waagent[1638]: 2024-11-12T17:47:15.113485Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler
Nov 12 17:47:15.120375 waagent[1638]: 2024-11-12T17:47:15.120312Z INFO Daemon Daemon Test for route to 168.63.129.16
Nov 12 17:47:15.125742 waagent[1638]: 2024-11-12T17:47:15.125644Z INFO Daemon Daemon Route to 168.63.129.16 exists
Nov 12 17:47:15.130652 waagent[1638]: 2024-11-12T17:47:15.130600Z INFO Daemon Daemon Wire server endpoint:168.63.129.16
Nov 12 17:47:15.214043 waagent[1638]: 2024-11-12T17:47:15.213982Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05
Nov 12 17:47:15.221256 waagent[1638]: 2024-11-12T17:47:15.221226Z INFO Daemon Daemon Wire protocol version:2012-11-30
Nov 12 17:47:15.226842 waagent[1638]: 2024-11-12T17:47:15.226784Z INFO Daemon Daemon Server preferred version:2015-04-05
Nov 12 17:47:15.601143 waagent[1638]: 2024-11-12T17:47:15.600988Z INFO Daemon Daemon Initializing goal state during protocol detection
Nov 12 17:47:15.607719 waagent[1638]: 2024-11-12T17:47:15.607643Z INFO Daemon Daemon Forcing an update of the goal state.
Nov 12 17:47:15.617196 waagent[1638]: 2024-11-12T17:47:15.617135Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1]
Nov 12 17:47:15.661369 waagent[1638]: 2024-11-12T17:47:15.661315Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.159
Nov 12 17:47:15.667556 waagent[1638]: 2024-11-12T17:47:15.667497Z INFO Daemon
Nov 12 17:47:15.670546 waagent[1638]: 2024-11-12T17:47:15.670491Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: e9fa0d30-6e23-4d6d-8d01-1bd2eb69e617 eTag: 12515893000576337480 source: Fabric]
Nov 12 17:47:15.682456 waagent[1638]: 2024-11-12T17:47:15.682400Z INFO Daemon The vmSettings originated via Fabric; will ignore them.
Nov 12 17:47:15.689342 waagent[1638]: 2024-11-12T17:47:15.689287Z INFO Daemon
Nov 12 17:47:15.692315 waagent[1638]: 2024-11-12T17:47:15.692265Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1]
Nov 12 17:47:15.703434 waagent[1638]: 2024-11-12T17:47:15.703393Z INFO Daemon Daemon Downloading artifacts profile blob
Nov 12 17:47:15.801702 waagent[1638]: 2024-11-12T17:47:15.801609Z INFO Daemon Downloaded certificate {'thumbprint': '3363BA2F025F62D18B69832F9FE20DE54AD85864', 'hasPrivateKey': True}
Nov 12 17:47:15.811519 waagent[1638]: 2024-11-12T17:47:15.811462Z INFO Daemon Downloaded certificate {'thumbprint': '1E487D3386EC2C7780EC44EFF9AA78856CB17520', 'hasPrivateKey': False}
Nov 12 17:47:15.821801 waagent[1638]: 2024-11-12T17:47:15.821742Z INFO Daemon Fetch goal state completed
Nov 12 17:47:15.833400 waagent[1638]: 2024-11-12T17:47:15.833343Z INFO Daemon Daemon Starting provisioning
Nov 12 17:47:15.839418 waagent[1638]: 2024-11-12T17:47:15.839325Z INFO Daemon Daemon Handle ovf-env.xml.
Nov 12 17:47:15.844443 waagent[1638]: 2024-11-12T17:47:15.844387Z INFO Daemon Daemon Set hostname [ci-4081.2.0-a-d5417ce23b]
Nov 12 17:47:15.852543 waagent[1638]: 2024-11-12T17:47:15.852468Z INFO Daemon Daemon Publish hostname [ci-4081.2.0-a-d5417ce23b]
Nov 12 17:47:15.859691 waagent[1638]: 2024-11-12T17:47:15.859621Z INFO Daemon Daemon Examine /proc/net/route for primary interface
Nov 12 17:47:15.866741 waagent[1638]: 2024-11-12T17:47:15.866679Z INFO Daemon Daemon Primary interface is [eth0]
Nov 12 17:47:15.887964 systemd-networkd[1385]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
Nov 12 17:47:15.887972 systemd-networkd[1385]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
Nov 12 17:47:15.887999 systemd-networkd[1385]: eth0: DHCP lease lost
Nov 12 17:47:15.889114 waagent[1638]: 2024-11-12T17:47:15.888615Z INFO Daemon Daemon Create user account if not exists
Nov 12 17:47:15.894499 waagent[1638]: 2024-11-12T17:47:15.894432Z INFO Daemon Daemon User core already exists, skip useradd
Nov 12 17:47:15.900908 waagent[1638]: 2024-11-12T17:47:15.900844Z INFO Daemon Daemon Configure sudoer
Nov 12 17:47:15.905176 systemd-networkd[1385]: eth0: DHCPv6 lease lost
Nov 12 17:47:15.905857 waagent[1638]: 2024-11-12T17:47:15.905758Z INFO Daemon Daemon Configure sshd
Nov 12 17:47:15.911762 waagent[1638]: 2024-11-12T17:47:15.911660Z INFO Daemon Daemon Added a configuration snippet disabling SSH password-based authentication methods. It also configures SSH client probing to keep connections alive.
Nov 12 17:47:15.924401 waagent[1638]: 2024-11-12T17:47:15.924324Z INFO Daemon Daemon Deploy ssh public key.
Nov 12 17:47:15.935972 systemd-networkd[1385]: eth0: DHCPv4 address 10.200.20.49/24, gateway 10.200.20.1 acquired from 168.63.129.16
Nov 12 17:47:17.011850 waagent[1638]: 2024-11-12T17:47:17.011797Z INFO Daemon Daemon Provisioning complete
Nov 12 17:47:17.028380 waagent[1638]: 2024-11-12T17:47:17.028331Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping
Nov 12 17:47:17.035101 waagent[1638]: 2024-11-12T17:47:17.035037Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions.
Nov 12 17:47:17.045616 waagent[1638]: 2024-11-12T17:47:17.045552Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.9.1.1 is the most current agent
Nov 12 17:47:17.182932 waagent[1700]: 2024-11-12T17:47:17.182245Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.9.1.1)
Nov 12 17:47:17.182932 waagent[1700]: 2024-11-12T17:47:17.182397Z INFO ExtHandler ExtHandler OS: flatcar 4081.2.0
Nov 12 17:47:17.182932 waagent[1700]: 2024-11-12T17:47:17.182450Z INFO ExtHandler ExtHandler Python: 3.11.9
Nov 12 17:47:17.199976 waagent[1700]: 2024-11-12T17:47:17.199638Z INFO ExtHandler ExtHandler Distro: flatcar-4081.2.0; OSUtil: FlatcarUtil; AgentService: waagent; Python: 3.11.9; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.20.1;
Nov 12 17:47:17.199976 waagent[1700]: 2024-11-12T17:47:17.199876Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file
Nov 12 17:47:17.200140 waagent[1700]: 2024-11-12T17:47:17.199977Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16
Nov 12 17:47:17.209051 waagent[1700]: 2024-11-12T17:47:17.208967Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1]
Nov 12 17:47:17.218731 waagent[1700]: 2024-11-12T17:47:17.218679Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.159
Nov 12 17:47:17.219312 waagent[1700]: 2024-11-12T17:47:17.219263Z INFO ExtHandler
Nov 12 17:47:17.219386 waagent[1700]: 2024-11-12T17:47:17.219353Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: a9e6a7e4-927e-450f-bf7a-9c64d77fbedb eTag: 12515893000576337480 source: Fabric]
Nov 12 17:47:17.219692 waagent[1700]: 2024-11-12T17:47:17.219650Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them.
Nov 12 17:47:17.220291 waagent[1700]: 2024-11-12T17:47:17.220242Z INFO ExtHandler
Nov 12 17:47:17.220357 waagent[1700]: 2024-11-12T17:47:17.220327Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1]
Nov 12 17:47:17.224460 waagent[1700]: 2024-11-12T17:47:17.224422Z INFO ExtHandler ExtHandler Downloading artifacts profile blob
Nov 12 17:47:17.309301 waagent[1700]: 2024-11-12T17:47:17.309170Z INFO ExtHandler Downloaded certificate {'thumbprint': '3363BA2F025F62D18B69832F9FE20DE54AD85864', 'hasPrivateKey': True}
Nov 12 17:47:17.309680 waagent[1700]: 2024-11-12T17:47:17.309634Z INFO ExtHandler Downloaded certificate {'thumbprint': '1E487D3386EC2C7780EC44EFF9AA78856CB17520', 'hasPrivateKey': False}
Nov 12 17:47:17.310104 waagent[1700]: 2024-11-12T17:47:17.310063Z INFO ExtHandler Fetch goal state completed
Nov 12 17:47:17.324475 waagent[1700]: 2024-11-12T17:47:17.324416Z INFO ExtHandler ExtHandler WALinuxAgent-2.9.1.1 running as process 1700
Nov 12 17:47:17.324629 waagent[1700]: 2024-11-12T17:47:17.324596Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ********
Nov 12 17:47:17.326261 waagent[1700]: 2024-11-12T17:47:17.326215Z INFO ExtHandler ExtHandler Cgroup monitoring is not supported on ['flatcar', '4081.2.0', '', 'Flatcar Container Linux by Kinvolk']
Nov 12 17:47:17.326646 waagent[1700]: 2024-11-12T17:47:17.326610Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules
Nov 12 17:47:17.333970 waagent[1700]: 2024-11-12T17:47:17.333905Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service
Nov 12 17:47:17.334179 waagent[1700]: 2024-11-12T17:47:17.334137Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup
Nov 12 17:47:17.340159 waagent[1700]: 2024-11-12T17:47:17.340112Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now
Nov 12 17:47:17.347249 systemd[1]: Reloading requested from client PID 1715 ('systemctl') (unit waagent.service)...
Nov 12 17:47:17.347266 systemd[1]: Reloading...
Nov 12 17:47:17.408955 zram_generator::config[1748]: No configuration found.
Nov 12 17:47:17.526319 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly.
Nov 12 17:47:17.603356 systemd[1]: Reloading finished in 255 ms.
Nov 12 17:47:17.626528 waagent[1700]: 2024-11-12T17:47:17.626155Z INFO ExtHandler ExtHandler Executing systemctl daemon-reload for setting up waagent-network-setup.service
Nov 12 17:47:17.633419 systemd[1]: Reloading requested from client PID 1806 ('systemctl') (unit waagent.service)...
Nov 12 17:47:17.633436 systemd[1]: Reloading...
Nov 12 17:47:17.694991 zram_generator::config[1837]: No configuration found.
Nov 12 17:47:17.805810 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly.
Nov 12 17:47:17.882442 systemd[1]: Reloading finished in 248 ms.
Nov 12 17:47:17.907841 waagent[1700]: 2024-11-12T17:47:17.907071Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service
Nov 12 17:47:17.907841 waagent[1700]: 2024-11-12T17:47:17.907246Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully
Nov 12 17:47:17.995131 waagent[1700]: 2024-11-12T17:47:17.995051Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up.
Nov 12 17:47:17.995858 waagent[1700]: 2024-11-12T17:47:17.995812Z 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]
Nov 12 17:47:17.996773 waagent[1700]: 2024-11-12T17:47:17.996721Z INFO ExtHandler ExtHandler Starting env monitor service.
Nov 12 17:47:17.996885 waagent[1700]: 2024-11-12T17:47:17.996838Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file
Nov 12 17:47:17.996985 waagent[1700]: 2024-11-12T17:47:17.996948Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16
Nov 12 17:47:17.997230 waagent[1700]: 2024-11-12T17:47:17.997184Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled.
Nov 12 17:47:17.997771 waagent[1700]: 2024-11-12T17:47:17.997712Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service.
Nov 12 17:47:17.998028 waagent[1700]: 2024-11-12T17:47:17.997956Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route:
Nov 12 17:47:17.998028 waagent[1700]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT
Nov 12 17:47:17.998028 waagent[1700]: eth0 00000000 0114C80A 0003 0 0 1024 00000000 0 0 0
Nov 12 17:47:17.998028 waagent[1700]: eth0 0014C80A 00000000 0001 0 0 1024 00FFFFFF 0 0 0
Nov 12 17:47:17.998028 waagent[1700]: eth0 0114C80A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0
Nov 12 17:47:17.998028 waagent[1700]: eth0 10813FA8 0114C80A 0007 0 0 1024 FFFFFFFF 0 0 0
Nov 12 17:47:17.998028 waagent[1700]: eth0 FEA9FEA9 0114C80A 0007 0 0 1024 FFFFFFFF 0 0 0
Nov 12 17:47:17.998664 waagent[1700]: 2024-11-12T17:47:17.998562Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread
Nov 12 17:47:17.998756 waagent[1700]: 2024-11-12T17:47:17.998678Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file
Nov 12 17:47:17.998831 waagent[1700]: 2024-11-12T17:47:17.998796Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16
Nov 12 17:47:17.999129 waagent[1700]: 2024-11-12T17:47:17.999019Z INFO EnvHandler ExtHandler Configure routes
Nov 12 17:47:17.999129 waagent[1700]: 2024-11-12T17:47:17.999080Z INFO ExtHandler ExtHandler Start Extension Telemetry service.
Nov 12 17:47:17.999425 waagent[1700]: 2024-11-12T17:47:17.999375Z INFO EnvHandler ExtHandler Gateway:None
Nov 12 17:47:17.999814 waagent[1700]: 2024-11-12T17:47:17.999747Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True
Nov 12 17:47:17.999926 waagent[1700]: 2024-11-12T17:47:17.999870Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status.
Nov 12 17:47:18.000184 waagent[1700]: 2024-11-12T17:47:18.000099Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread
Nov 12 17:47:18.000184 waagent[1700]: 2024-11-12T17:47:17.999988Z INFO EnvHandler ExtHandler Routes:None
Nov 12 17:47:18.007631 waagent[1700]: 2024-11-12T17:47:18.007503Z INFO ExtHandler ExtHandler
Nov 12 17:47:18.009965 waagent[1700]: 2024-11-12T17:47:18.009086Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: ad267a8a-d6da-425e-9348-dacb72aef6f4 correlation ccc9a472-a847-4186-bc6a-2425da44cea8 created: 2024-11-12T17:45:46.543182Z]
Nov 12 17:47:18.009965 waagent[1700]: 2024-11-12T17:47:18.009497Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything.
Nov 12 17:47:18.010487 waagent[1700]: 2024-11-12T17:47:18.010428Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 2 ms]
Nov 12 17:47:18.030789 waagent[1700]: 2024-11-12T17:47:18.030709Z INFO MonitorHandler ExtHandler Network interfaces:
Nov 12 17:47:18.030789 waagent[1700]: Executing ['ip', '-a', '-o', 'link']:
Nov 12 17:47:18.030789 waagent[1700]: 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
Nov 12 17:47:18.030789 waagent[1700]: 2: eth0: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 00:0d:3a:f7:1f:ed brd ff:ff:ff:ff:ff:ff
Nov 12 17:47:18.030789 waagent[1700]: 3: enP10189s1: <BROADCAST,MULTICAST,SLAVE,UP,LOWER_UP> mtu 1500 qdisc mq master eth0 state UP mode DEFAULT group default qlen 1000\ link/ether 00:0d:3a:f7:1f:ed brd ff:ff:ff:ff:ff:ff\ altname enP10189p0s2
Nov 12 17:47:18.030789 waagent[1700]: Executing ['ip', '-4', '-a', '-o', 'address']:
Nov 12 17:47:18.030789 waagent[1700]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever
Nov 12 17:47:18.030789 waagent[1700]: 2: eth0 inet 10.200.20.49/24 metric 1024 brd 10.200.20.255 scope global eth0\ valid_lft forever preferred_lft forever
Nov 12 17:47:18.030789 waagent[1700]: Executing ['ip', '-6', '-a', '-o', 'address']:
Nov 12 17:47:18.030789 waagent[1700]: 1: lo inet6 ::1/128 scope host noprefixroute \ valid_lft forever preferred_lft forever
Nov 12 17:47:18.030789 waagent[1700]: 2: eth0 inet6 fe80::20d:3aff:fef7:1fed/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever
Nov 12 17:47:18.030789 waagent[1700]: 3: enP10189s1 inet6 fe80::20d:3aff:fef7:1fed/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever
Nov 12 17:47:18.074819 waagent[1700]: 2024-11-12T17:47:18.074736Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.9.1.1 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: FF1D0FF4-1979-4760-A707-32A2619019F9;DroppedPackets: 0;UpdateGSErrors: 0;AutoUpdate: 0]
Nov 12 17:47:18.083880 waagent[1700]: 2024-11-12T17:47:18.083801Z INFO EnvHandler ExtHandler Successfully added Azure fabric firewall rules. Current Firewall rules:
Nov 12 17:47:18.083880 waagent[1700]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes)
Nov 12 17:47:18.083880 waagent[1700]: pkts bytes target prot opt in out source destination
Nov 12 17:47:18.083880 waagent[1700]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes)
Nov 12 17:47:18.083880 waagent[1700]: pkts bytes target prot opt in out source destination
Nov 12 17:47:18.083880 waagent[1700]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes)
Nov 12 17:47:18.083880 waagent[1700]: pkts bytes target prot opt in out source destination
Nov 12 17:47:18.083880 waagent[1700]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53
Nov 12 17:47:18.083880 waagent[1700]: 3 164 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0
Nov 12 17:47:18.083880 waagent[1700]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW
Nov 12 17:47:18.087011 waagent[1700]: 2024-11-12T17:47:18.086936Z INFO EnvHandler ExtHandler Current Firewall rules:
Nov 12 17:47:18.087011 waagent[1700]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes)
Nov 12 17:47:18.087011 waagent[1700]: pkts bytes target prot opt in out source destination
Nov 12 17:47:18.087011 waagent[1700]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes)
Nov 12 17:47:18.087011 waagent[1700]: pkts bytes target prot opt in out source destination
Nov 12 17:47:18.087011 waagent[1700]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes)
Nov 12 17:47:18.087011 waagent[1700]: pkts bytes target prot opt in out source destination
Nov 12 17:47:18.087011 waagent[1700]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53
Nov 12 17:47:18.087011 waagent[1700]: 10 1045 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0
Nov 12 17:47:18.087011 waagent[1700]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW
Nov 12 17:47:18.087270 waagent[1700]: 2024-11-12T17:47:18.087232Z INFO EnvHandler ExtHandler Set block dev timeout: sda with timeout: 300
Nov 12 17:47:36.640468 chronyd[1544]: Selected source PHC0
Nov 12 17:47:54.171197 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd.
Nov 12 17:47:54.179386 systemd[1]: Started sshd@0-10.200.20.49:22-10.200.16.10:48650.service - OpenSSH per-connection server daemon (10.200.16.10:48650).
Nov 12 17:47:54.645591 sshd[1929]: Accepted publickey for core from 10.200.16.10 port 48650 ssh2: RSA SHA256:TIkrWVWjrNI/pejEA/uIpX6ZyC4H86o4M+609uLmOY0
Nov 12 17:47:54.646940 sshd[1929]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
Nov 12 17:47:54.651440 systemd-logind[1506]: New session 3 of user core.
Nov 12 17:47:54.657108 systemd[1]: Started session-3.scope - Session 3 of User core.
Nov 12 17:47:55.069227 systemd[1]: Started sshd@1-10.200.20.49:22-10.200.16.10:48658.service - OpenSSH per-connection server daemon (10.200.16.10:48658).
Nov 12 17:47:55.517549 sshd[1934]: Accepted publickey for core from 10.200.16.10 port 48658 ssh2: RSA SHA256:TIkrWVWjrNI/pejEA/uIpX6ZyC4H86o4M+609uLmOY0
Nov 12 17:47:55.518839 sshd[1934]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
Nov 12 17:47:55.523758 systemd-logind[1506]: New session 4 of user core.
Nov 12 17:47:55.530153 systemd[1]: Started session-4.scope - Session 4 of User core.
Nov 12 17:47:55.843463 sshd[1934]: pam_unix(sshd:session): session closed for user core
Nov 12 17:47:55.847169 systemd[1]: sshd@1-10.200.20.49:22-10.200.16.10:48658.service: Deactivated successfully.
Nov 12 17:47:55.848858 systemd[1]: session-4.scope: Deactivated successfully.
Nov 12 17:47:55.849561 systemd-logind[1506]: Session 4 logged out. Waiting for processes to exit.
Nov 12 17:47:55.850880 systemd-logind[1506]: Removed session 4.
Nov 12 17:47:55.912516 systemd[1]: Started sshd@2-10.200.20.49:22-10.200.16.10:48666.service - OpenSSH per-connection server daemon (10.200.16.10:48666).
Nov 12 17:47:56.326627 sshd[1941]: Accepted publickey for core from 10.200.16.10 port 48666 ssh2: RSA SHA256:TIkrWVWjrNI/pejEA/uIpX6ZyC4H86o4M+609uLmOY0
Nov 12 17:47:56.327915 sshd[1941]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
Nov 12 17:47:56.331552 systemd-logind[1506]: New session 5 of user core.
Nov 12 17:47:56.342085 systemd[1]: Started session-5.scope - Session 5 of User core.
Nov 12 17:47:56.642870 sshd[1941]: pam_unix(sshd:session): session closed for user core
Nov 12 17:47:56.646559 systemd[1]: sshd@2-10.200.20.49:22-10.200.16.10:48666.service: Deactivated successfully.
Nov 12 17:47:56.648243 systemd[1]: session-5.scope: Deactivated successfully.
Nov 12 17:47:56.648912 systemd-logind[1506]: Session 5 logged out. Waiting for processes to exit.
Nov 12 17:47:56.649854 systemd-logind[1506]: Removed session 5.
Nov 12 17:47:56.728820 systemd[1]: Started sshd@3-10.200.20.49:22-10.200.16.10:48668.service - OpenSSH per-connection server daemon (10.200.16.10:48668).
Nov 12 17:47:57.173958 sshd[1948]: Accepted publickey for core from 10.200.16.10 port 48668 ssh2: RSA SHA256:TIkrWVWjrNI/pejEA/uIpX6ZyC4H86o4M+609uLmOY0
Nov 12 17:47:57.175260 sshd[1948]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
Nov 12 17:47:57.179150 systemd-logind[1506]: New session 6 of user core.
Nov 12 17:47:57.190084 systemd[1]: Started session-6.scope - Session 6 of User core.
Nov 12 17:47:57.210877 kernel: hv_balloon: Max. dynamic memory size: 4096 MB
Nov 12 17:47:57.515957 sshd[1948]: pam_unix(sshd:session): session closed for user core
Nov 12 17:47:57.519089 systemd-logind[1506]: Session 6 logged out. Waiting for processes to exit.
Nov 12 17:47:57.519102 systemd[1]: session-6.scope: Deactivated successfully.
Nov 12 17:47:57.520583 systemd[1]: sshd@3-10.200.20.49:22-10.200.16.10:48668.service: Deactivated successfully.
Nov 12 17:47:57.583440 systemd[1]: Started sshd@4-10.200.20.49:22-10.200.16.10:48682.service - OpenSSH per-connection server daemon (10.200.16.10:48682).
Nov 12 17:47:57.594512 update_engine[1508]: I20241112 17:47:57.593962 1508 update_attempter.cc:509] Updating boot flags...
Nov 12 17:47:57.628961 kernel: BTRFS warning: duplicate device /dev/sda3 devid 1 generation 40 scanned by (udev-worker) (1969)
Nov 12 17:47:57.992616 sshd[1955]: Accepted publickey for core from 10.200.16.10 port 48682 ssh2: RSA SHA256:TIkrWVWjrNI/pejEA/uIpX6ZyC4H86o4M+609uLmOY0
Nov 12 17:47:57.994145 sshd[1955]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
Nov 12 17:47:57.998441 systemd-logind[1506]: New session 7 of user core.
Nov 12 17:47:58.007112 systemd[1]: Started session-7.scope - Session 7 of User core.
Nov 12 17:47:58.259703 sudo[1997]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1
Nov 12 17:47:58.260054 sudo[1997]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500)
Nov 12 17:47:58.280450 sudo[1997]: pam_unix(sudo:session): session closed for user root
Nov 12 17:47:58.363137 sshd[1955]: pam_unix(sshd:session): session closed for user core
Nov 12 17:47:58.367462 systemd[1]: sshd@4-10.200.20.49:22-10.200.16.10:48682.service: Deactivated successfully.
Nov 12 17:47:58.369420 systemd[1]: session-7.scope: Deactivated successfully.
Nov 12 17:47:58.371576 systemd-logind[1506]: Session 7 logged out. Waiting for processes to exit.
Nov 12 17:47:58.372606 systemd-logind[1506]: Removed session 7.
Nov 12 17:47:58.459044 systemd[1]: Started sshd@5-10.200.20.49:22-10.200.16.10:36928.service - OpenSSH per-connection server daemon (10.200.16.10:36928).
Nov 12 17:47:58.938887 sshd[2002]: Accepted publickey for core from 10.200.16.10 port 36928 ssh2: RSA SHA256:TIkrWVWjrNI/pejEA/uIpX6ZyC4H86o4M+609uLmOY0
Nov 12 17:47:58.940266 sshd[2002]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
Nov 12 17:47:58.944112 systemd-logind[1506]: New session 8 of user core.
Nov 12 17:47:58.952099 systemd[1]: Started session-8.scope - Session 8 of User core.
Nov 12 17:47:59.210282 sudo[2006]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules
Nov 12 17:47:59.210906 sudo[2006]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500)
Nov 12 17:47:59.214292 sudo[2006]: pam_unix(sudo:session): session closed for user root
Nov 12 17:47:59.219366 sudo[2005]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules
Nov 12 17:47:59.219638 sudo[2005]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500)
Nov 12 17:47:59.236477 systemd[1]: Stopping audit-rules.service - Load Security Auditing Rules...
Nov 12 17:47:59.237716 auditctl[2009]: No rules
Nov 12 17:47:59.238117 systemd[1]: audit-rules.service: Deactivated successfully.
Nov 12 17:47:59.238291 systemd[1]: Stopped audit-rules.service - Load Security Auditing Rules.
Nov 12 17:47:59.241372 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules...
Nov 12 17:47:59.267321 augenrules[2027]: No rules
Nov 12 17:47:59.268598 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules.
Nov 12 17:47:59.270087 sudo[2005]: pam_unix(sudo:session): session closed for user root
Nov 12 17:47:59.357813 sshd[2002]: pam_unix(sshd:session): session closed for user core
Nov 12 17:47:59.363186 systemd[1]: sshd@5-10.200.20.49:22-10.200.16.10:36928.service: Deactivated successfully.
Nov 12 17:47:59.364825 systemd[1]: session-8.scope: Deactivated successfully.
Nov 12 17:47:59.366676 systemd-logind[1506]: Session 8 logged out. Waiting for processes to exit.
Nov 12 17:47:59.367845 systemd-logind[1506]: Removed session 8.
Nov 12 17:47:59.442250 systemd[1]: Started sshd@6-10.200.20.49:22-10.200.16.10:36942.service - OpenSSH per-connection server daemon (10.200.16.10:36942).
Nov 12 17:47:59.888194 sshd[2035]: Accepted publickey for core from 10.200.16.10 port 36942 ssh2: RSA SHA256:TIkrWVWjrNI/pejEA/uIpX6ZyC4H86o4M+609uLmOY0
Nov 12 17:47:59.889496 sshd[2035]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
Nov 12 17:47:59.894850 systemd-logind[1506]: New session 9 of user core.
Nov 12 17:47:59.901147 systemd[1]: Started session-9.scope - Session 9 of User core.
Nov 12 17:48:00.231153 sshd[2035]: pam_unix(sshd:session): session closed for user core
Nov 12 17:48:00.234620 systemd[1]: sshd@6-10.200.20.49:22-10.200.16.10:36942.service: Deactivated successfully.
Nov 12 17:48:00.236550 systemd[1]: session-9.scope: Deactivated successfully.
Nov 12 17:48:00.238661 systemd-logind[1506]: Session 9 logged out. Waiting for processes to exit.
Nov 12 17:48:00.239730 systemd-logind[1506]: Removed session 9.