[=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.154-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 Apr 12 17:21:24 -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=0x37b33f98 [ 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 0x1bf7f1900-0x1bf7f6fff] [ 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 30 pages/cpu s83032 r8192 d31656 u122880 [ 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=c0b96868344262519ffdb2dae3782c942008a0fecdbc0bc85d2e170bd2e8b8a8 [ 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: 3990260K/4194160K available (9792K kernel code, 2092K rwdata, 7568K rodata, 36352K init, 777K bss, 203900K 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.007878] Console: colour dummy device 80x25 [ 0.012201] printk: console [tty1] enabled [ 0.016481] ACPI: Core revision 20210730 [ 0.020442] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) [ 0.030313] pid_max: default: 32768 minimum: 301 [ 0.034946] LSM: Security Framework initializing [ 0.039393] SELinux: Initializing. [ 0.042918] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) [ 0.050255] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) [ 0.058183] Hyper-V: privilege flags low 0x2e7f, high 0x3a8030, hints 0xe, misc 0x31e1 [ 0.066070] Hyper-V: Host Build 10.0.22477.1369-1-0 [ 0.070853] rcu: Hierarchical SRCU implementation. [ 0.075638] Remapping and enabling EFI services. [ 0.080214] smp: Bringing up secondary CPUs ... [ 0.084853] Detected PIPT I-cache on CPU1 [ 0.084877] GICv3: CPU1: found redistributor 1 region 1:0x00000000f000e000 [ 0.084941] arch_timer: Enabling local workaround for ARM erratum 1418040 [ 0.084982] CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] [ 0.085035] smp: Brought up 1 node, 2 CPUs [ 0.112495] SMP: Total of 2 processors activated. [ 0.117196] CPU features: detected: 32-bit EL0 Support [ 0.122119] CPU features: detected: Instruction cache invalidation not required for I/D coherence [ 0.130763] CPU features: detected: Data cache clean to the PoU not required for I/D coherence [ 0.139022] CPU features: detected: CRC32 instructions [ 0.144108] CPU features: detected: RCpc load-acquire (LDAPR) [ 0.149593] CPU features: detected: LSE atomic instructions [ 0.154918] CPU features: detected: Privileged Access Never [ 0.207903] CPU: All CPU(s) started at EL1 [ 0.211895] alternatives: patching kernel code [ 0.216671] devtmpfs: initialized [ 0.220007] KASLR enabled [ 0.222598] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.231996] futex hash table entries: 512 (order: 3, 32768 bytes, linear) [ 0.238643] pinctrl core: initialized pinctrl subsystem [ 0.243767] SMBIOS 3.1.0 present. [ 0.246973] DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 11/28/2023 [ 0.257140] NET: Registered PF_NETLINK/PF_ROUTE protocol family [ 0.262930] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.269837] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.277286] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.284949] audit: initializing netlink subsys (disabled) [ 0.290181] audit: type=2000 audit(0.089:1): state=initialized audit_enabled=0 res=1 [ 0.290267] thermal_sys: Registered thermal governor 'step_wise' [ 0.297621] cpuidle: using governor menu [ 0.307137] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. [ 0.313654] ASID allocator initialised with 32768 entries [ 0.318994] ACPI: bus type PCI registered [ 0.322816] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.329038] Serial: AMBA PL011 UART driver [ 0.333965] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.340657] HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages [ 0.347258] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.353943] HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages [ 0.480234] cryptd: max_cpu_qlen set to 1000 [ 0.487164] alg: No test for fips(ansi_cprng) (fips_ansi_cprng) [ 0.493273] ACPI: Added _OSI(Module Device) [ 0.497335] ACPI: Added _OSI(Processor Device) [ 0.501660] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.506226] ACPI: Added _OSI(Processor Aggregator Device) [ 0.511392] ACPI: Added _OSI(Linux-Dell-Video) [ 0.515619] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) [ 0.520797] ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) [ 0.530481] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.536862] ACPI: Interpreter enabled [ 0.540415] ACPI: Using GIC for interrupt routing [ 0.545341] ARMH0011:00: ttyAMA0 at MMIO 0xeffec000 (irq = 12, base_baud = 0) is a SBSA [ 0.553204] printk: console [ttyAMA0] enabled [ 0.553204] printk: console [ttyAMA0] enabled [ 0.560477] printk: bootconsole [pl11] disabled [ 0.560477] printk: bootconsole [pl11] disabled [ 0.568085] ARMH0011:01: ttyAMA1 at MMIO 0xeffeb000 (irq = 13, base_baud = 0) is a SBSA [ 0.573928] iommu: Default domain type: Translated [ 0.577358] iommu: DMA domain TLB invalidation policy: strict mode [ 0.581764] vgaarb: loaded [ 0.583657] pps_core: LinuxPPS API ver. 1 registered [ 0.587202] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.593683] PTP clock support registered [ 0.596432] Registered efivars operations [ 0.599223] No ACPI PMU IRQ for CPU0 [ 0.601725] No ACPI PMU IRQ for CPU1 [ 0.604385] clocksource: Switched to clocksource arch_sys_counter [ 0.614553] VFS: Disk quotas dquot_6.6.0 [ 0.617503] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.622410] pnp: PnP ACPI init [ 0.624608] pnp: PnP ACPI: found 0 devices [ 0.629388] NET: Registered PF_INET protocol family [ 0.632917] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) [ 0.638651] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) [ 0.644621] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) [ 0.650271] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) [ 0.656010] TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) [ 0.661154] TCP: Hash tables configured (established 32768 bind 32768) [ 0.665849] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) [ 0.670614] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) [ 0.675662] NET: Registered PF_UNIX/PF_LOCAL protocol family [ 0.679714] PCI: CLS 0 bytes, default 64 [ 0.691493] hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 1 counters available [ 0.697212] kvm [1]: HYP mode not available [ 0.892032] Initialise system trusted keyrings [ 0.895452] workingset: timestamp_bits=39 max_order=20 bucket_order=0 [ 0.901344] Key type asymmetric registered [ 0.904287] Asymmetric key parser 'x509' registered [ 0.907743] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) [ 0.912951] io scheduler mq-deadline registered [ 0.916273] io scheduler kyber registered [ 0.919119] io scheduler bfq registered [ 0.922713] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 0.927651] thunder_xcv, ver 1.0 [ 0.929907] thunder_bgx, ver 1.0 [ 0.932261] nicpf, ver 1.0 [ 0.934154] nicvf, ver 1.0 [ 0.936415] rtc-efi rtc-efi.0: registered as rtc0 [ 0.939811] rtc-efi rtc-efi.0: setting system clock to 2024-04-12T18:31:55 UTC (1712946715) [ 0.945704] efifb: probing for efifb [ 0.948261] efifb: framebuffer at 0x40000000, using 3072k, total 3072k [ 0.952962] efifb: mode is 1024x768x32, linelength=4096, pages=1 [ 0.957230] efifb: scrolling: redraw [ 0.959737] efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 [ 0.965460] Console: switching to colour frame buffer device 128x48 [ 0.970853] fb0: EFI VGA frame buffer device [ 0.973860] SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... [ 0.978373] hid: raw HID events driver (C) Jiri Kosina [ 0.982232] NET: Registered PF_INET6 protocol family [ 0.985949] Segment Routing with IPv6 [ 0.988521] In-situ OAM (IOAM) with IPv6 [ 0.991257] NET: Registered PF_PACKET protocol family [ 0.994946] Key type dns_resolver registered [ 0.998075] registered taskstats version 1 [ 1.000956] Loading compiled-in X.509 certificates [ 1.033766] Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.15.154-flatcar: 8c258d82bbd8df4a9da2c0ea4108142f04be6b34' [ 1.042329] Key type .fscrypt registered [ 1.045119] Key type fscrypt-provisioning registered [ 1.048687] ima: No TPM chip found, activating TPM-bypass! [ 1.052514] ima: Allocated hash algorithm: sha1 [ 1.055765] ima: No architecture policies found [ 1.064604] Freeing unused kernel memory: 36352K [ 1.067965] Run /init as init process [ 1.086470] 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.109020] systemd[1]: Detected virtualization microsoft. [ 1.114084] systemd[1]: Detected architecture arm64. [ 1.118032] systemd[1]: Running in initrd. Welcome to dracut-053 (Initramfs)! [ 1.125163] systemd[1]: No hostname configured, using default hostname. [ 1.130308] systemd[1]: Hostname set to . [ 1.134381] systemd[1]: Initializing machine ID from random generator. [ 1.234134] systemd[1]: Queued start job for default target initrd.target. [ 1.241271] systemd[1]: Started systemd-ask-password-console.path. [ OK ] Started systemd-ask-password-console.path. [ 1.251253] systemd[1]: Reached target cryptsetup.target. [ OK ] Reached target cryptsetup.target. [ 1.259815] systemd[1]: Reached target paths.target. [ OK ] Reached target paths.target. [ 1.267934] systemd[1]: Reached target slices.target. [ OK ] Reached target slices.target. [ 1.276044] systemd[1]: Reached target swap.target. [ OK ] Reached target swap.target. [ 1.283884] systemd[1]: Reached target timers.target. [ OK ] Reached target timers.target. [ 1.291990] systemd[1]: Listening on iscsid.socket. [ OK ] Listening on iscsid.socket. [ 1.301070] systemd[1]: Listening on iscsiuio.socket. [ OK ] Listening on iscsiuio.socket. [ 1.309332] systemd[1]: Listening on systemd-journald-audit.socket. [ OK ] Listening on systemd-journald-audit.socket. [ 1.319321] systemd[1]: Listening on systemd-journald-dev-log.socket. [ OK ] Listening on systemd-journald-dev-log.socket. [ 1.329677] systemd[1]: Listening on systemd-journald.socket. [ OK ] Listening on systemd-journald.socket. [ 1.338895] systemd[1]: Listening on systemd-networkd.socket. [ OK ] Listening on systemd-networkd.socket. [ 1.349252] systemd[1]: Listening on systemd-udevd-control.socket. [ OK ] Listening on systemd-udevd-control.socket. [ 1.358942] systemd[1]: Listening on systemd-udevd-kernel.socket. [ OK ] Listening on systemd-udevd-kernel.socket. [ 1.368371] systemd[1]: Reached target sockets.target. [ OK ] Reached target sockets.target. [ 1.377707] systemd[1]: Starting kmod-static-nodes.service... Starting kmod-static-nodes.service... [ 1.385966] systemd[1]: Finished network-cleanup.service. [ OK ] Finished network-cleanup.service. [ 1.396260] systemd[1]: Starting systemd-fsck-usr.service... Starting systemd-fsck-usr.service... [ 1.405761] systemd[1]: Starting systemd-journald.service... Starting systemd-journald.service... [ 1.414906] systemd[1]: Starting systemd-modules-load.service... Starting systemd-modules-load.service... [ 1.424948] systemd[1]: Starting systemd-resolved.service... Starting systemd-resolved.service... [ 1.442234] systemd[1]: Starting systemd-vconsole-setup.service... [ 1.103705] systemd-modules-load[236]: Inserted module 'overlay'[ 1.463163] bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. [ 1.124573] systemd-resolved[237]: Positive Trust Anchors: Starting systemd-vconsole-setup.service...[ 1.478165] Bridge firewalling registered [ 1.135773] systemd-resolved[237]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d[ 1.495716] systemd[1]: Started systemd-journald.service. [ 1.495921] SCSI subsystem initialized [ OK ] Started systemd-journald.service. [ 1.513220] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. [ 1.523587] audit: type=1130 audit(1712946716.072:2): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 1.523634] device-mapper: uevent: version 1.0.3 [ 1.163840] systemd-resolved[237]: 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.542806] device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com [ OK ] Started systemd-resolved.service. [ 1.231191] systemd-resolved[237]: Defaulting to hostname 'linux'.[ 1.588777] audit: type=1130 audit(1712946716.144:3): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 1.254493] systemd-modules-load[236]: Inserted module 'br_netfilter' [ OK ] Finished kmod-static-nodes.service. [ 1.259355] systemd[1]: Started systemd-resolved.service.[ 1.616625] audit: type=1130 audit(1712946716.172:4): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Finished systemd-fsck-usr.service. [ 1.283396] systemd-modules-load[236]: Inserted module 'dm_multipath' [ 1.641551] audit: type=1130 audit(1712946716.196:5): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Finished systemd-modules-load.service. [ 1.307286] systemd[1]: Finished kmod-static-nodes.service. [ 1.665467] audit: type=1130 audit(1712946716.221: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 ] Finished systemd-vconsole-setup.service. [ 1.316184] systemd[1]: Finished systemd-fsck-usr.service. [ 1.689302] audit: type=1130 audit(1712946716.245: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' [ OK ] Reached target nss-lookup.target. [ 1.340054] systemd[1]: Finished systemd-modules-load.service. Starting dracut-cmdline-ask.service... Starting systemd-sysctl.service... Starting systemd-tmpfiles-setup-dev.service... [ 1.365148] systemd[1]: Finished systemd-vconsole-setup.service. [ 1.384793] systemd[1]: Reached target nss-lookup.target. [ OK ] Finished systemd-tmpfiles-setup-dev.service. [ 1.395370] systemd[1]: Starting dracut-cmdline-ask.service...[ 1.749719] audit: type=1130 audit(1712946716.309:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Finished systemd-sysctl.service. [ 1.427777] systemd[1]: Starting systemd-sysctl.service... [ OK ] Finished dracut-cmdline-ask.service. [ 1.431849] systemd[1]: Starting systemd-tmpfiles-setup-dev.service...[ 1.786488] audit: type=1130 audit(1712946716.340:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 1.805630] audit: type=1130 audit(1712946716.345: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' Starting dracut-cmdline.service... [ 1.455439] systemd[1]: Finished systemd-tmpfiles-setup-dev.service. [ 1.486070] systemd[1]: Finished systemd-sysctl.service. [ 1.490541] systemd[1]: Finished dracut-cmdline-ask.service. [ 1.495424] dracut-cmdline[258]: dracut-dracut-053 [ 1.499432] dracut-cmdline[258]: 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=t [ 1.518164] dracut-cmdline[258]: tyAMA0,115200n8 earlycon=pl011,0xeffec000 flatcar.first_boot=detected acpi=force flatcar.oem.id=azure flatcar.autologin verity.usrhash=c0b96868344262519ffdb2dae3782c942008a0fecdbc0bc85d2e170bd2e8b8a8 [ 1.533924] systemd[1]: Starting dracut-cmdline.service... [ 1.922026] Loading iSCSI transport class v2.0-870. [ 1.938709] iscsi: registered transport (tcp) [ 1.956442] iscsi: registered transport (qla4xxx) [ 1.960431] QLogic iSCSI HBA Driver [ OK ] Finished dracut-cmdline.service. [ 1.653128] systemd[1]: Finished dracut-cmdline.service. [ 1.657825] systemd[1]: Starting dracut-pre-udev.service... Starting dracut-pre-udev.service... [ 2.048403] raid6: neonx8 gen() 13795 MB/s [ 2.069387] raid6: neonx8 xor() 10836 MB/s [ 2.089391] raid6: neonx4 gen() 13538 MB/s [ 2.109402] raid6: neonx4 xor() 11079 MB/s [ 2.130396] raid6: neonx2 gen() 12936 MB/s [ 2.150386] raid6: neonx2 xor() 10374 MB/s [ 2.171387] raid6: neonx1 gen() 10536 MB/s [ 2.192386] raid6: neonx1 xor() 8794 MB/s [ 2.213393] raid6: int64x8 gen() 6270 MB/s [ 2.233385] raid6: int64x8 xor() 3544 MB/s [ 2.254387] raid6: int64x4 gen() 7226 MB/s [ 2.274386] raid6: int64x4 xor() 3852 MB/s [ 2.294386] raid6: int64x2 gen() 6153 MB/s [ 2.315389] raid6: int64x2 xor() 3321 MB/s [ 2.335389] raid6: int64x1 gen() 5050 MB/s [ 2.355389] raid6: int64x1 xor() 2646 MB/s [ 2.359937] raid6: using algorithm neonx8 gen() 13795 MB/s [ 2.364326] raid6: .... xor() 10836 MB/s, rmw enabled [ 2.368647] raid6: using neon recovery algorithm [ 2.381263] xor: measuring software checksum speed [ 2.386079] 8regs : 17300 MB/sec [ 2.390275] 32regs : 20755 MB/sec [ 2.394284] arm64_neon : 27939 MB/sec [ 2.397951] xor: using function: arm64_neon (27939 MB/sec) [ 2.451509] Btrfs loaded, crc32c=crc32c-generic, zoned=no, fsverity=no [ OK ] Finished dracut-pre-udev.service. [ 2.119111] systemd[1]: Finished dracut-pre-udev.service. Starting systemd-udevd.service... [ 2.126923] systemd[1]: Starting systemd-udevd.service... [ 2.144209] systemd-udevd[435]: Using default interface naming scheme 'v252'. [ OK ] Started systemd-udevd.service. [ 2.155406] systemd[1]: Started systemd-udevd.service. Starting dracut-pre-trigger.service... [ 2.164658] systemd[1]: Starting dracut-pre-trigger.service... [ 2.174388] dracut-pre-trigger[456]: rd.md=0: removing MD RAID activation [ OK ] Finished dracut-pre-trigger.service. [ 2.206563] systemd[1]: Finished dracut-pre-trigger.service. Starting systemd-udev-trigger.service... [ 2.215288] systemd[1]: Starting systemd-udev-trigger.service... [ OK ] Finished systemd-udev-trigger.service. [ 2.255944] systemd[1]: Finished systemd-udev-trigger.service. [ 2.653228] hv_vmbus: Vmbus version:5.3 [ 2.661690] hv_vmbus: registering driver hyperv_keyboard [ 2.667328] hv_vmbus: registering driver hid_hyperv [ 2.674719] hv_vmbus: registering driver hv_storvsc [ 2.679565] input: AT Translated Set 2 keyboard as /devices/LNXSYSTM:00/LNXSYBUS:00/ACPI0004:00/VMBUS:00/d34b2567-b9b6-42b9-8778-0a4ec0b955bf/serio0/input/input0 [ 2.692437] scsi host0: storvsc_host_t [ 2.692940] hv_vmbus: registering driver hv_netvsc [ 2.699552] scsi 0:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 [ 2.705931] scsi host1: storvsc_host_t [ 2.709873] scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 0 [ 2.710502] input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input1 [ 2.727411] hid-generic 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on [ 2.743526] sr 0:0:0:2: [sr0] scsi-1 drive [ 2.747217] cdrom: Uniform CD-ROM driver Revision: 3.20 [ 2.756323] sd 0:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB) [ 2.763323] sd 0:0:0:0: [sda] 4096-byte physical blocks [ 2.768170] sd 0:0:0:0: [sda] Write Protect is off [ 2.772460] sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA [ 2.781128] sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 [ 2.786278] sd 0:0:0:0: [sda] Attached SCSI disk [ 2.815048] hv_netvsc 000d3a06-2a7e-000d-3a06-2a7e000d3a06 eth0: VF slot 1 added [ 2.825910] hv_vmbus: registering driver hv_pci [ 2.830131] hv_pci 506c366b-519a-4a4c-9010-41318ce71cde: PCI VMBus probing: Using version 0x10004 [ 2.840228] hv_pci 506c366b-519a-4a4c-9010-41318ce71cde: PCI host bridge to bus 519a:00 [ 2.846646] pci_bus 519a:00: root bus resource [mem 0xfc0000000-0xfc00fffff window] [ 2.852516] pci_bus 519a:00: No busn resource found for root bus, will use [bus 00-ff] [ 2.859780] pci 519a:00:02.0: [15b3:1018] type 00 class 0x020000 [ 2.869641] pci 519a:00:02.0: reg 0x10: [mem 0xfc0000000-0xfc00fffff 64bit pref] [ 2.893605] pci 519a:00:02.0: enabling Extended Tags [ 2.903955] pci 519a:00:02.0: 0.000 Gb/s available PCIe bandwidth, limited by Unknown x0 link at 519a:00:02.0 (capable of 126.016 Gb/s with 8.0 GT/s PCIe x16 link) [ 2.915745] pci_bus 519a:00: busn_res: [bus 00-ff] end is updated to 00 [ 2.921890] pci 519a:00:02.0: BAR 0: assigned [mem 0xfc0000000-0xfc00fffff 64bit pref] [ 2.962212] mlx5_core 519a:00:02.0: firmware version: 16.30.1284 [ 3.123660] mlx5_core 519a:00:02.0: MLX5E: StrdRq(1) RqSz(8) StrdSz(2048) RxCqeCmprss(0) [ 3.177653] hv_netvsc 000d3a06-2a7e-000d-3a06-2a7e000d3a06 eth0: VF registering: eth1 [ 3.183870] mlx5_core 519a:00:02.0 eth1: joined to eth0 [ 3.196007] mlx5_core 519a:00:02.0 enP20890s1: renamed from eth1 [ 2.952768] systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device. [ OK ] Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device. [ 3.336038] BTRFS: device label OEM devid 1 transid 12 /dev/sda6 scanned by (udev-worker) (489) [ OK ] Found device dev-disk-by\x2dlabel-OEM.device. [ 3.007750] systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. [ OK ] Found device dev-disk-by\x2dpartlabel-USR\x2dA.device. [ 3.231213] systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device. [ OK ] Found device dev-disk-by\x…2d8e26\x2d6cce9662f132.device. [ 3.242072] systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device. Starting disk-uuid.service... [ 3.258039] systemd[1]: Starting disk-uuid.service... [ 3.621178] sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 [ OK ] Found device dev-disk-by\x2dlabel-ROOT.device. [ 3.276921] systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device. [ 3.647703] sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 [ 4.645037] sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 [ 4.303072] disk-uuid[563]: The operation has completed successfully. [ OK ] Finished disk-uuid.service. [ 4.356393] systemd[1]: disk-uuid.service: Deactivated successfully. [ 4.365041] systemd[1]: Finished disk-uuid.service. [ 4.368701] systemd[1]: Starting verity-setup.service... Starting verity-setup.service... [ 4.756618] device-mapper: verity: sha256 using implementation "sha256-ce" [ OK ] Found device dev-mapper-usr.device. [ 4.711108] systemd[1]: Found device dev-mapper-usr.device. [ 4.720301] systemd[1]: Mounting sysusr-usr.mount... Mounting sysusr-usr.mount... [ OK ] Finished verity-setup.service. [ 4.728878] systemd[1]: Finished verity-setup.service. [ 5.126615] EXT4-fs (dm-0): mounted filesystem without journal. Opts: norecovery. Quota mode: none. [ OK ] Mounted sysusr-usr.mount. [ 4.785917] systemd[1]: Mounted sysusr-usr.mount. Starting ignition-setup.service... Starting parse-ip-for-networkd.service... [ 4.793337] systemd[1]: afterburn-network-kargs.service was skipped because no trigger condition checks were met. [ 4.812156] systemd[1]: Starting ignition-setup.service... [ 4.816715] systemd[1]: Starting parse-ip-for-networkd.service... [ 5.173377] BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm [ 5.180884] BTRFS info (device sda6): using free space tree [ 5.185702] BTRFS info (device sda6): has skinny extents [ OK ] Finished parse-ip-for-networkd.service. [ 4.886839] systemd[1]: Finished parse-ip-for-networkd.service. [ 4.893230] systemd[1]: Starting systemd-networkd.service... Starting systemd-networkd.service... [ 4.919711] systemd-networkd[831]: lo: Link UP [ 4.923242] systemd-networkd[831]: lo: Gained carrier [ OK ] Started systemd-networkd.service. [ 4.926991] systemd-networkd[831]: Enumeration completed [ OK ] Reached target network.target. [ 4.935432] systemd[1]: Started systemd-networkd.service. [ 4.943961] systemd-networkd[831]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Starting iscsiuio.service... [ OK ] Started iscsiuio.service. Starting iscsid.service... [ 4.951132] systemd[1]: Reached target network.target. [ OK ] Started iscsid.service. [ 4.968164] systemd[1]: Starting iscsiuio.service... Starting dracut-initqueue.service... [ 4.975715] iscsid[840]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi [ 4.987393] iscsid[840]: 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. [ 5.011077] iscsid[840]: into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier]. [ OK ] Reached target remote-fs-pre.target. [ 5.024594] iscsid[840]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. [ OK ] Reached target remote-cryptsetup.target. [ 5.034318] iscsid[840]: If using hardware iscsi like qla4xxx this message can be ignored. [ OK ] Reached target remote-fs.target. [ 5.045293] iscsid[840]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi [ 5.057439] iscsid[840]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Starting dracut-pre-mount.service... [ 5.064417] systemd[1]: Started iscsiuio.service. [ 5.075994] systemd[1]: Starting iscsid.service... [ OK ] Finished ignition-setup.service. [ 5.080061] systemd[1]: mnt-oem.mount: Deactivated successfully.[ 5.438589] kauditd_printk_skb: 16 callbacks suppressed [ OK ] Finished dracut-pre-mount.service.[ 5.438593] audit: type=1130 audit(1712946719.994:27): 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.466583] mlx5_core 519a:00:02.0 enP20890s1: Link up [ 5.093636] systemd[1]: Started iscsid.service.[ 5.476397] audit: type=1130 audit(1712946720.036:28): 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.144087] systemd[1]: Starting dracut-initqueue.service... [ 5.148412] systemd[1]: Finished dracut-initqueue.service. [ 5.152520] systemd[1]: Reached target remote-fs-pre.target.[ 5.506020] hv_netvsc 000d3a06-2a7e-000d-3a06-2a7e000d3a06 eth0: Data path switched to VF: enP20890s1 [ 5.163386] systemd[1]: Reached target remote-cryptsetup.target.[ 5.517675] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 5.173469] systemd[1]: Reached target remote-fs.target. Starting ignition-fetch-offline.service... [ 5.177387] systemd[1]: Starting dracut-pre-mount.service... [ 5.186038] systemd[1]: Finished ignition-setup.service. [ 5.190156] systemd[1]: Finished dracut-pre-mount.service. [ 5.194287] systemd[1]: Starting ignition-fetch-offline.service... [ 5.198932] systemd-networkd[831]: enP20890s1: Link UP [ 5.202740] systemd-networkd[831]: eth0: Link UP [ 5.206252] systemd-networkd[831]: eth0: Gained carrier [ 5.210143] systemd-networkd[831]: enP20890s1: Gained carrier [ 5.214379] systemd-networkd[831]: eth0: DHCPv4 address 10.200.20.43/24, gateway 10.200.20.1 acquired from 168.63.129.16 [ 7.135448] systemd-networkd[831]: eth0: Gained IPv6LL [* ] Job ignition-fetch-offline.service/start running (6s / no limit) M [** ] Job ignition-fetch-offline.service/start running (7s / no limit) M [*** ] Job ignition-fetch-offline.service/start running (7s / no limit) [ 8.773425] ignition[855]: Ignition 2.14.0 [ 8.776738] ignition[855]: Stage: fetch-offline [ 8.780119] ignition[855]: reading system config file "/usr/lib/ignition/base.d/base.ign" [ 8.890648] ignition[855]: no config dir at "/usr/lib/ignition/base.platform.d/azure" M [ OK ] Finished ignition-fetch-offline.service. [ 8.896712] systemd[1]: Finished ignition-fetch-offline.service.[ 9.255095] audit: type=1130 audit(1712946723.810: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.923270] ignition[855]: no config URL provided Starting ignition-fetch.service... [ 8.926801] systemd[1]: Starting ignition-fetch.service... [ 8.935119] ignition[855]: reading system config file "/usr/lib/ignition/user.ign" [ 8.940888] ignition[855]: no config at "/usr/lib/ignition/user.ign" [ 8.945851] ignition[855]: failed to fetch config: resource requires networking [ 8.951197] ignition[855]: Ignition finished successfully [ 8.955311] ignition[862]: Ignition 2.14.0 [ 8.958429] ignition[862]: Stage: fetch [ 8.961379] ignition[862]: reading system config file "/usr/lib/ignition/base.d/base.ign" [ 8.967288] ignition[862]: no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 8.972942] ignition[862]: no config URL provided [ 8.976447] ignition[862]: reading system config file "/usr/lib/ignition/user.ign" [ OK ] Finished ignition-fetch.service. [ 9.335859] audit: type=1130 audit(1712946723.895:30): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Starting ignition-kargs.service... [ 9.009219] [862]: fetched base config from "system" [ 9.014306] ignition[862]: no config at "/usr/lib/ignition/user.ign" [ 9.019245] [862]: fetched base config from "system" [ OK ] Finished ignition-kargs.service. [ 9.023077] ignition[862]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1[ 9.376680] audit: type=1130 audit(1712946723.936: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.049862] [862]: fetched user config from "azure" [ 9.063933] ignition[862]: GET result: OK [ 9.067235] systemd[1]: Finished ignition-fetch.service. [ 9.071295] ignition[862]: config has been read from IMDS userdata [ OK ] Finished ignition-disks.service. [ 9.429658] audit: type=1130 audit(1712946723.989: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.107247] systemd[1]: Starting ignition-kargs.service... [ OK ] Reached target local-fs-pre.target. [ 9.111320] systemd[1]: Finished ignition-kargs.service. [ OK ] Reached target local-fs.target. [ 9.119428] ignition[862]: fetch: fetch complete [ OK ] Reached target sysinit.target. [ 9.126959] systemd[1]: Starting ignition-disks.service... [ OK ] Reached target basic.target. [ 9.135061] ignition[862]: fetch: fetch passed [ 9.142770] systemd[1]: Finished ignition-disks.service. [ 9.146872] ignition[862]: Ignition finished successfully Starting systemd-fsck-root.service... [ 9.151301] systemd[1]: Reached target initrd-root-device.target. [ 9.162693] ignition[869]: Ignition 2.14.0 [ 9.166012] systemd[1]: Reached target local-fs-pre.target. [ 9.170259] ignition[869]: Stage: kargs [ 9.173105] systemd[1]: Reached target local-fs.target. [ 9.176933] ignition[869]: reading system config file "/usr/lib/ignition/base.d/base.ign" [ 9.183234] systemd[1]: Reached target sysinit.target. [ 9.187164] systemd[1]: Reached target basic.target. [ 9.190731] ignition[869]: no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 9.196651] systemd[1]: Starting systemd-fsck-root.service... [ 9.201050] ignition[869]: kargs: kargs passed [ 9.204372] ignition[869]: Ignition finished successfully [ 9.208448] ignition[875]: Ignition 2.14.0 [ 9.211507] ignition[875]: Stage: disks [ 9.214297] ignition[875]: reading system config file "/usr/lib/ignition/base.d/base.ign" [ 9.220210] ignition[875]: no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 9.225811] ignition[875]: disks: disks passed [ 9.229157] ignition[875]: Ignition finished successfully [ 9.233231] systemd-fsck[883]: ROOT: clean, 612/7326000 files, 481074/7359488 blocks [ OK ] Finished systemd-fsck-root.service. [ 9.241796] systemd[1]: Finished systemd-fsck-root.service.[ 9.595942] audit: type=1130 audit(1712946724.155:33): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mounting sysroot.mount... [ 9.270542] systemd[1]: Mounting sysroot.mount... [ 9.863413] EXT4-fs (sda9): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none. [ OK ] Mounted sysroot.mount. [ 9.523869] systemd[1]: Mounted sysroot.mount. [ OK ] Reached target initrd-root-fs.target. [ 9.531941] systemd[1]: Reached target initrd-root-fs.target. Mounting sysroot-usr.mount... [ 9.589709] systemd[1]: Mounting sysroot-usr.mount... Starting flatcar-metadata-hostname.service... [ OK ] Reached target ignition-diskful.target. [ 9.594698] systemd[1]: Starting flatcar-metadata-hostname.service... [ OK ] Mounted sysroot-usr.mount. [ 9.609153] systemd[1]: ignition-remount-sysroot.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). [ 9.622306] systemd[1]: Reached target ignition-diskful.target. [ 9.626729] systemd[1]: Mounted sysroot-usr.mount. Mounting sysroot-usr-share-oem.mount... [ 9.685707] systemd[1]: Mounting sysroot-usr-share-oem.mount... Starting initrd-setup-root.service... [ 9.691769] systemd[1]: Starting initrd-setup-root.service... [ 10.052852] BTRFS: device label OEM devid 1 transid 14 /dev/sda6 scanned by mount (894) [ 10.060996] BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm [ 10.067806] BTRFS info (device sda6): using free space tree [ 10.072525] BTRFS info (device sda6): has skinny extents [ 9.727960] initrd-setup-root[899]: cut: /sysroot/etc/passwd: No such file or directory [ 9.738061] systemd[1]: Mounted sysroot-usr-share-oem.mount. [ OK ] Mounted sysroot-usr-share-oem.mount. [ 10.616895] initrd-setup-root[926]: cut: /sysroot/etc/group: No such file or directory [ 10.644137] initrd-setup-root[934]: cut: /sysroot/etc/shadow: No such file or directory [ 10.653755] initrd-setup-root[942]: cut: /sysroot/etc/gshadow: No such file or directory [ OK ] Finished initrd-setup-root.service. [ 11.702021] audit: type=1130 audit(1712946726.261: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' [ 11.346994] systemd[1]: Finished initrd-setup-root.service. Starting ignition-mount.service... [ 11.374671] systemd[1]: Starting ignition-mount.service... [ 11.382140] systemd[1]: Starting sysroot-boot.service... Starting sysroot-boot.service... [ 11.392133] systemd[1]: sysusr-usr-share-oem.mount: Deactivated successfully. [ 11.397450] systemd[1]: sysroot-usr-share-oem.mount: Deactivated successfully. [ OK ] Finished sysroot-boot.service. [ 11.411357] systemd[1]: Finished sysroot-boot.service.[ 11.768622] audit: type=1130 audit(1712946726.325: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' [ 11.520894] coreos-metadata[893]: Apr 12 18:32:06.430 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 [ 11.530890] coreos-metadata[893]: Apr 12 18:32:06.440 INFO Fetch successful [ 11.566458] coreos-metadata[893]: Apr 12 18:32:06.475 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 [ 11.578962] coreos-metadata[893]: Apr 12 18:32:06.488 INFO Fetch successful [ 11.593533] ignition[965]: INFO : Ignition 2.14.0 [ 11.598063] ignition[965]: INFO : Stage: mount [ OK ] Finished flatcar-metadata-hostname.service. [ 11.604303] ignition[965]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign"[ 11.959993] audit: type=1130 audit(1712946726.519:36): 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' [ 11.634143] ignition[965]: DEBUG : parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63 [ OK ] Finished ignition-mount.service. [ 11.650252] coreos-metadata[893]: Apr 12 18:32:06.511 INFO wrote hostname ci-3510.3.3-a-0276e98552 to /sysroot/etc/hostname[ 12.011560] audit: type=1130 audit(1712946726.563:37): 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' Starting ignition-files.service... [ 11.678601] systemd[1]: Finished flatcar-metadata-hostname.service. Mounting sysroot-usr-share-oem.mount... [ 11.687271] ignition[965]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 11.698421] ignition[965]: INFO : mount: mount passed [ 11.702570] ignition[965]: INFO : Ignition finished successfully [ 11.707530] systemd[1]: Finished ignition-mount.service. [ 11.711756] systemd[1]: Starting ignition-files.service... [ 11.716073] systemd[1]: Mounting sysroot-usr-share-oem.mount... [ 12.075282] BTRFS: device label OEM devid 1 transid 15 /dev/sda6 scanned by mount (972) [ 12.083459] BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm [ 12.090052] BTRFS info (device sda6): using free space tree [ 12.094902] BTRFS info (device sda6): has skinny extents [ OK ] Mounted sysroot-usr-share-oem.mount. [ 11.754907] systemd[1]: Mounted sysroot-usr-share-oem.mount. [ 11.768966] ignition[991]: INFO : Ignition 2.14.0 [ 11.774146] ignition[991]: INFO : Stage: files [ 11.778315] ignition[991]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" [ 11.785472] ignition[991]: DEBUG : parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63 [ 11.798291] ignition[991]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 11.805386] ignition[991]: DEBUG : files: compiled without relabeling support, skipping [ 11.811467] ignition[991]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" [ 11.818946] ignition[991]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" [ 11.888423] ignition[991]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" [ 11.898232] ignition[991]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" [ 11.906526] ignition[991]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" [ 11.914045] ignition[991]: wrote ssh authorized keys file for user: core [ 11.919725] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/opt/cni-plugins-linux-arm64-v1.3.0.tgz" [ 11.930379] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(3): GET https://github.com/containernetworking/plugins/releases/download/v1.3.0/cni-plugins-linux-arm64-v1.3.0.tgz: attempt #1 [ 12.248132] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(3): GET result: OK [ 12.544626] ignition[991]: DEBUG : files: createFilesystemsFiles: createFiles: op(3): file matches expected sum of: b2b7fb74f1b3cb8928f49e5bf9d4bc686e057e837fac3caf1b366d54757921dba80d70cc010399b274d136e8dee9a25b1ad87cdfdc4ffcf42cf88f3e8f99587a [ 12.563751] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/opt/cni-plugins-linux-arm64-v1.3.0.tgz" [ 12.577325] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/opt/crictl-v1.27.0-linux-arm64.tar.gz" [ 12.590901] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(4): GET https://github.com/kubernetes-sigs/cri-tools/releases/download/v1.27.0/crictl-v1.27.0-linux-arm64.tar.gz: attempt #1 [ 12.814950] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(4): GET result: OK [ 12.963918] ignition[991]: DEBUG : files: createFilesystemsFiles: createFiles: op(4): file matches expected sum of: db062e43351a63347871e7094115be2ae3853afcd346d47f7b51141da8c3202c2df58d2e17359322f632abcb37474fd7fdb3b7aadbc5cfd5cf6d3bad040b6251 [ 12.981772] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/opt/crictl-v1.27.0-linux-arm64.tar.gz" [ 12.993328] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing file "/sysroot/opt/bin/kubeadm" [ 13.003317] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(5): GET https://dl.k8s.io/release/v1.27.2/bin/linux/arm64/kubeadm: attempt #1 [ 13.213345] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(5): GET result: OK [ 13.534381] ignition[991]: DEBUG : files: createFilesystemsFiles: createFiles: op(5): file matches expected sum of: 45b3100984c979ba0f1c0df8f4211474c2d75ebe916e677dff5fc8e3b3697cf7a953da94e356f39684cc860dff6878b772b7514c55651c2f866d9efeef23f970 [ 13.550930] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing file "/sysroot/opt/bin/kubeadm" [ 13.560551] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/opt/bin/kubelet" [ 13.570394] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET https://dl.k8s.io/release/v1.27.2/bin/linux/arm64/kubelet: attempt #1 [ 13.603077] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET result: OK [ *** ] Job ignition-files.service/start running (13s / no limit) [ 14.212983] ignition[991]: DEBUG : files: createFilesystemsFiles: createFiles: op(6): file matches expected sum of: 71857ff499ae135fa478e1827a0ed8865e578a8d2b1e25876e914fd0beba03733801c0654bcd4c0567bafeb16887dafb2dbbe8d1116e6ea28dcd8366c142d348 [ 14.227843] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/opt/bin/kubelet" [ 14.236655] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(7): [started] writing file "/sysroot/home/core/install.sh"[ 14.590424] BTRFS info: devid 1 device path /dev/sda6 changed to /dev/disk/by-label/OEM scanned by ignition (991) [ 14.253468] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(7): [finished] writing file "/sysroot/home/core/install.sh" [ 14.264535] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(8): [started] writing file "/sysroot/etc/docker/daemon.json" [ 14.273681] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(8): [finished] writing file "/sysroot/etc/docker/daemon.json" [ 14.283207] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(9): [started] writing file "/sysroot/etc/flatcar/update.conf" [ 14.292412] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(9): [finished] writing file "/sysroot/etc/flatcar/update.conf" [ 14.302275] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(a): [started] writing file "/sysroot/etc/systemd/system/waagent.service" [ 14.313807] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(a): oem config not found in "/usr/share/oem", looking on oem partition M [ OK ] Finished ignition-files.service. [ 14.680745] audit: type=1130 audit(1712946729.240: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.326647] systemd[1]: mnt-oem3526544481.mount: Deactivated successfully. [ 14.351180] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(a): op(b): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3526544481" Starting initrd-setup-root-after-ignition.service... [ 14.363508] ignition[991]: CRITICAL : files: createFilesystemsFiles: createFiles: op(a): op(b): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3526544481": device or resource busy Starting ignition-quench.service... [ 14.383111] ignition[991]: ERROR : files: createFilesystemsFiles: createFiles: op(a): failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem3526544481", trying btrfs: device or resource busy [ 14.401743] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(a): op(c): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3526544481" [ 14.413609] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(a): op(c): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3526544481" [ 14.425682] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(a): op(d): [started] unmounting "/mnt/oem3526544481" [ 14.434948] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(a): op(d): [finished] unmounting "/mnt/oem3526544481" [ 14.444285] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(a): [finished] writing file "/sysroot/etc/systemd/system/waagent.service" [ 14.455344] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(e): [started] writing file "/sysroot/etc/systemd/system/nvidia.service" [ 14.466076] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(e): oem config not found in "/usr/share/oem", looking on oem partition [ 14.477046] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(e): op(f): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2808680670" [ OK ] Finished ignition-quench.service. [ 14.487659] ignition[991]: CRITICAL : files: createFilesystemsFiles: createFiles: op(e): op(f): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2808680670": device or resource busy[ 14.853447] audit: type=1130 audit(1712946729.401: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.520871] ignition[991]: ERROR : files: createFilesystemsFiles: createFiles: op(e): failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem2808680670", trying btrfs: device or resource busy[ 14.870427] audit: type=1131 audit(1712946729.401:40): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 14.548089] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(e): op(10): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2808680670" [ 14.560163] systemd[1]: mnt-oem2808680670.mount: Deactivated successfully. [ 14.565395] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(e): op(10): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2808680670" [ 14.575970] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(e): op(11): [started] unmounting "/mnt/oem2808680670" [ 14.586027] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(e): op(11): [finished] unmounting "/mnt/oem2808680670" [ 14.595605] ignition[991]: INFO : files: createFilesystemsFiles: createFiles: op(e): [finished] writing file "/sysroot/etc/systemd/system/nvidia.service" [ 14.605795] ignition[991]: INFO : files: op(12): [started] processing unit "waagent.service" [ 14.612689] ignition[991]: INFO : files: op(12): [finished] processing unit "waagent.service" [ 14.619577] ignition[991]: INFO : files: op(13): [started] processing unit "nvidia.service" [ 14.625895] ignition[991]: INFO : files: op(13): [finished] processing unit "nvidia.service" [ 14.632503] ignition[991]: INFO : files: op(14): [started] processing unit "prepare-cni-plugins.service" [ 14.639636] ignition[991]: INFO : files: op(14): op(15): [started] writing unit "prepare-cni-plugins.service" at "/sysroot/etc/systemd/system/prepare-cni-plugins.service" [ 14.651011] ignition[991]: INFO : files: op(14): op(15): [finished] writing unit "prepare-cni-plugins.service" at "/sysroot/etc/systemd/system/prepare-cni-plugins.service" [ 14.663812] ignition[991]: INFO : files: op(14): [finished] processing unit "prepare-cni-plugins.service" [ 14.670904] ignition[991]: INFO : files: op(16): [started] processing unit "prepare-critools.service" [ 14.678073] ignition[991]: INFO : files: op(16): op(17): [started] writing unit "prepare-critools.service" at "/sysroot/etc/systemd/system/prepare-critools.service" [ 14.689126] ignition[991]: INFO : files: op(16): op(17): [finished] writing unit "prepare-critools.service" at "/sysroot/etc/systemd/system/prepare-critools.service" [ 14.700265] ignition[991]: INFO : files: op(16): [finished] processing unit "prepare-critools.service" [ 14.707589] ignition[991]: INFO : files: op(18): [started] setting preset to enabled for "prepare-cni-plugins.service" [ 14.716651] ignition[991]: INFO : files: op(18): [finished] setting preset to enabled for "prepare-cni-plugins.service" [ 14.726354] ignition[991]: INFO : files: op(19): [started] setting preset to enabled for "prepare-critools.service" [ 14.736168] systemd[1]: Finished ignition-files.service. [ 14.741191] ignition[991]: INFO : files: op(19): [finished] setting preset to enabled for "prepare-critools.service" [ 14.750566] ignition[991]: INFO : files: op(1a): [started] setting preset to enabled for "waagent.service" [ 14.759173] ignition[991]: INFO : files: op(1a): [finished] setting preset to enabled for "waagent.service" [ OK ] Finished initrd-setup-root-after-ignition.service. [ 14.767169] ignition[991]: INFO : files: op(1b): [started] setting preset to enabled for "nvidia.service"[ 15.122025] audit: type=1130 audit(1712946729.681: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.795482] ignition[991]: INFO : files: op(1b): [finished] setting preset to enabled for "nvidia.service" Starting initrd-parse-etc.service... [ 14.816156] ignition[991]: INFO : files: createResultFile: createFiles: op(1c): [started] writing file "/sysroot/etc/.ignition-result.json" [ 14.826306] ignition[991]: INFO : files: createResultFile: createFiles: op(1c): [finished] writing file "/sysroot/etc/.ignition-result.json" [ OK ] Finished initrd-parse-etc.service. [ 14.836377] ignition[991]: INFO : files: files passed[ 15.190306] audit: type=1130 audit(1712946729.750: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.859801] ignition[991]: INFO : Ignition finished successfully [ 15.216830] audit: type=1131 audit(1712946729.771:43): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Reached target initrd-fs.target. [ 14.867674] systemd[1]: Starting initrd-setup-root-after-ignition.service... [ OK ] Reached target initrd.target. [ 14.895255] initrd-setup-root-after-ignition[1016]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory [ 14.908341] systemd[1]: torcx-profile-populate.service was skipped because of an unmet condition check (ConditionPathExists=/sysroot/etc/torcx/next-profile). Starting dracut-pre-pivot.service... [ 14.921522] systemd[1]: Starting ignition-quench.service... [ 14.930388] systemd[1]: ignition-quench.service: Deactivated successfully. [ 14.935947] systemd[1]: Finished ignition-quench.service. [ OK ] Finished dracut-pre-pivot.service. [ 14.940065] systemd[1]: Finished initrd-setup-root-after-ignition.service. [ 14.950729] systemd[1]: Reached target ignition-complete.target. Starting initrd-cleanup.service... [ 14.955410] systemd[1]: Starting initrd-parse-etc.service... [ 14.964419] systemd[1]: initrd-parse-etc.service: Deactivated successfully. [ OK ] Stopped target nss-lookup.target. [ 14.971545] systemd[1]: Finished initrd-parse-etc.service. [ OK ] Stopped target remote-cryptsetup.target. [ 14.981136] systemd[1]: Reached target initrd-fs.target. [ OK ] Stopped target timers.target. [ 14.992492] systemd[1]: Reached target initrd.target. [ OK ] Stopped dracut-pre-pivot.service. [ 15.000681] systemd[1]: dracut-mount.service was skipped because no trigger condition checks were met. [ OK ] Stopped target initrd.target. [ 15.012967] systemd[1]: Starting dracut-pre-pivot.service... [ OK ] Stopped target basic.target. [ 15.022519] systemd[1]: Finished dracut-pre-pivot.service. [ OK ] Stopped target ignition-complete.target. [ 15.031278] systemd[1]: Starting initrd-cleanup.service... [ OK ] Stopped target ignition-diskful.target. [ 15.039988] systemd[1]: Stopped target nss-lookup.target. [ OK ] Stopped target initrd-root-device.target. [ 15.048533] systemd[1]: Stopped target remote-cryptsetup.target. [ OK ] Stopped target remote-fs.target. [ 15.057564] systemd[1]: Stopped target timers.target. [ OK ] Stopped target remote-fs-pre.target. [ 15.065318] systemd[1]: dracut-pre-pivot.service: Deactivated successfully. [ OK ] Stopped target sysinit.target. [ 15.075822] systemd[1]: Stopped dracut-pre-pivot.service. [ OK ] Stopped target local-fs.target. [ 15.086033] systemd[1]: Stopped target initrd.target. [ OK ] Stopped target local-fs-pre.target. [ 15.093710] systemd[1]: Stopped target basic.target. [ OK ] Stopped target swap.target. [ 15.101855] systemd[1]: Stopped target ignition-complete.target. [ OK ] Stopped dracut-pre-mount.service. [ 15.109977] systemd[1]: Stopped target ignition-diskful.target. [ OK ] Stopped target cryptsetup.target. [ 15.118593] systemd[1]: Stopped target initrd-root-device.target. [ OK ] Stopped dracut-initqueue.service. [ 15.127130] systemd[1]: Stopped target remote-fs.target. [ OK ] Stopped initrd-setup-root-after-ignition.service. [ 15.137152] systemd[1]: Stopped target remote-fs-pre.target. [ OK ] Stopped ignition-files.service. [ 15.146626] systemd[1]: Stopped target sysinit.target. [ OK ] Stopped flatcar-metadata-hostname.service. [ 15.154366] systemd[1]: Stopped target local-fs.target. Stopping ignition-mount.service... [ 15.163017] systemd[1]: Stopped target local-fs-pre.target. [ OK ] Stopped kmod-static-nodes.service. Stopping sysroot-boot.service... [ 15.173877] systemd[1]: Stopped target swap.target. [ OK ] Stopped systemd-udev-trigger.service. [ 15.187025] systemd[1]: dracut-pre-mount.service: Deactivated successfully. [ 15.201066] ignition[1029]: INFO : Ignition 2.14.0 [ OK ] Stopped dracut-pre-trigger.service. [ 15.206680] ignition[1029]: INFO : Stage: umount [ OK ] Finished initrd-cleanup.service. [ 15.214623] ignition[1029]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" [ 15.226685] ignition[1029]: DEBUG : parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63 [ OK ] Stopped ignition-mount.service. [ 15.239204] ignition[1029]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" [ OK ] Stopped ignition-disks.service. [ 15.250398] systemd[1]: Stopped dracut-pre-mount.service. [ OK ] Stopped ignition-kargs.service. [ 15.258935] ignition[1029]: INFO : umount: umount passed [ OK ] Stopped ignition-fetch.service. [ 15.266866] ignition[1029]: INFO : Ignition finished successfully [ OK ] Stopped target network.target. [ 15.276279] systemd[1]: Stopped target cryptsetup.target. [ OK ] Stopped ignition-fetch-offline.service. [ 15.284643] systemd[1]: dracut-initqueue.service: Deactivated successfully. [ 15.294940] systemd[1]: Stopped dracut-initqueue.service. [ OK ] Stopped target paths.target. [ 15.299105] systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. [ 15.309281] systemd[1]: Stopped initrd-setup-root-after-ignition.service. [ OK ] Stopped systemd-ask-password-console.path. [ 15.314193] systemd[1]: ignition-files.service: Deactivated successfully. [ OK ] Stopped target slices.target. [ 15.324072] systemd[1]: Stopped ignition-files.service. [ OK ] Stopped target sockets.target. [ 15.332112] systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. [ OK ] Closed iscsid.socket. [ 15.342362] systemd[1]: Stopped flatcar-metadata-hostname.service. [ OK ] Closed iscsiuio.socket. [ 15.350522] systemd[1]: Stopping ignition-mount.service... [ OK ] Stopped ignition-setup.service. [ 15.358211] systemd[1]: kmod-static-nodes.service: Deactivated successfully. Stopping systemd-networkd.service... [ 15.367341] systemd[1]: Stopped kmod-static-nodes.service. Stopping systemd-resolved.service... [ 15.375525] systemd[1]: Stopping sysroot-boot.service... [ OK ] Stopped sysroot-boot.service. [ 15.386144] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. [ OK ] Stopped systemd-resolved.service. [ 15.397741] systemd[1]: Stopped systemd-udev-trigger.service. [ OK ] Stopped systemd-networkd.service. [ 15.406330] systemd[1]: dracut-pre-trigger.service: Deactivated successfully. [ OK ] Closed systemd-networkd.socket. [ 15.416439] systemd[1]: Stopped dracut-pre-trigger.service. [ OK ] Stopped initrd-setup-root.service. [ 15.424750] systemd[1]: initrd-cleanup.service: Deactivated successfully. Stopping network-cleanup.service... [ 15.435308] systemd[1]: Finished initrd-cleanup.service. [ OK ] Stopped parse-ip-for-networkd.service. [ 15.444232] systemd[1]: ignition-mount.service: Deactivated successfully. [ OK ] Stopped systemd-sysctl.service. [ 15.453156] systemd[1]: Stopped ignition-mount.service. [ OK ] Stopped systemd-modules-load.service. [ 15.461395] systemd[1]: ignition-disks.service: Deactivated successfully. Stopping systemd-udevd.service... [ 15.471677] systemd[1]: Stopped ignition-disks.service. [ OK ] Stopped systemd-udevd.service. [ 15.480396] systemd[1]: ignition-kargs.service: Deactivated successfully. [ 15.490063] systemd[1]: Stopped ignition-kargs.service. [ OK ] Closed systemd-udevd-control.socket. [ 15.495200] systemd[1]: ignition-fetch.service: Deactivated successfully. [ OK ] Closed systemd-udevd-kernel.socket. [ 15.504719] systemd[1]: Stopped ignition-fetch.service. [ OK ] Stopped dracut-pre-udev.service. [ 15.513200] systemd[1]: Stopped target network.target. [ OK ] Stopped dracut-cmdline.service. [ 15.521356] systemd[1]: ignition-fetch-offline.service: Deactivated successfully. [ 15.880584] hv_netvsc 000d3a06-2a7e-000d-3a06-2a7e000d3a06 eth0: Data path switched from VF: enP20890s1 [ OK ] Stopped dracut-cmdline-ask.service. [ 15.540335] systemd[1]: Stopped ignition-fetch-offline.service. [ 15.550544] systemd[1]: Stopped target paths.target. [ 15.554421] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Starting initrd-udevadm-cleanup-db.service... [ 15.560527] systemd[1]: Stopped systemd-ask-password-console.path. [ OK ] Stopped systemd-vconsole-setup.service. [ 15.569681] systemd[1]: Stopped target slices.target. [ OK ] Finished initrd-udevadm-cleanup-db.service. [ 15.578456] systemd[1]: Stopped target sockets.target. [ 15.587801] systemd[1]: iscsid.socket: Deactivated successfully. [ 15.592608] systemd[1]: Closed iscsid.socket. [ 15.595960] systemd[1]: iscsiuio.socket: Deactivated successfully. [ 15.600729] systemd[1]: Closed iscsiuio.socket. [ 15.604269] systemd[1]: ignition-setup.service: Deactivated successfully. [ 15.609320] systemd[1]: Stopped ignition-setup.service. [ 15.613325] systemd[1]: Stopping systemd-networkd.service... [ 15.617628] systemd[1]: Stopping systemd-resolved.service... [ 15.622087] systemd-networkd[831]: eth0: DHCPv6 lease lost [ 15.626208] systemd[1]: sysroot-boot.mount: Deactivated successfully. [ 15.631282] systemd[1]: sysroot-boot.service: Deactivated successfully. [ 15.636264] systemd[1]: Stopped sysroot-boot.service. [ OK ] Stopped network-cleanup.service. [ 15.640247] systemd[1]: systemd-resolved.service: Deactivated successfully. [ OK ] Reached target initrd-switch-root.target. [ 15.649698] systemd[1]: Stopped systemd-resolved.service. Starting initrd-switch-root.service... [ 15.658536] systemd[1]: systemd-networkd.service: Deactivated successfully. [ 15.672779] systemd[1]: Stopped systemd-networkd.service. [ 15.676996] systemd[1]: systemd-networkd.socket: Deactivated successfully. [ 15.682137] systemd[1]: Closed systemd-networkd.socket. [ 15.686128] systemd[1]: initrd-setup-root.service: Deactivated successfully. [ 15.691260] systemd[1]: Stopped initrd-setup-root.service. [ 15.695478] systemd[1]: Stopping network-cleanup.service... [ 16.051157] systemd-journald[235]: Received SIGTERM from PID 1 (systemd). [ 15.708668] systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. [ 18.903071] SELinux: Class mctp_socket not defined in policy. [ 18.909396] SELinux: Class anon_inode not defined in policy. [ 18.914249] SELinux: the above unknown classes and permissions will be allowed [ 18.922214] SELinux: policy capability network_peer_controls=1 [ 18.927330] SELinux: policy capability open_perms=1 [ 18.931860] SELinux: policy capability extended_socket_class=1 [ 18.937063] SELinux: policy capability always_check_network=0 [ 18.942164] SELinux: policy capability cgroup_seclabel=1 [ 18.946801] SELinux: policy capability nnp_nosuid_transition=1 [ 18.952091] SELinux: policy capability genfs_seclabel_symlinks=0 [ 18.958297] SELinux: policy capability ioctl_skip_cloexec=0 [ 18.983045] kauditd_printk_skb: 35 callbacks suppressed [ 18.983048] audit: type=1403 audit(1712946733.542:79): auid=4294967295 ses=4294967295 lsm=selinux res=1 [ 19.010963] systemd[1]: Successfully loaded SELinux policy in 392.511ms. [ 19.681304] systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 26.541ms. [ 19.791036] 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.818224] systemd[1]: Detected virtualization microsoft. [ 19.823840] systemd[1]: Detected architecture arm64. [ 19.828836] systemd[1]: Detected first boot. Welcome to Flatcar Container Linux by Kinvolk 3510.3.3 (LTS 2023)! [ 19.875255] systemd[1]: Hostname set to . [ 19.923729] systemd[1]: Initializing machine ID from random generator. [ 20.016722] audit: type=1400 audit(1712946734.576:80): avc: denied { bpf } for pid=1 comm="systemd" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1 [ 20.035010] audit: type=1400 audit(1712946734.576:81): avc: denied { perfmon } for pid=1 comm="systemd" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1 [ 20.050884] audit: type=1334 audit(1712946734.594:82): prog-id=10 op=LOAD [ 20.056907] audit: type=1334 audit(1712946734.594:83): prog-id=10 op=UNLOAD [ 20.062856] audit: type=1334 audit(1712946734.610:84): prog-id=11 op=LOAD [ 20.068588] audit: type=1334 audit(1712946734.610:85): prog-id=11 op=UNLOAD [ 21.859562] SELinux: Context system_u:object_r:container_file_t:s0:c1022,c1023 is not valid (left unmapped). [ 21.869206] audit: type=1400 audit(1712946736.419:86): avc: denied { associate } for pid=1062 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.892627] audit: type=1300 audit(1712946736.419:86): arch=c00000b7 syscall=5 success=yes exit=0 a0=400014589c a1=40000c6df8 a2=40000cd0c0 a3=32 items=0 ppid=1045 pid=1062 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.921710] audit: type=1327 audit(1712946736.419:86): proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61 [ 29.978153] systemd[1]: Populated /etc with preset unit settings. [ 30.917987] systemd[1]: /usr/lib/systemd/system/locksmithd.service:8: Unit uses CPUShares=; please use CPUWeight= instead. Support for CPUShares= will be removed soon. [ 30.933030] systemd[1]: /usr/lib/systemd/system/locksmithd.service:9: Unit uses MemoryLimit=; please use MemoryMax= instead. Support for MemoryLimit= will be removed soon. [ 31.129527] 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. [ 31.215567] kauditd_printk_skb: 6 callbacks suppressed [ 31.215572] audit: type=1334 audit(1712946745.775:88): prog-id=12 op=LOAD [ 31.226469] audit: type=1334 audit(1712946745.775:89): prog-id=3 op=UNLOAD [ 31.228785] systemd[1]: iscsiuio.service: Deactivated successfully. [ 31.232228] audit: type=1334 audit(1712946745.780:90): prog-id=13 op=LOAD [ 31.237546] systemd[1]: Stopped iscsiuio.service. [ 31.242874] audit: type=1334 audit(1712946745.786:91): prog-id=14 op=LOAD [ 31.252706] audit: type=1334 audit(1712946745.786:92): prog-id=4 op=UNLOAD [ OK ] Stopped iscsiuio.service.[ 31.258377] audit: type=1334 audit(1712946745.786:93): prog-id=5 op=UNLOAD [ 31.267006] systemd[1]: iscsid.service: Deactivated successfully. [ 31.268096] audit: type=1131 audit(1712946745.788:94): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 31.268100] audit: type=1334 audit(1712946745.817:95): prog-id=12 op=UNLOAD [ 31.268104] audit: type=1131 audit(1712946745.826:96): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=iscsiuio comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 31.273436] systemd[1]: Stopped iscsid.service. [ OK ] Stopped iscsid.service. [ 31.322531] audit: type=1131 audit(1712946745.882:97): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=iscsid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 31.322860] systemd[1]: initrd-switch-root.service: Deactivated successfully. [ 31.347961] systemd[1]: Stopped initrd-switch-root.service. [ OK ] Stopped initrd-switch-root.service. [ 31.359458] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 31.369533] systemd[1]: Created slice system-addon\x2dconfig.slice. [ OK ] Created slice system-addon\x2dconfig.slice. [ 31.381781] systemd[1]: Created slice system-addon\x2drun.slice. [ OK ] Created slice system-addon\x2drun.slice. [ 31.392873] systemd[1]: Created slice system-getty.slice. [ OK ] Created slice system-getty.slice. [ 31.402634] systemd[1]: Created slice system-modprobe.slice. [ OK ] Created slice system-modprobe.slice. [ 31.412609] systemd[1]: Created slice system-serial\x2dgetty.slice. [ OK ] Created slice system-serial\x2dgetty.slice. [ 31.425177] systemd[1]: Created slice system-system\x2dcloudinit.slice. [ OK ] Created slice system-system\x2dcloudinit.slice. [ 31.438193] systemd[1]: Created slice system-systemd\x2dfsck.slice. [ OK ] Created slice system-systemd\x2dfsck.slice. [ 31.449203] systemd[1]: Created slice user.slice. [ OK ] Created slice user.slice. [ 31.460281] systemd[1]: Started systemd-ask-password-console.path. [ OK ] Started systemd-ask-password-console.path. [ 31.472920] systemd[1]: Started systemd-ask-password-wall.path. [ OK ] Started systemd-ask-password-wall.path. [ 31.483118] systemd[1]: Set up automount boot.automount. [ OK ] Set up automount boot.automount. [ 31.493278] systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount. [ OK ] Set up automount proc-sys-fs-binfmt_misc.automount. [ 31.504831] systemd[1]: Stopped target initrd-switch-root.target. [ OK ] Stopped target initrd-switch-root.target. [ 31.515197] systemd[1]: Stopped target initrd-fs.target. [ OK ] Stopped target initrd-fs.target. [ 31.524142] systemd[1]: Stopped target initrd-root-fs.target. [ OK ] Stopped target initrd-root-fs.target. [ 31.533890] systemd[1]: Reached target integritysetup.target. [ OK ] Reached target integritysetup.target. [ 31.544459] systemd[1]: Reached target remote-cryptsetup.target. [ OK ] Reached target remote-cryptsetup.target. [ 31.555074] systemd[1]: Reached target remote-fs.target. [ OK ] Reached target remote-fs.target. [ 31.564304] systemd[1]: Reached target slices.target. [ OK ] Reached target slices.target. [ 31.572780] systemd[1]: Reached target swap.target. [ OK ] Reached target swap.target. [ 31.580791] systemd[1]: Reached target torcx.target. [ OK ] Reached target torcx.target. [ 31.588923] systemd[1]: Reached target veritysetup.target. [ OK ] Reached target veritysetup.target. [ 31.600338] systemd[1]: Listening on systemd-coredump.socket. [ OK ] Listening on systemd-coredump.socket. [ 31.610173] systemd[1]: Listening on systemd-initctl.socket. [ OK ] Listening on systemd-initctl.socket. [ 31.620049] systemd[1]: Listening on systemd-networkd.socket. [ OK ] Listening on systemd-networkd.socket. [ 31.662608] systemd[1]: Listening on systemd-udevd-control.socket. [ OK ] Listening on systemd-udevd-control.socket. [ 31.676522] systemd[1]: Listening on systemd-udevd-kernel.socket. [ OK ] Listening on systemd-udevd-kernel.socket. [ 31.687622] systemd[1]: Listening on systemd-userdbd.socket. [ OK ] Listening on systemd-userdbd.socket. [ 31.699019] systemd[1]: Mounting dev-hugepages.mount... Mounting dev-hugepages.mount... [ 31.708070] systemd[1]: Mounting dev-mqueue.mount... Mounting dev-mqueue.mount... [ 31.717198] systemd[1]: Mounting media.mount... Mounting media.mount... [ 31.727995] systemd[1]: Mounting sys-kernel-debug.mount... Mounting sys-kernel-debug.mount... [ 31.737885] systemd[1]: Mounting sys-kernel-tracing.mount... Mounting sys-kernel-tracing.mount... [ 31.751579] systemd[1]: Mounting tmp.mount... Mounting tmp.mount... [ 31.759803] systemd[1]: Starting flatcar-tmpfiles.service... Starting flatcar-tmpfiles.service... [ 31.770314] systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. [ 31.781210] systemd[1]: Starting kmod-static-nodes.service... Starting kmod-static-nodes.service... [ 31.791546] systemd[1]: Starting modprobe@configfs.service... Starting modprobe@configfs.service... [ 31.801358] systemd[1]: Starting modprobe@dm_mod.service... Starting modprobe@dm_mod.service... [ 31.810900] systemd[1]: Starting modprobe@drm.service... Starting modprobe@drm.service... [ 31.820320] systemd[1]: Starting modprobe@efi_pstore.service... Starting modprobe@efi_pstore.service... [ 31.830789] systemd[1]: Starting modprobe@fuse.service... Starting modprobe@fuse.service... [ 31.841439] systemd[1]: Starting modprobe@loop.service... Starting modprobe@loop.service... [ 31.849829] systemd[1]: setup-nsswitch.service was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). [ 31.859868] systemd[1]: systemd-fsck-root.service: Deactivated successfully. [ 31.865840] systemd[1]: Stopped systemd-fsck-root.service. [ OK ] Stopped systemd-fsck-root.service. [ 31.875487] systemd[1]: systemd-fsck-usr.service: Deactivated successfully. [ 31.882182] systemd[1]: Stopped systemd-fsck-usr.service. [ OK ] Stopped systemd-fsck-usr.service. [ 31.891884] systemd[1]: Stopped systemd-journald.service. [ OK ] Stopped systemd-journald.service. [ 31.903460] systemd[1]: systemd-journald.service: Consumed 3.039s CPU time. [ 31.912318] fuse: init (API version 7.34) [ 31.914752] systemd[1]: Starting systemd-journald.service... Starting systemd-journald.service...[ 31.925010] loop: module loaded [ 31.946208] systemd[1]: Starting systemd-modules-load.service... Starting systemd-modules-load.service... [ 31.957460] systemd[1]: Starting systemd-network-generator.service... Starting systemd-network-generator.service... [ 31.969084] systemd[1]: Starting systemd-remount-fs.service... Starting systemd-remount-fs.service... [ 31.983475] systemd[1]: Starting systemd-udev-trigger.service... Starting systemd-udev-trigger.service... [ 31.992766] systemd[1]: verity-setup.service: Deactivated successfully. [ 31.998593] systemd[1]: Stopped verity-setup.service. [ OK ] Stopped verity-setup.service. [ 32.010494] systemd[1]: Mounted dev-hugepages.mount. [ OK ] Mounted dev-hugepages.mount. [ 32.019759] systemd[1]: Mounted dev-mqueue.mount. [ OK ] Mounted dev-mqueue.mount. [ 32.030341] systemd[1]: Mounted media.mount. [ OK ] Mounted media.mount. [ 32.037658] systemd[1]: Mounted sys-kernel-debug.mount. [ OK ] Mounted sys-kernel-debug.mount. [ 32.046292] systemd[1]: Mounted sys-kernel-tracing.mount. [ OK ] Mounted sys-kernel-tracing.mount. [ 32.055198] systemd[1]: Mounted tmp.mount. [ OK ] Mounted tmp.mount. [ 32.063306] systemd[1]: Finished flatcar-tmpfiles.service. [ OK ] Finished flatcar-tmpfiles.service. [ 32.074296] systemd[1]: Started systemd-journald.service. [ OK ] Started systemd-journald.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 ] Finished systemd-modules-load.service. [ OK ] Finished systemd-udev-trigger.service. [ OK ] Reached target network-pre.target. Mounting sys-fs-fuse-connections.mount... Mounting sys-kernel-config.mount... Starting systemd-hwdb-update.service... Starting systemd-journal-flush.service... Starting systemd-random-seed.service... Starting systemd-sysctl.service... Starting systemd-sysusers.service... Starting systemd-udev-settle.service... [ OK ] Mounted sys-fs-fuse-connections.mount. [ OK ] Mounted sys-kernel-config.mount. [ OK ] Finished systemd-random-seed.service. [ OK ] Reached target first-boot-complete.target. [ 32.267676] systemd-journald[1164]: Received client request to flush runtime journal. [ 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... [ 34.158208] mousedev: PS/2 mouse device common for all mice Starting systemd-userdbd.service... [ 34.176710] hv_vmbus: registering driver hyperv_fb [ 34.184049] hyperv_fb: Synthvid Version major 3, minor 5 [ 34.186281] hv_vmbus: registering driver hv_balloon [ 34.193736] hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 [ 34.202137] hv_balloon: Using Dynamic Memory protocol version 2.0 [ 34.206901] hv_balloon: Memory hot add disabled on ARM64 [ 34.212727] Console: switching to colour dummy device 80x25 [ 34.220772] Console: switching to colour frame buffer device 128x48 [ 34.233748] hv_utils: Registering HyperV Utility Driver [ 34.239775] hv_vmbus: registering driver hv_utils [ 34.244539] hv_utils: Heartbeat IC version 3.0 [ 34.248223] hv_utils: Shutdown IC version 3.2 [ 34.253465] hv_utils: TimeSync IC version 4.0 [ OK ] Started systemd-userdbd.service. [ 34.481305] BTRFS info: devid 1 device path /dev/disk/by-label/OEM changed to /dev/sda6 scanned by (udev-worker) (1201) [ 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... [ 34.889646] mlx5_core 519a:00:02.0 enP20890s1: Link up [ 34.913012] hv_netvsc 000d3a06-2a7e-000d-3a06-2a7e000d3a06 eth0: Data path switched to VF: enP20890s1 [ 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. [ 36.548988] kauditd_printk_skb: 73 callbacks suppressed [ 36.548991] audit: type=1130 audit(1712946751.158:154): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-networkd-wait-online comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Finished systemd-tmpfiles-setup.service. [ 37.394934] audit: type=1130 audit(1712946752.004:155): 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... [ 37.429144] audit: type=1334 audit(1712946752.038:156): prog-id=24 op=LOAD Starting systemd-resolved.service... [ 37.441138] audit: type=1334 audit(1712946752.050:157): prog-id=25 op=LOAD Starting systemd-timesyncd.service... Starting systemd-update-utmp.service... [ OK ] Finished clean-ca-certificates.service. [ 37.489659] audit: type=1130 audit(1712946752.099:158): 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' [ 37.512883] audit: type=1127 audit(1712946752.122:159): pid=1288 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg=' comm="systemd-update-utmp" exe="/usr/lib/systemd/systemd-update-utmp" hostname=? addr=? terminal=? res=success' [ OK ] Finished systemd-update-utmp.service. [ 37.536172] audit: type=1130 audit(1712946752.145:160): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-update-utmp comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Started systemd-timesyncd.service. [ OK ] Reached target time-set.target.[ 37.600543] audit: type=1130 audit(1712946752.210:161): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-timesyncd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Finished systemd-journal-catalog-update.service. [ 37.635561] audit: type=1130 audit(1712946752.245:162): 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. [ OK ] Reached target network.target.[ 37.674654] audit: type=1130 audit(1712946752.279:163): 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-online.target. [ OK ] Reached target nss-lookup.target. [ OK ] Finished audit-rules.service. [* ] 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 [ *** ] Job ldconfig.service/start running (11s / no limit) M [ ***] Job ldconfig.service/start running (12s / no limit) M [ **] Job ldconfig.service/start running (12s / no limit) M [ *] Job ldconfig.service/start running (13s / 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. [ 44.770934] extend-filesystems[1314]: Found sda [ OK ] Finished motdgen.service. [ 44.775514] extend-filesystems[1314]: Found sda1 [ 44.784714] extend-filesystems[1314]: Found sda2 [ 44.789261] extend-filesystems[1314]: Found sda3 [ 44.796506] extend-filesystems[1314]: Found usr [ 44.807174] extend-filesystems[1314]: Found sda4 [ 44.810856] extend-filesystems[1314]: Found sda6 [ 44.815637] extend-filesystems[1314]: Found sda7 [ 44.819775] extend-filesystems[1314]: Found sda9 [ 44.828086] extend-filesystems[1314]: Checking size of /dev/sda9 [ 44.891964] extend-filesystems[1314]: Old size kept for /dev/sda9 [ OK ] Finished extend-filesystems.service. [ 44.905661] extend-filesystems[1314]: Found sr0 [ OK ] Started containerd.service. [ 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 ] 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.3-a-0276e98552 (Linux aarch64 5.15.154-flatcar) 18:32:42 SSH host key: SHA256:3IzwckAseAxY3/3AGpW36P2+U188FTBIl+NS+jZ/tpM (ED25519) SSH host key: SHA256:mtiw46TFZW0lkfrQAkQ5hXW4q4fPDvqRNJhEsCqTVgs (RSA) SSH host key: SHA256:bAgbGS2TpGXdW+BQdFRuaydtK+MTtdLjqAXznccrDRs (ECDSA) enP20890s1: eth0: 10.200.20.43 fe80::20d:3aff:fe06:2a7e ci-3510 login: core (automatic login) Flatcar Container Linux by Kinvolk lts 3510.3.3 for Microsoft Azure [?2004hcore@ci-3510 ~ $ 2024-04-12T18:32:50.687449Z INFO Daemon Daemon Azure Linux Agent Version:2.6.0.2 2024-04-12T18:32:50.694838Z INFO Daemon Daemon OS: flatcar 3510.3.3 2024-04-12T18:32:50.699892Z INFO Daemon Daemon Python: 3.9.16 2024-04-12T18:32:50.705427Z INFO Daemon Daemon Run daemon 2024-04-12T18:32:50.710407Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='3510.3.3' 2024-04-12T18:32:50.728625Z 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-04-12T18:32:50.747244Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' 2024-04-12T18:32:50.758241Z INFO Daemon Daemon cloud-init is enabled: False 2024-04-12T18:32:50.763558Z INFO Daemon Daemon Using waagent for provisioning 2024-04-12T18:32:50.771478Z INFO Daemon Daemon Activate resource disk 2024-04-12T18:32:50.777842Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb 2024-04-12T18:32:50.795841Z INFO Daemon Daemon Found device: None 2024-04-12T18:32:50.801172Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology 2024-04-12T18:32:50.810023Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 2024-04-12T18:32:50.822541Z INFO Daemon Daemon Clean protocol and wireserver endpoint 2024-04-12T18:32:50.828623Z INFO Daemon Daemon Running default provisioning handler 2024-04-12T18:32:50.842798Z 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-04-12T18:32:50.858217Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' 2024-04-12T18:32:50.868204Z INFO Daemon Daemon cloud-init is enabled: False 2024-04-12T18:32:50.873719Z INFO Daemon Daemon Copying ovf-env.xml 2024-04-12T18:32:50.957444Z INFO Daemon Daemon Successfully mounted dvd 2024-04-12T18:32:51.155991Z INFO Daemon Daemon Detect protocol endpoint 2024-04-12T18:32:51.164118Z INFO Daemon Daemon Clean protocol and wireserver endpoint 2024-04-12T18:32:51.170354Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler 2024-04-12T18:32:51.177244Z INFO Daemon Daemon Test for route to 168.63.129.16 2024-04-12T18:32:51.182960Z INFO Daemon Daemon Route to 168.63.129.16 exists 2024-04-12T18:32:51.188649Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 2024-04-12T18:32:51.328637Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 2024-04-12T18:32:51.336089Z INFO Daemon Daemon Wire protocol version:2012-11-30 2024-04-12T18:32:51.341497Z INFO Daemon Daemon Server preferred version:2015-04-05 2024-04-12T18:32:51.962640Z INFO Daemon Daemon Initializing goal state during protocol detection 2024-04-12T18:32:51.977733Z INFO Daemon Daemon Forcing an update of the goal state.. 2024-04-12T18:32:51.984018Z INFO Daemon Daemon Fetching goal state [incarnation 1] 2024-04-12T18:32:52.069430Z INFO Daemon Daemon Found private key matching thumbprint 483E4C9B5EC1E1C2B657B6E25CF8C4CB28E8F63D 2024-04-12T18:32:52.078698Z INFO Daemon Daemon Certificate with thumbprint AB28D43AB93025377631FEE6A6E0B15DE0F09D96 has no matching private key. 2024-04-12T18:32:52.090122Z INFO Daemon Daemon Fetch goal state completed 2024-04-12T18:32:52.141653Z INFO Daemon Daemon Fetched new vmSettings [correlation ID: beb63fac-d835-46ff-b48e-4c2339d6c232 New eTag: 5472363111454335917] 2024-04-12T18:32:52.152675Z INFO Daemon Daemon Status Blob type 'None' is not valid, assuming BlockBlob 2024-04-12T18:32:52.169115Z INFO Daemon Daemon Starting provisioning 2024-04-12T18:32:52.174004Z INFO Daemon Daemon Handle ovf-env.xml. 2024-04-12T18:32:52.179844Z INFO Daemon Daemon Set hostname [ci-3510.3.3-a-0276e98552] 2024-04-12T18:32:52.252439Z INFO Daemon Daemon Publish hostname [ci-3510.3.3-a-0276e98552] 2024-04-12T18:32:52.259476Z INFO Daemon Daemon Examine /proc/net/route for primary interface 2024-04-12T18:32:52.266192Z INFO Daemon Daemon Primary interface is [eth0] 2024-04-12T18:32:52.328216Z INFO Daemon Daemon Create user account if not exists 2024-04-12T18:32:52.334409Z INFO Daemon Daemon User core already exists, skip useradd 2024-04-12T18:32:52.340917Z INFO Daemon Daemon Configure sudoer 2024-04-12T18:32:52.346130Z INFO Daemon Daemon Configure sshd 2024-04-12T18:32:52.351097Z INFO Daemon Daemon Deploy ssh public key. 2024-04-12T18:32:53.618496Z INFO Daemon Daemon Provisioning complete 2024-04-12T18:32:53.641554Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping 2024-04-12T18:32:53.649806Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. [ 82.349704] hv_balloon: Max. dynamic memory size: 4096 MB [ 117.295804] SELinux: Context system_u:object_r:container_file_t:s0 is not valid (left unmapped). [ 137.644464] WARNING: Unprivileged eBPF is enabled, data leaks possible via Spectre v2 BHB attacks! [ 138.112054] Initializing XFRM netlink socket [ 138.117644] WARNING: Unprivileged eBPF is enabled, data leaks possible via Spectre v2 BHB attacks! [ 139.773054] IPv6: ADDRCONF(NETDEV_CHANGE): cilium_host: link becomes ready [ 140.214567] NET: Registered PF_ALG protocol family [ 141.159411] IPv6: ADDRCONF(NETDEV_CHANGE): lxc_health: link becomes ready [ 141.677262] eth0: renamed from tmp00cd2 [ 141.686955] IPv6: ADDRCONF(NETDEV_CHANGE): lxc08b623e4ddde: link becomes ready [ 154.736480] eth0: renamed from tmp41ef6 [ 154.748019] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 154.752999] IPv6: ADDRCONF(NETDEV_CHANGE): lxc289834fdf511: link becomes ready [ 169.578705] FS-Cache: Loaded [ 169.656056] RPC: Registered named UNIX socket transport module. [ 169.660580] RPC: Registered udp transport module. [ 169.664100] RPC: Registered tcp transport module. [ 169.667583] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 169.801181] FS-Cache: Netfs 'nfs' registered for caching [ 169.978343] NFS: Registering the id_resolver key type [ 169.982143] Key type id_resolver registered [ 169.985417] Key type id_legacy registered [ 170.673101] eth0: renamed from tmp6dda3 [ 170.685422] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 170.690143] IPv6: ADDRCONF(NETDEV_CHANGE): lxc4c72b7368730: link becomes ready [ 187.995354] alg: No test for seqiv(rfc4106(gcm(aes))) (seqiv(rfc4106(gcm-aes-ce))) [ 190.585490] IPv6: ADDRCONF(NETDEV_CHANGE): lxc_health: link becomes ready