[=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.010124] Console: colour dummy device 80x25 [ 0.015455] printk: console [tty1] enabled [ 0.019895] ACPI: Core revision 20210730 [ 0.024535] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) [ 0.036654] pid_max: default: 32768 minimum: 301 [ 0.042273] LSM: Security Framework initializing [ 0.047587] SELinux: Initializing. [ 0.051646] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) [ 0.060472] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) [ 0.069895] Hyper-V: privilege flags low 0x2e7f, high 0x3a8030, hints 0xe, misc 0x31e1 [ 0.078901] Hyper-V: Host Build 10.0.22477.1369-1-0 [ 0.084583] rcu: Hierarchical SRCU implementation. [ 0.100050] Remapping and enabling EFI services. [ 0.105362] smp: Bringing up secondary CPUs ... [ 0.110493] Detected PIPT I-cache on CPU1 [ 0.110519] GICv3: CPU1: found redistributor 1 region 1:0x00000000f000e000 [ 0.110575] arch_timer: Enabling local workaround for ARM erratum 1418040 [ 0.110621] CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] [ 0.110676] smp: Brought up 1 node, 2 CPUs [ 0.146099] SMP: Total of 2 processors activated. [ 0.152016] CPU features: detected: 32-bit EL0 Support [ 0.158058] CPU features: detected: Instruction cache invalidation not required for I/D coherence [ 0.169406] CPU features: detected: Data cache clean to the PoU not required for I/D coherence [ 0.180635] CPU features: detected: CRC32 instructions [ 0.187524] CPU features: detected: RCpc load-acquire (LDAPR) [ 0.194571] CPU features: detected: LSE atomic instructions [ 0.201296] CPU features: detected: Privileged Access Never [ 0.268524] CPU: All CPU(s) started at EL1 [ 0.273521] alternatives: patching kernel code [ 0.278817] devtmpfs: initialized [ 0.283335] KASLR enabled [ 0.286963] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.299821] futex hash table entries: 512 (order: 3, 32768 bytes, linear) [ 0.308733] pinctrl core: initialized pinctrl subsystem [ 0.316366] SMBIOS 3.1.0 present. [ 0.320770] DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 07/12/2023 [ 0.334821] NET: Registered PF_NETLINK/PF_ROUTE protocol family [ 0.342763] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.352277] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.361843] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.371544] audit: initializing netlink subsys (disabled) [ 0.378310] audit: type=2000 audit(0.101:1): state=initialized audit_enabled=0 res=1 [ 0.378394] thermal_sys: Registered thermal governor 'step_wise' [ 0.387687] cpuidle: using governor menu [ 0.399975] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. [ 0.408198] ASID allocator initialised with 32768 entries [ 0.414507] ACPI: bus type PCI registered [ 0.419257] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.428189] Serial: AMBA PL011 UART driver [ 0.434046] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.442074] HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages [ 0.449756] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.457711] HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages [ 0.585277] cryptd: max_cpu_qlen set to 1000 [ 0.593535] alg: No test for fips(ansi_cprng) (fips_ansi_cprng) [ 0.601194] ACPI: Added _OSI(Module Device) [ 0.606511] ACPI: Added _OSI(Processor Device) [ 0.612117] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.617940] ACPI: Added _OSI(Processor Aggregator Device) [ 0.624930] ACPI: Added _OSI(Linux-Dell-Video) [ 0.630853] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) [ 0.637333] ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) [ 0.648884] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.657101] ACPI: Interpreter enabled [ 0.661500] ACPI: Using GIC for interrupt routing [ 0.667471] ARMH0011:00: ttyAMA0 at MMIO 0xeffec000 (irq = 12, base_baud = 0) is a SBSA [ 0.678164] printk: console [ttyAMA0] enabled [ 0.678164] printk: console [ttyAMA0] enabled [ 0.687529] printk: bootconsole [pl11] disabled [ 0.687529] printk: bootconsole [pl11] disabled [ 0.697538] ARMH0011:01: ttyAMA1 at MMIO 0xeffeb000 (irq = 13, base_baud = 0) is a SBSA [ 0.704848] iommu: Default domain type: Translated [ 0.709300] iommu: DMA domain TLB invalidation policy: strict mode [ 0.715112] vgaarb: loaded [ 0.717533] pps_core: LinuxPPS API ver. 1 registered [ 0.721928] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.730589] PTP clock support registered [ 0.734121] Registered efivars operations [ 0.737842] No ACPI PMU IRQ for CPU0 [ 0.741089] No ACPI PMU IRQ for CPU1 [ 0.744590] clocksource: Switched to clocksource arch_sys_counter [ 0.756417] VFS: Disk quotas dquot_6.6.0 [ 0.760282] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.766896] pnp: PnP ACPI init [ 0.769755] pnp: PnP ACPI: found 0 devices [ 0.775741] NET: Registered PF_INET protocol family [ 0.780310] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) [ 0.788245] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) [ 0.796348] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) [ 0.804115] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) [ 0.811742] TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) [ 0.819361] TCP: Hash tables configured (established 32768 bind 32768) [ 0.825584] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) [ 0.832248] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) [ 0.843039] NET: Registered PF_UNIX/PF_LOCAL protocol family [ 0.848227] PCI: CLS 0 bytes, default 64 [ 0.862639] hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 1 counters available [ 0.870978] kvm [1]: HYP mode not available [ 1.047207] Initialise system trusted keyrings [ 1.051314] workingset: timestamp_bits=39 max_order=20 bucket_order=0 [ 1.058216] Key type asymmetric registered [ 1.061988] Asymmetric key parser 'x509' registered [ 1.066369] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) [ 1.073111] io scheduler mq-deadline registered [ 1.077138] io scheduler kyber registered [ 1.080722] io scheduler bfq registered [ 1.085309] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 1.091709] thunder_xcv, ver 1.0 [ 1.094816] thunder_bgx, ver 1.0 [ 1.097708] nicpf, ver 1.0 [ 1.100327] nicvf, ver 1.0 [ 1.103048] rtc-efi rtc-efi.0: registered as rtc0 [ 1.107417] rtc-efi rtc-efi.0: setting system clock to 2024-02-09T18:34:53 UTC (1707503693) [ 1.115157] efifb: probing for efifb [ 1.118262] efifb: framebuffer at 0x40000000, using 3072k, total 3072k [ 1.124429] efifb: mode is 1024x768x32, linelength=4096, pages=1 [ 1.129867] efifb: scrolling: redraw [ 1.133030] efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 [ 1.140579] Console: switching to colour frame buffer device 128x48 [ 1.147151] fb0: EFI VGA frame buffer device [ 1.151055] SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... [ 1.156722] hid: raw HID events driver (C) Jiri Kosina [ 1.161605] NET: Registered PF_INET6 protocol family [ 1.166257] Segment Routing with IPv6 [ 1.169611] In-situ OAM (IOAM) with IPv6 [ 1.173228] NET: Registered PF_PACKET protocol family [ 1.178634] Key type dns_resolver registered [ 1.183142] registered taskstats version 1 [ 1.186934] Loading compiled-in X.509 certificates [ 1.220700] Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.15.148-flatcar: 947a80114e81e2815f6db72a0d388260762488f9' [ 1.232204] Key type .fscrypt registered [ 1.235698] Key type fscrypt-provisioning registered [ 1.240311] ima: No TPM chip found, activating TPM-bypass! [ 1.245400] ima: Allocated hash algorithm: sha1 [ 1.249708] ima: No architecture policies found [ 1.258571] Freeing unused kernel memory: 34688K [ 1.262634] Run /init as init process [ 1.284691] 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.314212] systemd[1]: Detected virtualization microsoft. [ 1.321018] systemd[1]: Detected architecture arm64. [ 1.325747] systemd[1]: Running in initrd. Welcome to dracut-053 (Initramfs)! [ 1.333738] systemd[1]: No hostname configured, using default hostname. [ 1.340157] systemd[1]: Hostname set to . [ 1.345320] systemd[1]: Initializing machine ID from random generator. [ 1.446123] systemd[1]: Queued start job for default target initrd.target. [ 1.455104] systemd[1]: Started systemd-ask-password-console.path. [ OK ] Started systemd-ask-password-console.path. [ 1.467694] systemd[1]: Reached target cryptsetup.target. [ OK ] Reached target cryptsetup.target. [ 1.478357] systemd[1]: Reached target paths.target. [ OK ] Reached target paths.target. [ 1.488490] systemd[1]: Reached target slices.target. [ OK ] Reached target slices.target. [ 1.498667] systemd[1]: Reached target swap.target. [ OK ] Reached target swap.target. [ 1.508730] systemd[1]: Reached target timers.target. [ OK ] Reached target timers.target. [ 1.519574] systemd[1]: Listening on iscsid.socket. [ OK ] Listening on iscsid.socket. [ 1.529033] systemd[1]: Listening on iscsiuio.socket. [ OK ] Listening on iscsiuio.socket. [ 1.538177] systemd[1]: Listening on systemd-journald-audit.socket. [ OK ] Listening on systemd-journald-audit.socket. [ 1.549032] systemd[1]: Listening on systemd-journald-dev-log.socket. [ OK ] Listening on systemd-journald-dev-log.socket. [ 1.559933] systemd[1]: Listening on systemd-journald.socket. [ OK ] Listening on systemd-journald.socket. [ 1.571846] systemd[1]: Listening on systemd-networkd.socket. [ OK ] Listening on systemd-networkd.socket. [ 1.582307] systemd[1]: Listening on systemd-udevd-control.socket. [ OK ] Listening on systemd-udevd-control.socket. [ 1.593947] systemd[1]: Listening on systemd-udevd-kernel.socket. [ OK ] Listening on systemd-udevd-kernel.socket. [ 1.605225] systemd[1]: Reached target sockets.target. [ OK ] Reached target sockets.target. [ 1.615791] systemd[1]: Starting kmod-static-nodes.service... Starting kmod-static-nodes.service... [ 1.625945] systemd[1]: Finished network-cleanup.service. [ OK ] Finished network-cleanup.service. [ 1.636284] systemd[1]: Starting systemd-fsck-usr.service... Starting systemd-fsck-usr.service... [ 1.646954] systemd[1]: Starting systemd-journald.service... Starting systemd-journald.service... [ 1.658121] systemd[1]: Starting systemd-modules-load.service... Starting systemd-modules-load.service... [ 1.670018] systemd[1]: Starting systemd-resolved.service... Starting systemd-resolved.service...[ 1.694092] bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. [ 1.212883] systemd-modules-load[277]: Inserted module 'overlay'[ 1.713857] systemd[1]: Starting systemd-vconsole-setup.service... [ 1.724830] Bridge firewalling registered Starting systemd-vconsole-setup.service... [ 1.254036] systemd-modules-load[277]: Inserted module 'br_netfilter'[ 1.739123] systemd[1]: Started systemd-journald.service. [ 1.753454] SCSI subsystem initialized [ OK ] Started systemd-journald.service. [ 1.766110] audit: type=1130 audit(1707503694.158: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' [ 1.285449] systemd-resolved[278]: Positive Trust Anchors: [ OK ] Started systemd-resolved.service. [ 1.313862] systemd-resolved[278]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d[ 1.802158] audit: type=1130 audit(1707503694.187: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.802523] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. [ OK ] Finished kmod-static-nodes.service. [ 1.839178] device-mapper: uevent: version 1.0.3 [ 1.843594] audit: type=1130 audit(1707503694.236: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' [ 1.358345] 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.902603] device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com [ OK ] Finished systemd-fsck-usr.service. [ 1.436709] systemd-resolved[278]: Defaulting to hostname 'linux'.[ 1.917501] audit: type=1130 audit(1707503694.309: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.468946] systemd[1]: Started systemd-resolved.service. [ 1.954506] audit: type=1130 audit(1707503694.342: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' [ OK ] Reached target nss-lookup.target. [ 1.497415] systemd[1]: Finished kmod-static-nodes.service. Starting dracut-cmdline-ask.service... [ 1.509201] systemd[1]: Finished systemd-fsck-usr.service. [ 1.518354] systemd[1]: Finished systemd-vconsole-setup.service. Starting systemd-tmpfiles-setup-dev.service... [ 1.524216] systemd[1]: Reached target nss-lookup.target. [ 1.537996] systemd-modules-load[277]: Inserted module 'dm_multipath' [ OK ] Finished systemd-modules-load.service. [ 2.026665] audit: type=1130 audit(1707503694.419: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.543888] systemd[1]: Starting dracut-cmdline-ask.service... [ OK ] Finished systemd-tmpfiles-setup-dev.service. [ 1.571338] systemd[1]: Starting systemd-tmpfiles-setup-dev.service...[ 2.053055] audit: type=1130 audit(1707503694.445:8): 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' [ 1.603165] systemd[1]: Finished systemd-modules-load.service. [ OK ] Finished dracut-cmdline-ask.service. [ 1.609500] systemd[1]: Finished systemd-tmpfiles-setup-dev.service.[ 2.095902] audit: type=1130 audit(1707503694.482:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 1.638619] systemd[1]: Finished dracut-cmdline-ask.service. Starting dracut-cmdline.service... [ 1.646313] systemd[1]: Starting dracut-cmdline.service... [ 1.657395] systemd[1]: Starting systemd-sysctl.service... Starting systemd-sysctl.service... [ OK ] Finished systemd-sysctl.service. [ 1.674853] dracut-cmdline[295]: dracut-dracut-053 [ 1.679873] 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.199393] audit: type=1130 audit(1707503694.591: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' [ 2.220772] Loading iSCSI transport class v2.0-870. [ 1.749870] systemd[1]: Finished systemd-sysctl.service. [ 2.238643] iscsi: registered transport (tcp) [ 2.255547] iscsi: registered transport (qla4xxx) [ 2.261421] QLogic iSCSI HBA Driver [ OK ] Finished dracut-cmdline.service. [ 1.830729] systemd[1]: Finished dracut-cmdline.service. Starting dracut-pre-udev.service... [ 1.841537] systemd[1]: Starting dracut-pre-udev.service... [ 2.366600] raid6: neonx8 gen() 13807 MB/s [ 2.388598] raid6: neonx8 xor() 10834 MB/s [ 2.409634] raid6: neonx4 gen() 13587 MB/s [ 2.430591] raid6: neonx4 xor() 11243 MB/s [ 2.452592] raid6: neonx2 gen() 12996 MB/s [ 2.473591] raid6: neonx2 xor() 10248 MB/s [ 2.494596] raid6: neonx1 gen() 10486 MB/s [ 2.516591] raid6: neonx1 xor() 8799 MB/s [ 2.537592] raid6: int64x8 gen() 6298 MB/s [ 2.558593] raid6: int64x8 xor() 3547 MB/s [ 2.580591] raid6: int64x4 gen() 7255 MB/s [ 2.601591] raid6: int64x4 xor() 3852 MB/s [ 2.622591] raid6: int64x2 gen() 6152 MB/s [ 2.644591] raid6: int64x2 xor() 3320 MB/s [ 2.665592] raid6: int64x1 gen() 5046 MB/s [ 2.686591] raid6: int64x1 xor() 2644 MB/s [ 2.692308] raid6: using algorithm neonx8 gen() 13807 MB/s [ 2.699163] raid6: .... xor() 10834 MB/s, rmw enabled [ 2.704464] raid6: using neon recovery algorithm [ 2.718409] xor: measuring software checksum speed [ 2.723684] 8regs : 17322 MB/sec [ 2.728743] 32regs : 20733 MB/sec [ 2.733292] arm64_neon : 27845 MB/sec [ 2.737338] xor: using function: arm64_neon (27845 MB/sec) [ 2.793075] Btrfs loaded, crc32c=crc32c-generic, zoned=no, fsverity=no [ OK ] Finished dracut-pre-udev.service. [ 2.335623] systemd[1]: Finished dracut-pre-udev.service. Starting systemd-udevd.service... [ 2.347191] systemd[1]: Starting systemd-udevd.service... [ 2.369749] systemd-udevd[474]: Using default interface naming scheme 'v252'. [ OK ] Started systemd-udevd.service. [ 2.384267] systemd[1]: Started systemd-udevd.service. Starting dracut-pre-trigger.service... [ 2.395493] systemd[1]: Starting dracut-pre-trigger.service... [ 2.419458] dracut-pre-trigger[493]: rd.md=0: removing MD RAID activation [ OK ] Finished dracut-pre-trigger.service. [ 2.454043] systemd[1]: Finished dracut-pre-trigger.service. Starting systemd-udev-trigger.service... [ 2.463458] systemd[1]: Starting systemd-udev-trigger.service... [ OK ] Finished systemd-udev-trigger.service. [ 2.503223] systemd[1]: Finished systemd-udev-trigger.service. [ 3.025483] hv_vmbus: Vmbus version:5.3 [ 3.040253] hv_vmbus: registering driver hyperv_keyboard [ 3.048764] input: AT Translated Set 2 keyboard as /devices/LNXSYSTM:00/LNXSYBUS:00/ACPI0004:00/VMBUS:00/d34b2567-b9b6-42b9-8778-0a4ec0b955bf/serio0/input/input0 [ 3.049784] hv_vmbus: registering driver hv_netvsc [ 3.068544] hv_vmbus: registering driver hv_storvsc [ 3.073714] hv_vmbus: registering driver hid_hyperv [ 3.080233] scsi host1: storvsc_host_t [ 3.084726] input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input1 [ 3.095524] hid-generic 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on [ 3.106088] scsi host0: storvsc_host_t [ 3.110518] scsi 0:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 [ 3.118736] scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 0 [ 3.137574] sr 0:0:0:2: [sr0] scsi-1 drive [ 3.141675] cdrom: Uniform CD-ROM driver Revision: 3.20 [ 3.151215] sd 0:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB) [ 3.152405] hv_netvsc 002248b5-3987-0022-48b5-3987002248b5 eth0: VF slot 1 added [ 3.159517] sd 0:0:0:0: [sda] 4096-byte physical blocks [ 3.173957] sd 0:0:0:0: [sda] Write Protect is off [ 3.179234] sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA [ 3.189330] sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 [ 3.195213] sd 0:0:0:0: [sda] Attached SCSI disk [ 3.205230] hv_vmbus: registering driver hv_pci [ 3.212729] hv_pci 79759b15-0dcb-41b5-a9b7-3d2a8c0eea96: PCI VMBus probing: Using version 0x10004 [ 3.225848] hv_pci 79759b15-0dcb-41b5-a9b7-3d2a8c0eea96: PCI host bridge to bus 0dcb:00 [ 3.233386] pci_bus 0dcb:00: root bus resource [mem 0xfc0000000-0xfc00fffff window] [ 3.240741] pci_bus 0dcb:00: No busn resource found for root bus, will use [bus 00-ff] [ 3.248752] pci 0dcb:00:02.0: [15b3:1018] type 00 class 0x020000 [ 3.259507] pci 0dcb:00:02.0: reg 0x10: [mem 0xfc0000000-0xfc00fffff 64bit pref] [ 3.283807] pci 0dcb:00:02.0: enabling Extended Tags [ 3.296910] pci 0dcb:00:02.0: 0.000 Gb/s available PCIe bandwidth, limited by Unknown x0 link at 0dcb:00:02.0 (capable of 126.016 Gb/s with 8.0 GT/s PCIe x16 link) [ 3.309342] pci_bus 0dcb:00: busn_res: [bus 00-ff] end is updated to 00 [ 3.314984] pci 0dcb:00:02.0: BAR 0: assigned [mem 0xfc0000000-0xfc00fffff 64bit pref] [ 3.355704] mlx5_core 0dcb:00:02.0: firmware version: 16.30.1284 [ 3.514805] mlx5_core 0dcb:00:02.0: MLX5E: StrdRq(1) RqSz(8) StrdSz(2048) RxCqeCmprss(0) [ OK ] Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device. [ 3.095902] systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device. [ 3.584891] hv_netvsc 002248b5-3987-0022-48b5-3987002248b5 eth0: VF registering: eth1 [ 3.593090] mlx5_core 0dcb:00:02.0 eth1: joined to eth0 [ 3.604115] mlx5_core 0dcb:00:02.0 enP3531s1: renamed from eth1 [ 3.609853] BTRFS: device label OEM devid 1 transid 12 /dev/sda6 scanned by (udev-worker) (539) [ OK ] Found device dev-disk-by\x2dlabel-OEM.device. [ 3.158985] systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. [ OK ] Found device dev-disk-by\x2dlabel-ROOT.device. [ 3.335057] systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device. [ 3.352818] 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\x2dpartlabel-USR\x2dA.device. [ 3.367387] systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device. Starting disk-uuid.service... [ 3.380614] systemd[1]: Starting disk-uuid.service... [ 3.866892] sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 [ 3.887060] sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 [ 4.885043] sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 [ 4.421852] disk-uuid[604]: The operation has completed successfully. [ OK ] Finished disk-uuid.service. [ 4.497535] systemd[1]: disk-uuid.service: Deactivated successfully. [ 4.572719] systemd[1]: Finished disk-uuid.service. Starting verity-setup.service... [ 4.578388] systemd[1]: Starting verity-setup.service... [ 5.086474] device-mapper: verity: sha256 using implementation "sha256-ce" [ OK ] Found device dev-mapper-usr.device. [ 4.882922] systemd[1]: Found device dev-mapper-usr.device. Mounting sysusr-usr.mount... [ OK ] Finished verity-setup.service. [ 4.894397] systemd[1]: Mounting sysusr-usr.mount... [ 4.909878] systemd[1]: Finished verity-setup.service. [ 5.430349] EXT4-fs (dm-0): mounted filesystem without journal. Opts: norecovery. Quota mode: none. [ OK ] Mounted sysusr-usr.mount. [ 4.964986] systemd[1]: Mounted sysusr-usr.mount. [ 4.973349] systemd[1]: afterburn-network-kargs.service was skipped because no trigger condition checks were met. Starting ignition-setup.service... Starting parse-ip-for-networkd.service... [ 4.983068] systemd[1]: Starting ignition-setup.service... [ 4.999314] systemd[1]: Starting parse-ip-for-networkd.service... [ 5.487094] BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm [ 5.495613] BTRFS info (device sda6): using free space tree [ 5.500740] BTRFS info (device sda6): has skinny extents [ OK ] Finished parse-ip-for-networkd.service. [ 5.084300] systemd[1]: Finished parse-ip-for-networkd.service. Starting systemd-networkd.service... [ 5.096329] systemd[1]: Starting systemd-networkd.service... [ 5.118407] systemd-networkd[870]: lo: Link UP [ 5.122661] systemd-networkd[870]: lo: Gained carrier [ OK ] Started systemd-networkd.service. [ 5.127199] systemd-networkd[870]: Enumeration completed[ 5.611640] kauditd_printk_skb: 12 callbacks suppressed [ OK ] Reached target network.target.[ 5.611643] audit: type=1130 audit(1707503698.000:23): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 5.141741] systemd-networkd[870]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. [ 5.179346] systemd[1]: Started systemd-networkd.service. [ 5.184393] systemd[1]: Reached target network.target. Starting iscsiuio.service... [ 5.189244] systemd[1]: Starting iscsiuio.service... [ 5.197600] systemd[1]: Started iscsiuio.service. [ OK ] Started iscsiuio.service. [ 5.682162] audit: type=1130 audit(1707503698.074:24): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=iscsiuio comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Starting iscsid.service... [ 5.212480] systemd[1]: mnt-oem.mount: Deactivated successfully. [ OK ] Started iscsid.service. [ 5.234091] iscsid[880]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi[ 5.721919] audit: type=1130 audit(1707503698.106:25): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=iscsid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Starting dracut-initqueue.service... [ OK ] Finished dracut-initqueue.service. [ 5.275337] iscsid[880]: iscsid: Warning: InitiatorName file /etc/iscsi/initiatorname.iscsi does not exist or does not contain a properly formatted InitiatorName. If using software iscsi (iscsi_tcp or ib_iser) or partial offload (bnx2i or cxgbi iscsi), you may not be able to log[ 5.772820] audit: type=1130 audit(1707503698.165:26): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 5.793946] mlx5_core 0dcb:00:02.0 enP3531s1: Link up [ OK ] Reached target remote-fs-pre.target. [ 5.328205] iscsid[880]: into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier]. [ OK ] Reached target remote-cryptsetup.target. [ 5.343192] iscsid[880]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. [ OK ] Reached target remote-fs.target. [ 5.834862] hv_netvsc 002248b5-3987-0022-48b5-3987002248b5 eth0: Data path switched to VF: enP3531s1 [ 5.354516] iscsid[880]: If using hardware iscsi like qla4xxx this message can be ignored.[ 5.851420] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Starting dracut-pre-mount.service... [ 5.381397] iscsid[880]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi [ OK ] Finished dracut-pre-mount.service. [ 5.395897] iscsid[880]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf[ 5.884732] audit: type=1130 audit(1707503698.269: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.429219] systemd[1]: Starting iscsid.service... [ 5.433462] systemd[1]: Started iscsid.service. [ 5.437494] systemd[1]: Starting dracut-initqueue.service... [ 5.442607] systemd[1]: Finished dracut-initqueue.service. [ 5.447974] systemd[1]: Reached target remote-fs-pre.target. [ 5.452817] systemd[1]: Reached target remote-cryptsetup.target. [ 5.458080] systemd[1]: Reached target remote-fs.target. [ 5.462536] systemd[1]: Starting dracut-pre-mount.service... [ 5.467469] systemd-networkd[870]: enP3531s1: Link UP [ 5.471903] systemd-networkd[870]: eth0: Link UP [ 5.475753] systemd-networkd[870]: eth0: Gained carrier [ 5.480318] systemd[1]: Finished dracut-pre-mount.service. [ 5.484876] systemd-networkd[870]: enP3531s1: Gained carrier [ 5.496565] systemd-networkd[870]: eth0: DHCPv4 address 10.200.20.21/24, gateway 10.200.20.1 acquired from 168.63.129.16 [ OK ] Finished ignition-setup.service. [ 5.556623] systemd[1]: Finished ignition-setup.service. [ 6.040343] audit: type=1130 audit(1707503698.428: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.589764] systemd[1]: Starting ignition-fetch-offline.service... [ 6.815412] systemd-networkd[870]: eth0: Gained IPv6LL [* ] Job ignition-fetch-offline.service/start running (6s / no limit) M [** ] Job ignition-fetch-offline.service/start running (7s / no limit) [ 8.832892] ignition[895]: Ignition 2.14.0 [ 8.836199] ignition[895]: Stage: fetch-offline [ 8.839684] ignition[895]: reading system config file "/usr/lib/ignition/base.d/base.ign" [ 8.923974] ignition[895]: no config dir at "/usr/lib/ignition/base.platform.d/azure" M [*** ] Job ignition-fetch-offline.service/start running (7s / no limit) [ 8.930070] ignition[895]: no config URL provided M [ OK ] Finished ignition-fetch-offline.service. [ 8.941066] ignition[895]: reading system config file "/usr/lib/ignition/user.ign"[ 9.428507] audit: type=1130 audit(1707503701.815: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.971665] systemd[1]: Finished ignition-fetch-offline.service. Starting ignition-fetch.service... [ 8.976775] ignition[895]: no config at "/usr/lib/ignition/user.ign" [ 8.987053] systemd[1]: Starting ignition-fetch.service... [ 8.991774] ignition[895]: failed to fetch config: resource requires networking [ 8.997804] ignition[895]: Ignition finished successfully [ 9.002334] ignition[901]: Ignition 2.14.0 [ 9.005727] ignition[901]: Stage: fetch [ 9.008584] ignition[901]: reading system config file "/usr/lib/ignition/base.d/base.ign" [ 9.015129] ignition[901]: no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 9.021186] ignition[901]: no config URL provided [ 9.024887] ignition[901]: reading system config file "/usr/lib/ignition/user.ign" [ 9.030570] ignition[901]: no config at "/usr/lib/ignition/user.ign" [ 9.035511] ignition[901]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 [ 9.070529] ignition[901]: GET result: OK [ 9.073763] ignition[901]: config has been read from IMDS userdata [ 9.086749] ignition[901]: fetched base config from "system" [ 9.092115] ignition[901]: fetched base config from "system" [ OK ] Finished ignition-fetch.service. [ 9.096614] ignition[901]: fetch: fetch complete[ 9.576691] audit: type=1130 audit(1707503701.969: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... [ 9.119462] ignition[901]: fetched user config from "azure" [ 9.130182] ignition[901]: fetch: fetch passed [ 9.133906] systemd[1]: Finished ignition-fetch.service. [ 9.137998] ignition[901]: Ignition finished successfully [ OK ] Finished ignition-kargs.service. [ 9.143142] systemd[1]: Starting ignition-kargs.service...[ 9.627529] audit: type=1130 audit(1707503702.015: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... [ 9.171714] ignition[907]: Ignition 2.14.0 [ 9.176742] systemd[1]: Finished ignition-kargs.service. [ 9.181296] ignition[907]: Stage: kargs [ OK ] Finished ignition-disks.service. [ 9.665065] audit: type=1130 audit(1707503702.057: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. [ 9.210292] systemd[1]: Starting ignition-disks.service... [ OK ] Reached target local-fs-pre.target. [ 9.219105] ignition[907]: reading system config file "/usr/lib/ignition/base.d/base.ign" [ OK ] Reached target local-fs.target. [ 9.229501] systemd[1]: Finished ignition-disks.service. [ OK ] Reached target sysinit.target. [ 9.237732] systemd[1]: Reached target initrd-root-device.target. [ OK ] Reached target basic.target. [ 9.246625] ignition[907]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Starting systemd-fsck-root.service... [ 9.256721] systemd[1]: Reached target local-fs-pre.target. [ 9.269410] ignition[907]: kargs: kargs passed [ 9.272851] systemd[1]: Reached target local-fs.target. [ 9.277066] ignition[907]: Ignition finished successfully [ 9.281234] systemd[1]: Reached target sysinit.target. [ 9.285244] ignition[913]: Ignition 2.14.0 [ 9.288414] systemd[1]: Reached target basic.target. [ 9.293646] ignition[913]: Stage: disks [ 9.296864] systemd[1]: Starting systemd-fsck-root.service... [ 9.301272] ignition[913]: reading system config file "/usr/lib/ignition/base.d/base.ign" [ 9.307542] ignition[913]: no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 9.314080] ignition[913]: disks: disks passed [ 9.318023] ignition[913]: Ignition finished successfully [ 9.372648] systemd-fsck[921]: ROOT: clean, 602/7326000 files, 481069/7359488 blocks [ OK ] Finished systemd-fsck-root.service. Mounting sysroot.mount... [ 9.388939] systemd[1]: Finished systemd-fsck-root.service. [ 9.398760] systemd[1]: Mounting sysroot.mount... [ 9.886968] EXT4-fs (sda9): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none. [ OK ] Mounted sysroot.mount. [ 9.422130] systemd[1]: Mounted sysroot.mount. [ OK ] Reached target initrd-root-fs.target. [ 9.430252] systemd[1]: Reached target initrd-root-fs.target. Mounting sysroot-usr.mount... [ 9.497720] systemd[1]: Mounting sysroot-usr.mount... Starting flatcar-metadata-hostname.service... [ OK ] Reached target ignition-diskful.target. [ 9.504300] systemd[1]: Starting flatcar-metadata-hostname.service... [ OK ] Mounted sysroot-usr.mount. [ 9.519786] systemd[1]: ignition-remount-sysroot.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). [ 9.541910] systemd[1]: Reached target ignition-diskful.target. [ 9.548346] systemd[1]: Mounted sysroot-usr.mount. Mounting sysroot-usr-share-oem.mount... [ 9.571464] systemd[1]: Mounting sysroot-usr-share-oem.mount... [ 9.578073] systemd[1]: Starting initrd-setup-root.service... Starting initrd-setup-root.service... [ 10.065250] BTRFS: device label OEM devid 1 transid 14 /dev/sda6 scanned by mount (932) [ 10.073575] BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm [ 9.605041] initrd-setup-root[937]: cut: /sysroot/etc/passwd: No such file or directory [ 10.087210] BTRFS info (device sda6): using free space tree [ 10.092264] BTRFS info (device sda6): has skinny extents [ 9.626136] initrd-setup-root[963]: cut: /sysroot/etc/group: No such file or directory [ OK ] Mounted sysroot-usr-share-oem.mount. [ 9.639533] systemd[1]: Mounted sysroot-usr-share-oem.mount. [ 9.644333] initrd-setup-root[971]: cut: /sysroot/etc/shadow: No such file or directory [ 9.671324] initrd-setup-root[979]: cut: /sysroot/etc/gshadow: No such file or directory [ OK ] Finished initrd-setup-root.service. [ 10.120194] systemd[1]: Finished initrd-setup-root.service. Starting ignition-mount.service... Starting sysroot-boot.service... [ 10.130380] systemd[1]: Starting ignition-mount.service... [ 10.152943] systemd[1]: Starting sysroot-boot.service... [ 10.157622] systemd[1]: sysusr-usr-share-oem.mount: Deactivated successfully. [ 10.163901] systemd[1]: sysroot-usr-share-oem.mount: Deactivated successfully. [ OK ] Finished sysroot-boot.service. [ 10.188183] systemd[1]: Finished sysroot-boot.service.[ 10.673234] kauditd_printk_skb: 2 callbacks suppressed [ 10.673237] audit: type=1130 audit(1707503703.061:35): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 10.223813] ignition[1002]: INFO : Ignition 2.14.0 [ OK ] Finished ignition-mount.service. [ 10.235114] ignition[1002]: INFO : Stage: mount[ 10.719897] audit: type=1130 audit(1707503703.107:36): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 10.264552] ignition[1002]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" [ 10.276061] ignition[1002]: DEBUG : parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63 [ 10.293113] systemd[1]: Finished ignition-mount.service. [ 10.298200] ignition[1002]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 10.307582] ignition[1002]: INFO : mount: mount passed [ 10.313075] ignition[1002]: INFO : Ignition finished successfully [ 10.802235] coreos-metadata[931]: Feb 09 18:35:03.670 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 [ 10.813599] coreos-metadata[931]: Feb 09 18:35:03.681 INFO Fetch successful [ 10.841809] coreos-metadata[931]: Feb 09 18:35:03.709 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 [ 10.856644] coreos-metadata[931]: Feb 09 18:35:03.724 INFO Fetch successful [ 10.862861] coreos-metadata[931]: Feb 09 18:35:03.730 INFO wrote hostname ci-3510.3.2-a-bd3bd4ac96 to /sysroot/etc/hostname [ OK ] Finished flatcar-metadata-hostname.service. [ 10.872965] systemd[1]: Finished flatcar-metadata-hostname.service.[ 11.360571] audit: type=1130 audit(1707503703.747:37): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=flatcar-metadata-hostname comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Starting ignition-files.service... [ 10.906421] systemd[1]: Starting ignition-files.service... Mounting sysroot-usr-share-oem.mount... [ 10.916917] systemd[1]: Mounting sysroot-usr-share-oem.mount... [ 11.407334] BTRFS: device label OEM devid 1 transid 15 /dev/sda6 scanned by mount (1011) [ 11.416345] BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm [ 11.424568] BTRFS info (device sda6): using free space tree [ 11.431790] BTRFS info (device sda6): has skinny extents [ OK ] Mounted sysroot-usr-share-oem.mount. [ 10.966615] systemd[1]: Mounted sysroot-usr-share-oem.mount. [ 10.986113] ignition[1030]: INFO : Ignition 2.14.0 [ 10.991247] ignition[1030]: INFO : Stage: files [ 10.996075] ignition[1030]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" [ 11.003809] ignition[1030]: DEBUG : parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63 [ 11.018765] ignition[1030]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 11.026253] ignition[1030]: DEBUG : files: compiled without relabeling support, skipping [ 11.033422] ignition[1030]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" [ 11.041736] ignition[1030]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" [ 11.086876] ignition[1030]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" [ 11.095566] ignition[1030]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" [ 11.113180] ignition[1030]: wrote ssh authorized keys file for user: core [ 11.118968] ignition[1030]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" [ 11.127086] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/opt/cni-plugins-linux-arm64-v1.3.0.tgz" [ 11.138716] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(3): GET https://github.com/containernetworking/plugins/releases/download/v1.3.0/cni-plugins-linux-arm64-v1.3.0.tgz: attempt #1 [ 11.453101] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(3): GET result: OK [ 11.715671] ignition[1030]: DEBUG : files: createFilesystemsFiles: createFiles: op(3): file matches expected sum of: b2b7fb74f1b3cb8928f49e5bf9d4bc686e057e837fac3caf1b366d54757921dba80d70cc010399b274d136e8dee9a25b1ad87cdfdc4ffcf42cf88f3e8f99587a [ 11.733655] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/opt/cni-plugins-linux-arm64-v1.3.0.tgz" [ 11.746062] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/opt/crictl-v1.27.0-linux-arm64.tar.gz" [ 11.757387] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(4): GET https://github.com/kubernetes-sigs/cri-tools/releases/download/v1.27.0/crictl-v1.27.0-linux-arm64.tar.gz: attempt #1 [ 11.999148] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(4): GET result: OK [ 12.129382] ignition[1030]: DEBUG : files: createFilesystemsFiles: createFiles: op(4): file matches expected sum of: db062e43351a63347871e7094115be2ae3853afcd346d47f7b51141da8c3202c2df58d2e17359322f632abcb37474fd7fdb3b7aadbc5cfd5cf6d3bad040b6251 [ 12.148568] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/opt/crictl-v1.27.0-linux-arm64.tar.gz" [ 12.162298] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing file "/sysroot/opt/bin/kubeadm" [ 12.173950] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(5): GET https://dl.k8s.io/release/v1.28.1/bin/linux/arm64/kubeadm: attempt #1 [ 12.365997] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(5): GET result: OK [ 12.671523] ignition[1030]: DEBUG : files: createFilesystemsFiles: createFiles: op(5): file matches expected sum of: 5a08b81f9cc82d3cce21130856ca63b8dafca9149d9775dd25b376eb0f18209aa0e4a47c0a6d7e6fb1316aacd5d59dec770f26c09120c866949d70bc415518b3 [ 12.688308] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing file "/sysroot/opt/bin/kubeadm" [ 12.698111] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/opt/bin/kubelet" [ 12.707842] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET https://dl.k8s.io/release/v1.28.1/bin/linux/arm64/kubelet: attempt #1 [ 12.729251] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET result: OK [ *** ] Job ignition-files.service/start running (12s / no limit) [ 13.374993] ignition[1030]: DEBUG : files: createFilesystemsFiles: createFiles: op(6): file matches expected sum of: 5a898ef543a6482895101ea58e33602e3c0a7682d322aaf08ac3dc8a5a3c8da8f09600d577024549288f8cebb1a86f9c79927796b69a3d8fe989ca8f12b147d6 [ 13.873571] BTRFS info: devid 1 device path /dev/sda6 changed to /dev/disk/by-label/OEM scanned by ignition (1033) [ 13.397244] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/opt/bin/kubelet" [ 13.418063] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(7): [started] writing file "/sysroot/home/core/install.sh" [ 13.432366] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(7): [finished] writing file "/sysroot/home/core/install.sh" [ 13.449077] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(8): [started] writing file "/sysroot/etc/docker/daemon.json" [ 13.462915] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(8): [finished] writing file "/sysroot/etc/docker/daemon.json" M [ OK ] Finished ignition-files.service. [ 13.478354] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(9): [started] writing file "/sysroot/etc/flatcar/update.conf"[ 13.960262] audit: type=1130 audit(1707503706.352: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' Starting initrd-setup-root-after-ignition.service... [ 13.514368] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(9): [finished] writing file "/sysroot/etc/flatcar/update.conf" Starting ignition-quench.service... [ 13.535758] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(a): [started] writing file "/sysroot/etc/systemd/system/waagent.service" [ 13.554205] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(a): oem config not found in "/usr/share/oem", looking on oem partition [ OK ] Finished ignition-quench.service. [ 13.566621] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(a): op(b): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3009832576"[ 14.062517] audit: type=1130 audit(1707503706.440: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' [ OK ] Finished initrd-setup-root-after-ignition.service. [ 14.094151] audit: type=1131 audit(1707503706.440: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' [ 13.612436] ignition[1030]: CRITICAL : files: createFilesystemsFiles: createFiles: op(a): op(b): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3009832576": device or resource busy[ 14.129375] audit: type=1130 audit(1707503706.486: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' [ OK ] Reached target ignition-complete.target. [ 13.677297] ignition[1030]: ERROR : files: createFilesystemsFiles: createFiles: op(a): failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem3009832576", trying btrfs: device or resource busy [ 13.701172] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(a): op(c): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3009832576" Starting initrd-parse-etc.service... [ 13.714453] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(a): op(c): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3009832576" [ 13.733648] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(a): op(d): [started] unmounting "/mnt/oem3009832576" [ 13.745735] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(a): op(d): [finished] unmounting "/mnt/oem3009832576" [ OK ] Finished initrd-parse-etc.service. [ 13.756971] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(a): [finished] writing file "/sysroot/etc/systemd/system/waagent.service"[ 14.238121] audit: type=1130 audit(1707503706.630: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' [ 13.794104] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(e): [started] writing file "/sysroot/etc/systemd/system/nvidia.service" [ OK ] Reached target initrd-fs.target. [ 13.809204] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(e): oem config not found in "/usr/share/oem", looking on oem partition [ 14.302756] audit: type=1131 audit(1707503706.664: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. [ 13.854403] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(e): op(f): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3034092174" Starting dracut-pre-pivot.service... [ 13.878336] ignition[1030]: CRITICAL : files: createFilesystemsFiles: createFiles: op(e): op(f): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3034092174": device or resource busy [ 13.896601] ignition[1030]: ERROR : files: createFilesystemsFiles: createFiles: op(e): failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem3034092174", trying btrfs: device or resource busy [ 13.914282] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(e): op(10): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3034092174" [ 13.929788] systemd[1]: mnt-oem3009832576.mount: Deactivated successfully. [ 13.937614] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(e): op(10): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3034092174" [ OK ] Finished dracut-pre-pivot.service. [ 13.953069] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(e): op(11): [started] unmounting "/mnt/oem3034092174"[ 14.447747] audit: type=1130 audit(1707503706.828: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' Starting initrd-cleanup.service... [ 13.995835] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(e): op(11): [finished] unmounting "/mnt/oem3034092174" [ OK ] Stopped target nss-lookup.target. [ 14.013053] ignition[1030]: INFO : files: createFilesystemsFiles: createFiles: op(e): [finished] writing file "/sysroot/etc/systemd/system/nvidia.service" [ OK ] Stopped target remote-cryptsetup.target. [ 14.032141] ignition[1030]: INFO : files: op(12): [started] processing unit "waagent.service" [ OK ] Stopped target timers.target. [ 14.046967] ignition[1030]: INFO : files: op(12): [finished] processing unit "waagent.service" [ OK ] Stopped dracut-pre-pivot.service. [ 14.060221] ignition[1030]: INFO : files: op(13): [started] processing unit "nvidia.service" [ OK ] Stopped target initrd.target. [ 14.074280] ignition[1030]: INFO : files: op(13): [finished] processing unit "nvidia.service" [ OK ] Stopped target basic.target. [ 14.088749] ignition[1030]: INFO : files: op(14): [started] processing unit "prepare-critools.service" [ OK ] Stopped target ignition-complete.target. [ 14.108277] ignition[1030]: INFO : files: op(14): op(15): [started] writing unit "prepare-critools.service" at "/sysroot/etc/systemd/system/prepare-critools.service" [ OK ] Stopped target ignition-diskful.target. [ 14.129813] ignition[1030]: INFO : files: op(14): op(15): [finished] writing unit "prepare-critools.service" at "/sysroot/etc/systemd/system/prepare-critools.service" [ OK ] Stopped target initrd-root-device.target. [ 14.150641] ignition[1030]: INFO : files: op(14): [finished] processing unit "prepare-critools.service" [ OK ] Stopped target remote-fs.target. [ 14.166887] ignition[1030]: INFO : files: op(16): [started] processing unit "prepare-cni-plugins.service" [ OK ] Stopped target remote-fs-pre.target. [ 14.181737] ignition[1030]: INFO : files: op(16): op(17): [started] writing unit "prepare-cni-plugins.service" at "/sysroot/etc/systemd/system/prepare-cni-plugins.service" [ OK ] Stopped target sysinit.target. [ 14.202814] ignition[1030]: INFO : files: op(16): op(17): [finished] writing unit "prepare-cni-plugins.service" at "/sysroot/etc/systemd/system/prepare-cni-plugins.service" [ OK ] Stopped target local-fs.target. [ 14.223904] ignition[1030]: INFO : files: op(16): [finished] processing unit "prepare-cni-plugins.service" [ OK ] Stopped target local-fs-pre.target. [ 14.238582] ignition[1030]: INFO : files: op(18): [started] setting preset to enabled for "waagent.service" [ OK ] Stopped target swap.target. [ 14.253532] ignition[1030]: INFO : files: op(18): [finished] setting preset to enabled for "waagent.service" [ OK ] Stopped dracut-pre-mount.service. [ 14.267749] ignition[1030]: INFO : files: op(19): [started] setting preset to enabled for "nvidia.service" [ OK ] Stopped target cryptsetup.target. [ 14.282616] ignition[1030]: INFO : files: op(19): [finished] setting preset to enabled for "nvidia.service" [ OK ] Stopped dracut-initqueue.service. [ 14.297754] systemd[1]: Finished ignition-files.service. [ OK ] Stopped initrd-setup-root-after-ignition.service. [ 14.308241] ignition[1030]: INFO : files: op(1a): [started] setting preset to enabled for "prepare-critools.service" [ OK ] Stopped ignition-files.service. [ 14.324600] ignition[1030]: INFO : files: op(1a): [finished] setting preset to enabled for "prepare-critools.service" [ OK ] Stopped flatcar-metadata-hostname.service. [ 14.342076] ignition[1030]: INFO : files: op(1b): [started] setting preset to enabled for "prepare-cni-plugins.service" Stopping ignition-mount.service... [ 14.365352] ignition[1030]: INFO : files: op(1b): [finished] setting preset to enabled for "prepare-cni-plugins.service" [ 14.439228] ignition[1030]: INFO : files: createResultFile: createFiles: op(1c): [started] writing file "/sysroot/etc/.ignition-result.json" Stopping iscsiuio.service... [ 14.456853] ignition[1030]: INFO : files: createResultFile: createFiles: op(1c): [finished] writing file "/sysroot/etc/.ignition-result.json" Stopping sysroot-boot.service... [ OK ] Stopped systemd-udev-trigger.service. [ 14.477414] ignition[1030]: INFO : files: files passed [ OK ] Stopped dracut-pre-trigger.service. [ 14.495210] ignition[1030]: INFO : Ignition finished successfully [ OK ] Stopped iscsiuio.service. [ OK ] Finished initrd-cleanup.service. [ 14.507626] initrd-setup-root-after-ignition[1055]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory [ OK ] Stopped ignition-mount.service. [ 14.528648] systemd[1]: Starting initrd-setup-root-after-ignition.service... [ OK ] Stopped ignition-disks.service. [ 14.549872] systemd[1]: torcx-profile-populate.service was skipped because of an unmet condition check (ConditionPathExists=/sysroot/etc/torcx/next-profile). [ OK ] Stopped ignition-kargs.service. [ 14.569354] systemd[1]: Starting ignition-quench.service... [ OK ] Stopped ignition-fetch.service. [ 14.575151] systemd[1]: ignition-quench.service: Deactivated successfully. [ OK ] Stopped target network.target. [ 14.587485] systemd[1]: Finished ignition-quench.service. [ OK ] Stopped ignition-fetch-offline.service. [ 14.598441] systemd[1]: Finished initrd-setup-root-after-ignition.service. [ OK ] Stopped target paths.target. [ 14.612621] systemd[1]: Reached target ignition-complete.target. [ OK ] Stopped systemd-ask-password-console.path. [ 14.623405] ignition[1068]: INFO : Ignition 2.14.0 [ OK ] Stopped target slices.target. [ 14.634597] ignition[1068]: INFO : Stage: umount [ OK ] Stopped target sockets.target. [ 14.644792] ignition[1068]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" [ OK ] Closed iscsid.socket. [ 14.657784] ignition[1068]: DEBUG : parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63 [ OK ] Closed iscsiuio.socket. [ 14.677614] ignition[1068]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" [ OK ] Stopped ignition-setup.service. [ 14.690768] ignition[1068]: INFO : umount: umount passed Stopping systemd-networkd.service... [ 14.701605] ignition[1068]: INFO : Ignition finished successfully Stopping systemd-resolved.service... [ 14.712465] systemd[1]: Starting initrd-parse-etc.service... [ OK ] Stopped systemd-resolved.service. [ 14.724243] systemd[1]: initrd-parse-etc.service: Deactivated successfully. [ OK ] Stopped systemd-networkd.service. [ 14.737426] systemd[1]: Finished initrd-parse-etc.service. [ OK ] Closed systemd-networkd.socket. [ 14.749602] systemd[1]: Reached target initrd-fs.target. [ 14.760616] systemd[1]: Reached target initrd.target. Stopping network-cleanup.service... [ 14.765539] systemd[1]: dracut-mount.service was skipped because no trigger condition checks were met. [ OK ] Stopped parse-ip-for-networkd.service. [ 14.779466] systemd[1]: Starting dracut-pre-pivot.service... [ OK ] Stopped systemd-sysctl.service. [ 14.791359] systemd[1]: Finished dracut-pre-pivot.service. [ OK ] Stopped systemd-modules-load.service. [ 14.801841] systemd[1]: Starting initrd-cleanup.service... Stopping systemd-udevd.service... [ 14.813194] systemd[1]: Stopped target nss-lookup.target. [ 14.825451] systemd[1]: Stopped target remote-cryptsetup.target. [ OK ] Stopped systemd-udevd.service. [ 14.831462] systemd[1]: Stopped target timers.target. [ OK ] Closed systemd-udevd-control.socket. [ 14.842899] systemd[1]: dracut-pre-pivot.service: Deactivated successfully. [ OK ] Closed systemd-udevd-kernel.socket. [ 14.859585] systemd[1]: Stopped dracut-pre-pivot.service. [ 15.347428] hv_netvsc 002248b5-3987-0022-48b5-3987002248b5 eth0: Data path switched from VF: enP3531s1 [ OK ] Stopped dracut-pre-udev.service. [ 14.888127] systemd[1]: Stopped target initrd.target. [ OK ] Stopped dracut-cmdline.service. [ 14.899540] systemd[1]: Stopped target basic.target. [ OK ] Stopped dracut-cmdline-ask.service. [ 14.910710] systemd[1]: Stopped target ignition-complete.target. [ 14.923782] systemd[1]: Stopped target ignition-diskful.target. Starting initrd-udevadm-cleanup-db.service... [ 14.930247] systemd[1]: Stopped target initrd-root-device.target. [ OK ] Stopped systemd-tmpfiles-setup-dev.service. [ 14.942424] systemd[1]: Stopped target remote-fs.target. [ OK ] Stopped kmod-static-nodes.service. [ 14.954551] systemd[1]: Stopped target remote-fs-pre.target. [ OK ] Stopped systemd-vconsole-setup.service. [ 14.966056] systemd[1]: Stopped target sysinit.target. [ OK ] Finished initrd-udevadm-cleanup-db.service. [ 14.976727] systemd[1]: Stopped target local-fs.target. [ 14.987553] systemd[1]: Stopped target local-fs-pre.target. [ 14.993037] systemd[1]: Stopped target swap.target. [ OK ] Stopped network-cleanup.service. [ 14.998089] systemd[1]: dracut-pre-mount.service: Deactivated successfully. [ 15.009772] systemd[1]: Stopped dracut-pre-mount.service. [ 15.014830] systemd[1]: Stopped target cryptsetup.target. [ 15.020315] systemd[1]: dracut-initqueue.service: Deactivated successfully. [ 15.026703] systemd[1]: Stopped dracut-initqueue.service. [ 15.034855] systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. [ 15.045552] systemd[1]: Stopped initrd-setup-root-after-ignition.service. [ 15.051175] systemd[1]: ignition-files.service: Deactivated successfully. [ 15.057827] systemd[1]: Stopped ignition-files.service. [ 15.062277] systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. [ 15.069019] systemd[1]: Stopped flatcar-metadata-hostname.service. [ 15.074351] systemd[1]: Stopping ignition-mount.service... [ 15.079129] systemd[1]: Stopping iscsiuio.service... [ 15.083630] systemd[1]: Stopping sysroot-boot.service... [ 15.088451] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. [ 15.094869] systemd[1]: Stopped systemd-udev-trigger.service. [ 15.100134] systemd[1]: dracut-pre-trigger.service: Deactivated successfully. [ 15.108888] systemd[1]: Stopped dracut-pre-trigger.service. [ 15.114851] systemd[1]: iscsiuio.service: Deactivated successfully. [ 15.120287] systemd[1]: Stopped iscsiuio.service. [ 15.124207] systemd[1]: initrd-cleanup.service: Deactivated successfully. [ 15.130184] systemd[1]: Finished initrd-cleanup.service. [ 15.135119] systemd[1]: ignition-mount.service: Deactivated successfully. [ 15.141338] systemd[1]: Stopped ignition-mount.service. [ 15.145884] systemd[1]: ignition-disks.service: Deactivated successfully. [ 15.152220] systemd[1]: Stopped ignition-disks.service. [ 15.156868] systemd[1]: ignition-kargs.service: Deactivated successfully. [ 15.162753] systemd[1]: Stopped ignition-kargs.service. [ 15.167718] systemd[1]: ignition-fetch.service: Deactivated successfully. [ 15.173634] systemd[1]: Stopped ignition-fetch.service. [ 15.178302] systemd[1]: Stopped target network.target. [ 15.182910] systemd[1]: ignition-fetch-offline.service: Deactivated successfully. [ OK ] Stopped sysroot-boot.service. [ 15.189238] systemd[1]: Stopped ignition-fetch-offline.service. [ 15.199566] systemd[1]: Stopped target paths.target. [ OK ] Reached target initrd-switch-root.target. [ 15.203779] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. [ OK ] Stopped initrd-setup-root.service. [ 15.216642] systemd[1]: Stopped systemd-ask-password-console.path.[ 15.697255] kauditd_printk_skb: 34 callbacks suppressed [ 15.697257] audit: type=1131 audit(1707503708.089:79): 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 initrd-switch-root.service... [ 15.231877] systemd[1]: Stopped target slices.target. [ 15.264028] systemd[1]: Stopped target sockets.target. [ 15.268689] systemd[1]: iscsid.socket: Deactivated successfully. [ 15.273902] systemd[1]: Closed iscsid.socket. [ 15.277977] systemd[1]: iscsiuio.socket: Deactivated successfully. [ 15.283487] systemd[1]: Closed iscsiuio.socket. [ 15.287337] systemd[1]: ignition-setup.service: Deactivated successfully. [ 15.293267] systemd[1]: Stopped ignition-setup.service. [ 15.297696] systemd[1]: Stopping systemd-networkd.service... [ 15.781299] systemd-journald[276]: Received SIGTERM from PID 1 (n/a). [ 15.313284] systemd[1]: Stopping systemd-resolved.service... [ 15.794344] audit: type=1334 audit(1707503708.186:80): prog-id=9 op=UNLOAD [ 17.947215] SELinux: Class mctp_socket not defined in policy. [ 17.953390] SELinux: Class anon_inode not defined in policy. [ 17.958225] SELinux: the above unknown classes and permissions will be allowed [ 17.966287] SELinux: policy capability network_peer_controls=1 [ 17.971591] SELinux: policy capability open_perms=1 [ 17.975953] SELinux: policy capability extended_socket_class=1 [ 17.981019] SELinux: policy capability always_check_network=0 [ 17.986677] SELinux: policy capability cgroup_seclabel=1 [ 17.991390] SELinux: policy capability nnp_nosuid_transition=1 [ 17.996255] SELinux: policy capability genfs_seclabel_symlinks=0 [ 18.001470] SELinux: policy capability ioctl_skip_cloexec=0 [ 18.025266] audit: type=1403 audit(1707503710.417:81): auid=4294967295 ses=4294967295 lsm=selinux res=1 [ 18.047639] systemd[1]: Successfully loaded SELinux policy in 298.626ms. [ 18.530347] systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 23.683ms. [ 18.606089] 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) [ 18.636046] systemd[1]: Detected virtualization microsoft. [ 18.640760] systemd[1]: Detected architecture arm64. [ 18.645128] systemd[1]: Detected first boot. Welcome to Flatcar Container Linux by Kinvolk 3510.3.2 (LTS 2023)! [ 18.668739] systemd[1]: Hostname set to . [ 18.701958] systemd[1]: Initializing machine ID from random generator. [ 18.746809] audit: type=1400 audit(1707503711.139:82): avc: denied { bpf } for pid=1 comm="systemd" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1 [ 18.763847] audit: type=1400 audit(1707503711.142:83): avc: denied { perfmon } for pid=1 comm="systemd" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1 [ 18.782793] audit: type=1334 audit(1707503711.156:84): prog-id=10 op=LOAD [ 18.788677] audit: type=1334 audit(1707503711.156:85): prog-id=10 op=UNLOAD [ 18.794492] audit: type=1334 audit(1707503711.175:86): prog-id=11 op=LOAD [ 18.800661] audit: type=1334 audit(1707503711.175:87): prog-id=11 op=UNLOAD [ 19.986660] SELinux: Context system_u:object_r:container_file_t:s0:c1022,c1023 is not valid (left unmapped). [ 19.995649] audit: type=1400 audit(1707503712.379:88): avc: denied { associate } for pid=1102 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" [ 25.085701] systemd[1]: Populated /etc with preset unit settings. [ 25.769630] systemd[1]: /usr/lib/systemd/system/locksmithd.service:8: Unit uses CPUShares=; please use CPUWeight= instead. Support for CPUShares= will be removed soon. [ 25.783732] systemd[1]: /usr/lib/systemd/system/locksmithd.service:9: Unit uses MemoryLimit=; please use MemoryMax= instead. Support for MemoryLimit= will be removed soon. [ 25.842450] 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. [ 25.921615] kauditd_printk_skb: 8 callbacks suppressed [ 25.921619] audit: type=1334 audit(1707503718.313:90): prog-id=12 op=LOAD [ 25.923263] systemd[1]: iscsid.service: Deactivated successfully. [ 25.927703] audit: type=1334 audit(1707503718.313:91): prog-id=3 op=UNLOAD [ 25.934372] systemd[1]: Stopped iscsid.service. [ 25.940761] audit: type=1334 audit(1707503718.313:92): prog-id=13 op=LOAD [ 25.956458] audit: type=1334 audit(1707503718.313:93): prog-id=14 op=LOAD [ 25.956461] audit: type=1334 audit(1707503718.314:94): prog-id=4 op=UNLOAD [ OK ] Stopped iscsid.service.[ 25.967769] audit: type=1334 audit(1707503718.314:95): prog-id=5 op=UNLOAD [ 25.976956] systemd[1]: initrd-switch-root.service: Deactivated successfully. [ 25.976966] audit: type=1131 audit(1707503718.315:96): 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' [ 25.984725] systemd[1]: Stopped initrd-switch-root.service. [ 26.002931] audit: type=1334 audit(1707503718.345:97): prog-id=12 op=UNLOAD [ 26.014266] audit: type=1131 audit(1707503718.369:98): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=iscsid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Stopped initrd-switch-root.service. [ 26.039572] audit: type=1130 audit(1707503718.431:99): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=initrd-switch-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 26.040141] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 26.066764] systemd[1]: Created slice system-addon\x2dconfig.slice. [ OK ] Created slice system-addon\x2dconfig.slice. [ 26.078924] systemd[1]: Created slice system-addon\x2drun.slice. [ OK ] Created slice system-addon\x2drun.slice. [ 26.091569] systemd[1]: Created slice system-getty.slice. [ OK ] Created slice system-getty.slice. [ 26.101894] systemd[1]: Created slice system-modprobe.slice. [ OK ] Created slice system-modprobe.slice. [ 26.112784] systemd[1]: Created slice system-serial\x2dgetty.slice. [ OK ] Created slice system-serial\x2dgetty.slice. [ 26.125201] systemd[1]: Created slice system-system\x2dcloudinit.slice. [ OK ] Created slice system-system\x2dcloudinit.slice. [ 26.138195] systemd[1]: Created slice system-systemd\x2dfsck.slice. [ OK ] Created slice system-systemd\x2dfsck.slice. [ 26.151435] systemd[1]: Created slice user.slice. [ OK ] Created slice user.slice. [ 26.160688] systemd[1]: Started systemd-ask-password-console.path. [ OK ] Started systemd-ask-password-console.path. [ 26.171959] systemd[1]: Started systemd-ask-password-wall.path. [ OK ] Started systemd-ask-password-wall.path. [ 26.182739] systemd[1]: Set up automount boot.automount. [ OK ] Set up automount boot.automount. [ 26.193998] systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount. [ OK ] Set up automount proc-sys-fs-binfmt_misc.automount. [ 26.206725] systemd[1]: Stopped target initrd-switch-root.target. [ OK ] Stopped target initrd-switch-root.target. [ 26.218434] systemd[1]: Stopped target initrd-fs.target. [ OK ] Stopped target initrd-fs.target. [ 26.227896] systemd[1]: Stopped target initrd-root-fs.target. [ OK ] Stopped target initrd-root-fs.target. [ 26.238177] systemd[1]: Reached target integritysetup.target. [ OK ] Reached target integritysetup.target. [ 26.248657] systemd[1]: Reached target remote-cryptsetup.target. [ OK ] Reached target remote-cryptsetup.target. [ 26.260601] systemd[1]: Reached target remote-fs.target. [ OK ] Reached target remote-fs.target. [ 26.271361] systemd[1]: Reached target slices.target. [ OK ] Reached target slices.target. [ 26.280925] systemd[1]: Reached target swap.target. [ OK ] Reached target swap.target. [ 26.290378] systemd[1]: Reached target torcx.target. [ OK ] Reached target torcx.target. [ 26.299256] systemd[1]: Reached target veritysetup.target. [ OK ] Reached target veritysetup.target. [ 26.310030] systemd[1]: Listening on systemd-coredump.socket. [ OK ] Listening on systemd-coredump.socket. [ 26.321773] systemd[1]: Listening on systemd-initctl.socket. [ OK ] Listening on systemd-initctl.socket. [ 26.331945] systemd[1]: Listening on systemd-networkd.socket. [ OK ] Listening on systemd-networkd.socket. [ 26.342238] systemd[1]: Listening on systemd-udevd-control.socket. [ OK ] Listening on systemd-udevd-control.socket. [ 26.353070] systemd[1]: Listening on systemd-udevd-kernel.socket. [ OK ] Listening on systemd-udevd-kernel.socket. [ 26.363918] systemd[1]: Listening on systemd-userdbd.socket. [ OK ] Listening on systemd-userdbd.socket. [ 26.376210] systemd[1]: Mounting dev-hugepages.mount... Mounting dev-hugepages.mount... [ 26.385622] systemd[1]: Mounting dev-mqueue.mount... Mounting dev-mqueue.mount... [ 26.396086] systemd[1]: Mounting media.mount... Mounting media.mount... [ 26.404016] systemd[1]: Mounting sys-kernel-debug.mount... Mounting sys-kernel-debug.mount... [ 26.415805] systemd[1]: Mounting sys-kernel-tracing.mount... Mounting sys-kernel-tracing.mount... [ 26.426031] systemd[1]: Mounting tmp.mount... Mounting tmp.mount... [ 26.434874] systemd[1]: Starting flatcar-tmpfiles.service... Starting flatcar-tmpfiles.service... [ 26.445759] systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. [ 26.455072] systemd[1]: Starting kmod-static-nodes.service... Starting kmod-static-nodes.service... [ 26.465236] systemd[1]: Starting modprobe@configfs.service... Starting modprobe@configfs.service... [ 26.475367] systemd[1]: Starting modprobe@dm_mod.service... Starting modprobe@dm_mod.service... [ 26.485075] systemd[1]: Starting modprobe@drm.service... Starting modprobe@drm.service... [ 26.495327] systemd[1]: Starting modprobe@efi_pstore.service... Starting modprobe@efi_pstore.service... [ 26.505639] systemd[1]: Starting modprobe@fuse.service... Starting modprobe@fuse.service... [ 26.514923] systemd[1]: Starting modprobe@loop.service... Starting modprobe@loop.service... [ 26.524782] systemd[1]: setup-nsswitch.service was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). [ 26.536462] systemd[1]: systemd-fsck-root.service: Deactivated successfully. [ 26.543945] systemd[1]: Stopped systemd-fsck-root.service. [ OK ] Stopped systemd-fsck-root.service. [ 26.553844] systemd[1]: systemd-fsck-usr.service: Deactivated successfully. [ 26.559464] systemd[1]: Stopped systemd-fsck-usr.service. [ OK ] Stopped systemd-fsck-usr.service. [ 26.569243] systemd[1]: Stopped systemd-journald.service. [ 26.569902] loop: module loaded [ OK ] Stopped systemd-journald.service. [ 26.581606] systemd[1]: systemd-journald.service: Consumed 3.745s CPU time. [ 26.590385] systemd[1]: Starting systemd-journald.service... Starting systemd-journald.service... [ 26.615906] systemd[1]: Starting systemd-modules-load.service... Starting systemd-modules-load.service... [ 26.627210] systemd[1]: Starting systemd-network-generator.service... Starting systemd-network-generator.service...[ 26.633650] fuse: init (API version 7.34) [ 26.642108] systemd[1]: Starting systemd-remount-fs.service... Starting systemd-remount-fs.service... [ 26.653720] systemd[1]: Starting systemd-udev-trigger.service... Starting systemd-udev-trigger.service... [ 26.664475] systemd[1]: verity-setup.service: Deactivated successfully. [ 26.670569] systemd[1]: Stopped verity-setup.service. [ OK ] Stopped verity-setup.service. [ 26.682414] systemd[1]: Mounted dev-hugepages.mount. [ OK ] Mounted dev-hugepages.mount. [ 26.692361] systemd[1]: Mounted dev-mqueue.mount. [ OK ] Mounted dev-mqueue.mount. [ 26.702746] systemd[1]: Mounted media.mount. [ OK ] Mounted media.mount. [ 26.710571] systemd[1]: Mounted sys-kernel-debug.mount. [ OK ] Mounted sys-kernel-debug.mount. [ 26.719839] systemd[1]: Started systemd-journald.service. [ OK ] Started systemd-journald.service. [ OK ] Mounted sys-kernel-tracing.mount. [ OK ] Mounted tmp.mount. [ OK ] Finished flatcar-tmpfiles.service. [ OK ] Finished kmod-static-nodes.service. [ OK ] Finished modprobe@configfs.service. [ 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 ] 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... [ OK ] Finished systemd-udev-trigger.service. [ OK ] Mounted sys-fs-fuse-connections.mount. [ OK ] Mounted sys-kernel-config.mount. Starting systemd-udev-settle.service... [ 26.906082] systemd-journald[1208]: Received client request to flush runtime journal. [ OK ] Finished systemd-random-seed.service. [ OK ] Reached target first-boot-complete.target. [ OK ] Finished systemd-journal-flush.service. [ OK ] Finished systemd-sysctl.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... Starting systemd-userdbd.service... [ 28.338044] hv_vmbus: registering driver hv_balloon [ 28.345778] hv_balloon: Using Dynamic Memory protocol version 2.0 [ 28.350898] hv_balloon: Memory hot add disabled on ARM64 [ 28.356924] hv_vmbus: registering driver hyperv_fb [ 28.362124] mousedev: PS/2 mouse device common for all mice [ 28.369460] hv_utils: Registering HyperV Utility Driver [ OK ] Started systemd-userdbd.service.[ 28.381428] hv_vmbus: registering driver hv_utils [ 28.389137] hyperv_fb: Synthvid Version major 3, minor 5 [ 28.393991] hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 [ 28.404059] hv_utils: Heartbeat IC version 3.0 [ 28.407812] hv_utils: Shutdown IC version 3.2 [ 28.411754] Console: switching to colour dummy device 80x25 [ 28.416128] hv_utils: TimeSync IC version 4.0 [ 28.423222] Console: switching to colour frame buffer device 128x48 [ 28.621570] BTRFS info: devid 1 device path /dev/disk/by-label/OEM changed to /dev/sda6 scanned by (udev-worker) (1247) [ OK ] Started systemd-networkd.service. Starting systemd-networkd-wait-online.service... [ OK ] Found device dev-disk-by\x2dlabel-OEM.device. [ OK ] Finished systemd-udev-settle.service. Starting lvm2-activation-early.service... [ 28.738785] mlx5_core 0dcb:00:02.0 enP3531s1: Link up [ 28.762190] hv_netvsc 002248b5-3987-0022-48b5-3987002248b5 eth0: Data path switched to VF: enP3531s1 [ OK ] Finished lvm2-activation-early.service. [ OK ] Reached target cryptsetup.target. Starting lvm2-activation.service... [ 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-machine-id-commit.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-networkd-wait-online.service. [ OK ] Finished systemd-tmpfiles-setup.service. [ 31.708510] kauditd_printk_skb: 74 callbacks suppressed [ 31.708513] audit: type=1130 audit(1707503724.143:157): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Starting audit-rules.service... Starting clean-ca-certificates.service... Starting systemd-journal-catalog-update.service... [ 31.751283] audit: type=1334 audit(1707503724.186:158): prog-id=24 op=LOAD Starting systemd-resolved.service... [ 31.763269] audit: type=1334 audit(1707503724.198:159): prog-id=25 op=LOAD Starting systemd-timesyncd.service... Starting systemd-update-utmp.service... [ OK ] Finished clean-ca-certificates.service. [ 31.808845] audit: type=1130 audit(1707503724.244:160): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=clean-ca-certificates comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 31.850847] audit: type=1127 audit(1707503724.286:161): pid=1328 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg=' comm="systemd-update-utmp" exe="/usr/lib/systemd/systemd-update-utmp" hostname=? addr=? terminal=? res=success' [ OK ] Finished systemd-update-utmp.service. [ 31.874670] audit: type=1130 audit(1707503724.310:162): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-update-utmp comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Started systemd-timesyncd.service. [ OK ] Reached target time-set.target.[ 31.907703] audit: type=1130 audit(1707503724.338:163): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-timesyncd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Finished systemd-journal-catalog-update.service. [ 31.954133] audit: type=1130 audit(1707503724.389:164): 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' [ OK ] Started systemd-resolved.service. [ 32.074532] audit: type=1130 audit(1707503724.510:165): 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. [ 32.152640] audit: type=1305 audit(1707503724.588:166): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 [ OK ] Finished audit-rules.service. [* ] Job ldconfig.service/start running (8s / no limit) M [** ] Job ldconfig.service/start running (9s / 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 [ 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 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. [ 36.666054] extend-filesystems[1354]: Found sda [ 36.670146] extend-filesystems[1354]: Found sda1 [ OK ] Finished motdgen.service. [ 36.674410] extend-filesystems[1354]: Found sda2 [ 36.683522] extend-filesystems[1354]: Found sda3 [ 36.687814] extend-filesystems[1354]: Found usr [ 36.692518] extend-filesystems[1354]: Found sda4 [ 36.699576] extend-filesystems[1354]: Found sda6 [ 36.704971] extend-filesystems[1354]: Found sda7 [ 36.709945] extend-filesystems[1354]: Found sda9 [ 36.714323] extend-filesystems[1354]: Checking size of /dev/sda9 [ 36.804985] extend-filesystems[1354]: Old size kept for /dev/sda9 [ OK ] Finished extend-filesystems.service. [ 36.823215] extend-filesystems[1354]: Found sr0 [ OK ] Finished update-ssh-keys-after-ignition.service. [ OK ] Started dbus.service. [ OK ] Reached target system-config.target. [ OK ] Reached target user-config.target. [ OK ] Started containerd.service. [ OK ] Started systemd-logind.service. [ OK ] Finished prepare-critools.service. [ OK ] Started update-engine.service. [ OK ] Started locksmithd.service. [ OK ] Finished prepare-cni-plugins.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-bd3bd4ac96 (Linux aarch64 5.15.148-flatcar) 18:35:32 SSH host key: SHA256:o1z56Y9AnrA/k2gEAxacHRQP8bZQrWud8jA/dADF66Y (RSA) SSH host key: SHA256:WXRVpLmZv+ll/tH2LJuvyarS7oP/enOFbKzlSJ8Eo2U (ED25519) SSH host key: SHA256:LHPaYhCyLJSf4TtADSAEVlFdcNgcaSQ7VZ6hJswX08M (ECDSA) enP3531s1: eth0: 10.200.20.21 fe80::222:48ff:feb5:3987 ci-3510 login: core (automatic login) Flatcar Container Linux by Kinvolk lts 3510.3.2 for Microsoft Azure [?2004hcore@ci-3510 ~ $ 2024-02-09T18:35:38.072291Z INFO Daemon Daemon Azure Linux Agent Version:2.6.0.2 2024-02-09T18:35:38.079522Z INFO Daemon Daemon OS: flatcar 3510.3.2 2024-02-09T18:35:38.084910Z INFO Daemon Daemon Python: 3.9.16 2024-02-09T18:35:38.089658Z INFO Daemon Daemon Run daemon 2024-02-09T18:35:38.094425Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='3510.3.2' 2024-02-09T18:35:38.111276Z 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:35:38.127767Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' 2024-02-09T18:35:38.139175Z INFO Daemon Daemon cloud-init is enabled: False 2024-02-09T18:35:38.145137Z INFO Daemon Daemon Using waagent for provisioning 2024-02-09T18:35:38.151374Z INFO Daemon Daemon Activate resource disk 2024-02-09T18:35:38.156573Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb 2024-02-09T18:35:38.171486Z INFO Daemon Daemon Found device: None 2024-02-09T18:35:38.176433Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology 2024-02-09T18:35:38.185444Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 2024-02-09T18:35:38.198116Z INFO Daemon Daemon Clean protocol and wireserver endpoint 2024-02-09T18:35:38.204178Z INFO Daemon Daemon Running default provisioning handler 2024-02-09T18:35:38.217525Z 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:35:38.233115Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' 2024-02-09T18:35:38.243202Z INFO Daemon Daemon cloud-init is enabled: False 2024-02-09T18:35:38.248640Z INFO Daemon Daemon Copying ovf-env.xml 2024-02-09T18:35:38.341893Z INFO Daemon Daemon Successfully mounted dvd 2024-02-09T18:35:38.443929Z INFO Daemon Daemon Detect protocol endpoint 2024-02-09T18:35:38.449652Z INFO Daemon Daemon Clean protocol and wireserver endpoint 2024-02-09T18:35:38.455911Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler 2024-02-09T18:35:38.462633Z INFO Daemon Daemon Test for route to 168.63.129.16 2024-02-09T18:35:38.468526Z INFO Daemon Daemon Route to 168.63.129.16 exists 2024-02-09T18:35:38.473939Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 2024-02-09T18:35:38.564595Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 2024-02-09T18:35:38.574773Z INFO Daemon Daemon Wire protocol version:2012-11-30 2024-02-09T18:35:38.581310Z INFO Daemon Daemon Server preferred version:2015-04-05 2024-02-09T18:35:39.015858Z INFO Daemon Daemon Initializing goal state during protocol detection 2024-02-09T18:35:39.033140Z INFO Daemon Daemon Forcing an update of the goal state.. 2024-02-09T18:35:39.040166Z INFO Daemon Daemon Fetching goal state [incarnation 1] 2024-02-09T18:35:39.113508Z INFO Daemon Daemon Found private key matching thumbprint B1B4C04372CB8FE30A7CA4044898D88DD0CD4BE8 2024-02-09T18:35:39.122913Z INFO Daemon Daemon Certificate with thumbprint BE5D131E9C642C7F6941CBC0F99F58B6A389401F has no matching private key. 2024-02-09T18:35:39.133488Z INFO Daemon Daemon Fetch goal state completed 2024-02-09T18:35:39.209940Z INFO Daemon Daemon Fetched new vmSettings [correlation ID: de7c462a-4acc-40ed-930b-8d974d402bb8 New eTag: 14190595541399572655] 2024-02-09T18:35:39.221906Z INFO Daemon Daemon Status Blob type 'None' is not valid, assuming BlockBlob 2024-02-09T18:35:39.237624Z INFO Daemon Daemon Starting provisioning 2024-02-09T18:35:39.242842Z INFO Daemon Daemon Handle ovf-env.xml. 2024-02-09T18:35:39.247830Z INFO Daemon Daemon Set hostname [ci-3510.3.2-a-bd3bd4ac96] 2024-02-09T18:35:39.291032Z INFO Daemon Daemon Publish hostname [ci-3510.3.2-a-bd3bd4ac96] 2024-02-09T18:35:39.298039Z INFO Daemon Daemon Examine /proc/net/route for primary interface 2024-02-09T18:35:39.305048Z INFO Daemon Daemon Primary interface is [eth0] 2024-02-09T18:35:39.365693Z INFO Daemon Daemon Create user account if not exists 2024-02-09T18:35:39.373020Z INFO Daemon Daemon User core already exists, skip useradd 2024-02-09T18:35:39.381020Z INFO Daemon Daemon Configure sudoer 2024-02-09T18:35:39.386604Z INFO Daemon Daemon Configure sshd 2024-02-09T18:35:39.391932Z INFO Daemon Daemon Deploy ssh public key. 2024-02-09T18:35:40.624539Z INFO Daemon Daemon Provisioning complete 2024-02-09T18:35:40.645119Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping 2024-02-09T18:35:40.651978Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. [ 76.456774] hv_balloon: Max. dynamic memory size: 4096 MB [ 91.441816] SELinux: Context system_u:object_r:container_file_t:s0 is not valid (left unmapped). [ 113.293431] cni0: port 1(veth5a04fa15) entered blocking state [ 113.298125] cni0: port 1(veth5a04fa15) entered disabled state [ 113.303829] device veth5a04fa15 entered promiscuous mode [ 113.308024] cni0: port 1(veth5a04fa15) entered blocking state [ 113.312428] cni0: port 1(veth5a04fa15) entered forwarding state [ 113.317019] cni0: port 1(veth5a04fa15) entered disabled state [ 113.324625] IPv6: ADDRCONF(NETDEV_CHANGE): veth5a04fa15: link becomes ready [ 113.329869] cni0: port 1(veth5a04fa15) entered blocking state [ 113.334287] cni0: port 1(veth5a04fa15) entered forwarding state [ 122.591429] cni0: port 2(veth0a7536ed) entered blocking state [ 122.599064] cni0: port 2(veth0a7536ed) entered disabled state [ 122.603709] device veth0a7536ed entered promiscuous mode [ 122.611144] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 122.615748] IPv6: ADDRCONF(NETDEV_CHANGE): veth0a7536ed: link becomes ready [ 122.621235] cni0: port 2(veth0a7536ed) entered blocking state [ 122.626439] cni0: port 2(veth0a7536ed) entered forwarding state [ 137.925911] FS-Cache: Loaded [ 137.995650] RPC: Registered named UNIX socket transport module. [ 138.000150] RPC: Registered udp transport module. [ 138.003520] RPC: Registered tcp transport module. [ 138.007961] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 138.106014] FS-Cache: Netfs 'nfs' registered for caching [ 138.262296] NFS: Registering the id_resolver key type [ 138.265972] Key type id_resolver registered [ 138.268951] Key type id_legacy registered [ 138.892750] cni0: port 3(vethd917948a) entered blocking state [ 138.898246] cni0: port 3(vethd917948a) entered disabled state [ 138.903351] device vethd917948a entered promiscuous mode [ 138.910667] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 138.915202] IPv6: ADDRCONF(NETDEV_CHANGE): vethd917948a: link becomes ready [ 138.920713] cni0: port 3(vethd917948a) entered blocking state [ 138.924832] cni0: port 3(vethd917948a) entered forwarding state