[=3hWelcome to GRUB! check_signatures=no cmddevice=hd0,gpt1 cmdpath=(hd0,gpt1)/EFI/BOOT color_highlight=black/light-gray color_normal=light-gray/black feature_200_final=y feature_all_video_module=y feature_chainloader_bpb=y feature_default_font_path=y feature_menuentry_id=y feature_menuentry_options=y feature_nativedisk_cmd=y feature_ntldr=y feature_platform_search_hint=y feature_timeout_style=y grub_cpu=arm64 grub_platform=efi lang= locale_dir= net_default_ip=(null) net_default_mac=(null) net_default_server= pager= prefix=(memdisk) pxe_default_server= root=hd0,gpt1 secondary_locale_dir= error: serial port `com0' isn't found. error: terminal `serial' isn't found. error: terminal `serial' isn't found. GNU GRUB version 2.02 ┌────────────────────────────────────────────────────────────────────────────┐││││││││││││││││││││││││││└────────────────────────────────────────────────────────────────────────────┘ Use the ▲ and ▼ keys to select which entry is highlighted. Press enter to boot the selected OS, `e' to edit the commands before booting or `c' for a command-line.  *Flatcar default  Flatcar USR-A  Flatcar USR-B             The highlighted entry will be executed automatically in 1s.  The highlighted entry will be executed automatically in 0s.  Booting `Flatcar default' EFI stub: Booting Linux Kernel... EFI stub: Using DTB from configuration table EFI stub: Exiting boot services... [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] [ 0.000000] Linux version 5.15.148-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 11.3.1_p20221209 p3) 11.3.1 20221209, GNU ld (Gentoo 2.39 p5) 2.39.0) #1 SMP PREEMPT Fri Feb 9 17:24:35 -00 2024 [ 0.000000] earlycon: pl11 at MMIO 0x00000000effec000 (options '') [ 0.000000] printk: bootconsole [pl11] enabled [ 0.000000] efi: EFI v2.70 by EDK II [ 0.000000] efi: ACPI 2.0=0x3fd89018 SMBIOS=0x3fd66000 SMBIOS 3.0=0x3fd64000 MEMATTR=0x3ef3c198 RNG=0x3fd89998 MEMRESERVE=0x37e73f98 [ 0.000000] random: crng init done [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x000000003FD89018 000024 (v02 VRTUAL) [ 0.000000] ACPI: XSDT 0x000000003FD89F18 00006C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: FACP 0x000000003FD89C18 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: DSDT 0x000000003EBD2018 01DEC0 (v02 MSFTVM DSDT01 00000001 MSFT 05000000) [ 0.000000] ACPI: DBG2 0x000000003FD89B18 000072 (v00 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: GTDT 0x000000003FD89D98 000060 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: OEM0 0x000000003FD89098 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: SPCR 0x000000003FD89A98 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: APIC 0x000000003FD89818 0000FC (v04 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: SRAT 0x000000003FD89198 000234 (v03 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: PPTT 0x000000003FD89418 000120 (v01 VRTUAL MICROSFT 00000000 MSFT 00000000) [ 0.000000] ACPI: BGRT 0x000000003FD89E98 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: SPCR: console: pl011,mmio32,0xeffec000,115200 [ 0.000000] NUMA: Failed to initialise from firmware [ 0.000000] NUMA: Faking a node at [mem 0x0000000000000000-0x00000001bfffffff] [ 0.000000] NUMA: NODE_DATA [mem 0x1bf7f2900-0x1bf7f7fff] [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000000000-0x00000000ffffffff] [ 0.000000] DMA32 empty [ 0.000000] Normal [mem 0x0000000100000000-0x00000001bfffffff] [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000000000-0x00000000007fffff] [ 0.000000] node 0: [mem 0x0000000000824000-0x000000003ec80fff] [ 0.000000] node 0: [mem 0x000000003ec81000-0x000000003eca9fff] [ 0.000000] node 0: [mem 0x000000003ecaa000-0x000000003fd29fff] [ 0.000000] node 0: [mem 0x000000003fd2a000-0x000000003fd7dfff] [ 0.000000] node 0: [mem 0x000000003fd7e000-0x000000003fd89fff] [ 0.000000] node 0: [mem 0x000000003fd8a000-0x000000003fd8dfff] [ 0.000000] node 0: [mem 0x000000003fd8e000-0x000000003fffffff] [ 0.000000] node 0: [mem 0x0000000100000000-0x00000001bfffffff] [ 0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x00000001bfffffff] [ 0.000000] On node 0, zone DMA: 36 pages in unavailable ranges [ 0.000000] psci: probing for conduit method from ACPI. [ 0.000000] psci: PSCIv1.1 detected in firmware. [ 0.000000] psci: Using standard PSCI v0.2 function IDs [ 0.000000] psci: MIGRATE_INFO_TYPE not supported. [ 0.000000] psci: SMC Calling Convention v1.4 [ 0.000000] ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x0 -> Node -1 [ 0.000000] ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x1 -> Node -1 [ 0.000000] percpu: Embedded 29 pages/cpu s79960 r8192 d30632 u118784 [ 0.000000] Detected PIPT I-cache on CPU0 [ 0.000000] CPU features: detected: GIC system register CPU interface [ 0.000000] CPU features: detected: Hardware dirty bit management [ 0.000000] CPU features: detected: Spectre-BHB [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI) [ 0.000000] CPU features: detected: ARM erratum 1418040 [ 0.000000] CPU features: detected: ARM erratum 1542419 (kernel portion) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1032156 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=tty1 console=ttyAMA0,115200n8 earlycon=pl011,0xeffec000 flatcar.first_boot=detected acpi=force flatcar.oem.id=azure flatcar.autologin verity.usrhash=680ffc8c0dfb23738bd19ec96ea37b5bbadfb5cebf23767d1d52c89a6d5c00b4 [ 0.000000] Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. [ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) [ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) [ 0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off [ 0.000000] software IO TLB: mapped [mem 0x000000003abd2000-0x000000003ebd2000] (64MB) [ 0.000000] Memory: 3991936K/4194160K available (9792K kernel code, 2092K rwdata, 7556K rodata, 34688K init, 778K bss, 202224K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 [ 0.000000] trace event string verifier disabled [ 0.000000] rcu: Preemptible hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. [ 0.000000] Trampoline variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 [ 0.000000] GICv3: 960 SPIs implemented [ 0.000000] GICv3: 0 Extended SPIs implemented [ 0.000000] GICv3: Distributor has no Range Selector support [ 0.000000] Root IRQ handler: gic_handle_irq [ 0.000000] GICv3: 16 PPIs implemented [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000effee000 [ 0.000000] ITS: No ITS available, not enabling LPIs [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040 [ 0.000000] arch_timer: cp15 timer(s) running at 25.00MHz (virt). [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns [ 0.009827] Console: colour dummy device 80x25 [ 0.015187] printk: console [tty1] enabled [ 0.020201] ACPI: Core revision 20210730 [ 0.024637] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) [ 0.036395] pid_max: default: 32768 minimum: 301 [ 0.042166] LSM: Security Framework initializing [ 0.047748] SELinux: Initializing. [ 0.052070] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) [ 0.060292] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) [ 0.069549] Hyper-V: privilege flags low 0x2e7f, high 0x3a8030, hints 0xe, misc 0x31e1 [ 0.079076] Hyper-V: Host Build 10.0.22477.1369-1-0 [ 0.084908] rcu: Hierarchical SRCU implementation. [ 0.090821] Remapping and enabling EFI services. [ 0.096773] smp: Bringing up secondary CPUs ... [ 0.102314] Detected PIPT I-cache on CPU1 [ 0.102339] GICv3: CPU1: found redistributor 1 region 1:0x00000000f000e000 [ 0.102389] arch_timer: Enabling local workaround for ARM erratum 1418040 [ 0.102435] CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] [ 0.102491] smp: Brought up 1 node, 2 CPUs [ 0.134946] SMP: Total of 2 processors activated. [ 0.140687] CPU features: detected: 32-bit EL0 Support [ 0.146364] CPU features: detected: Instruction cache invalidation not required for I/D coherence [ 0.156576] CPU features: detected: Data cache clean to the PoU not required for I/D coherence [ 0.166353] CPU features: detected: CRC32 instructions [ 0.172265] CPU features: detected: RCpc load-acquire (LDAPR) [ 0.179465] CPU features: detected: LSE atomic instructions [ 0.185680] CPU features: detected: Privileged Access Never [ 0.242493] CPU: All CPU(s) started at EL1 [ 0.247266] alternatives: patching kernel code [ 0.252554] devtmpfs: initialized [ 0.256461] KASLR enabled [ 0.259537] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.271228] futex hash table entries: 512 (order: 3, 32768 bytes, linear) [ 0.278781] pinctrl core: initialized pinctrl subsystem [ 0.284617] SMBIOS 3.1.0 present. [ 0.288349] DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 07/12/2023 [ 0.299968] NET: Registered PF_NETLINK/PF_ROUTE protocol family [ 0.307487] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.316177] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.325854] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.336043] audit: initializing netlink subsys (disabled) [ 0.342023] audit: type=2000 audit(0.092:1): state=initialized audit_enabled=0 res=1 [ 0.342105] thermal_sys: Registered thermal governor 'step_wise' [ 0.351581] cpuidle: using governor menu [ 0.361948] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. [ 0.370500] ASID allocator initialised with 32768 entries [ 0.377142] ACPI: bus type PCI registered [ 0.382439] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.391033] Serial: AMBA PL011 UART driver [ 0.397655] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.405088] HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages [ 0.412895] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.420480] HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages [ 0.547747] cryptd: max_cpu_qlen set to 1000 [ 0.554953] alg: No test for fips(ansi_cprng) (fips_ansi_cprng) [ 0.561614] ACPI: Added _OSI(Module Device) [ 0.566151] ACPI: Added _OSI(Processor Device) [ 0.570943] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.576157] ACPI: Added _OSI(Processor Aggregator Device) [ 0.581964] ACPI: Added _OSI(Linux-Dell-Video) [ 0.586905] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) [ 0.592840] ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) [ 0.603064] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.610315] ACPI: Interpreter enabled [ 0.614160] ACPI: Using GIC for interrupt routing [ 0.619636] ARMH0011:00: ttyAMA0 at MMIO 0xeffec000 (irq = 12, base_baud = 0) is a SBSA [ 0.628237] printk: console [ttyAMA0] enabled [ 0.628237] printk: console [ttyAMA0] enabled [ 0.636584] printk: bootconsole [pl11] disabled [ 0.636584] printk: bootconsole [pl11] disabled [ 0.645190] ARMH0011:01: ttyAMA1 at MMIO 0xeffeb000 (irq = 13, base_baud = 0) is a SBSA [ 0.652209] iommu: Default domain type: Translated [ 0.656029] iommu: DMA domain TLB invalidation policy: strict mode [ 0.660834] vgaarb: loaded [ 0.663167] pps_core: LinuxPPS API ver. 1 registered [ 0.667450] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.674671] PTP clock support registered [ 0.678053] Registered efivars operations [ 0.681453] No ACPI PMU IRQ for CPU0 [ 0.684067] No ACPI PMU IRQ for CPU1 [ 0.687216] clocksource: Switched to clocksource arch_sys_counter [ 0.697848] VFS: Disk quotas dquot_6.6.0 [ 0.701039] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.706164] pnp: PnP ACPI init [ 0.708738] pnp: PnP ACPI: found 0 devices [ 0.715139] NET: Registered PF_INET protocol family [ 0.720750] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) [ 0.727844] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) [ 0.734542] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) [ 0.740462] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) [ 0.746879] TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) [ 0.752608] TCP: Hash tables configured (established 32768 bind 32768) [ 0.757873] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) [ 0.762851] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) [ 0.768673] NET: Registered PF_UNIX/PF_LOCAL protocol family [ 0.773109] PCI: CLS 0 bytes, default 64 [ 0.785263] hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 1 counters available [ 0.792483] kvm [1]: HYP mode not available [ 0.990026] Initialise system trusted keyrings [ 0.993823] workingset: timestamp_bits=39 max_order=20 bucket_order=0 [ 1.000136] Key type asymmetric registered [ 1.003428] Asymmetric key parser 'x509' registered [ 1.007313] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) [ 1.013256] io scheduler mq-deadline registered [ 1.016925] io scheduler kyber registered [ 1.020290] io scheduler bfq registered [ 1.024047] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 1.029684] thunder_xcv, ver 1.0 [ 1.032210] thunder_bgx, ver 1.0 [ 1.034634] nicpf, ver 1.0 [ 1.036763] nicvf, ver 1.0 [ 1.039487] rtc-efi rtc-efi.0: registered as rtc0 [ 1.043880] rtc-efi rtc-efi.0: setting system clock to 2024-02-09T18:34:04 UTC (1707503644) [ 1.050692] efifb: probing for efifb [ 1.053665] efifb: framebuffer at 0x40000000, using 3072k, total 3072k [ 1.058718] efifb: mode is 1024x768x32, linelength=4096, pages=1 [ 1.063848] efifb: scrolling: redraw [ 1.066746] efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 [ 1.073422] Console: switching to colour frame buffer device 128x48 [ 1.079233] fb0: EFI VGA frame buffer device [ 1.082682] SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... [ 1.088027] hid: raw HID events driver (C) Jiri Kosina [ 1.092029] NET: Registered PF_INET6 protocol family [ 1.096327] Segment Routing with IPv6 [ 1.099254] In-situ OAM (IOAM) with IPv6 [ 1.102063] NET: Registered PF_PACKET protocol family [ 1.106197] Key type dns_resolver registered [ 1.109785] registered taskstats version 1 [ 1.112778] Loading compiled-in X.509 certificates [ 1.146014] Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.15.148-flatcar: 947a80114e81e2815f6db72a0d388260762488f9' [ 1.155059] Key type .fscrypt registered [ 1.158154] Key type fscrypt-provisioning registered [ 1.161897] ima: No TPM chip found, activating TPM-bypass! [ 1.166248] ima: Allocated hash algorithm: sha1 [ 1.169841] ima: No architecture policies found [ 1.178442] Freeing unused kernel memory: 34688K [ 1.181931] Run /init as init process [ 1.203222] systemd[1]: systemd 252 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL -ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE -TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified) [ 1.228511] systemd[1]: Detected virtualization microsoft. [ 1.234581] systemd[1]: Detected architecture arm64. [ 1.239019] systemd[1]: Running in initrd. Welcome to dracut-053 (Initramfs)! [ 1.246400] systemd[1]: No hostname configured, using default hostname. [ 1.251960] systemd[1]: Hostname set to . [ 1.256399] systemd[1]: Initializing machine ID from random generator. [ 1.350412] systemd[1]: Queued start job for default target initrd.target. [ 1.357907] systemd[1]: Started systemd-ask-password-console.path. [ OK ] Started systemd-ask-password-console.path. [ 1.368915] systemd[1]: Reached target cryptsetup.target. [ OK ] Reached target cryptsetup.target. [ 1.378918] systemd[1]: Reached target paths.target. [ OK ] Reached target paths.target. [ 1.388337] systemd[1]: Reached target slices.target. [ OK ] Reached target slices.target. [ 1.397442] systemd[1]: Reached target swap.target. [ OK ] Reached target swap.target. [ 1.406297] systemd[1]: Reached target timers.target. [ OK ] Reached target timers.target. [ 1.416060] systemd[1]: Listening on iscsid.socket. [ OK ] Listening on iscsid.socket. [ 1.424949] systemd[1]: Listening on iscsiuio.socket. [ OK ] Listening on iscsiuio.socket. [ 1.434484] systemd[1]: Listening on systemd-journald-audit.socket. [ OK ] Listening on systemd-journald-audit.socket. [ 1.445318] systemd[1]: Listening on systemd-journald-dev-log.socket. [ OK ] Listening on systemd-journald-dev-log.socket. [ 1.456518] systemd[1]: Listening on systemd-journald.socket. [ OK ] Listening on systemd-journald.socket. [ 1.467022] systemd[1]: Listening on systemd-networkd.socket. [ OK ] Listening on systemd-networkd.socket. [ 1.479478] systemd[1]: Listening on systemd-udevd-control.socket. [ OK ] Listening on systemd-udevd-control.socket. [ 1.491102] systemd[1]: Listening on systemd-udevd-kernel.socket. [ OK ] Listening on systemd-udevd-kernel.socket. [ 1.502356] systemd[1]: Reached target sockets.target. [ OK ] Reached target sockets.target. [ 1.513057] systemd[1]: Starting kmod-static-nodes.service... Starting kmod-static-nodes.service... [ 1.523337] systemd[1]: Finished network-cleanup.service. [ OK ] Finished network-cleanup.service. [ 1.533649] systemd[1]: Starting systemd-fsck-usr.service... Starting systemd-fsck-usr.service... [ 1.544487] systemd[1]: Starting systemd-journald.service... Starting systemd-journald.service... [ 1.554314] systemd[1]: Starting systemd-modules-load.service... Starting systemd-modules-load.service... [ 1.566262] systemd[1]: Starting systemd-resolved.service... Starting systemd-resolved.service... [ 1.591309] systemd[1]: Starting systemd-vconsole-setup.service... [ 1.170875] systemd-modules-load[277]: Inserted module 'overlay' [ 1.604581] bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Starting systemd-vconsole-setup.service... [ 1.190540] systemd-resolved[278]: Positive Trust Anchors:[ 1.623319] systemd[1]: Started systemd-journald.service. [ 1.634093] Bridge firewalling registered [ 1.211647] systemd-resolved[278]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d [ OK ] Started systemd-journald.service. [ 1.653508] audit: type=1130 audit(1707503645.109:2): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Started systemd-resolved.service.[ 1.671791] SCSI subsystem initialized [ OK ] Finished kmod-static-nodes.service.[ 1.686017] audit: type=1130 audit(1707503645.136:3): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 1.686372] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. [ 1.249267] systemd-resolved[278]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test[ 1.714531] device-mapper: uevent: version 1.0.3 [ 1.754643] audit: type=1130 audit(1707503645.205:4): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Finished systemd-fsck-usr.service. [ 1.776078] device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com [ 1.345265] systemd-resolved[278]: Defaulting to hostname 'linux'.[ 1.788942] audit: type=1130 audit(1707503645.239:5): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Finished systemd-vconsole-setup.service. [ 1.809829] audit: type=1130 audit(1707503645.265:6): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 1.403035] systemd-modules-load[277]: Inserted module 'br_netfilter' [ OK ] Reached target nss-lookup.target. [ 1.408548] systemd[1]: Started systemd-resolved.service. Starting dracut-cmdline-ask.service... [ 1.418344] systemd[1]: Finished kmod-static-nodes.service. [ 1.431055] systemd[1]: Finished systemd-fsck-usr.service. Starting systemd-tmpfiles-setup-dev.service... [ 1.440895] systemd[1]: Finished systemd-vconsole-setup.service. [ 1.451936] systemd[1]: Reached target nss-lookup.target. [ OK ] Finished systemd-modules-load.service. [ 1.456574] systemd-modules-load[277]: Inserted module 'dm_multipath'[ 1.889207] audit: type=1130 audit(1707503645.345:7): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 1.484658] systemd[1]: Starting dracut-cmdline-ask.service... [ OK ] Finished dracut-cmdline-ask.service. [ 1.491139] systemd[1]: Starting systemd-tmpfiles-setup-dev.service... [ 1.928329] audit: type=1130 audit(1707503645.378:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Finished systemd-tmpfiles-setup-dev.service. [ 1.518320] systemd[1]: Finished systemd-modules-load.service.[ 1.955560] audit: type=1130 audit(1707503645.406:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Starting dracut-cmdline.service... [ 1.545058] systemd[1]: Finished dracut-cmdline-ask.service. [ 1.558865] systemd[1]: Finished systemd-tmpfiles-setup-dev.service. Starting systemd-sysctl.service... [ 1.565462] systemd[1]: Starting dracut-cmdline.service... [ 1.580650] dracut-cmdline[295]: dracut-dracut-053 [ OK ] Finished systemd-sysctl.service. [ 1.585343] dracut-cmdline[295]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=tty1 console=ttyAMA0,115200n8 earlycon=pl011,0xeffec000 flatcar.first_boot=detected acpi=force flatcar.oem.id=azure flatcar.autologin verity.usrhash=680ffc8c0dfb23738bd19ec96ea37b5bbadfb5cebf23767d1d52c89a6d5c00b4[ 2.018082] audit: type=1130 audit(1707503645.473:10): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 1.646671] systemd[1]: Starting systemd-sysctl.service... [ 1.654042] systemd[1]: Finished systemd-sysctl.service. [ 2.124354] Loading iSCSI transport class v2.0-870. [ 2.137112] iscsi: registered transport (tcp) [ 2.153836] iscsi: registered transport (qla4xxx) [ 2.158523] QLogic iSCSI HBA Driver [ OK ] Finished dracut-cmdline.service. [ 1.763567] systemd[1]: Finished dracut-cmdline.service. [ 1.773213] systemd[1]: Starting dracut-pre-udev.service... Starting dracut-pre-udev.service... [ 2.246217] raid6: neonx8 gen() 13814 MB/s [ 2.267217] raid6: neonx8 xor() 10835 MB/s [ 2.287216] raid6: neonx4 gen() 13571 MB/s [ 2.308217] raid6: neonx4 xor() 11165 MB/s [ 2.330227] raid6: neonx2 gen() 12962 MB/s [ 2.350217] raid6: neonx2 xor() 10274 MB/s [ 2.371221] raid6: neonx1 gen() 10495 MB/s [ 2.393217] raid6: neonx1 xor() 8802 MB/s [ 2.414218] raid6: int64x8 gen() 6295 MB/s [ 2.435219] raid6: int64x8 xor() 3547 MB/s [ 2.456222] raid6: int64x4 gen() 7229 MB/s [ 2.476218] raid6: int64x4 xor() 3856 MB/s [ 2.497216] raid6: int64x2 gen() 6150 MB/s [ 2.519217] raid6: int64x2 xor() 3322 MB/s [ 2.539227] raid6: int64x1 gen() 5047 MB/s [ 2.560219] raid6: int64x1 xor() 2647 MB/s [ 2.565290] raid6: using algorithm neonx8 gen() 13814 MB/s [ 2.570006] raid6: .... xor() 10835 MB/s, rmw enabled [ 2.574685] raid6: using neon recovery algorithm [ 2.587466] xor: measuring software checksum speed [ 2.592804] 8regs : 17304 MB/sec [ 2.597615] 32regs : 20749 MB/sec [ 2.602384] arm64_neon : 27911 MB/sec [ 2.607518] xor: using function: arm64_neon (27911 MB/sec) [ 2.662243] Btrfs loaded, crc32c=crc32c-generic, zoned=no, fsverity=no [ OK ] Finished dracut-pre-udev.service. [ 2.251797] systemd[1]: Finished dracut-pre-udev.service. Starting systemd-udevd.service... [ 2.262036] systemd[1]: Starting systemd-udevd.service... [ 2.279941] systemd-udevd[474]: Using default interface naming scheme 'v252'. [ OK ] Started systemd-udevd.service. [ 2.293193] systemd[1]: Started systemd-udevd.service. Starting dracut-pre-trigger.service... [ 2.304178] systemd[1]: Starting dracut-pre-trigger.service... [ 2.313870] dracut-pre-trigger[495]: rd.md=0: removing MD RAID activation [ OK ] Finished dracut-pre-trigger.service. [ 2.342683] systemd[1]: Finished dracut-pre-trigger.service. [ 2.353216] systemd[1]: Starting systemd-udev-trigger.service... Starting systemd-udev-trigger.service... [ OK ] Finished systemd-udev-trigger.service. [ 2.389206] systemd[1]: Finished systemd-udev-trigger.service. [ 2.862050] hv_vmbus: Vmbus version:5.3 [ 2.869697] hv_vmbus: registering driver hid_hyperv [ 2.876237] hv_vmbus: registering driver hyperv_keyboard [ 2.882667] input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input0 [ 2.891247] input: AT Translated Set 2 keyboard as /devices/LNXSYSTM:00/LNXSYBUS:00/ACPI0004:00/VMBUS:00/d34b2567-b9b6-42b9-8778-0a4ec0b955bf/serio0/input/input1 [ 2.892381] hv_vmbus: registering driver hv_netvsc [ 2.905191] hid-generic 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on [ 2.921106] hv_vmbus: registering driver hv_storvsc [ 2.927452] scsi host0: storvsc_host_t [ 2.931798] scsi host1: storvsc_host_t [ 2.936310] scsi 0:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 [ 2.944321] scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 0 [ 2.969605] sr 0:0:0:2: [sr0] scsi-1 drive [ 2.973833] cdrom: Uniform CD-ROM driver Revision: 3.20 [ 2.994044] sd 0:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB) [ 3.002243] sd 0:0:0:0: [sda] 4096-byte physical blocks [ 3.007201] sd 0:0:0:0: [sda] Write Protect is off [ 3.011709] sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA [ 3.022244] sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 [ 3.027297] hv_netvsc 002248b4-05ca-0022-48b4-05ca002248b4 eth0: VF slot 1 added [ 3.036783] sd 0:0:0:0: [sda] Attached SCSI disk [ 3.045423] hv_vmbus: registering driver hv_pci [ 3.051179] hv_pci 1c9ee890-429e-407f-a75b-edd732bdc665: PCI VMBus probing: Using version 0x10004 [ 3.062437] hv_pci 1c9ee890-429e-407f-a75b-edd732bdc665: PCI host bridge to bus 429e:00 [ 3.069327] pci_bus 429e:00: root bus resource [mem 0xfc0000000-0xfc00fffff window] [ 3.075957] pci_bus 429e:00: No busn resource found for root bus, will use [bus 00-ff] [ 3.084710] pci 429e:00:02.0: [15b3:1018] type 00 class 0x020000 [ 3.096096] pci 429e:00:02.0: reg 0x10: [mem 0xfc0000000-0xfc00fffff 64bit pref] [ 3.124129] pci 429e:00:02.0: enabling Extended Tags [ 3.135942] pci 429e:00:02.0: 0.000 Gb/s available PCIe bandwidth, limited by Unknown x0 link at 429e:00:02.0 (capable of 126.016 Gb/s with 8.0 GT/s PCIe x16 link) [ 3.148925] pci_bus 429e:00: busn_res: [bus 00-ff] end is updated to 00 [ 3.154846] pci 429e:00:02.0: BAR 0: assigned [mem 0xfc0000000-0xfc00fffff 64bit pref] [ 3.196853] mlx5_core 429e:00:02.0: firmware version: 16.30.1284 [ 3.350607] mlx5_core 429e:00:02.0: MLX5E: StrdRq(1) RqSz(8) StrdSz(2048) RxCqeCmprss(0) [ 3.407652] hv_netvsc 002248b4-05ca-0022-48b4-05ca002248b4 eth0: VF registering: eth1 [ 3.416365] mlx5_core 429e:00:02.0 eth1: joined to eth0 [ 3.428427] mlx5_core 429e:00:02.0 enP17054s1: renamed from eth1 [ OK ] Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device. [ 3.053753] systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device. [ 3.506893] BTRFS: device label OEM devid 1 transid 12 /dev/sda6 scanned by (udev-worker) (534) [ OK ] Found device dev-disk-by\x2dlabel-OEM.device. [ 3.102381] systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. [ OK ] Found device dev-disk-by\x2dpartlabel-USR\x2dA.device. [ 3.271836] systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device. [ 3.285496] systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device. [ OK ] Found device dev-disk-by\x…2d8e26\x2d6cce9662f132.device. [ OK ] Found device dev-disk-by\x2dlabel-ROOT.device. [ 3.305900] systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device. Starting disk-uuid.service... [ 3.317744] systemd[1]: Starting disk-uuid.service... [ 3.757468] sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 [ 4.774527] sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 [ 4.353294] disk-uuid[603]: The operation has completed successfully. [ OK ] Finished disk-uuid.service. [ 4.411589] systemd[1]: disk-uuid.service: Deactivated successfully. Starting verity-setup.service... [ 4.421768] systemd[1]: Finished disk-uuid.service. [ 4.429586] systemd[1]: Starting verity-setup.service... [ 4.883500] device-mapper: verity: sha256 using implementation "sha256-ce" [ OK ] Found device dev-mapper-usr.device. [ 4.672044] systemd[1]: Found device dev-mapper-usr.device. [ 4.678130] systemd[1]: Mounting sysusr-usr.mount... Mounting sysusr-usr.mount... [ OK ] Finished verity-setup.service. [ 4.688844] systemd[1]: Finished verity-setup.service. [ 5.165135] EXT4-fs (dm-0): mounted filesystem without journal. Opts: norecovery. Quota mode: none. [ OK ] Mounted sysusr-usr.mount. [ 4.747895] systemd[1]: Mounted sysusr-usr.mount. Starting ignition-setup.service... Starting parse-ip-for-networkd.service... [ 4.755967] systemd[1]: afterburn-network-kargs.service was skipped because no trigger condition checks were met. [ 4.777220] systemd[1]: Starting ignition-setup.service... [ 4.782620] systemd[1]: Starting parse-ip-for-networkd.service... [ 5.215816] BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm [ 5.224306] BTRFS info (device sda6): using free space tree [ 5.229709] BTRFS info (device sda6): has skinny extents [ OK ] Finished parse-ip-for-networkd.service. [ 4.864053] systemd[1]: Finished parse-ip-for-networkd.service. Starting systemd-networkd.service... [ 4.873349] systemd[1]: Starting systemd-networkd.service... [ 4.896577] systemd-networkd[870]: lo: Link UP [ OK ] Started systemd-networkd.service. [ 4.902642] systemd-networkd[870]: lo: Gained carrier [ OK ] Reached target network.target. [ 4.911689] systemd-networkd[870]: Enumeration completed Starting iscsiuio.service... [ 4.922645] systemd[1]: Started systemd-networkd.service. [ 4.931655] systemd[1]: mnt-oem.mount: Deactivated successfully. [ OK ] Started iscsiuio.service. [ 4.936654] systemd[1]: Reached target network.target. Starting iscsid.service... [ OK ] Started iscsid.service. [ 4.951477] systemd-networkd[870]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Starting dracut-initqueue.service... [ 4.970535] iscsid[879]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi [ 4.980572] iscsid[879]: iscsid: Warning: InitiatorName file /etc/iscsi/initiatorname.iscsi does not exist or does not contain a properly formatted InitiatorName. If using software iscsi (iscsi_tcp or ib_iser) or partial offload (bnx2i or cxgbi iscsi), you may not be able to log [ 5.002920] iscsid[879]: into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier]. [ 5.019235] iscsid[879]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. [ 5.025290] iscsid[879]: If using hardware iscsi like qla4xxx this message can be ignored. [ 5.459488] mlx5_core 429e:00:02.0 enP17054s1: Link up [ OK ] Finished dracut-initqueue.service. [ 5.036900] iscsid[879]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi [ OK ] Reached target remote-fs-pre.target. [ 5.052490] iscsid[879]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf [ OK ] Reached target remote-cryptsetup.target. [ 5.500932] hv_netvsc 002248b4-05ca-0022-48b4-05ca002248b4 eth0: Data path switched to VF: enP17054s1 [ 5.068039] systemd[1]: Starting iscsiuio.service... [ OK ] Reached target remote-fs.target. [ 5.525458] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 5.093415] systemd[1]: Started iscsiuio.service. [ 5.109180] systemd[1]: Starting iscsid.service... Starting dracut-pre-mount.service... [ 5.115469] systemd[1]: Started iscsid.service. [ 5.126201] systemd[1]: Starting dracut-initqueue.service... [ OK ] Finished dracut-pre-mount.service. [ 5.131405] systemd[1]: Finished dracut-initqueue.service.[ 5.568085] kauditd_printk_skb: 16 callbacks suppressed [ 5.568089] audit: type=1130 audit(1707503649.019:27): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 5.166918] systemd[1]: Reached target remote-fs-pre.target. [ 5.173608] systemd[1]: Reached target remote-cryptsetup.target. [ 5.180133] systemd[1]: Reached target remote-fs.target. [ 5.185317] systemd[1]: Starting dracut-pre-mount.service... [ 5.190700] systemd-networkd[870]: enP17054s1: Link UP [ 5.195139] systemd-networkd[870]: eth0: Link UP [ 5.199170] systemd-networkd[870]: eth0: Gained carrier [ 5.203770] systemd-networkd[870]: enP17054s1: Gained carrier [ 5.208567] systemd[1]: Finished dracut-pre-mount.service. [ 5.213289] systemd-networkd[870]: eth0: DHCPv4 address 10.200.20.16/24, gateway 10.200.20.1 acquired from 168.63.129.16 [ OK ] Finished ignition-setup.service. [ 5.260539] systemd[1]: Finished ignition-setup.service.[ 5.694024] audit: type=1130 audit(1707503649.149:28): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Starting ignition-fetch-offline.service... [ 5.290810] systemd[1]: Starting ignition-fetch-offline.service... [ 6.431369] systemd-networkd[870]: eth0: Gained IPv6LL [* ] Job ignition-fetch-offline.service/start running (6s / no limit) [ 8.110603] ignition[894]: Ignition 2.14.0 [ 8.115203] ignition[894]: Stage: fetch-offline [ 8.119319] ignition[894]: reading system config file "/usr/lib/ignition/base.d/base.ign" M [** ] Job ignition-fetch-offline.service/start running (7s / no limit) [ 8.206030] ignition[894]: no config dir at "/usr/lib/ignition/base.platform.d/azure" M [ OK ] Finished ignition-fetch-offline.service. [ 8.219129] systemd[1]: Finished ignition-fetch-offline.service.[ 8.646574] audit: type=1130 audit(1707503652.102:29): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch-offline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 8.241212] ignition[894]: no config URL provided [ 8.246978] systemd[1]: Starting ignition-fetch.service... [ 8.251567] ignition[894]: reading system config file "/usr/lib/ignition/user.ign" Starting ignition-fetch.service... [ 8.257785] ignition[894]: no config at "/usr/lib/ignition/user.ign" [ 8.269624] ignition[894]: failed to fetch config: resource requires networking [ 8.276659] ignition[894]: Ignition finished successfully [ 8.281729] ignition[900]: Ignition 2.14.0 [ 8.285357] ignition[900]: Stage: fetch [ 8.288883] ignition[900]: reading system config file "/usr/lib/ignition/base.d/base.ign" [ 8.295638] ignition[900]: no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 8.302307] ignition[900]: no config URL provided [ 8.305859] ignition[900]: reading system config file "/usr/lib/ignition/user.ign" [ 8.312383] ignition[900]: no config at "/usr/lib/ignition/user.ign" [ 8.317582] ignition[900]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 [ 8.367661] ignition[900]: GET result: OK [ 8.372487] ignition[900]: config has been read from IMDS userdata [ 8.404169] ignition[900]: fetched base config from "system" [ 8.409210] ignition[900]: fetched base config from "system" [ OK ] Finished ignition-fetch.service. [ 8.416086] ignition[900]: fetch: fetch complete[ 8.845987] audit: type=1130 audit(1707503652.301:30): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Starting ignition-kargs.service... [ 8.438304] ignition[900]: fetched user config from "azure" [ 8.450783] ignition[900]: fetch: fetch passed [ 8.455396] systemd[1]: Finished ignition-fetch.service. [ OK ] Finished ignition-kargs.service. [ 8.467144] ignition[900]: Ignition finished successfully[ 8.900466] audit: type=1130 audit(1707503652.351:31): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-kargs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Starting ignition-disks.service... [ 8.494017] systemd[1]: Starting ignition-kargs.service... [ OK ] Finished ignition-disks.service. [ 8.502716] ignition[907]: Ignition 2.14.0[ 8.938029] audit: type=1130 audit(1707503652.390:32): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-disks comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Reached target initrd-root-device.target. [ OK ] Reached target local-fs-pre.target. [ 8.532827] systemd[1]: Finished ignition-kargs.service. [ OK ] Reached target local-fs.target. [ 8.542728] ignition[907]: Stage: kargs [ OK ] Reached target sysinit.target. [ 8.550576] systemd[1]: Starting ignition-disks.service... [ OK ] Reached target basic.target. [ 8.559748] ignition[907]: reading system config file "/usr/lib/ignition/base.d/base.ign" [ 8.571913] systemd[1]: Finished ignition-disks.service. Starting systemd-fsck-root.service... [ 8.578204] systemd[1]: Reached target initrd-root-device.target. [ 8.589632] ignition[907]: no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 8.595979] systemd[1]: Reached target local-fs-pre.target. [ 8.600633] ignition[907]: kargs: kargs passed [ 8.604122] systemd[1]: Reached target local-fs.target. [ 8.608457] ignition[907]: Ignition finished successfully [ 8.613253] systemd[1]: Reached target sysinit.target. [ 8.618435] ignition[913]: Ignition 2.14.0 [ 8.621825] systemd[1]: Reached target basic.target. [ 8.625907] ignition[913]: Stage: disks [ 8.629059] systemd[1]: Starting systemd-fsck-root.service... [ 8.634068] ignition[913]: reading system config file "/usr/lib/ignition/base.d/base.ign" [ 8.640322] ignition[913]: no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 8.646751] ignition[913]: disks: disks passed [ 8.650433] ignition[913]: Ignition finished successfully [ 8.676722] systemd-fsck[921]: ROOT: clean, 602/7326000 files, 481069/7359488 blocks [ OK ] Finished systemd-fsck-root.service. [ 8.690782] systemd[1]: Finished systemd-fsck-root.service.[ 9.123490] audit: type=1130 audit(1707503652.579:33): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mounting sysroot.mount... [ 8.722917] systemd[1]: Mounting sysroot.mount... [ 9.165653] EXT4-fs (sda9): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none. [ OK ] Mounted sysroot.mount. [ 8.748101] systemd[1]: Mounted sysroot.mount. [ OK ] Reached target initrd-root-fs.target. [ 8.756241] systemd[1]: Reached target initrd-root-fs.target. Mounting sysroot-usr.mount... [ 8.795307] systemd[1]: Mounting sysroot-usr.mount... Starting flatcar-metadata-hostname.service... [ 8.801245] systemd[1]: Starting flatcar-metadata-hostname.service... [ OK ] Reached target ignition-diskful.target. [ 8.813419] systemd[1]: ignition-remount-sysroot.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). [ OK ] Mounted sysroot-usr.mount. [ 8.829092] systemd[1]: Reached target ignition-diskful.target. [ 8.839613] systemd[1]: Mounted sysroot-usr.mount. Mounting sysroot-usr-share-oem.mount... [ 8.879510] systemd[1]: Mounting sysroot-usr-share-oem.mount... [ 8.888697] systemd[1]: Starting initrd-setup-root.service... Starting initrd-setup-root.service... [ 9.328517] BTRFS: device label OEM devid 1 transid 14 /dev/sda6 scanned by mount (932) [ 9.338191] BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm [ 9.346272] BTRFS info (device sda6): using free space tree [ 8.919301] initrd-setup-root[937]: cut: /sysroot/etc/passwd: No such file or directory[ 9.352742] BTRFS info (device sda6): has skinny extents [ OK ] Mounted sysroot-usr-share-oem.mount. [ 8.941988] systemd[1]: Mounted sysroot-usr-share-oem.mount. [ 9.000796] initrd-setup-root[963]: cut: /sysroot/etc/group: No such file or directory [ 9.011778] initrd-setup-root[971]: cut: /sysroot/etc/shadow: No such file or directory [ 9.035980] initrd-setup-root[979]: cut: /sysroot/etc/gshadow: No such file or directory [ OK ] Finished initrd-setup-root.service. [ 9.479179] systemd[1]: Finished initrd-setup-root.service.[ 9.912668] audit: type=1130 audit(1707503653.368:34): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Starting ignition-mount.service... Starting sysroot-boot.service... [ 9.516558] systemd[1]: Starting ignition-mount.service... [ 9.530786] systemd[1]: Starting sysroot-boot.service... [ 9.536766] systemd[1]: sysusr-usr-share-oem.mount: Deactivated successfully. [ 9.543748] systemd[1]: sysroot-usr-share-oem.mount: Deactivated successfully. [ 9.560192] ignition[999]: INFO : Ignition 2.14.0 [ 9.565332] ignition[999]: INFO : Stage: mount [ OK ] Finished ignition-mount.service. [ 9.570705] ignition[999]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign"[ 10.011129] audit: type=1130 audit(1707503653.458:35): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Finished sysroot-boot.service. [ 9.602532] ignition[999]: DEBUG : parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63[ 10.050485] audit: type=1130 audit(1707503653.506:36): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 9.639531] ignition[999]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 9.648228] ignition[999]: INFO : mount: mount passed [ 9.652785] ignition[999]: INFO : Ignition finished successfully [ 9.658240] systemd[1]: Finished ignition-mount.service. [ 9.662650] systemd[1]: Finished sysroot-boot.service. [ 10.031145] coreos-metadata[931]: Feb 09 18:34:13.914 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 [ 10.041799] coreos-metadata[931]: Feb 09 18:34:13.925 INFO Fetch successful [ 10.075122] coreos-metadata[931]: Feb 09 18:34:13.958 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 [ 10.104955] coreos-metadata[931]: Feb 09 18:34:13.988 INFO Fetch successful [ 10.112913] coreos-metadata[931]: Feb 09 18:34:13.995 INFO wrote hostname ci-3510.3.2-a-76b5b28b66 to /sysroot/etc/hostname [ OK ] Finished flatcar-metadata-hostname.service. [ 10.123280] systemd[1]: Finished flatcar-metadata-hostname.service. Starting ignition-files.service... [ 10.135067] systemd[1]: Starting ignition-files.service... Mounting sysroot-usr-share-oem.mount... [ 10.148838] systemd[1]: Mounting sysroot-usr-share-oem.mount... [ 10.585032] BTRFS: device label OEM devid 1 transid 15 /dev/sda6 scanned by mount (1010) [ 10.594163] BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm [ 10.601579] BTRFS info (device sda6): using free space tree [ 10.607565] BTRFS info (device sda6): has skinny extents [ OK ] Mounted sysroot-usr-share-oem.mount. [ 10.190050] systemd[1]: Mounted sysroot-usr-share-oem.mount. [ 10.206975] ignition[1029]: INFO : Ignition 2.14.0 [ 10.212626] ignition[1029]: INFO : Stage: files [ 10.217793] ignition[1029]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" [ 10.225993] ignition[1029]: DEBUG : parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63 [ 10.239932] ignition[1029]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 10.247516] ignition[1029]: DEBUG : files: compiled without relabeling support, skipping [ 10.254268] ignition[1029]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" [ 10.263241] ignition[1029]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" [ 10.317232] ignition[1029]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" [ 10.325710] ignition[1029]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" [ 10.334792] ignition[1029]: wrote ssh authorized keys file for user: core [ 10.340622] ignition[1029]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" [ 10.348377] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/opt/helm-v3.13.2-linux-arm64.tar.gz" [ 10.359940] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(3): GET https://get.helm.sh/helm-v3.13.2-linux-arm64.tar.gz: attempt #1 [ 10.588899] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(3): GET result: OK [ 10.956722] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/opt/helm-v3.13.2-linux-arm64.tar.gz" [ 10.971152] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/opt/crictl-v1.26.0-linux-arm64.tar.gz" [ 10.983803] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(4): GET https://github.com/kubernetes-sigs/cri-tools/releases/download/v1.26.0/crictl-v1.26.0-linux-arm64.tar.gz: attempt #1 [ 11.320529] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(4): GET result: OK [ 11.468733] ignition[1029]: DEBUG : files: createFilesystemsFiles: createFiles: op(4): file matches expected sum of: 4c7e4541123cbd6f1d6fec1f827395cd58d65716c0998de790f965485738b6d6257c0dc46fd7f66403166c299f6d5bf9ff30b6e1ff9afbb071f17005e834518c [ 11.488457] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/opt/crictl-v1.26.0-linux-arm64.tar.gz" [ 11.500178] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing file "/sysroot/etc/flatcar-cgroupv1" [ 11.511130] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing file "/sysroot/etc/flatcar-cgroupv1" [ 11.521719] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/opt/cni-plugins-linux-arm64-v1.1.1.tgz" [ 11.533507] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET https://github.com/containernetworking/plugins/releases/download/v1.1.1/cni-plugins-linux-arm64-v1.1.1.tgz: attempt #1 [ 11.761260] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET result: OK [ 11.979113] ignition[1029]: DEBUG : files: createFilesystemsFiles: createFiles: op(6): file matches expected sum of: 6b5df61a53601926e4b5a9174828123d555f592165439f541bc117c68781f41c8bd30dccd52367e406d104df849bcbcfb72d9c4bafda4b045c59ce95d0ca0742 [ 11.998244] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/opt/cni-plugins-linux-arm64-v1.1.1.tgz" [ 12.011022] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(7): [started] writing file "/sysroot/opt/bin/cilium.tar.gz" [ 12.022297] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(7): GET https://github.com/cilium/cilium-cli/releases/download/v0.12.12/cilium-linux-arm64.tar.gz: attempt #1 [ 12.349374] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(7): GET result: OK [ 12.404822] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(7): [finished] writing file "/sysroot/opt/bin/cilium.tar.gz" [ 12.415811] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(8): [started] writing file "/sysroot/opt/bin/kubeadm" [ 12.426144] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(8): GET https://dl.k8s.io/release/v1.26.5/bin/linux/arm64/kubeadm: attempt #1 [*** ] Job ignition-files.service/start running (11s / no limit) [ 12.584074] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(8): GET result: OK [ 12.874492] ignition[1029]: DEBUG : files: createFilesystemsFiles: createFiles: op(8): file matches expected sum of: 46c9f489062bdb84574703f7339d140d7e42c9c71b367cd860071108a3c1d38fabda2ef69f9c0ff88f7c80e88d38f96ab2248d4c9a6c9c60b0a4c20fd640d0db [ 12.894806] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(8): [finished] writing file "/sysroot/opt/bin/kubeadm" [ 12.906208] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(9): [started] writing file "/sysroot/opt/bin/kubelet" [ 12.918026] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(9): GET https://dl.k8s.io/release/v1.26.5/bin/linux/arm64/kubelet: attempt #1 [ 12.937688] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(9): GET result: OK M [ *** ] Job ignition-files.service/start running (12s / no limit) M [ *** ] Job ignition-files.service/start running (12s / no limit) [ 13.621207] ignition[1029]: DEBUG : files: createFilesystemsFiles: createFiles: op(9): file matches expected sum of: 0e4ee1f23bf768c49d09beb13a6b5fad6efc8e3e685e7c5610188763e3af55923fb46158b5e76973a0f9a055f9b30d525b467c53415f965536adc2f04d9cf18d [ 13.639907] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(9): [finished] writing file "/sysroot/opt/bin/kubelet" [ 13.650843] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(a): [started] writing file "/sysroot/etc/docker/daemon.json" [ 13.661995] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(a): [finished] writing file "/sysroot/etc/docker/daemon.json" [ 13.674079] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(b): [started] writing file "/sysroot/opt/bin/kubectl" [ 13.685714] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(b): GET https://dl.k8s.io/release/v1.26.5/bin/linux/arm64/kubectl: attempt #1 [ 13.698700] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(b): GET result: OK [ 14.099358] ignition[1029]: DEBUG : files: createFilesystemsFiles: createFiles: op(b): file matches expected sum of: 3672fda0beebbbd636a2088f427463cbad32683ea4fbb1df61650552e63846b6a47db803ccb70c3db0a8f24746a23a5632bdc15a3fb78f4f7d833e7f86763c2a [ 14.119742] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(b): [finished] writing file "/sysroot/opt/bin/kubectl" M [ ***] Job ignition-files.service/start running (13s / no limit) [ 14.130392] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(c): [started] writing file "/sysroot/home/core/install.sh"[ 14.568418] BTRFS info: devid 1 device path /dev/sda6 changed to /dev/disk/by-label/OEM scanned by ignition (1034) [ 14.157221] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(c): [finished] writing file "/sysroot/home/core/install.sh" [ 14.179123] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(d): [started] writing file "/sysroot/home/core/nginx.yaml" [ 14.191931] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(d): [finished] writing file "/sysroot/home/core/nginx.yaml" [ 14.203975] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(e): [started] writing file "/sysroot/home/core/nfs-pod.yaml" M [ OK ] Finished ignition-files.service. [ 14.218077] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(e): [finished] writing file "/sysroot/home/core/nfs-pod.yaml"[ 14.649106] kauditd_printk_skb: 1 callbacks suppressed [ 14.649111] audit: type=1130 audit(1707503658.104:38): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 14.236571] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(f): [started] writing file "/sysroot/home/core/nfs-pvc.yaml" [ 14.267067] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(f): [finished] writing file "/sysroot/home/core/nfs-pvc.yaml" Starting initrd-setup-root-after-ignition.service... [ 14.278017] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(10): [started] writing file "/sysroot/etc/flatcar/update.conf" [ 14.296633] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(10): [finished] writing file "/sysroot/etc/flatcar/update.conf" Starting ignition-quench.service... [ 14.307694] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(11): [started] writing file "/sysroot/etc/systemd/system/nvidia.service" [ 14.324070] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(11): oem config not found in "/usr/share/oem", looking on oem partition [ OK ] Finished ignition-quench.service. [ 14.768441] audit: type=1130 audit(1707503658.224:39): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 14.335617] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(11): op(12): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1160066773"[ 14.787579] audit: type=1131 audit(1707503658.240:40): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 14.387350] ignition[1029]: CRITICAL : files: createFilesystemsFiles: createFiles: op(11): op(12): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1160066773": device or resource busy [ OK ] Finished initrd-setup-root-after-ignition.service. [ 14.404141] ignition[1029]: ERROR : files: createFilesystemsFiles: createFiles: op(11): failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem1160066773", trying btrfs: device or resource busy[ 14.838457] audit: type=1130 audit(1707503658.294:41): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 14.447304] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(11): op(13): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1160066773" [ OK ] Reached target ignition-complete.target. [ 14.462427] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(11): op(13): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1160066773" [ 14.481429] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(11): op(14): [started] unmounting "/mnt/oem1160066773" Starting initrd-parse-etc.service... [ 14.492648] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(11): op(14): [finished] unmounting "/mnt/oem1160066773" [ 14.508706] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(11): [finished] writing file "/sysroot/etc/systemd/system/nvidia.service" [ 14.521887] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(15): [started] writing file "/sysroot/etc/systemd/system/waagent.service" [ OK ] Finished initrd-parse-etc.service. [ 14.533955] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(15): oem config not found in "/usr/share/oem", looking on oem partition[ 14.966567] audit: type=1130 audit(1707503658.422:42): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 14.568820] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(15): op(16): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3115453084" [ OK ] Reached target initrd-fs.target. [ 14.584304] ignition[1029]: CRITICAL : files: createFilesystemsFiles: createFiles: op(15): op(16): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3115453084": device or resource busy [ 15.031274] audit: type=1131 audit(1707503658.454:43): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Reached target initrd.target. [ 14.624777] ignition[1029]: ERROR : files: createFilesystemsFiles: createFiles: op(15): failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem3115453084", trying btrfs: device or resource busy Starting dracut-pre-pivot.service... [ 14.648714] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(15): op(17): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3115453084" [ OK ] Finished dracut-pre-pivot.service. [ 14.668796] systemd[1]: mnt-oem1160066773.mount: Deactivated successfully.[ 15.100962] audit: type=1130 audit(1707503658.556:44): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 14.695811] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(15): op(17): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3115453084" [ 14.710767] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(15): op(18): [started] unmounting "/mnt/oem3115453084" Starting initrd-cleanup.service... [ 14.721449] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(15): op(18): [finished] unmounting "/mnt/oem3115453084" [ OK ] Stopped target nss-lookup.target. [ 14.736445] ignition[1029]: INFO : files: createFilesystemsFiles: createFiles: op(15): [finished] writing file "/sysroot/etc/systemd/system/waagent.service" [ OK ] Stopped target remote-cryptsetup.target. [ 14.753848] ignition[1029]: INFO : files: op(19): [started] processing unit "waagent.service" [ OK ] Stopped target timers.target. [ 14.767684] ignition[1029]: INFO : files: op(19): [finished] processing unit "waagent.service" [ OK ] Stopped dracut-pre-pivot.service. [ 14.782225] ignition[1029]: INFO : files: op(1a): [started] processing unit "nvidia.service"[ 15.215695] audit: type=1131 audit(1707503658.671:45): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 14.819449] ignition[1029]: INFO : files: op(1a): [finished] processing unit "nvidia.service" [ OK ] Stopped target initrd.target. [ 14.831155] ignition[1029]: INFO : files: op(1b): [started] processing unit "prepare-helm.service" [ OK ] Stopped target basic.target. [ 14.845387] ignition[1029]: INFO : files: op(1b): op(1c): [started] writing unit "prepare-helm.service" at "/sysroot/etc/systemd/system/prepare-helm.service" [ OK ] Stopped target ignition-complete.target. [ 14.866624] ignition[1029]: INFO : files: op(1b): op(1c): [finished] writing unit "prepare-helm.service" at "/sysroot/etc/systemd/system/prepare-helm.service" [ OK ] Stopped target ignition-diskful.target. [ 14.889848] ignition[1029]: INFO : files: op(1b): [finished] processing unit "prepare-helm.service" [ OK ] Stopped target initrd-root-device.target. [ 14.906815] ignition[1029]: INFO : files: op(1d): [started] processing unit "containerd.service" [ OK ] Stopped target remote-fs.target. [ 14.922374] ignition[1029]: INFO : files: op(1d): op(1e): [started] writing systemd drop-in "10-use-cgroupfs.conf" at "/sysroot/etc/systemd/system/containerd.service.d/10-use-cgroupfs.conf" [ OK ] Stopped target remote-fs-pre.target. [ 14.945334] ignition[1029]: INFO : files: op(1d): op(1e): [finished] writing systemd drop-in "10-use-cgroupfs.conf" at "/sysroot/etc/systemd/system/containerd.service.d/10-use-cgroupfs.conf" [ OK ] Stopped target sysinit.target. [ 14.971040] ignition[1029]: INFO : files: op(1d): [finished] processing unit "containerd.service" [ OK ] Stopped target local-fs.target. [ 14.984655] ignition[1029]: INFO : files: op(1f): [started] processing unit "prepare-cni-plugins.service" [ OK ] Stopped target local-fs-pre.target. [ 14.998703] ignition[1029]: INFO : files: op(1f): op(20): [started] writing unit "prepare-cni-plugins.service" at "/sysroot/etc/systemd/system/prepare-cni-plugins.service" [ OK ] Stopped target swap.target. [ 15.019063] systemd[1]: Finished ignition-files.service. [ OK ] Stopped dracut-pre-mount.service. [ 15.028141] ignition[1029]: INFO : files: op(1f): op(20): [finished] writing unit "prepare-cni-plugins.service" at "/sysroot/etc/systemd/system/prepare-cni-plugins.service" [ 15.474067] audit: type=1131 audit(1707503658.916:46): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Stopped target cryptsetup.target. [ 15.067749] ignition[1029]: INFO : files: op(1f): [finished] processing unit "prepare-cni-plugins.service" [ OK ] Stopped dracut-initqueue.service. [ 15.081340] ignition[1029]: INFO : files: op(21): [started] processing unit "prepare-critools.service"[ 15.521634] audit: type=1131 audit(1707503658.969:47): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Stopped initrd-setup-root-after-ignition.service. [ 15.114730] ignition[1029]: INFO : files: op(21): op(22): [started] writing unit "prepare-critools.service" at "/sysroot/etc/systemd/system/prepare-critools.service" [ OK ] Stopped ignition-files.service. [ 15.134381] ignition[1029]: INFO : files: op(21): op(22): [finished] writing unit "prepare-critools.service" at "/sysroot/etc/systemd/system/prepare-critools.service" [ 15.152574] ignition[1029]: INFO : files: op(21): [finished] processing unit "prepare-critools.service" [ OK ] Stopped flatcar-metadata-hostname.service. [ 15.161342] ignition[1029]: INFO : files: op(23): [started] setting preset to enabled for "prepare-critools.service" Stopping ignition-mount.service... [ 15.179446] ignition[1029]: INFO : files: op(23): [finished] setting preset to enabled for "prepare-critools.service" Stopping sysroot-boot.service... [ 15.197114] ignition[1029]: INFO : files: op(24): [started] setting preset to enabled for "waagent.service" [ 15.215232] ignition[1029]: INFO : files: op(24): [finished] setting preset to enabled for "waagent.service" [ OK ] Stopped systemd-udev-trigger.service. [ 15.224593] ignition[1029]: INFO : files: op(25): [started] setting preset to enabled for "nvidia.service" [ OK ] Stopped dracut-pre-trigger.service. [ 15.238490] ignition[1029]: INFO : files: op(25): [finished] setting preset to enabled for "nvidia.service" [ OK ] Finished initrd-cleanup.service. [ 15.251599] ignition[1029]: INFO : files: op(26): [started] setting preset to enabled for "prepare-helm.service" [ OK ] Stopped ignition-mount.service. [ 15.265855] ignition[1029]: INFO : files: op(26): [finished] setting preset to enabled for "prepare-helm.service" [ OK ] Stopped ignition-disks.service. [ 15.279086] ignition[1029]: INFO : files: op(27): [started] setting preset to enabled for "prepare-cni-plugins.service" [ OK ] Stopped ignition-kargs.service. [ 15.292674] ignition[1029]: INFO : files: op(27): [finished] setting preset to enabled for "prepare-cni-plugins.service" [ 15.307084] ignition[1029]: INFO : files: createResultFile: createFiles: op(28): [started] writing file "/sysroot/etc/.ignition-result.json" [ OK ] Stopped ignition-fetch.service. [ 15.317315] ignition[1029]: INFO : files: createResultFile: createFiles: op(28): [finished] writing file "/sysroot/etc/.ignition-result.json" [ OK ] Stopped target network.target. [ 15.332699] ignition[1029]: INFO : files: files passed [ OK ] Stopped ignition-fetch-offline.service. [ 15.341738] ignition[1029]: INFO : Ignition finished successfully [ OK ] Stopped target paths.target. [ 15.352528] initrd-setup-root-after-ignition[1055]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory [ OK ] Stopped systemd-ask-password-console.path. [ 15.366069] systemd[1]: Starting initrd-setup-root-after-ignition.service... [ OK ] Stopped target slices.target. [ 15.378128] systemd[1]: torcx-profile-populate.service was skipped because of an unmet condition check (ConditionPathExists=/sysroot/etc/torcx/next-profile). [ OK ] Stopped target sockets.target. [ 15.393806] systemd[1]: Starting ignition-quench.service... [ OK ] Closed iscsid.socket. [ 15.402625] systemd[1]: ignition-quench.service: Deactivated successfully. [ OK ] Closed iscsiuio.socket. [ 15.412414] systemd[1]: Finished ignition-quench.service. [ OK ] Stopped ignition-setup.service. [ 15.421103] systemd[1]: Finished initrd-setup-root-after-ignition.service. Stopping systemd-networkd.service... [ 15.431741] systemd[1]: Reached target ignition-complete.target. Stopping systemd-resolved.service... [ 15.442248] ignition[1068]: INFO : Ignition 2.14.0 [ OK ] Stopped systemd-networkd.service. [ 15.450847] ignition[1068]: INFO : Stage: umount [ OK ] Stopped sysroot-boot.service. [ 15.462438] ignition[1068]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" [ OK ] Stopped systemd-resolved.service. [ 15.475173] ignition[1068]: DEBUG : parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63 [ OK ] Closed systemd-networkd.socket. [ 15.496370] ignition[1068]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" [ OK ] Stopped initrd-setup-root.service. [ 15.508607] ignition[1068]: INFO : umount: umount passed Stopping network-cleanup.service... [ OK ] Stopped parse-ip-for-networkd.service. [ 15.518410] ignition[1068]: INFO : Ignition finished successfully [ OK ] Stopped systemd-sysctl.service. [ 15.534440] systemd[1]: Starting initrd-parse-etc.service... [ OK ] Stopped systemd-modules-load.service. [ 15.543731] systemd[1]: initrd-parse-etc.service: Deactivated successfully. Stopping systemd-udevd.service... [ 15.555437] systemd[1]: Finished initrd-parse-etc.service. [ OK ] Stopped systemd-udevd.service. [ 15.564272] systemd[1]: Reached target initrd-fs.target. [ OK ] Closed systemd-udevd-control.socket. [ OK ] Closed systemd-udevd-kernel.socket. [ 15.573214] systemd[1]: Reached target initrd.target. [ OK ] Stopped dracut-pre-udev.service. [ 15.591995] systemd[1]: dracut-mount.service was skipped because no trigger condition checks were met. [ OK ] Stopped dracut-cmdline.service. [ 15.605142] systemd[1]: Starting dracut-pre-pivot.service... [ OK ] Stopped dracut-cmdline-ask.service. [ 16.053600] hv_netvsc 002248b4-05ca-0022-48b4-05ca002248b4 eth0: Data path switched from VF: enP17054s1 [ 15.615529] systemd[1]: Finished dracut-pre-pivot.service. Starting initrd-udevadm-cleanup-db.service... [ 15.640665] systemd[1]: Starting initrd-cleanup.service... [ OK ] Stopped systemd-tmpfiles-setup-dev.service. [ 15.650884] systemd[1]: Stopped target nss-lookup.target. [ OK ] Stopped kmod-static-nodes.service. [ 15.661161] systemd[1]: Stopped target remote-cryptsetup.target. [ OK ] Stopped systemd-vconsole-setup.service. [ 15.671377] systemd[1]: Stopped target timers.target. [ OK ] Finished initrd-udevadm-cleanup-db.service. [ 15.680765] systemd[1]: dracut-pre-pivot.service: Deactivated successfully. [ 15.694326] systemd[1]: Stopped dracut-pre-pivot.service. [ 15.698712] systemd[1]: Stopped target initrd.target. [ 15.703125] systemd[1]: Stopped target basic.target. [ 15.707202] systemd[1]: Stopped target ignition-complete.target. [ 15.711946] systemd[1]: Stopped target ignition-diskful.target. [ 15.716847] systemd[1]: Stopped target initrd-root-device.target. [ 15.721671] systemd[1]: Stopped target remote-fs.target. [ 15.726256] systemd[1]: Stopped target remote-fs-pre.target. [ 15.730932] systemd[1]: Stopped target sysinit.target. [ 15.735474] systemd[1]: Stopped target local-fs.target. [ OK ] Stopped network-cleanup.service. [ 15.740051] systemd[1]: Stopped target local-fs-pre.target. [ OK ] Reached target initrd-switch-root.target. [ 15.749419] systemd[1]: Stopped target swap.target. Starting initrd-switch-root.service... [ 15.758798] systemd[1]: dracut-pre-mount.service: Deactivated successfully. [ 15.773128] systemd[1]: Stopped dracut-pre-mount.service. [ 15.777688] systemd[1]: Stopped target cryptsetup.target. [ 15.782960] systemd[1]: dracut-initqueue.service: Deactivated successfully. [ 15.788865] systemd[1]: Stopped dracut-initqueue.service. [ 15.793380] systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. [ 15.800097] systemd[1]: Stopped initrd-setup-root-after-ignition.service. [ 15.805981] systemd[1]: ignition-files.service: Deactivated successfully. [ 15.812174] systemd[1]: Stopped ignition-files.service. [ 15.817171] systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. [ 15.823722] systemd[1]: Stopped flatcar-metadata-hostname.service. [ 15.829117] systemd[1]: Stopping ignition-mount.service... [ 15.833856] systemd[1]: Stopping sysroot-boot.service... [ 15.842859] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. [ 16.279331] systemd-journald[276]: Received SIGTERM from PID 1 (n/a). (flatcar) runtime switch to legacy cgroups [ 19.444410] SELinux: Class mctp_socket not defined in policy. [ 19.451199] SELinux: Class anon_inode not defined in policy. [ 19.456498] SELinux: the above unknown classes and permissions will be allowed [ 19.465013] SELinux: policy capability network_peer_controls=1 [ 19.470818] SELinux: policy capability open_perms=1 [ 19.476622] SELinux: policy capability extended_socket_class=1 [ 19.482182] SELinux: policy capability always_check_network=0 [ 19.487914] SELinux: policy capability cgroup_seclabel=1 [ 19.493420] SELinux: policy capability nnp_nosuid_transition=1 [ 19.499311] SELinux: policy capability genfs_seclabel_symlinks=0 [ 19.505645] SELinux: policy capability ioctl_skip_cloexec=0 [ 19.548249] systemd[1]: Successfully loaded SELinux policy in 311.962ms. [ 20.086566] systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 22.217ms. [ 20.126251] systemd[1]: systemd 252 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL -ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE -TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified) [ 20.156233] systemd[1]: Detected virtualization microsoft. [ 20.161873] systemd[1]: Detected architecture arm64. [ 20.166901] systemd[1]: Detected first boot. Welcome to Flatcar Container Linux by Kinvolk 3510.3.2 (LTS 2023)! [ 20.210139] systemd[1]: Hostname set to . [ 20.246539] systemd[1]: Initializing machine ID from random generator. [ 21.714680] SELinux: Context system_u:object_r:container_file_t:s0:c1022,c1023 is not valid (left unmapped). [ 21.725146] kauditd_printk_skb: 39 callbacks suppressed [ 21.725148] audit: type=1400 audit(1707503665.170:87): avc: denied { associate } for pid=1121 comm="torcx-generator" name="docker" dev="tmpfs" ino=2 scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 srawcon="system_u:object_r:container_file_t:s0:c1022,c1023" [ 21.754928] audit: type=1300 audit(1707503665.170:87): arch=c00000b7 syscall=5 success=yes exit=0 a0=4000147234 a1=40000c84b0 a2=40000ce680 a3=32 items=0 ppid=1104 pid=1121 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="torcx-generator" exe="/usr/lib/systemd/system-generators/torcx-generator" subj=system_u:system_r:kernel_t:s0 key=(null) [ 21.789296] audit: type=1327 audit(1707503665.170:87): proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61 [ 21.815752] audit: type=1400 audit(1707503665.186:88): avc: denied { associate } for pid=1121 comm="torcx-generator" name="usr" scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 [ 21.834271] audit: type=1300 audit(1707503665.186:88): arch=c00000b7 syscall=34 success=yes exit=0 a0=ffffffffffffff9c a1=4000147319 a2=1ed a3=0 items=2 ppid=1104 pid=1121 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="torcx-generator" exe="/usr/lib/systemd/system-generators/torcx-generator" subj=system_u:system_r:kernel_t:s0 key=(null) [ 21.866270] audit: type=1307 audit(1707503665.186:88): cwd="/" [ 21.871953] audit: type=1302 audit(1707503665.186:88): item=0 name=(null) inode=2 dev=00:29 mode=040755 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:unlabeled_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 [ 21.890530] audit: type=1302 audit(1707503665.186:88): item=1 name=(null) inode=3 dev=00:29 mode=040755 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:unlabeled_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 [ 21.909816] audit: type=1327 audit(1707503665.186:88): proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61 [ 27.183263] systemd[1]: Populated /etc with preset unit settings. [ 27.703924] systemd[1]: /usr/lib/systemd/system/locksmithd.service:8: Unit uses CPUShares=; please use CPUWeight= instead. Support for CPUShares= will be removed soon. [ 27.718418] systemd[1]: /usr/lib/systemd/system/locksmithd.service:9: Unit uses MemoryLimit=; please use MemoryMax= instead. Support for MemoryLimit= will be removed soon. [ 27.772480] systemd[1]: /run/systemd/system/docker.socket:8: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. [ 27.811653] systemd[1]: Queued start job for default target multi-user.target. [ 27.825404] systemd[1]: Created slice system-addon\x2dconfig.slice. [ OK ] Created slice system-addon\x2dconfig.slice. [ 27.837371] systemd[1]: Created slice system-addon\x2drun.slice. [ OK ] Created slice system-addon\x2drun.slice. [ 27.849277] systemd[1]: Created slice system-getty.slice. [ OK ] Created slice system-getty.slice. [ 27.860790] systemd[1]: Created slice system-modprobe.slice. [ OK ] Created slice system-modprobe.slice. [ 27.871699] systemd[1]: Created slice system-serial\x2dgetty.slice. [ OK ] Created slice system-serial\x2dgetty.slice. [ 27.883764] systemd[1]: Created slice system-system\x2dcloudinit.slice. [ OK ] Created slice system-system\x2dcloudinit.slice. [ 27.896415] systemd[1]: Created slice system-systemd\x2dfsck.slice. [ OK ] Created slice system-systemd\x2dfsck.slice. [ 27.908550] systemd[1]: Created slice user.slice. [ OK ] Created slice user.slice. [ 27.918519] systemd[1]: Started systemd-ask-password-console.path. [ OK ] Started systemd-ask-password-console.path. [ 27.929578] systemd[1]: Started systemd-ask-password-wall.path. [ OK ] Started systemd-ask-password-wall.path. [ 27.940532] systemd[1]: Set up automount boot.automount. [ OK ] Set up automount boot.automount. [ 27.950466] systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount. [ OK ] Set up automount proc-sys-fs-binfmt_misc.automount. [ 27.963985] systemd[1]: Reached target integritysetup.target. [ OK ] Reached target integritysetup.target. [ 27.974319] systemd[1]: Reached target remote-cryptsetup.target. [ OK ] Reached target remote-cryptsetup.target. [ 27.984880] systemd[1]: Reached target remote-fs.target. [ OK ] Reached target remote-fs.target. [ 27.997514] systemd[1]: Reached target slices.target. [ OK ] Reached target slices.target. [ 28.007131] systemd[1]: Reached target swap.target. [ OK ] Reached target swap.target. [ 28.017077] systemd[1]: Reached target torcx.target. [ OK ] Reached target torcx.target. [ 28.025848] systemd[1]: Reached target veritysetup.target. [ OK ] Reached target veritysetup.target. [ 28.036783] systemd[1]: Listening on systemd-coredump.socket. [ OK ] Listening on systemd-coredump.socket. [ 28.047890] systemd[1]: Listening on systemd-initctl.socket. [ OK ] Listening on systemd-initctl.socket. [ 28.058545] audit: type=1400 audit(1707503671.514:89): avc: denied { audit_read } for pid=1 comm="systemd" capability=37 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1 [ 28.058563] systemd[1]: Listening on systemd-journald-audit.socket. [ 28.078050] audit: type=1335 audit(1707503671.514:90): pid=1 uid=0 auid=4294967295 tty=(none) ses=4294967295 subj=system_u:system_r:kernel_t:s0 comm="systemd" exe="/usr/lib/systemd/systemd" nl-mcgrp=1 op=connect res=1 [ OK ] Listening on systemd-journald-audit.socket. [ 28.106512] systemd[1]: Listening on systemd-journald-dev-log.socket. [ OK ] Listening on systemd-journald-dev-log.socket. [ 28.118978] systemd[1]: Listening on systemd-journald.socket. [ OK ] Listening on systemd-journald.socket. [ 28.129661] systemd[1]: Listening on systemd-networkd.socket. [ OK ] Listening on systemd-networkd.socket. [ 28.141435] systemd[1]: Listening on systemd-udevd-control.socket. [ OK ] Listening on systemd-udevd-control.socket. [ 28.153008] systemd[1]: Listening on systemd-udevd-kernel.socket. [ OK ] Listening on systemd-udevd-kernel.socket. [ 28.164939] systemd[1]: Listening on systemd-userdbd.socket. [ OK ] Listening on systemd-userdbd.socket. [ 28.176979] systemd[1]: Mounting dev-hugepages.mount... Mounting dev-hugepages.mount... [ 28.187681] systemd[1]: Mounting dev-mqueue.mount... Mounting dev-mqueue.mount... [ 28.197599] systemd[1]: Mounting media.mount... Mounting media.mount... [ 28.206391] systemd[1]: Mounting sys-kernel-debug.mount... Mounting sys-kernel-debug.mount... [ 28.216685] systemd[1]: Mounting sys-kernel-tracing.mount... Mounting sys-kernel-tracing.mount... [ 28.227266] systemd[1]: Mounting tmp.mount... Mounting tmp.mount... [ 28.237337] systemd[1]: Starting flatcar-tmpfiles.service... Starting flatcar-tmpfiles.service... [ 28.250084] systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. [ 28.260054] systemd[1]: Starting kmod-static-nodes.service... Starting kmod-static-nodes.service... [ 28.270928] systemd[1]: Starting modprobe@configfs.service... Starting modprobe@configfs.service... [ 28.283454] systemd[1]: Starting modprobe@dm_mod.service... Starting modprobe@dm_mod.service... [ 28.295438] systemd[1]: Starting modprobe@drm.service... Starting modprobe@drm.service... [ 28.305395] systemd[1]: Starting modprobe@efi_pstore.service... Starting modprobe@efi_pstore.service... [ 28.317209] systemd[1]: Starting modprobe@fuse.service... Starting modprobe@fuse.service... [ 28.327776] systemd[1]: Starting modprobe@loop.service... Starting modprobe@loop.service... [ 28.337675] systemd[1]: setup-nsswitch.service was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). [ 28.352575] systemd[1]: systemd-journald.service: unit configures an IP firewall, but the local system does not support BPF/cgroup firewalling. [ 28.364549] systemd[1]: (This warning is only shown for the first unit using IP firewalling.) [ 28.373140] systemd[1]: Starting systemd-journald.service... [ 28.377637] loop: module loaded Starting systemd-journald.service... [ 28.394438] fuse: init (API version 7.34) [ 28.428063] systemd[1]: Starting systemd-modules-load.service... Starting systemd-modules-load.service... [ 28.440391] systemd[1]: Starting systemd-network-generator.service... Starting systemd-network-generator.service... [ 28.452532] systemd[1]: Starting systemd-remount-fs.service... Starting systemd-remount-fs.service... [ 28.463854] systemd[1]: Starting systemd-udev-trigger.service... [ 28.464924] audit: type=1305 audit(1707503671.919:91): op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Starting systemd-udev-trigger.service... [ 28.488299] audit: type=1300 audit(1707503671.919:91): arch=c00000b7 syscall=211 success=yes exit=60 a0=3 a1=ffffcf45dda0 a2=4000 a3=1 items=0 ppid=1 pid=1232 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="systemd-journal" exe="/usr/lib/systemd/systemd-journald" subj=system_u:system_r:kernel_t:s0 key=(null) [ 28.489808] systemd[1]: Started systemd-journald.service. [ 28.523772] audit: type=1327 audit(1707503671.919:91): proctitle="/usr/lib/systemd/systemd-journald" [ OK ] Started systemd-journald.service. [ 28.539080] audit: type=1130 audit(1707503671.994:92): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Mounted dev-hugepages.mount. [ OK ] Mounted dev-mqueue.mount. [ OK ] Mounted media.mount. [ OK ] Mounted sys-kernel-debug.mount. [ OK ] Mounted sys-kernel-tracing.mount. [ OK ] Mounted tmp.mount. [ OK ] Finished flatcar-tmpfiles.service. [ 28.592190] audit: type=1130 audit(1707503672.048:93): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=flatcar-tmpfiles comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Finished kmod-static-nodes.service. [ 28.620316] audit: type=1130 audit(1707503672.076:94): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Finished modprobe@configfs.service. [ 28.645885] audit: type=1130 audit(1707503672.101:95): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@configfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 28.664524] audit: type=1131 audit(1707503672.101:96): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@configfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Finished modprobe@dm_mod.service. [ OK ] Finished modprobe@drm.service. [ OK ] Finished modprobe@efi_pstore.service. [ OK ] Finished modprobe@fuse.service. [ OK ] Finished modprobe@loop.service. [ OK ] Finished systemd-modules-load.service. [ OK ] Finished systemd-network-generator.service. [ OK ] Finished systemd-remount-fs.service. [ OK ] Finished systemd-udev-trigger.service. [ OK ] Reached target network-pre.target. Mounting sys-fs-fuse-connections.mount... Mounting sys-kernel-config.mount... Starting systemd-hwdb-update.service... Starting systemd-journal-flush.service... Starting systemd-random-seed.service... Starting systemd-sysctl.service... Starting systemd-sysusers.service... Starting systemd-udev-settle.service... [ OK ] Mounted sys-fs-fuse-connections.mount. [ OK ] Mounted sys-kernel-config.mount. [ 28.829850] systemd-journald[1232]: Received client request to flush runtime journal. [ OK ] Finished systemd-random-seed.service. [ OK ] Reached target first-boot-complete.target. [ OK ] Finished systemd-sysctl.service. [ OK ] Finished systemd-journal-flush.service. [ OK ] Finished systemd-sysusers.service. Starting systemd-tmpfiles-setup-dev.service... [ OK ] Finished systemd-tmpfiles-setup-dev.service. [ OK ] Finished systemd-hwdb-update.service. Starting systemd-udevd.service... [ OK ] Started systemd-udevd.service. Starting systemd-networkd.service... [ OK ] Found device dev-ttyAMA0.device. [ 30.341586] mousedev: PS/2 mouse device common for all mice [ 30.353851] hv_vmbus: registering driver hv_balloon Starting systemd-userdbd.service... [ 30.371789] hv_vmbus: registering driver hyperv_fb [ 30.378172] hv_balloon: Using Dynamic Memory protocol version 2.0 [ 30.384009] hyperv_fb: Synthvid Version major 3, minor 5 [ 30.390256] hv_balloon: Memory hot add disabled on ARM64 [ 30.390597] hv_utils: Registering HyperV Utility Driver [ 30.399983] hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 [ 30.406429] hv_vmbus: registering driver hv_utils [ 30.412928] Console: switching to colour dummy device 80x25 [ 30.414242] hv_utils: Heartbeat IC version 3.0 [ 30.421457] hv_utils: Shutdown IC version 3.2 [ 30.425206] Console: switching to colour frame buffer device 128x48 [ 30.425273] hv_utils: TimeSync IC version 4.0 [ 30.432083] systemd-journald[1232]: Time jumped backwards, rotating. [ OK ] Started systemd-userdbd.service. [ 30.644650] BTRFS info: devid 1 device path /dev/disk/by-label/OEM changed to /dev/sda6 scanned by (udev-worker) (1298) [ OK ] Finished systemd-udev-settle.service. Starting lvm2-activation-early.service... [ OK ] Started systemd-networkd.service. Starting systemd-networkd-wait-online.service... [ 31.027638] mlx5_core 429e:00:02.0 enP17054s1: Link up [ OK ] Finished lvm2-activation-early.service. [ OK ] Reached target cryptsetup.target. Starting lvm2-activation.service... [ 31.053242] hv_netvsc 002248b4-05ca-0022-48b4-05ca002248b4 eth0: Data path switched to VF: enP17054s1 [ OK ] Finished lvm2-activation.service. [ OK ] Reached target local-fs-pre.target. [ OK ] Reached target local-fs.target. [ OK ] Reached target machines.target. Starting ldconfig.service... Starting systemd-boot-update.service... Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service... Starting systemd-machine-id-commit.service... Starting systemd-tmpfiles-setup.service... Starting systemd-fsck@dev-…label-EFI\x2dSYSTEM.service... [ OK ] Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service. [ OK ] Finished systemd-fsck@dev-…2dlabel-EFI\x2dSYSTEM.service. Mounting boot.mount... [ OK ] Mounted boot.mount. [ OK ] Finished systemd-boot-update.service. [ OK ] Finished systemd-machine-id-commit.service. [ OK ] Finished systemd-tmpfiles-setup.service. Starting audit-rules.service... Starting clean-ca-certificates.service... Starting systemd-journal-catalog-update.service... Starting systemd-resolved.service... Starting systemd-timesyncd.service... Starting systemd-update-utmp.service... [ OK ] Finished systemd-networkd-wait-online.service. [ OK ] Finished clean-ca-certificates.service. [ OK ] Finished systemd-update-utmp.service. [ OK ] Started systemd-timesyncd.service. [ OK ] Reached target time-set.target. [ OK ] Started systemd-resolved.service. [ 33.130430] kauditd_printk_skb: 52 callbacks suppressed [ 33.130433] audit: type=1130 audit(1707503676.406:134): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Reached target network.target. [ OK ] Reached target network-online.target. [ OK ] Reached target nss-lookup.target. [ OK ] Finished systemd-journal-catalog-update.service. [ 33.190485] audit: type=1130 audit(1707503676.466:135): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journal-catalog-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 33.240999] audit: type=1305 audit(1707503676.516:136): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 [ 33.253275] audit: type=1300 audit(1707503676.516:136): arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=fffff70a84a0 a2=420 a3=0 items=0 ppid=1389 pid=1413 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="auditctl" exe="/usr/sbin/auditctl" subj=system_u:system_r:kernel_t:s0 key=(null) [ 33.277948] audit: type=1327 audit(1707503676.516:136): proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 [ OK ] Finished audit-rules.service. [* ] Job ldconfig.service/start running (7s / no limit) M [** ] Job ldconfig.service/start running (8s / no limit) M [*** ] Job ldconfig.service/start running (8s / no limit) M [ *** ] Job ldconfig.service/start running (9s / no limit) M [ *** ] Job ldconfig.service/start running (10s / no limit) M [ ***] Job ldconfig.service/start running (10s / no limit) M [ **] Job ldconfig.service/start running (11s / no limit) M [ OK ] Finished ldconfig.service.  Starting systemd-update-done.service... [ OK ] Finished systemd-update-done.service. [ OK ] Reached target sysinit.target. [ OK ] Started motdgen.path. [ OK ] Started user-cloudinit@var…car\x2dinstall-user_data.path. [ OK ] Started logrotate.timer. [ OK ] Started mdadm.timer. [ OK ] Started systemd-tmpfiles-clean.timer. [ OK ] Reached target paths.target. [ OK ] Reached target timers.target. [ OK ] Listening on dbus.socket. Starting docker.socket... [ OK ] Listening on sshd.socket. [ OK ] Listening on docker.socket. [ OK ] Reached target sockets.target. [ OK ] Reached target basic.target. Starting containerd.service... Starting dbus.service... Starting enable-oem-cloudinit.service... Starting extend-filesystems.service... Starting motdgen.service... [ OK ] Started nvidia.service. Starting prepare-cni-plugins.service... Starting prepare-critools.service... Starting prepare-helm.service... Starting ssh-key-proc-cmdline.service... Starting sshd-keygen.service... Starting systemd-logind.service... Starting update-engine.service... Starting update-ssh-keys-after-ignition.service... [ OK ] Finished ssh-key-proc-cmdline.service. [ 38.938924] extend-filesystems[1429]: Found sda [ 38.944393] extend-filesystems[1429]: Found sda1 [ 38.949803] extend-filesystems[1429]: Found sda2 [ 38.954616] extend-filesystems[1429]: Found sda3 [ 38.959171] extend-filesystems[1429]: Found usr [ 38.964340] extend-filesystems[1429]: Found sda4 [ 38.969926] extend-filesystems[1429]: Found sda6 [ 38.974437] extend-filesystems[1429]: Found sda7 [ 38.992792] extend-filesystems[1429]: Found sda9 [ OK ] Finished motdgen.service. [ 39.007154] extend-filesystems[1429]: Checking size of /dev/sda9 [ 39.081042] extend-filesystems[1429]: Old size kept for /dev/sda9 [ 39.088365] extend-filesystems[1429]: Found sr0 [ OK ] Finished extend-filesystems.service. [ OK ] Finished update-ssh-keys-after-ignition.service. [ OK ] Started containerd.service. [ OK ] Started dbus.service. [ OK ] Reached target system-config.target. [ OK ] Reached target user-config.target. [ OK ] Started systemd-logind.service. [ OK ] Started update-engine.service. [ OK ] Started locksmithd.service. [ OK ] Finished prepare-cni-plugins.service. [ OK ] Finished prepare-helm.service. [ OK ] Finished prepare-critools.service. [ OK ] Finished sshd-keygen.service. Starting issuegen.service... [ OK ] Started waagent.service. [ OK ] Finished issuegen.service. Starting systemd-user-sessions.service... [ OK ] Finished systemd-user-sessions.service. [ OK ] Started getty@tty1.service. [ OK ] Started serial-getty@ttyAMA0.service. [ OK ] Reached target getty.target. [ OK ] Reached target multi-user.target. Starting systemd-update-utmp-runlevel.service... [ OK ] Finished systemd-update-utmp-runlevel.service. This is ci-3510.3.2-a-76b5b28b66 (Linux aarch64 5.15.148-flatcar) 18:34:45 SSH host key: SHA256:9y48ZGSl3S8+xl52cbSqFjWRzueKogY81zMaBndXXDY (RSA) SSH host key: SHA256:m+GQJ6e0a91GWAFsH7PmzJn5xszRxyyNFLNEWhMIhSs (ED25519) SSH host key: SHA256:KkqY43Jj9+BZEE22iqW+Myo3VTGCTac4WrHdiLAWbvg (ECDSA) enP17054s1: eth0: 10.200.20.16 fe80::222:48ff:feb4:5ca ci-3510 login: core (automatic login) Flatcar Container Linux by Kinvolk lts 3510.3.2 for Microsoft Azure Warning: using legacy cgroups Read more: https://kinvolk.io/docs/flatcar-container-linux/latest/container-runtimes/switching-to-unified-cgroups [?2004hcore@ci-3510 ~ $ 2024-02-09T18:34:51.288204Z INFO Daemon Daemon Azure Linux Agent Version:2.6.0.2 2024-02-09T18:34:51.311121Z INFO Daemon Daemon OS: flatcar 3510.3.2 2024-02-09T18:34:51.317493Z INFO Daemon Daemon Python: 3.9.16 2024-02-09T18:34:51.323802Z INFO Daemon Daemon Run daemon 2024-02-09T18:34:51.329597Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='3510.3.2' 2024-02-09T18:34:51.355906Z INFO Daemon Daemon Unable to get cloud-init enabled status from systemctl: Command '['systemctl', 'is-enabled', 'cloud-init-local.service']' returned non-zero exit status 1. 2024-02-09T18:34:51.377754Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' 2024-02-09T18:34:51.391135Z INFO Daemon Daemon cloud-init is enabled: False 2024-02-09T18:34:51.397583Z INFO Daemon Daemon Using waagent for provisioning 2024-02-09T18:34:51.404932Z INFO Daemon Daemon Activate resource disk 2024-02-09T18:34:51.411053Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb 2024-02-09T18:34:51.427372Z INFO Daemon Daemon Found device: None 2024-02-09T18:34:51.432833Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology 2024-02-09T18:34:51.445117Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 2024-02-09T18:34:51.459653Z INFO Daemon Daemon Clean protocol and wireserver endpoint 2024-02-09T18:34:51.467341Z INFO Daemon Daemon Running default provisioning handler 2024-02-09T18:34:51.482183Z INFO Daemon Daemon Unable to get cloud-init enabled status from systemctl: Command '['systemctl', 'is-enabled', 'cloud-init-local.service']' returned non-zero exit status 1. 2024-02-09T18:34:51.500845Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' 2024-02-09T18:34:51.513094Z INFO Daemon Daemon cloud-init is enabled: False 2024-02-09T18:34:51.519512Z INFO Daemon Daemon Copying ovf-env.xml 2024-02-09T18:34:51.606269Z INFO Daemon Daemon Successfully mounted dvd 2024-02-09T18:34:51.699103Z INFO Daemon Daemon Detect protocol endpoint 2024-02-09T18:34:51.706195Z INFO Daemon Daemon Clean protocol and wireserver endpoint 2024-02-09T18:34:51.714409Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler 2024-02-09T18:34:51.722718Z INFO Daemon Daemon Test for route to 168.63.129.16 2024-02-09T18:34:51.730300Z INFO Daemon Daemon Route to 168.63.129.16 exists 2024-02-09T18:34:51.738148Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 2024-02-09T18:34:51.845951Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 2024-02-09T18:34:51.854779Z INFO Daemon Daemon Wire protocol version:2012-11-30 2024-02-09T18:34:51.861708Z INFO Daemon Daemon Server preferred version:2015-04-05 2024-02-09T18:34:52.870430Z INFO Daemon Daemon Initializing goal state during protocol detection 2024-02-09T18:34:52.888425Z INFO Daemon Daemon Forcing an update of the goal state.. 2024-02-09T18:34:52.896358Z INFO Daemon Daemon Fetching goal state [incarnation 1] 2024-02-09T18:34:52.972095Z INFO Daemon Daemon Found private key matching thumbprint 2985E154D5AAEF2A6C7C0C00267190710D8F23E7 2024-02-09T18:34:52.983614Z INFO Daemon Daemon Certificate with thumbprint 0A4FBD51624F4BC857D9CD40517071A9A2287EA1 has no matching private key. 2024-02-09T18:34:52.997239Z INFO Daemon Daemon Fetch goal state completed 2024-02-09T18:34:53.048413Z INFO Daemon Daemon Fetched new vmSettings [correlation ID: 77eb749c-6bb8-49f4-8ca0-5ab2ec0a6f69 New eTag: 1796429660715282920] 2024-02-09T18:34:53.062488Z INFO Daemon Daemon Status Blob type 'None' is not valid, assuming BlockBlob 2024-02-09T18:34:53.082151Z INFO Daemon Daemon Starting provisioning 2024-02-09T18:34:53.088786Z INFO Daemon Daemon Handle ovf-env.xml. 2024-02-09T18:34:53.094851Z INFO Daemon Daemon Set hostname [ci-3510.3.2-a-76b5b28b66] 2024-02-09T18:34:53.149116Z INFO Daemon Daemon Publish hostname [ci-3510.3.2-a-76b5b28b66] 2024-02-09T18:34:53.157026Z INFO Daemon Daemon Examine /proc/net/route for primary interface 2024-02-09T18:34:53.165590Z INFO Daemon Daemon Primary interface is [eth0] 2024-02-09T18:34:53.232717Z INFO Daemon Daemon Create user account if not exists 2024-02-09T18:34:53.244364Z INFO Daemon Daemon User core already exists, skip useradd 2024-02-09T18:34:53.251955Z INFO Daemon Daemon Configure sudoer 2024-02-09T18:34:53.259393Z INFO Daemon Daemon Configure sshd 2024-02-09T18:34:53.266353Z INFO Daemon Daemon Deploy ssh public key. 2024-02-09T18:34:54.512389Z INFO Daemon Daemon Provisioning complete 2024-02-09T18:34:54.537997Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping 2024-02-09T18:34:54.546395Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. [ 78.523327] hv_balloon: Max. dynamic memory size: 4096 MB [ 90.408394] Initializing XFRM netlink socket [ 114.026510] SELinux: Context system_u:object_r:container_file_t:s0 is not valid (left unmapped). [ 152.146250] WARNING: Unprivileged eBPF is enabled, data leaks possible via Spectre v2 BHB attacks! [ 152.571642] WARNING: Unprivileged eBPF is enabled, data leaks possible via Spectre v2 BHB attacks! [ 154.217180] IPv6: ADDRCONF(NETDEV_CHANGE): cilium_host: link becomes ready [ 154.628701] NET: Registered PF_ALG protocol family [ 155.364061] IPv6: ADDRCONF(NETDEV_CHANGE): lxc_health: link becomes ready [ 155.570012] eth0: renamed from tmp14f6b [ 155.587923] IPv6: ADDRCONF(NETDEV_CHANGE): lxc7c74f16d7cc2: link becomes ready [ 155.605495] eth0: renamed from tmp91dcf [ 155.615796] IPv6: ADDRCONF(NETDEV_CHANGE): lxc307f630d164d: link becomes ready [ 345.885759] alg: No test for seqiv(rfc4106(gcm(aes))) (seqiv(rfc4106(gcm-aes-ce))) [ 348.542339] IPv6: ADDRCONF(NETDEV_CHANGE): lxc_health: link becomes ready