[=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.009586] Console: colour dummy device 80x25 [ 0.015101] printk: console [tty1] enabled [ 0.020007] ACPI: Core revision 20210730 [ 0.024707] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) [ 0.036808] pid_max: default: 32768 minimum: 301 [ 0.042372] LSM: Security Framework initializing [ 0.047981] SELinux: Initializing. [ 0.052476] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) [ 0.061830] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) [ 0.071867] Hyper-V: privilege flags low 0x2e7f, high 0x3a8030, hints 0xe, misc 0x31e1 [ 0.082350] Hyper-V: Host Build 10.0.22477.1369-1-0 [ 0.088494] rcu: Hierarchical SRCU implementation. [ 0.094907] Remapping and enabling EFI services. [ 0.100583] smp: Bringing up secondary CPUs ... [ 0.106136] Detected PIPT I-cache on CPU1 [ 0.106163] GICv3: CPU1: found redistributor 1 region 1:0x00000000f000e000 [ 0.106216] arch_timer: Enabling local workaround for ARM erratum 1418040 [ 0.106263] CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] [ 0.106318] smp: Brought up 1 node, 2 CPUs [ 0.142014] SMP: Total of 2 processors activated. [ 0.147861] CPU features: detected: 32-bit EL0 Support [ 0.154304] CPU features: detected: Instruction cache invalidation not required for I/D coherence [ 0.165727] CPU features: detected: Data cache clean to the PoU not required for I/D coherence [ 0.176821] CPU features: detected: CRC32 instructions [ 0.183007] CPU features: detected: RCpc load-acquire (LDAPR) [ 0.190027] CPU features: detected: LSE atomic instructions [ 0.197768] CPU features: detected: Privileged Access Never [ 0.258897] CPU: All CPU(s) started at EL1 [ 0.264263] alternatives: patching kernel code [ 0.270602] devtmpfs: initialized [ 0.275123] KASLR enabled [ 0.278720] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.291643] futex hash table entries: 512 (order: 3, 32768 bytes, linear) [ 0.300616] pinctrl core: initialized pinctrl subsystem [ 0.307997] SMBIOS 3.1.0 present. [ 0.312498] DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 07/12/2023 [ 0.326093] NET: Registered PF_NETLINK/PF_ROUTE protocol family [ 0.334514] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.343513] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.353220] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.364052] audit: initializing netlink subsys (disabled) [ 0.371161] audit: type=2000 audit(0.095:1): state=initialized audit_enabled=0 res=1 [ 0.371243] thermal_sys: Registered thermal governor 'step_wise' [ 0.381249] cpuidle: using governor menu [ 0.393784] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. [ 0.402738] ASID allocator initialised with 32768 entries [ 0.409934] ACPI: bus type PCI registered [ 0.415144] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.423712] Serial: AMBA PL011 UART driver [ 0.430299] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.439066] HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages [ 0.447806] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.456219] HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages [ 0.584723] cryptd: max_cpu_qlen set to 1000 [ 0.593377] alg: No test for fips(ansi_cprng) (fips_ansi_cprng) [ 0.601711] ACPI: Added _OSI(Module Device) [ 0.607418] ACPI: Added _OSI(Processor Device) [ 0.613022] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.619508] ACPI: Added _OSI(Processor Aggregator Device) [ 0.626823] ACPI: Added _OSI(Linux-Dell-Video) [ 0.632925] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) [ 0.640466] ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) [ 0.652470] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.660829] ACPI: Interpreter enabled [ 0.665478] ACPI: Using GIC for interrupt routing [ 0.671925] ARMH0011:00: ttyAMA0 at MMIO 0xeffec000 (irq = 12, base_baud = 0) is a SBSA [ 0.683318] printk: console [ttyAMA0] enabled [ 0.683318] printk: console [ttyAMA0] enabled [ 0.693010] printk: bootconsole [pl11] disabled [ 0.693010] printk: bootconsole [pl11] disabled [ 0.703598] ARMH0011:01: ttyAMA1 at MMIO 0xeffeb000 (irq = 13, base_baud = 0) is a SBSA [ 0.711289] iommu: Default domain type: Translated [ 0.715618] iommu: DMA domain TLB invalidation policy: strict mode [ 0.721606] vgaarb: loaded [ 0.724192] pps_core: LinuxPPS API ver. 1 registered [ 0.728870] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.737060] PTP clock support registered [ 0.740573] Registered efivars operations [ 0.744114] No ACPI PMU IRQ for CPU0 [ 0.747283] No ACPI PMU IRQ for CPU1 [ 0.750825] clocksource: Switched to clocksource arch_sys_counter [ 0.762161] VFS: Disk quotas dquot_6.6.0 [ 0.765760] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.772572] pnp: PnP ACPI init [ 0.775361] pnp: PnP ACPI: found 0 devices [ 0.781170] NET: Registered PF_INET protocol family [ 0.785994] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) [ 0.793458] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) [ 0.801484] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) [ 0.808797] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) [ 0.816105] TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) [ 0.823088] TCP: Hash tables configured (established 32768 bind 32768) [ 0.829411] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) [ 0.835898] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) [ 0.842726] NET: Registered PF_UNIX/PF_LOCAL protocol family [ 0.847972] PCI: CLS 0 bytes, default 64 [ 0.860870] hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 1 counters available [ 0.868473] kvm [1]: HYP mode not available [ 1.049330] Initialise system trusted keyrings [ 1.053778] workingset: timestamp_bits=39 max_order=20 bucket_order=0 [ 1.060922] Key type asymmetric registered [ 1.064613] Asymmetric key parser 'x509' registered [ 1.069250] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) [ 1.075865] io scheduler mq-deadline registered [ 1.079854] io scheduler kyber registered [ 1.083495] io scheduler bfq registered [ 1.087932] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 1.094329] thunder_xcv, ver 1.0 [ 1.097230] thunder_bgx, ver 1.0 [ 1.100119] nicpf, ver 1.0 [ 1.102687] nicvf, ver 1.0 [ 1.105694] rtc-efi rtc-efi.0: registered as rtc0 [ 1.110229] rtc-efi rtc-efi.0: setting system clock to 2024-02-09T18:34:52 UTC (1707503692) [ 1.117241] efifb: probing for efifb [ 1.120308] efifb: framebuffer at 0x40000000, using 3072k, total 3072k [ 1.126144] efifb: mode is 1024x768x32, linelength=4096, pages=1 [ 1.131527] efifb: scrolling: redraw [ 1.134909] efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 [ 1.142019] Console: switching to colour frame buffer device 128x48 [ 1.148564] fb0: EFI VGA frame buffer device [ 1.152519] SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... [ 1.158401] hid: raw HID events driver (C) Jiri Kosina [ 1.163502] NET: Registered PF_INET6 protocol family [ 1.168455] Segment Routing with IPv6 [ 1.171926] In-situ OAM (IOAM) with IPv6 [ 1.175523] NET: Registered PF_PACKET protocol family [ 1.180287] Key type dns_resolver registered [ 1.184405] registered taskstats version 1 [ 1.188038] Loading compiled-in X.509 certificates [ 1.221511] Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.15.148-flatcar: 947a80114e81e2815f6db72a0d388260762488f9' [ 1.233505] Key type .fscrypt registered [ 1.237246] Key type fscrypt-provisioning registered [ 1.242303] ima: No TPM chip found, activating TPM-bypass! [ 1.247695] ima: Allocated hash algorithm: sha1 [ 1.251990] ima: No architecture policies found [ 1.261416] Freeing unused kernel memory: 34688K [ 1.265913] Run /init as init process [ 1.287993] 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.316243] systemd[1]: Detected virtualization microsoft. [ 1.322761] systemd[1]: Detected architecture arm64. [ 1.327605] systemd[1]: Running in initrd. Welcome to dracut-053 (Initramfs)! [ 1.335752] systemd[1]: No hostname configured, using default hostname. [ 1.342913] systemd[1]: Hostname set to . [ 1.347866] systemd[1]: Initializing machine ID from random generator. [ 1.441198] systemd[1]: Queued start job for default target initrd.target. [ 1.449413] systemd[1]: Started systemd-ask-password-console.path. [ OK ] Started systemd-ask-password-console.path. [ 1.461263] systemd[1]: Reached target cryptsetup.target. [ OK ] Reached target cryptsetup.target. [ 1.471794] systemd[1]: Reached target paths.target. [ OK ] Reached target paths.target. [ 1.481258] systemd[1]: Reached target slices.target. [ OK ] Reached target slices.target. [ 1.491008] systemd[1]: Reached target swap.target. [ OK ] Reached target swap.target. [ 1.500274] systemd[1]: Reached target timers.target. [ OK ] Reached target timers.target. [ 1.511397] systemd[1]: Listening on iscsid.socket. [ OK ] Listening on iscsid.socket. [ 1.521187] systemd[1]: Listening on iscsiuio.socket. [ OK ] Listening on iscsiuio.socket. [ 1.531645] systemd[1]: Listening on systemd-journald-audit.socket. [ OK ] Listening on systemd-journald-audit.socket. [ 1.544223] systemd[1]: Listening on systemd-journald-dev-log.socket. [ OK ] Listening on systemd-journald-dev-log.socket. [ 1.557646] systemd[1]: Listening on systemd-journald.socket. [ OK ] Listening on systemd-journald.socket. [ 1.570310] systemd[1]: Listening on systemd-networkd.socket. [ OK ] Listening on systemd-networkd.socket. [ 1.582102] systemd[1]: Listening on systemd-udevd-control.socket. [ OK ] Listening on systemd-udevd-control.socket. [ 1.594817] systemd[1]: Listening on systemd-udevd-kernel.socket. [ OK ] Listening on systemd-udevd-kernel.socket. [ 1.606874] systemd[1]: Reached target sockets.target. [ OK ] Reached target sockets.target. [ 1.619217] systemd[1]: Starting kmod-static-nodes.service... Starting kmod-static-nodes.service... [ 1.629932] systemd[1]: Finished network-cleanup.service. [ OK ] Finished network-cleanup.service. [ 1.641676] systemd[1]: Starting systemd-fsck-usr.service... Starting systemd-fsck-usr.service... [ 1.653116] systemd[1]: Starting systemd-journald.service... Starting systemd-journald.service... [ 1.665865] systemd[1]: Starting systemd-modules-load.service... Starting systemd-modules-load.service... [ 1.678439] systemd[1]: Starting systemd-resolved.service... Starting systemd-resolved.service... [ 1.211136] systemd-modules-load[277]: Inserted module 'overlay' [ 1.706923] systemd[1]: Starting systemd-vconsole-setup.service... [ 1.715147] bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Starting systemd-vconsole-setup.service... [ 1.734929] systemd[1]: Started systemd-journald.service. [ 1.740690] Bridge firewalling registered [ 1.258319] systemd-modules-load[277]: Inserted module 'br_netfilter' [ OK ] Started systemd-journald.service.[ 1.759039] SCSI subsystem initialized [ 1.277250] systemd[1]: Finished kmod-static-nodes.service.[ 1.765855] audit: type=1130 audit(1707503693.152:2): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Finished kmod-static-nodes.service. [ 1.318047] systemd[1]: Finished systemd-fsck-usr.service.[ 1.808288] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. [ 1.821546] device-mapper: uevent: version 1.0.3 [ 1.826220] audit: type=1130 audit(1707503693.193:3): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Finished systemd-fsck-usr.service.[ 1.847331] device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com [ 1.358164] systemd-resolved[278]: Positive Trust Anchors:[ 1.858848] audit: type=1130 audit(1707503693.248:4): 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' [ 1.394541] systemd-resolved[278]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d [ OK ] Started systemd-resolved.service. [ 1.404591] 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.932257] audit: type=1130 audit(1707503693.286:5): 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' [ OK ] Finished systemd-modules-load.service. [ 1.465163] systemd-resolved[278]: Defaulting to hostname 'linux'. [ OK ] Finished systemd-vconsole-setup.service. [ 1.476171] systemd-modules-load[277]: Inserted module 'dm_multipath'[ 1.974581] audit: type=1130 audit(1707503693.347:6): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Reached target nss-lookup.target. [ 1.999727] audit: type=1130 audit(1707503693.358:7): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 1.507703] systemd[1]: Started systemd-resolved.service. Starting dracut-cmdline-ask.service... [ 1.545132] systemd[1]: Finished systemd-modules-load.service. Starting systemd-sysctl.service... [ 1.555667] systemd[1]: Finished systemd-vconsole-setup.service. [ 1.565200] systemd[1]: Reached target nss-lookup.target. [ 1.570326] systemd[1]: Starting dracut-cmdline-ask.service... Starting systemd-tmpfiles-setup-dev.service... [ 1.577857] systemd[1]: Starting systemd-sysctl.service... [ 1.589115] systemd[1]: Starting systemd-tmpfiles-setup-dev.service... [ OK ] Finished systemd-sysctl.service. [ 1.595881] systemd[1]: Finished systemd-sysctl.service. [ 2.094113] audit: type=1130 audit(1707503693.483:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Finished systemd-tmpfiles-setup-dev.service. [ 1.628628] systemd[1]: Finished systemd-tmpfiles-setup-dev.service.[ 2.126492] audit: type=1130 audit(1707503693.510:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Finished dracut-cmdline-ask.service. [ 1.659488] systemd[1]: Finished dracut-cmdline-ask.service. Starting dracut-cmdline.service... [ 2.161859] audit: type=1130 audit(1707503693.541:10): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 1.670692] systemd[1]: Starting dracut-cmdline.service... [ 1.704901] dracut-cmdline[298]: dracut-dracut-053 [ 1.709945] dracut-cmdline[298]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=tty1 console=ttyAMA0,115200n8 earlycon=pl011,0xeffec000 flatcar.first_boot=detected acpi=force flatcar.oem.id=azure flatcar.autologin verity.usrhash=680ffc8c0dfb23738bd19ec96ea37b5bbadfb5cebf23767d1d52c89a6d5c00b4 [ 2.282212] Loading iSCSI transport class v2.0-870. [ 2.296268] iscsi: registered transport (tcp) [ 2.313533] iscsi: registered transport (qla4xxx) [ 2.321626] QLogic iSCSI HBA Driver [ OK ] Finished dracut-cmdline.service. [ 1.880088] systemd[1]: Finished dracut-cmdline.service. Starting dracut-pre-udev.service... [ 1.890755] systemd[1]: Starting dracut-pre-udev.service... [ 2.418841] raid6: neonx8 gen() 13797 MB/s [ 2.441829] raid6: neonx8 xor() 10832 MB/s [ 2.463839] raid6: neonx4 gen() 13513 MB/s [ 2.484827] raid6: neonx4 xor() 11269 MB/s [ 2.505829] raid6: neonx2 gen() 13091 MB/s [ 2.527827] raid6: neonx2 xor() 10281 MB/s [ 2.548828] raid6: neonx1 gen() 10514 MB/s [ 2.569828] raid6: neonx1 xor() 8785 MB/s [ 2.591831] raid6: int64x8 gen() 6294 MB/s [ 2.612828] raid6: int64x8 xor() 3549 MB/s [ 2.640827] raid6: int64x4 gen() 7218 MB/s [ 2.661828] raid6: int64x4 xor() 3854 MB/s [ 2.684829] raid6: int64x2 gen() 6150 MB/s [ 2.705827] raid6: int64x2 xor() 3320 MB/s [ 2.727827] raid6: int64x1 gen() 5044 MB/s [ 2.749827] raid6: int64x1 xor() 2644 MB/s [ 2.754304] raid6: using algorithm neonx8 gen() 13797 MB/s [ 2.759964] raid6: .... xor() 10832 MB/s, rmw enabled [ 2.765056] raid6: using neon recovery algorithm [ 2.778807] xor: measuring software checksum speed [ 2.788473] 8regs : 17322 MB/sec [ 2.794377] 32regs : 20765 MB/sec [ 2.799438] arm64_neon : 27997 MB/sec [ 2.804195] xor: using function: arm64_neon (27997 MB/sec) [ 2.859477] Btrfs loaded, crc32c=crc32c-generic, zoned=no, fsverity=no [ OK ] Finished dracut-pre-udev.service. [ 2.393245] systemd[1]: Finished dracut-pre-udev.service. Starting systemd-udevd.service... [ 2.402256] systemd[1]: Starting systemd-udevd.service... [ 2.421186] systemd-udevd[475]: Using default interface naming scheme 'v252'. [ OK ] Started systemd-udevd.service. [ 2.433792] systemd[1]: Started systemd-udevd.service. Starting dracut-pre-trigger.service... [ 2.445083] systemd[1]: Starting dracut-pre-trigger.service... [ 2.452503] dracut-pre-trigger[496]: rd.md=0: removing MD RAID activation [ OK ] Finished dracut-pre-trigger.service. [ 2.480076] systemd[1]: Finished dracut-pre-trigger.service. [ 2.490545] systemd[1]: Starting systemd-udev-trigger.service... Starting systemd-udev-trigger.service... [ OK ] Finished systemd-udev-trigger.service. [ 2.528908] systemd[1]: Finished systemd-udev-trigger.service. [ 3.054865] hv_vmbus: Vmbus version:5.3 [ 3.068390] hv_vmbus: registering driver hid_hyperv [ 3.075129] input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input0 [ 3.085043] hv_vmbus: registering driver hv_netvsc [ 3.086838] hid-generic 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on [ 3.100741] hv_vmbus: registering driver hyperv_keyboard [ 3.109943] input: AT Translated Set 2 keyboard as /devices/LNXSYSTM:00/LNXSYBUS:00/ACPI0004:00/VMBUS:00/d34b2567-b9b6-42b9-8778-0a4ec0b955bf/serio0/input/input1 [ 3.127273] hv_vmbus: registering driver hv_storvsc [ 3.135993] scsi host0: storvsc_host_t [ 3.141268] scsi 0:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 [ 3.149440] scsi host1: storvsc_host_t [ 3.153471] scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 0 [ 3.170935] sr 0:0:0:2: [sr0] scsi-1 drive [ 3.174427] cdrom: Uniform CD-ROM driver Revision: 3.20 [ 3.180286] sd 0:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB) [ 3.187086] sd 0:0:0:0: [sda] 4096-byte physical blocks [ 3.192013] sd 0:0:0:0: [sda] Write Protect is off [ 3.196722] sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA [ 3.206104] hv_netvsc 002248bd-b39d-0022-48bd-b39d002248bd eth0: VF slot 1 added [ 3.214462] sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 [ 3.225585] sd 0:0:0:0: [sda] Attached SCSI disk [ 3.233414] hv_vmbus: registering driver hv_pci [ 3.238861] hv_pci c8cb075e-fe1b-4bfc-b934-f57b1182020b: PCI VMBus probing: Using version 0x10004 [ 3.252793] hv_pci c8cb075e-fe1b-4bfc-b934-f57b1182020b: PCI host bridge to bus fe1b:00 [ 3.260679] pci_bus fe1b:00: root bus resource [mem 0xfc0000000-0xfc00fffff window] [ 3.269470] pci_bus fe1b:00: No busn resource found for root bus, will use [bus 00-ff] [ 3.278934] pci fe1b:00:02.0: [15b3:1018] type 00 class 0x020000 [ 3.291203] pci fe1b:00:02.0: reg 0x10: [mem 0xfc0000000-0xfc00fffff 64bit pref] [ 3.318750] pci fe1b:00:02.0: enabling Extended Tags [ 3.335584] pci fe1b:00:02.0: 0.000 Gb/s available PCIe bandwidth, limited by Unknown x0 link at fe1b:00:02.0 (capable of 126.016 Gb/s with 8.0 GT/s PCIe x16 link) [ 3.348877] pci_bus fe1b:00: busn_res: [bus 00-ff] end is updated to 00 [ 3.354730] pci fe1b:00:02.0: BAR 0: assigned [mem 0xfc0000000-0xfc00fffff 64bit pref] [ 3.396044] mlx5_core fe1b:00:02.0: firmware version: 16.30.1284 [ 3.549277] mlx5_core fe1b:00:02.0: MLX5E: StrdRq(1) RqSz(8) StrdSz(2048) RxCqeCmprss(0) [ 3.613265] hv_netvsc 002248bd-b39d-0022-48bd-b39d002248bd eth0: VF registering: eth1 [ 3.624219] mlx5_core fe1b:00:02.0 eth1: joined to eth0 [ 3.635916] mlx5_core fe1b:00:02.0 enP65051s1: renamed from eth1 [ OK ] Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device. [ 3.224599] systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device. [ 3.761740] BTRFS: device label OEM devid 1 transid 12 /dev/sda6 scanned by (udev-worker) (535) [ OK ] Found device dev-disk-by\x2dlabel-OEM.device. [ 3.298532] systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. [ OK ] Found device dev-disk-by\x…2d8e26\x2d6cce9662f132.device. [ 3.451180] systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device. [ OK ] Found device dev-disk-by\x2dpartlabel-USR\x2dA.device. [ 3.468758] systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device. [ OK ] Found device dev-disk-by\x2dlabel-ROOT.device. [ 3.482985] systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device. Starting disk-uuid.service... [ 3.495751] systemd[1]: Starting disk-uuid.service... [ 3.997202] sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 [ 4.008533] sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 [ 5.016452] sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 [ 4.537023] disk-uuid[604]: The operation has completed successfully. [ OK ] Finished disk-uuid.service. [ 4.598605] systemd[1]: disk-uuid.service: Deactivated successfully. [ 4.610109] systemd[1]: Finished disk-uuid.service. Starting verity-setup.service... [ 4.615012] systemd[1]: Starting verity-setup.service... [ 5.136918] device-mapper: verity: sha256 using implementation "sha256-ce" [ OK ] Found device dev-mapper-usr.device. [ 4.899078] systemd[1]: Found device dev-mapper-usr.device. Mounting sysusr-usr.mount... [ OK ] Finished verity-setup.service. [ 4.908465] systemd[1]: Mounting sysusr-usr.mount... [ 4.922614] systemd[1]: Finished verity-setup.service. [ 5.445356] EXT4-fs (dm-0): mounted filesystem without journal. Opts: norecovery. Quota mode: none. [ OK ] Mounted sysusr-usr.mount. [ 4.968705] systemd[1]: Mounted sysusr-usr.mount. Starting ignition-setup.service... Starting parse-ip-for-networkd.service... [ 4.977248] systemd[1]: afterburn-network-kargs.service was skipped because no trigger condition checks were met. [ 4.996516] systemd[1]: Starting ignition-setup.service... [ 5.001459] systemd[1]: Starting parse-ip-for-networkd.service... [ 5.497151] BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm [ 5.504606] BTRFS info (device sda6): using free space tree [ 5.511376] BTRFS info (device sda6): has skinny extents [ OK ] Finished parse-ip-for-networkd.service. [ 5.071032] systemd[1]: Finished parse-ip-for-networkd.service. Starting systemd-networkd.service... [ 5.081668] systemd[1]: Starting systemd-networkd.service... [ 5.109915] systemd-networkd[842]: lo: Link UP [ 5.114715] systemd-networkd[842]: lo: Gained carrier [ OK ] Started systemd-networkd.service. [ 5.119344] systemd-networkd[842]: Enumeration completed[ 5.612100] kauditd_printk_skb: 12 callbacks suppressed [ 5.612102] audit: type=1130 audit(1707503697.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' [ OK ] Reached target network.target. Starting iscsiuio.service... [ 5.134426] systemd[1]: Started systemd-networkd.service. [ OK ] Started iscsiuio.service. [ 5.170732] systemd-networkd[842]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.[ 5.662544] audit: type=1130 audit(1707503697.051: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... [ OK ] Started iscsid.service. [ 5.199544] systemd[1]: Reached target network.target. [ 5.793807] audit: type=1130 audit(1707503697.097: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' [ 5.337061] systemd[1]: Starting iscsiuio.service... [ 5.380458] systemd[1]: mnt-oem.mount: Deactivated successfully.[ 5.892799] mlx5_core fe1b:00:02.0 enP65051s1: Link up Starting dracut-initqueue.service... [ 5.475719] iscsid[854]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi [ 5.490100] iscsid[854]: 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 [ OK ] Finished dracut-initqueue.service.[ 6.005548] hv_netvsc 002248bd-b39d-0022-48bd-b39d002248bd eth0: Data path switched to VF: enP65051s1 [ 5.513681] iscsid[854]: into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier].[ 6.031594] audit: type=1130 audit(1707503697.405: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' [ 6.051675] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ OK ] Reached target remote-fs-pre.target. [ 5.571302] iscsid[854]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. [ 5.584521] iscsid[854]: If using hardware iscsi like qla4xxx this message can be ignored. [ OK ] Reached target remote-cryptsetup.target. [ 5.592179] iscsid[854]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi [ OK ] Reached target remote-fs.target. [ 5.607197] iscsid[854]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Starting dracut-pre-mount.service... [ 5.625283] systemd[1]: Started iscsiuio.service. [ 5.631019] systemd[1]: Starting iscsid.service... [ 5.635528] systemd[1]: Started iscsid.service. [ OK ] Finished dracut-pre-mount.service. [ 5.640424] systemd[1]: Starting dracut-initqueue.service...[ 6.132693] audit: type=1130 audit(1707503697.522: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.668922] systemd[1]: Finished dracut-initqueue.service. [ 5.675930] systemd[1]: Reached target remote-fs-pre.target. [ 5.680923] systemd[1]: Reached target remote-cryptsetup.target. [ 5.686101] systemd-networkd[842]: enP65051s1: Link UP [ 5.690369] systemd-networkd[842]: eth0: Link UP [ 5.699137] systemd-networkd[842]: eth0: Gained carrier [ 5.703901] systemd[1]: Reached target remote-fs.target. [ 5.710405] systemd-networkd[842]: enP65051s1: Gained carrier [ OK ] Finished ignition-setup.service. [ 5.721048] systemd[1]: Starting dracut-pre-mount.service...[ 6.213361] audit: type=1130 audit(1707503697.602: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' [ 5.749829] systemd[1]: Finished dracut-pre-mount.service. [ 5.766691] systemd-networkd[842]: eth0: DHCPv4 address 10.200.20.30/24, gateway 10.200.20.1 acquired from 168.63.129.16 Starting ignition-fetch-offline.service... [ 5.780349] systemd[1]: Finished ignition-setup.service. [ 5.791042] systemd[1]: Starting ignition-fetch-offline.service... [ 7.263459] systemd-networkd[842]: eth0: Gained IPv6LL [* ] Job ignition-fetch-offline.service/start running (7s / no limit) M [** ] Job ignition-fetch-offline.service/start running (7s / no limit) [ 8.745807] ignition[869]: Ignition 2.14.0 [ 8.749337] ignition[869]: Stage: fetch-offline [ 8.753439] ignition[869]: reading system config file "/usr/lib/ignition/base.d/base.ign" [ 8.852051] ignition[869]: no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 8.858926] ignition[869]: no config URL provided M [ OK ] Finished ignition-fetch-offline.service. [ 8.865101] ignition[869]: reading system config file "/usr/lib/ignition/user.ign"[ 9.355347] audit: type=1130 audit(1707503700.744: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.890132] systemd[1]: Finished ignition-fetch-offline.service. Starting ignition-fetch.service... [ 8.897295] ignition[869]: no config at "/usr/lib/ignition/user.ign" [ 8.908720] systemd[1]: Starting ignition-fetch.service... [ 8.913480] ignition[869]: failed to fetch config: resource requires networking [ 8.919639] ignition[869]: Ignition finished successfully [ 8.929592] ignition[875]: Ignition 2.14.0 [ 8.933075] ignition[875]: Stage: fetch [ 8.936046] ignition[875]: reading system config file "/usr/lib/ignition/base.d/base.ign" [ 8.945033] ignition[875]: no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 8.951207] ignition[875]: no config URL provided [ 8.955069] ignition[875]: reading system config file "/usr/lib/ignition/user.ign" [ 8.960971] ignition[875]: no config at "/usr/lib/ignition/user.ign" [ 8.965990] ignition[875]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 [ 9.001057] ignition[875]: GET result: OK [ 9.005514] ignition[875]: config has been read from IMDS userdata [ 9.018572] ignition[875]: fetched base config from "system" [ OK ] Finished ignition-fetch.service. [ 9.026121] ignition[875]: fetched base config from "system"[ 9.515281] audit: type=1130 audit(1707503700.904: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' [ 9.048126] ignition[875]: fetch: fetch complete [ 9.054388] [875]: fetched user config from "azure" [ 9.058147] ignition[875]: fetch: fetch passed Starting ignition-kargs.service... [ 9.061603] systemd[1]: Finished ignition-fetch.service. [ 9.075824] ignition[875]: Ignition finished successfully [ 9.081493] systemd[1]: Starting ignition-kargs.service... [ OK ] Finished ignition-kargs.service. [ 9.085885] ignition[881]: Ignition 2.14.0[ 9.576931] audit: type=1130 audit(1707503700.966: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.108406] systemd[1]: Finished ignition-kargs.service. [ 9.119148] ignition[881]: Stage: kargs [ 9.122080] systemd[1]: Starting ignition-disks.service... [ OK ] Finished ignition-disks.service. [ 9.617930] audit: type=1130 audit(1707503701.007: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.147839] ignition[881]: reading system config file "/usr/lib/ignition/base.d/base.ign" [ OK ] Reached target local-fs-pre.target. [ 9.159477] systemd[1]: Finished ignition-disks.service. [ OK ] Reached target local-fs.target. [ 9.167824] systemd[1]: Reached target initrd-root-device.target. [ OK ] Reached target sysinit.target. [ 9.176644] ignition[881]: no config dir at "/usr/lib/ignition/base.platform.d/azure" [ OK ] Reached target basic.target. [ 9.186592] systemd[1]: Reached target local-fs-pre.target. [ 9.196659] ignition[881]: kargs: kargs passed Starting systemd-fsck-root.service... [ 9.204409] systemd[1]: Reached target local-fs.target. [ 9.213078] ignition[881]: Ignition finished successfully [ 9.217175] systemd[1]: Reached target sysinit.target. [ 9.221889] ignition[887]: Ignition 2.14.0 [ 9.225306] systemd[1]: Reached target basic.target. [ 9.229135] ignition[887]: Stage: disks [ 9.231970] systemd[1]: Starting systemd-fsck-root.service... [ 9.236604] ignition[887]: reading system config file "/usr/lib/ignition/base.d/base.ign" [ 9.242799] ignition[887]: no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 9.248945] ignition[887]: disks: disks passed [ 9.252471] ignition[887]: Ignition finished successfully [ 9.256966] systemd-fsck[895]: ROOT: clean, 602/7326000 files, 481069/7359488 blocks [ OK ] Finished systemd-fsck-root.service. Mounting sysroot.mount... [ 9.278363] systemd[1]: Finished systemd-fsck-root.service. [ 9.283398] systemd[1]: Mounting sysroot.mount...[ 9.774630] EXT4-fs (sda9): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none. [ OK ] Mounted sysroot.mount. [ 9.297554] systemd[1]: Mounted sysroot.mount. [ OK ] Reached target initrd-root-fs.target. [ 9.304690] systemd[1]: Reached target initrd-root-fs.target. Mounting sysroot-usr.mount... [ 9.341954] systemd[1]: Mounting sysroot-usr.mount... Starting flatcar-metadata-hostname.service... [ OK ] Reached target ignition-diskful.target. [ 9.347677] systemd[1]: Starting flatcar-metadata-hostname.service... [ OK ] Mounted sysroot-usr.mount. [ 9.363291] systemd[1]: ignition-remount-sysroot.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). [ 9.377097] systemd[1]: Reached target ignition-diskful.target. [ 9.382297] systemd[1]: Mounted sysroot-usr.mount. Mounting sysroot-usr-share-oem.mount... [ 9.417298] systemd[1]: Mounting sysroot-usr-share-oem.mount... [ 9.424583] systemd[1]: Starting initrd-setup-root.service... Starting initrd-setup-root.service... [ 9.922620] BTRFS: device label OEM devid 1 transid 14 /dev/sda6 scanned by mount (906) [ 9.933929] BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm [ 9.940615] BTRFS info (device sda6): using free space tree [ 9.945894] BTRFS info (device sda6): has skinny extents [ 9.464215] initrd-setup-root[911]: cut: /sysroot/etc/passwd: No such file or directory [ OK ] Mounted sysroot-usr-share-oem.mount. [ 9.475416] systemd[1]: Mounted sysroot-usr-share-oem.mount. [ 9.506801] initrd-setup-root[937]: cut: /sysroot/etc/group: No such file or directory [ 9.516592] initrd-setup-root[945]: cut: /sysroot/etc/shadow: No such file or directory [ 9.541456] initrd-setup-root[953]: cut: /sysroot/etc/gshadow: No such file or directory [ OK ] Finished initrd-setup-root.service. [ 10.217625] systemd[1]: Finished initrd-setup-root.service.[ 10.714291] kauditd_printk_skb: 1 callbacks suppressed Starting ignition-mount.service...[ 10.714293] audit: type=1130 audit(1707503702.099:34): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 10.232419] systemd[1]: Starting ignition-mount.service... Starting sysroot-boot.service... [ 10.261258] systemd[1]: Starting sysroot-boot.service... [ 10.274779] systemd[1]: sysusr-usr-share-oem.mount: Deactivated successfully. [ 10.281288] systemd[1]: sysroot-usr-share-oem.mount: Deactivated successfully. [ 10.309545] ignition[974]: INFO : Ignition 2.14.0 [ OK ] Finished sysroot-boot.service. [ 10.313989] systemd[1]: Finished sysroot-boot.service. [ 10.324030] ignition[974]: INFO : Stage: mount [ 10.818005] audit: type=1130 audit(1707503702.207: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.348324] ignition[974]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" [ OK ] Finished ignition-mount.service. [ 10.358071] ignition[974]: DEBUG : parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63[ 10.849257] audit: type=1130 audit(1707503702.238: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.391620] systemd[1]: Finished ignition-mount.service. [ 10.397116] ignition[974]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 10.404145] ignition[974]: INFO : mount: mount passed [ 10.408938] ignition[974]: INFO : Ignition finished successfully [ 10.697491] coreos-metadata[905]: Feb 09 18:35:02.573 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 [ 10.708688] coreos-metadata[905]: Feb 09 18:35:02.585 INFO Fetch successful [ 10.742400] coreos-metadata[905]: Feb 09 18:35:02.618 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 [ 10.755295] coreos-metadata[905]: Feb 09 18:35:02.631 INFO Fetch successful [ 10.760735] coreos-metadata[905]: Feb 09 18:35:02.637 INFO wrote hostname ci-3510.3.2-a-5295330982 to /sysroot/etc/hostname [ OK ] Finished flatcar-metadata-hostname.service. [ 10.770072] systemd[1]: Finished flatcar-metadata-hostname.service.[ 11.262074] audit: type=1130 audit(1707503702.651: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.803070] systemd[1]: Starting ignition-files.service... Mounting sysroot-usr-share-oem.mount... [ 10.808395] systemd[1]: Mounting sysroot-usr-share-oem.mount... [ 11.304160] BTRFS: device label OEM devid 1 transid 15 /dev/sda6 scanned by mount (984) [ 11.311323] BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm [ 11.318077] BTRFS info (device sda6): using free space tree [ 11.323020] BTRFS info (device sda6): has skinny extents [ OK ] Mounted sysroot-usr-share-oem.mount. [ 10.845722] systemd[1]: Mounted sysroot-usr-share-oem.mount. [ 10.863788] ignition[1003]: INFO : Ignition 2.14.0 [ 10.869153] ignition[1003]: INFO : Stage: files [ 10.873631] ignition[1003]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" [ 10.881978] ignition[1003]: DEBUG : parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63 [ 10.895886] ignition[1003]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 10.902770] ignition[1003]: DEBUG : files: compiled without relabeling support, skipping [ 10.909299] ignition[1003]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" [ 10.917538] ignition[1003]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" [ 10.974293] ignition[1003]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" [ 10.981969] ignition[1003]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" [ 11.128128] ignition[1003]: wrote ssh authorized keys file for user: core [ 11.135106] ignition[1003]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" [ 11.144991] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/opt/cni-plugins-linux-arm64-v1.1.1.tgz" [ 11.159597] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(3): GET https://github.com/containernetworking/plugins/releases/download/v1.1.1/cni-plugins-linux-arm64-v1.1.1.tgz: attempt #1 [ 11.598035] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(3): GET result: OK [ 11.827243] ignition[1003]: DEBUG : files: createFilesystemsFiles: createFiles: op(3): file matches expected sum of: 6b5df61a53601926e4b5a9174828123d555f592165439f541bc117c68781f41c8bd30dccd52367e406d104df849bcbcfb72d9c4bafda4b045c59ce95d0ca0742 [ 11.847585] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/opt/cni-plugins-linux-arm64-v1.1.1.tgz" [ 11.860790] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/opt/crictl-v1.26.0-linux-arm64.tar.gz" [ 11.873626] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(4): GET https://github.com/kubernetes-sigs/cri-tools/releases/download/v1.26.0/crictl-v1.26.0-linux-arm64.tar.gz: attempt #1 [ 12.274326] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(4): GET result: OK [ 12.409452] ignition[1003]: DEBUG : files: createFilesystemsFiles: createFiles: op(4): file matches expected sum of: 4c7e4541123cbd6f1d6fec1f827395cd58d65716c0998de790f965485738b6d6257c0dc46fd7f66403166c299f6d5bf9ff30b6e1ff9afbb071f17005e834518c [ 12.429112] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/opt/crictl-v1.26.0-linux-arm64.tar.gz" [ 12.440642] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing file "/sysroot/opt/bin/kubeadm" [ 12.450395] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(5): GET https://dl.k8s.io/release/v1.26.5/bin/linux/arm64/kubeadm: attempt #1 [ 12.644954] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(5): GET result: OK [ 13.036182] ignition[1003]: DEBUG : files: createFilesystemsFiles: createFiles: op(5): file matches expected sum of: 46c9f489062bdb84574703f7339d140d7e42c9c71b367cd860071108a3c1d38fabda2ef69f9c0ff88f7c80e88d38f96ab2248d4c9a6c9c60b0a4c20fd640d0db [ 13.055437] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing file "/sysroot/opt/bin/kubeadm" [ 13.067153] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/opt/bin/kubelet" [ 13.079181] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET https://dl.k8s.io/release/v1.26.5/bin/linux/arm64/kubelet: attempt #1 [*** ] Job ignition-files.service/start running (12s / no limit) [ 13.121028] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET result: OK M [ *** ] Job ignition-files.service/start running (12s / no limit) [ 13.894562] ignition[1003]: DEBUG : files: createFilesystemsFiles: createFiles: op(6): file matches expected sum of: 0e4ee1f23bf768c49d09beb13a6b5fad6efc8e3e685e7c5610188763e3af55923fb46158b5e76973a0f9a055f9b30d525b467c53415f965536adc2f04d9cf18d [ 13.912082] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/opt/bin/kubelet"[ 14.403170] BTRFS info: devid 1 device path /dev/sda6 changed to /dev/disk/by-label/OEM scanned by ignition (1006) [ 13.929189] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(7): [started] writing file "/sysroot/home/core/install.sh" [ 13.940777] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(7): [finished] writing file "/sysroot/home/core/install.sh" [ 13.953030] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(8): [started] writing file "/sysroot/etc/docker/daemon.json" [ 13.965471] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(8): [finished] writing file "/sysroot/etc/docker/daemon.json" [ 13.978174] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(9): [started] writing file "/sysroot/etc/flatcar/update.conf" [ 13.991443] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(9): [finished] writing file "/sysroot/etc/flatcar/update.conf" [ 14.005945] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(a): [started] writing file "/sysroot/etc/systemd/system/waagent.service" M [ OK ] Finished ignition-files.service. [ 14.017723] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(a): oem config not found in "/usr/share/oem", looking on oem partition[ 14.509718] audit: type=1130 audit(1707503705.898:38): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 14.048663] systemd[1]: mnt-oem4201578602.mount: Deactivated successfully. Starting initrd-setup-root-after-ignition.service... [ 14.058100] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(a): op(b): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem4201578602" Starting ignition-quench.service... [ 14.080727] ignition[1003]: CRITICAL : files: createFilesystemsFiles: createFiles: op(a): op(b): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem4201578602": device or resource busy [ 14.095333] ignition[1003]: ERROR : files: createFilesystemsFiles: createFiles: op(a): failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem4201578602", trying btrfs: device or resource busy [ OK ] Finished ignition-quench.service. [ 14.606199] audit: type=1130 audit(1707503705.995:39): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 14.113362] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(a): op(c): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem4201578602"[ 14.627138] audit: type=1131 audit(1707503705.995: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' [ OK ] Finished initrd-setup-root-after-ignition.service. [ 14.182173] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(a): op(c): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem4201578602"[ 14.682084] audit: type=1130 audit(1707503706.071: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. [ 14.226664] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(a): op(d): [started] unmounting "/mnt/oem4201578602" [ 14.239616] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(a): op(d): [finished] unmounting "/mnt/oem4201578602" Starting initrd-parse-etc.service... [ 14.255836] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(a): [finished] writing file "/sysroot/etc/systemd/system/waagent.service" [ 14.269723] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(e): [started] writing file "/sysroot/etc/systemd/system/nvidia.service" [ OK ] Finished initrd-parse-etc.service. [ 14.280474] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(e): oem config not found in "/usr/share/oem", looking on oem partition[ 14.772272] audit: type=1130 audit(1707503706.161:42): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 14.804213] audit: type=1131 audit(1707503706.193: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' [ 14.314497] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(e): op(f): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem855174098" [ OK ] Reached target initrd-fs.target. [ OK ] Reached target initrd.target. [ 14.368503] ignition[1003]: CRITICAL : files: createFilesystemsFiles: createFiles: op(e): op(f): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem855174098": device or resource busy [ 14.386161] ignition[1003]: ERROR : files: createFilesystemsFiles: createFiles: op(e): failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem855174098", trying btrfs: device or resource busy Starting dracut-pre-pivot.service... [ 14.403763] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(e): op(10): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem855174098" [ 14.423581] systemd[1]: mnt-oem855174098.mount: Deactivated successfully. [ 14.430136] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(e): op(10): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem855174098" [ OK ] Finished dracut-pre-pivot.service. [ 14.445058] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(e): op(11): [started] unmounting "/mnt/oem855174098" Starting initrd-cleanup.service... [ 14.464556] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(e): op(11): [finished] unmounting "/mnt/oem855174098" [ 14.475681] ignition[1003]: INFO : files: createFilesystemsFiles: createFiles: op(e): [finished] writing file "/sysroot/etc/systemd/system/nvidia.service" [ OK ] Stopped target nss-lookup.target. [ 14.489385] ignition[1003]: INFO : files: op(12): [started] processing unit "waagent.service" [ OK ] Stopped target remote-cryptsetup.target. [ 14.506571] ignition[1003]: INFO : files: op(12): [finished] processing unit "waagent.service" [ OK ] Stopped target timers.target. [ 14.523047] ignition[1003]: INFO : files: op(13): [started] processing unit "nvidia.service" [ OK ] Stopped dracut-pre-pivot.service. [ 14.536069] ignition[1003]: INFO : files: op(13): [finished] processing unit "nvidia.service" [ OK ] Stopped target initrd.target. [ 14.549999] ignition[1003]: INFO : files: op(14): [started] processing unit "prepare-cni-plugins.service" [ OK ] Stopped target basic.target. [ 14.563990] ignition[1003]: INFO : files: op(14): op(15): [started] writing unit "prepare-cni-plugins.service" at "/sysroot/etc/systemd/system/prepare-cni-plugins.service" [ 14.584738] ignition[1003]: INFO : files: op(14): op(15): [finished] writing unit "prepare-cni-plugins.service" at "/sysroot/etc/systemd/system/prepare-cni-plugins.service" [ OK ] Stopped target ignition-complete.target. [ 14.599476] ignition[1003]: INFO : files: op(14): [finished] processing unit "prepare-cni-plugins.service" [ OK ] Stopped target ignition-diskful.target. [ 14.614104] ignition[1003]: INFO : files: op(16): [started] processing unit "prepare-critools.service" [ OK ] Stopped target initrd-root-device.target. [ 14.628858] ignition[1003]: INFO : files: op(16): op(17): [started] writing unit "prepare-critools.service" at "/sysroot/etc/systemd/system/prepare-critools.service" [ OK ] Stopped target remote-fs.target. [ 14.650396] ignition[1003]: INFO : files: op(16): op(17): [finished] writing unit "prepare-critools.service" at "/sysroot/etc/systemd/system/prepare-critools.service" [ 14.669099] ignition[1003]: INFO : files: op(16): [finished] processing unit "prepare-critools.service" [ OK ] Stopped target remote-fs-pre.target. [ 14.677688] ignition[1003]: INFO : files: op(18): [started] setting preset to enabled for "waagent.service" [ OK ] Stopped target sysinit.target. [ 14.692833] ignition[1003]: INFO : files: op(18): [finished] setting preset to enabled for "waagent.service" [ OK ] Stopped target local-fs.target. [ 14.707547] ignition[1003]: INFO : files: op(19): [started] setting preset to enabled for "nvidia.service" [ OK ] Stopped target local-fs-pre.target. [ 14.721316] ignition[1003]: INFO : files: op(19): [finished] setting preset to enabled for "nvidia.service" [ OK ] Stopped target swap.target. [ 14.736689] systemd[1]: Finished ignition-files.service. [ OK ] Stopped dracut-pre-mount.service. [ 14.746648] ignition[1003]: INFO : files: op(1a): [started] setting preset to enabled for "prepare-cni-plugins.service" [ OK ] Stopped target cryptsetup.target. [ 14.769455] ignition[1003]: INFO : files: op(1a): [finished] setting preset to enabled for "prepare-cni-plugins.service" [ OK ] Stopped dracut-initqueue.service. [ 14.785603] ignition[1003]: INFO : files: op(1b): [started] setting preset to enabled for "prepare-critools.service" [ OK ] Stopped initrd-setup-root-after-ignition.service. [ 14.801929] ignition[1003]: INFO : files: op(1b): [finished] setting preset to enabled for "prepare-critools.service" [ OK ] Stopped ignition-files.service. [ 14.819318] ignition[1003]: INFO : files: createResultFile: createFiles: op(1c): [started] writing file "/sysroot/etc/.ignition-result.json" [ OK ] Stopped flatcar-metadata-hostname.service. [ 14.837365] ignition[1003]: INFO : files: createResultFile: createFiles: op(1c): [finished] writing file "/sysroot/etc/.ignition-result.json" Stopping ignition-mount.service... Stopping iscsid.service... [ 14.860691] ignition[1003]: INFO : files: files passed [ OK ] Stopped kmod-static-nodes.service. [ 14.878076] ignition[1003]: INFO : Ignition finished successfully [ 14.893545] systemd[1]: Starting initrd-setup-root-after-ignition.service... Stopping sysroot-boot.service... [ 14.900988] initrd-setup-root-after-ignition[1028]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory [ OK ] Stopped systemd-udev-trigger.service. [ 14.920727] iscsid[854]: iscsid shutting down. [ OK ] Stopped dracut-pre-trigger.service. [ 14.930679] systemd[1]: torcx-profile-populate.service was skipped because of an unmet condition check (ConditionPathExists=/sysroot/etc/torcx/next-profile). [ OK ] Stopped iscsid.service. [ 14.950966] systemd[1]: Starting ignition-quench.service... [ OK ] Stopped ignition-mount.service. [ 14.960851] systemd[1]: ignition-quench.service: Deactivated successfully. [ OK ] Stopped ignition-disks.service. [ 14.972877] systemd[1]: Finished ignition-quench.service. [ OK ] Stopped ignition-kargs.service. [ 14.983294] systemd[1]: Finished initrd-setup-root-after-ignition.service. [ OK ] Stopped ignition-fetch.service. [ 14.995315] systemd[1]: Reached target ignition-complete.target. [ OK ] Stopped ignition-fetch-offline.service. [ 15.009767] systemd[1]: Starting initrd-parse-etc.service... [ OK ] Stopped target paths.target. [ 15.023485] ignition[1041]: INFO : Ignition 2.14.0 [ 15.033592] ignition[1041]: INFO : Stage: umount [ 15.038901] ignition[1041]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" [ OK ] Stopped systemd-ask-password-console.path. [ 15.047529] ignition[1041]: DEBUG : parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63 [ OK ] Stopped target slices.target. [ 15.071941] ignition[1041]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" [ OK ] Stopped target sockets.target. [ 15.085770] ignition[1041]: INFO : umount: umount passed [ OK ] Closed iscsid.socket. [ 15.096818] ignition[1041]: INFO : Ignition finished successfully [ OK ] Stopped ignition-setup.service. [ 15.107748] systemd[1]: initrd-parse-etc.service: Deactivated successfully. Stopping iscsiuio.service... [ 15.120848] systemd[1]: Finished initrd-parse-etc.service. [ OK ] Stopped iscsiuio.service. [ 15.130381] systemd[1]: Reached target initrd-fs.target. [ OK ] Stopped target network.target. [ 15.140691] systemd[1]: Reached target initrd.target. [ OK ] Closed iscsiuio.socket. [ 15.151297] systemd[1]: dracut-mount.service was skipped because no trigger condition checks were met. Stopping systemd-networkd.service... [ 15.164891] systemd[1]: Starting dracut-pre-pivot.service... Stopping systemd-resolved.service... [ OK ] Finished initrd-cleanup.service. [ 15.175446] systemd[1]: Finished dracut-pre-pivot.service. [ OK ] Stopped systemd-networkd.service. [ 15.192453] systemd[1]: Starting initrd-cleanup.service... [ 15.203738] systemd[1]: Stopped target nss-lookup.target. [ OK ] Stopped systemd-resolved.service. [ 15.209193] systemd[1]: Stopped target remote-cryptsetup.target. [ OK ] Closed systemd-networkd.socket. [ 15.220503] systemd[1]: Stopped target timers.target. [ 15.231504] systemd[1]: dracut-pre-pivot.service: Deactivated successfully. [ 15.238404] systemd[1]: Stopped dracut-pre-pivot.service. Stopping network-cleanup.service... [ 15.243822] systemd[1]: Stopped target initrd.target. [ OK ] Stopped parse-ip-for-networkd.service. [ 15.258041] systemd[1]: Stopped target basic.target.[ 15.751234] kauditd_printk_skb: 23 callbacks suppressed [ 15.751236] audit: type=1131 audit(1707503707.140:67): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=parse-ip-for-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 15.275941] systemd[1]: Stopped target ignition-complete.target. [ OK ] Stopped systemd-sysctl.service. [ 15.367659] systemd[1]: Stopped target ignition-diskful.target.[ 15.860264] audit: type=1131 audit(1707503707.249:68): 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' [ 15.397955] systemd[1]: Stopped target initrd-root-device.target. [ OK ] Stopped systemd-modules-load.service. [ 15.404997] systemd[1]: Stopped target remote-fs.target.[ 15.897727] audit: type=1131 audit(1707503707.287:69): 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' [ 15.434557] systemd[1]: Stopped target remote-fs-pre.target. Stopping systemd-udevd.service... [ 15.443061] systemd[1]: Stopped target sysinit.target. [ OK ] Stopped systemd-udevd.service. [ 15.453362] systemd[1]: Stopped target local-fs.target.[ 15.946343] audit: type=1131 audit(1707503707.335:70): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 15.483269] systemd[1]: Stopped target local-fs-pre.target. [ OK ] Stopped sysroot-boot.service. [ 15.490718] systemd[1]: Stopped target swap.target.[ 15.987480] audit: type=1131 audit(1707503707.372:71): 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' [ OK ] Closed systemd-udevd-control.socket. [ 15.521393] systemd[1]: dracut-pre-mount.service: Deactivated successfully. [ OK ] Closed systemd-udevd-kernel.socket. [ 15.536733] systemd[1]: Stopped dracut-pre-mount.service. [ OK ] Stopped dracut-pre-udev.service. [ 15.547535] systemd[1]: Stopped target cryptsetup.target.[ 16.044551] audit: type=1131 audit(1707503707.429:72): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-udev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 16.064263] hv_netvsc 002248bd-b39d-0022-48bd-b39d002248bd eth0: Data path switched from VF: enP65051s1 [ OK ] Stopped dracut-cmdline.service. [ 15.588009] systemd[1]: dracut-initqueue.service: Deactivated successfully.[ 16.086802] audit: type=1131 audit(1707503707.469:73): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Stopped dracut-cmdline-ask.service. [ 15.620357] systemd[1]: Stopped dracut-initqueue.service. [ OK ] Stopped initrd-setup-root.service. [ 16.123809] audit: type=1131 audit(1707503707.502:74): 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' [ 15.631295] systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully.[ 16.155082] audit: type=1131 audit(1707503707.513:75): 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-udevadm-cleanup-db.service... [ 15.689915] systemd[1]: Stopped initrd-setup-root-after-ignition.service. [ OK ] Stopped systemd-vconsole-setup.service. [ 15.702484] systemd[1]: ignition-files.service: Deactivated successfully.[ 16.201456] audit: type=1131 audit(1707503707.584:76): 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 ] Finished initrd-udevadm-cleanup-db.service. [ 15.738557] systemd[1]: Stopped ignition-files.service. [ 15.751090] systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. [ 15.759856] systemd[1]: Stopped flatcar-metadata-hostname.service. [ 15.768493] systemd[1]: Stopping ignition-mount.service... [ 15.774893] systemd[1]: Stopping iscsid.service... [ OK ] Stopped network-cleanup.service. [ 15.780199] systemd[1]: kmod-static-nodes.service: Deactivated successfully. [ OK ] Reached target initrd-switch-root.target. [ 15.794632] systemd[1]: Stopped kmod-static-nodes.service. [ 15.807175] systemd[1]: Stopping sysroot-boot.service... Starting initrd-switch-root.service... [ 15.812813] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. [ 15.826339] systemd[1]: Stopped systemd-udev-trigger.service. [ 15.832731] systemd[1]: dracut-pre-trigger.service: Deactivated successfully. [ 15.840248] systemd[1]: Stopped dracut-pre-trigger.service. [ 15.846099] systemd[1]: iscsid.service: Deactivated successfully. [ 16.339275] systemd-journald[276]: Received SIGTERM from PID 1 (n/a). [ 18.804743] SELinux: Class mctp_socket not defined in policy. [ 18.810951] SELinux: Class anon_inode not defined in policy. [ 18.815936] SELinux: the above unknown classes and permissions will be allowed [ 18.823907] SELinux: policy capability network_peer_controls=1 [ 18.829106] SELinux: policy capability open_perms=1 [ 18.833637] SELinux: policy capability extended_socket_class=1 [ 18.839133] SELinux: policy capability always_check_network=0 [ 18.844182] SELinux: policy capability cgroup_seclabel=1 [ 18.848899] SELinux: policy capability nnp_nosuid_transition=1 [ 18.854077] SELinux: policy capability genfs_seclabel_symlinks=0 [ 18.859153] SELinux: policy capability ioctl_skip_cloexec=0 [ 18.900287] systemd[1]: Successfully loaded SELinux policy in 292.397ms. [ 19.397487] systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 101.820ms. [ 19.465532] 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) [ 19.491799] systemd[1]: Detected virtualization microsoft. [ 19.496795] systemd[1]: Detected architecture arm64. [ 19.501111] systemd[1]: Detected first boot. Welcome to Flatcar Container Linux by Kinvolk 3510.3.2 (LTS 2023)! [ 19.528051] systemd[1]: Hostname set to . [ 19.571866] systemd[1]: Initializing machine ID from random generator. [ 21.160100] SELinux: Context system_u:object_r:container_file_t:s0:c1022,c1023 is not valid (left unmapped). [ 21.169364] kauditd_printk_skb: 11 callbacks suppressed [ 21.169366] audit: type=1400 audit(1707503712.549:88): avc: denied { associate } for pid=1075 comm="torcx-generator" name="docker" dev="tmpfs" ino=2 scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 srawcon="system_u:object_r:container_file_t:s0:c1022,c1023" [ 21.197661] audit: type=1300 audit(1707503712.549:88): arch=c00000b7 syscall=5 success=yes exit=0 a0=4000022814 a1=4000028ac8 a2=4000026d00 a3=32 items=0 ppid=1058 pid=1075 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="torcx-generator" exe="/usr/lib/systemd/system-generators/torcx-generator" subj=system_u:system_r:kernel_t:s0 key=(null) [ 21.228077] audit: type=1327 audit(1707503712.549:88): proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61 [ 21.251738] audit: type=1400 audit(1707503712.563:89): avc: denied { associate } for pid=1075 comm="torcx-generator" name="usr" scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 [ 21.269342] audit: type=1300 audit(1707503712.563:89): arch=c00000b7 syscall=34 success=yes exit=0 a0=ffffffffffffff9c a1=40000228f9 a2=1ed a3=0 items=2 ppid=1058 pid=1075 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="torcx-generator" exe="/usr/lib/systemd/system-generators/torcx-generator" subj=system_u:system_r:kernel_t:s0 key=(null) [ 21.302045] audit: type=1307 audit(1707503712.563:89): cwd="/" [ 21.307081] audit: type=1302 audit(1707503712.563:89): item=0 name=(null) inode=2 dev=00:1c mode=040755 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:unlabeled_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 [ 21.323986] audit: type=1302 audit(1707503712.563:89): item=1 name=(null) inode=3 dev=00:1c mode=040755 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:unlabeled_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 [ 21.340693] audit: type=1327 audit(1707503712.563:89): proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61 [ 27.035389] systemd[1]: Populated /etc with preset unit settings. [ 27.575429] systemd[1]: /usr/lib/systemd/system/locksmithd.service:8: Unit uses CPUShares=; please use CPUWeight= instead. Support for CPUShares= will be removed soon. [ 27.591332] systemd[1]: /usr/lib/systemd/system/locksmithd.service:9: Unit uses MemoryLimit=; please use MemoryMax= instead. Support for MemoryLimit= will be removed soon. [ 27.644618] systemd[1]: /run/systemd/system/docker.socket:8: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. [ 27.739867] audit: type=1334 audit(1707503719.126:90): prog-id=12 op=LOAD [ 27.744062] systemd[1]: initrd-switch-root.service: Deactivated successfully. [ 27.748072] audit: type=1334 audit(1707503719.126:91): prog-id=3 op=UNLOAD [ 27.755420] systemd[1]: Stopped initrd-switch-root.service. [ 27.762034] audit: type=1334 audit(1707503719.126:92): prog-id=13 op=LOAD [ OK ] Stopped initrd-switch-root.service.[ 27.774650] audit: type=1334 audit(1707503719.126:93): prog-id=14 op=LOAD [ 27.787052] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 27.787093] audit: type=1334 audit(1707503719.126:94): prog-id=4 op=UNLOAD [ 27.796816] systemd[1]: Created slice system-addon\x2dconfig.slice. [ 27.804190] audit: type=1334 audit(1707503719.126:95): prog-id=5 op=UNLOAD [ OK ] Created slice system-addon\x2dconfig.slice.[ 27.815748] audit: type=1334 audit(1707503719.127:96): prog-id=15 op=LOAD [ 27.826606] systemd[1]: Created slice system-addon\x2drun.slice. [ 27.826687] audit: type=1334 audit(1707503719.127:97): prog-id=12 op=UNLOAD [ OK ] Created slice system-addon\x2drun.slice.[ 27.840166] audit: type=1334 audit(1707503719.127:98): prog-id=16 op=LOAD [ 27.853131] systemd[1]: Created slice system-getty.slice. [ 27.854510] audit: type=1334 audit(1707503719.127:99): prog-id=17 op=LOAD [ OK ] Created slice system-getty.slice. [ 27.873788] systemd[1]: Created slice system-modprobe.slice. [ OK ] Created slice system-modprobe.slice. [ 27.884787] systemd[1]: Created slice system-serial\x2dgetty.slice. [ OK ] Created slice system-serial\x2dgetty.slice. [ 27.897433] systemd[1]: Created slice system-system\x2dcloudinit.slice. [ OK ] Created slice system-system\x2dcloudinit.slice. [ 27.910368] systemd[1]: Created slice system-systemd\x2dfsck.slice. [ OK ] Created slice system-systemd\x2dfsck.slice. [ 27.921282] systemd[1]: Created slice user.slice. [ OK ] Created slice user.slice. [ 27.930227] systemd[1]: Started systemd-ask-password-console.path. [ OK ] Started systemd-ask-password-console.path. [ 27.942243] systemd[1]: Started systemd-ask-password-wall.path. [ OK ] Started systemd-ask-password-wall.path. [ 27.954028] systemd[1]: Set up automount boot.automount. [ OK ] Set up automount boot.automount. [ 27.964688] systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount. [ OK ] Set up automount proc-sys-fs-binfmt_misc.automount. [ 27.976868] systemd[1]: Stopped target initrd-switch-root.target. [ OK ] Stopped target initrd-switch-root.target. [ 27.987487] systemd[1]: Stopped target initrd-fs.target. [ OK ] Stopped target initrd-fs.target. [ 27.996724] systemd[1]: Stopped target initrd-root-fs.target. [ OK ] Stopped target initrd-root-fs.target. [ 28.007127] systemd[1]: Reached target integritysetup.target. [ OK ] Reached target integritysetup.target. [ 28.017971] systemd[1]: Reached target remote-cryptsetup.target. [ OK ] Reached target remote-cryptsetup.target. [ 28.028108] systemd[1]: Reached target remote-fs.target. [ OK ] Reached target remote-fs.target. [ 28.037458] systemd[1]: Reached target slices.target. [ OK ] Reached target slices.target. [ 28.046308] systemd[1]: Reached target swap.target. [ OK ] Reached target swap.target. [ 28.054950] systemd[1]: Reached target torcx.target. [ OK ] Reached target torcx.target. [ 28.063786] systemd[1]: Reached target veritysetup.target. [ OK ] Reached target veritysetup.target. [ 28.075492] systemd[1]: Listening on systemd-coredump.socket. [ OK ] Listening on systemd-coredump.socket. [ 28.086102] systemd[1]: Listening on systemd-initctl.socket. [ OK ] Listening on systemd-initctl.socket. [ 28.095528] systemd[1]: Listening on systemd-networkd.socket. [ OK ] Listening on systemd-networkd.socket. [ 28.105423] systemd[1]: Listening on systemd-udevd-control.socket. [ OK ] Listening on systemd-udevd-control.socket. [ 28.115859] systemd[1]: Listening on systemd-udevd-kernel.socket. [ OK ] Listening on systemd-udevd-kernel.socket. [ 28.128027] systemd[1]: Listening on systemd-userdbd.socket. [ OK ] Listening on systemd-userdbd.socket. [ 28.138564] systemd[1]: Mounting dev-hugepages.mount... Mounting dev-hugepages.mount... [ 28.147855] systemd[1]: Mounting dev-mqueue.mount... Mounting dev-mqueue.mount... [ 28.157012] systemd[1]: Mounting media.mount... Mounting media.mount... [ 28.164959] systemd[1]: Mounting sys-kernel-debug.mount... Mounting sys-kernel-debug.mount... [ 28.176285] systemd[1]: Mounting sys-kernel-tracing.mount... Mounting sys-kernel-tracing.mount... [ 28.187501] systemd[1]: Mounting tmp.mount... Mounting tmp.mount... [ 28.195411] systemd[1]: Starting flatcar-tmpfiles.service... Starting flatcar-tmpfiles.service... [ 28.204291] systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. [ 28.213270] systemd[1]: Starting kmod-static-nodes.service... Starting kmod-static-nodes.service... [ 28.223254] systemd[1]: Starting modprobe@configfs.service... Starting modprobe@configfs.service... [ 28.234535] systemd[1]: Starting modprobe@dm_mod.service... Starting modprobe@dm_mod.service... [ 28.244557] systemd[1]: Starting modprobe@drm.service... Starting modprobe@drm.service... [ 28.253357] systemd[1]: Starting modprobe@efi_pstore.service... Starting modprobe@efi_pstore.service... [ 28.263605] systemd[1]: Starting modprobe@fuse.service... Starting modprobe@fuse.service... [ 28.273315] systemd[1]: Starting modprobe@loop.service... Starting modprobe@loop.service... [ 28.283865] systemd[1]: setup-nsswitch.service was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). [ 28.294648] systemd[1]: systemd-fsck-root.service: Deactivated successfully. [ 28.300752] systemd[1]: Stopped systemd-fsck-root.service. [ OK ] Stopped systemd-fsck-root.service. [ 28.312721] systemd[1]: systemd-fsck-usr.service: Deactivated successfully. [ 28.318849] systemd[1]: Stopped systemd-fsck-usr.service. [ OK ] Stopped systemd-fsck-usr.service. [ 28.329352] systemd[1]: Stopped systemd-journald.service. [ OK ] Stopped systemd-journald.service. [ 28.339093] systemd[1]: systemd-journald.service: Consumed 3.734s CPU time. [ 28.346395] systemd[1]: Starting systemd-journald.service... Starting systemd-journald.service... [ 28.359450] fuse: init (API version 7.34) [ 28.365360] loop: module loaded [ 28.394378] systemd[1]: Starting systemd-modules-load.service... Starting systemd-modules-load.service... [ 28.404668] systemd[1]: Starting systemd-network-generator.service... Starting systemd-network-generator.service... [ 28.415372] systemd[1]: Starting systemd-remount-fs.service... Starting systemd-remount-fs.service... [ 28.427436] systemd[1]: Starting systemd-udev-trigger.service... Starting systemd-udev-trigger.service... [ 28.436941] systemd[1]: verity-setup.service: Deactivated successfully. [ 28.442201] systemd[1]: Stopped verity-setup.service. [ OK ] Stopped verity-setup.service. [ 28.452698] systemd[1]: Mounted dev-hugepages.mount. [ OK ] Mounted dev-hugepages.mount. [ 28.461198] systemd[1]: Started systemd-journald.service. [ OK ] Started systemd-journald.service. [ OK ] Mounted dev-mqueue.mount. [ OK ] Mounted media.mount. [ OK ] Mounted sys-kernel-debug.mount. [ OK ] Mounted sys-kernel-tracing.mount. [ OK ] Mounted tmp.mount. [ OK ] Finished flatcar-tmpfiles.service. [ 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-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-sysusers.service... [ OK ] Mounted sys-fs-fuse-connections.mount. [ OK ] Mounted sys-kernel-config.mount. [ OK ] Finished systemd-udev-trigger.service. Starting systemd-udev-settle.service... [ OK ] Finished systemd-modules-load.service. Starting systemd-sysctl.service... [ 28.671927] systemd-journald[1181]: Received client request to flush runtime journal. [ OK ] Finished systemd-random-seed.service. [ OK ] Reached target first-boot-complete.target. [ OK ] Finished systemd-sysctl.service. [ OK ] Finished systemd-journal-flush.service. [ OK ] Finished systemd-sysusers.service. [ OK ] Finished systemd-hwdb-update.service. Starting systemd-udevd.service... [ OK ] Started systemd-udevd.service. Starting systemd-networkd.service... Starting systemd-userdbd.service...[ 30.008282] mousedev: PS/2 mouse device common for all mice [ 30.033421] hv_vmbus: registering driver hv_balloon [ 30.040905] hv_balloon: Using Dynamic Memory protocol version 2.0 [ 30.046164] hv_balloon: Memory hot add disabled on ARM64 [ 30.051608] hv_vmbus: registering driver hyperv_fb [ 30.057810] hv_utils: Registering HyperV Utility Driver [ 30.066520] hv_vmbus: registering driver hv_utils [ 30.071874] hyperv_fb: Synthvid Version major 3, minor 5 [ 30.078916] hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 [ 30.087042] hv_utils: Heartbeat IC version 3.0 [ 30.091551] hv_utils: Shutdown IC version 3.2 [ 30.096420] hv_utils: TimeSync IC version 4.0 [ OK ] Started systemd-userdbd.service.[ 30.105857] Console: switching to colour dummy device 80x25 [ 30.117759] Console: switching to colour frame buffer device 128x48 [ 30.400454] BTRFS info: devid 1 device path /dev/disk/by-label/OEM changed to /dev/sda6 scanned by (udev-worker) (1212) [ OK ] Found device dev-disk-by\x2dlabel-OEM.device. [ OK ] Finished systemd-udev-settle.service. Starting lvm2-activation-early.service... [ OK ] Started systemd-networkd.service. Starting systemd-networkd-wait-online.service... [ 30.525809] mlx5_core fe1b:00:02.0 enP65051s1: Link up [ 30.549523] hv_netvsc 002248bd-b39d-0022-48bd-b39d002248bd eth0: Data path switched to VF: enP65051s1 [ 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. [ 32.851255] kauditd_printk_skb: 84 callbacks suppressed [ 32.851258] audit: type=1130 audit(1707503724.366:167): 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... [ 32.892213] audit: type=1334 audit(1707503724.407:168): prog-id=30 op=LOAD Starting systemd-resolved.service... [ 32.904725] audit: type=1334 audit(1707503724.419:169): prog-id=31 op=LOAD Starting systemd-timesyncd.service... Starting systemd-update-utmp.service... [ OK ] Finished clean-ca-certificates.service. [ 32.992007] audit: type=1130 audit(1707503724.507:170): 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' [ OK ] Started systemd-timesyncd.service.[ 33.016774] audit: type=1127 audit(1707503724.531:171): pid=1299 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 ] Reached target time-set.target.[ 33.042206] audit: type=1130 audit(1707503724.553:172): 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-update-utmp.service. [ 33.073592] audit: type=1130 audit(1707503724.588:173): 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 ] Finished systemd-journal-catalog-update.service. [ 33.101693] audit: type=1130 audit(1707503724.616:174): 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. [ 33.182878] audit: type=1130 audit(1707503724.698:175): 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. [ 33.339323] audit: type=1305 audit(1707503724.854:176): 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 (7s / no limit) M [** ] Job ldconfig.service/start running (8s / no limit) M [*** ] Job ldconfig.service/start running (9s / no limit) M [ *** ] Job ldconfig.service/start running (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. [ 38.558809] extend-filesystems[1325]: Found sda [ 38.562903] extend-filesystems[1325]: Found sda1 [ 38.569819] extend-filesystems[1325]: Found sda2 [ 38.574943] extend-filesystems[1325]: Found sda3 [ OK ] Finished motdgen.service. [ 38.585395] extend-filesystems[1325]: Found usr [ 38.590080] extend-filesystems[1325]: Found sda4 [ 38.593860] extend-filesystems[1325]: Found sda6 [ 38.597862] extend-filesystems[1325]: Found sda7 [ 38.601684] extend-filesystems[1325]: Found sda9 [ 38.605858] extend-filesystems[1325]: Checking size of /dev/sda9 [ 38.663174] extend-filesystems[1325]: Old size kept for /dev/sda9 [ OK ] Finished extend-filesystems.service. [ 38.669415] extend-filesystems[1325]: 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 systemd-logind.service. [ OK ] Started containerd.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-5295330982 (Linux aarch64 5.15.148-flatcar) 18:35:32 SSH host key: SHA256:HbdhLf4eMvPesUFFPdgn8shBIhxor7iKDnWRkpCPeeg (RSA) SSH host key: SHA256:H6as+GdhluF/5wjI1oBcY2Tu3EzrvmOa4DS7ySq4qUY (ED25519) SSH host key: SHA256:JJCX9UoHVNQazexNOb1V8bQ0UaSqZnLQNEaS+BJtGqk (ECDSA) enP65051s1: eth0: 10.200.20.30 fe80::222:48ff:febd:b39d 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.930461Z INFO Daemon Daemon Azure Linux Agent Version:2.6.0.2 2024-02-09T18:35:38.937516Z INFO Daemon Daemon OS: flatcar 3510.3.2 2024-02-09T18:35:38.942303Z INFO Daemon Daemon Python: 3.9.16 2024-02-09T18:35:38.947049Z INFO Daemon Daemon Run daemon 2024-02-09T18:35:38.951715Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='3510.3.2' 2024-02-09T18:35:38.968786Z 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.983784Z 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.993912Z INFO Daemon Daemon cloud-init is enabled: False 2024-02-09T18:35:38.999005Z INFO Daemon Daemon Using waagent for provisioning 2024-02-09T18:35:39.004911Z INFO Daemon Daemon Activate resource disk 2024-02-09T18:35:39.010011Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb 2024-02-09T18:35:39.025201Z INFO Daemon Daemon Found device: None 2024-02-09T18:35:39.030236Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology 2024-02-09T18:35:39.039987Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 2024-02-09T18:35:39.052994Z INFO Daemon Daemon Clean protocol and wireserver endpoint 2024-02-09T18:35:39.059783Z INFO Daemon Daemon Running default provisioning handler 2024-02-09T18:35:39.072600Z 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:39.089019Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' 2024-02-09T18:35:39.099051Z INFO Daemon Daemon cloud-init is enabled: False 2024-02-09T18:35:39.107135Z INFO Daemon Daemon Copying ovf-env.xml 2024-02-09T18:35:39.207353Z INFO Daemon Daemon Successfully mounted dvd 2024-02-09T18:35:39.345152Z INFO Daemon Daemon Detect protocol endpoint 2024-02-09T18:35:39.350302Z INFO Daemon Daemon Clean protocol and wireserver endpoint 2024-02-09T18:35:39.356404Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler 2024-02-09T18:35:39.363325Z INFO Daemon Daemon Test for route to 168.63.129.16 2024-02-09T18:35:39.369762Z INFO Daemon Daemon Route to 168.63.129.16 exists 2024-02-09T18:35:39.375932Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 2024-02-09T18:35:39.472741Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 2024-02-09T18:35:39.480622Z INFO Daemon Daemon Wire protocol version:2012-11-30 2024-02-09T18:35:39.486764Z INFO Daemon Daemon Server preferred version:2015-04-05 2024-02-09T18:35:40.139722Z INFO Daemon Daemon Initializing goal state during protocol detection 2024-02-09T18:35:40.155485Z INFO Daemon Daemon Forcing an update of the goal state.. 2024-02-09T18:35:40.161746Z INFO Daemon Daemon Fetching goal state [incarnation 1] 2024-02-09T18:35:40.235483Z INFO Daemon Daemon Found private key matching thumbprint B1B4C04372CB8FE30A7CA4044898D88DD0CD4BE8 2024-02-09T18:35:40.244548Z INFO Daemon Daemon Certificate with thumbprint D5FE13DA968BDBFFC04546545C3E378FDCC820EC has no matching private key. 2024-02-09T18:35:40.254886Z INFO Daemon Daemon Fetch goal state completed 2024-02-09T18:35:40.279394Z INFO Daemon Daemon Fetched new vmSettings [correlation ID: b4c130b9-9940-45c5-a03d-f84fd1a12c75 New eTag: 10556791200043769555] 2024-02-09T18:35:40.290623Z INFO Daemon Daemon Status Blob type 'None' is not valid, assuming BlockBlob 2024-02-09T18:35:40.309345Z INFO Daemon Daemon Starting provisioning 2024-02-09T18:35:40.314679Z INFO Daemon Daemon Handle ovf-env.xml. 2024-02-09T18:35:40.319921Z INFO Daemon Daemon Set hostname [ci-3510.3.2-a-5295330982] 2024-02-09T18:35:40.357295Z INFO Daemon Daemon Publish hostname [ci-3510.3.2-a-5295330982] 2024-02-09T18:35:40.364111Z INFO Daemon Daemon Examine /proc/net/route for primary interface 2024-02-09T18:35:40.370624Z INFO Daemon Daemon Primary interface is [eth0] 2024-02-09T18:35:40.430050Z INFO Daemon Daemon Create user account if not exists 2024-02-09T18:35:40.436469Z INFO Daemon Daemon User core already exists, skip useradd 2024-02-09T18:35:40.445022Z INFO Daemon Daemon Configure sudoer 2024-02-09T18:35:40.450581Z INFO Daemon Daemon Configure sshd 2024-02-09T18:35:40.455133Z INFO Daemon Daemon Deploy ssh public key. 2024-02-09T18:35:41.679523Z INFO Daemon Daemon Provisioning complete 2024-02-09T18:35:41.700053Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping 2024-02-09T18:35:41.706852Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. [ 78.197940] hv_balloon: Max. dynamic memory size: 4096 MB [ 90.825235] SELinux: Context system_u:object_r:container_file_t:s0 is not valid (left unmapped). [ 123.810703] cni0: port 1(veth4bdf4807) entered blocking state [ 123.816040] cni0: port 1(veth4bdf4807) entered disabled state [ 123.820708] device veth4bdf4807 entered promiscuous mode [ 123.824877] cni0: port 1(veth4bdf4807) entered blocking state [ 123.829668] cni0: port 1(veth4bdf4807) entered forwarding state [ 123.835185] cni0: port 1(veth4bdf4807) entered disabled state [ 123.844436] IPv6: ADDRCONF(NETDEV_CHANGE): veth4bdf4807: link becomes ready [ 123.849942] cni0: port 1(veth4bdf4807) entered blocking state [ 123.854328] cni0: port 1(veth4bdf4807) entered forwarding state [ 132.925965] cni0: port 2(vethc0034796) entered blocking state [ 132.931446] cni0: port 2(vethc0034796) entered disabled state [ 132.937213] device vethc0034796 entered promiscuous mode [ 132.944081] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 132.949173] IPv6: ADDRCONF(NETDEV_CHANGE): vethc0034796: link becomes ready [ 132.954334] cni0: port 2(vethc0034796) entered blocking state [ 132.958748] cni0: port 2(vethc0034796) entered forwarding state