Welcome 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.132-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 Mon Oct 2 17:55:37 -00 2023 [ 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=0x3fd8d018 SMBIOS=0x3fd6a000 SMBIOS 3.0=0x3fd68000 MEMATTR=0x3ef3f098 RNG=0x3fd8d998 MEMRESERVE=0x37eb7f98 [ 0.000000] random: crng init done [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x000000003FD8D018 000024 (v02 VRTUAL) [ 0.000000] ACPI: XSDT 0x000000003FD8DF18 00006C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: FACP 0x000000003FD8DC18 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: DSDT 0x000000003EBD6018 01DEC0 (v02 MSFTVM DSDT01 00000001 MSFT 05000000) [ 0.000000] ACPI: DBG2 0x000000003FD8DB18 000072 (v00 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: GTDT 0x000000003FD8DD98 000060 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: OEM0 0x000000003FD8D098 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: SPCR 0x000000003FD8DA98 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: APIC 0x000000003FD8D818 0000FC (v04 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: SRAT 0x000000003FD8D198 000234 (v03 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: PPTT 0x000000003FD8D418 000120 (v01 VRTUAL MICROSFT 00000000 MSFT 00000000) [ 0.000000] ACPI: BGRT 0x000000003FD8DE98 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 0x1bf7f0900-0x1bf7f5fff] [ 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-0x000000003ec84fff] [ 0.000000] node 0: [mem 0x000000003ec85000-0x000000003ecadfff] [ 0.000000] node 0: [mem 0x000000003ecae000-0x000000003fd2dfff] [ 0.000000] node 0: [mem 0x000000003fd2e000-0x000000003fd81fff] [ 0.000000] node 0: [mem 0x000000003fd82000-0x000000003fd8dfff] [ 0.000000] node 0: [mem 0x000000003fd8e000-0x000000003fd91fff] [ 0.000000] node 0: [mem 0x000000003fd92000-0x000000003fffffff] [ 0.000000] node 0: [mem 0x0000000100000000-0x00000001bfffffff] [ 0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x00000001bfffffff] [ 0.000000] On node 0, zone DMA: 36 pages in unavailable ranges [ 0.000000] psci: probing for conduit method from ACPI. [ 0.000000] psci: PSCIv1.1 detected in firmware. [ 0.000000] psci: Using standard PSCI v0.2 function IDs [ 0.000000] psci: MIGRATE_INFO_TYPE not supported. [ 0.000000] psci: SMC Calling Convention v1.4 [ 0.000000] ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x0 -> Node -1 [ 0.000000] ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x1 -> Node -1 [ 0.000000] percpu: Embedded 29 pages/cpu s79960 r8192 d30632 u118784 [ 0.000000] Detected PIPT I-cache on CPU0 [ 0.000000] CPU features: detected: GIC system register CPU interface [ 0.000000] CPU features: detected: Hardware dirty bit management [ 0.000000] CPU features: detected: Spectre-BHB [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI) [ 0.000000] CPU features: detected: ARM erratum 1418040 [ 0.000000] CPU features: detected: ARM erratum 1542419 (kernel portion) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1032156 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=tty1 console=ttyAMA0,115200n8 earlycon=pl011,0xeffec000 flatcar.first_boot=detected acpi=force flatcar.oem.id=azure flatcar.autologin verity.usrhash=684fe6a2259d7fb96810743ab87aaaa03d9f185b113bd6990a64d1079e5672ca [ 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 0x000000003abd6000-0x000000003ebd6000] (64MB) [ 0.000000] Memory: 3992056K/4194160K available (9792K kernel code, 2092K rwdata, 7548K rodata, 34560K init, 779K bss, 202104K 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.008338] Console: colour dummy device 80x25 [ 0.012896] printk: console [tty1] enabled [ 0.017479] ACPI: Core revision 20210730 [ 0.022116] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) [ 0.033063] pid_max: default: 32768 minimum: 301 [ 0.038101] LSM: Security Framework initializing [ 0.043212] SELinux: Initializing. [ 0.046728] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) [ 0.054662] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) [ 0.063564] Hyper-V: privilege flags low 0x2e7f, high 0x3a8030, hints 0xe, misc 0x31e1 [ 0.071985] Hyper-V: Host Build 10.0.22477.1341-1-0 [ 0.076943] rcu: Hierarchical SRCU implementation. [ 0.081990] Remapping and enabling EFI services. [ 0.086700] smp: Bringing up secondary CPUs ... [ 0.091459] Detected PIPT I-cache on CPU1 [ 0.091480] GICv3: CPU1: found redistributor 1 region 1:0x00000000f000e000 [ 0.091526] arch_timer: Enabling local workaround for ARM erratum 1418040 [ 0.091564] CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] [ 0.091613] smp: Brought up 1 node, 2 CPUs [ 0.122844] SMP: Total of 2 processors activated. [ 0.127776] CPU features: detected: 32-bit EL0 Support [ 0.133115] CPU features: detected: Instruction cache invalidation not required for I/D coherence [ 0.142023] CPU features: detected: Data cache clean to the PoU not required for I/D coherence [ 0.151876] CPU features: detected: CRC32 instructions [ 0.157638] CPU features: detected: RCpc load-acquire (LDAPR) [ 0.166211] CPU features: detected: LSE atomic instructions [ 0.171881] CPU features: detected: Privileged Access Never [ 0.221234] CPU: All CPU(s) started at EL1 [ 0.225284] alternatives: patching kernel code [ 0.230118] devtmpfs: initialized [ 0.233479] KASLR enabled [ 0.236097] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.246235] futex hash table entries: 512 (order: 3, 32768 bytes, linear) [ 0.253181] pinctrl core: initialized pinctrl subsystem [ 0.258632] SMBIOS 3.1.0 present. [ 0.261972] DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 05/16/2022 [ 0.272833] NET: Registered PF_NETLINK/PF_ROUTE protocol family [ 0.278925] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.285964] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.293748] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.302507] audit: initializing netlink subsys (disabled) [ 0.308479] audit: type=2000 audit(0.085:1): state=initialized audit_enabled=0 res=1 [ 0.308556] thermal_sys: Registered thermal governor 'step_wise' [ 0.316601] cpuidle: using governor menu [ 0.327030] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. [ 0.334243] ASID allocator initialised with 32768 entries [ 0.339869] ACPI: bus type PCI registered [ 0.343723] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.350520] Serial: AMBA PL011 UART driver [ 0.355549] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.362410] HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages [ 0.370095] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.377043] HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages [ 0.503974] cryptd: max_cpu_qlen set to 1000 [ 0.512216] alg: No test for fips(ansi_cprng) (fips_ansi_cprng) [ 0.518234] ACPI: Added _OSI(Module Device) [ 0.522433] ACPI: Added _OSI(Processor Device) [ 0.527109] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.531772] ACPI: Added _OSI(Processor Aggregator Device) [ 0.537320] ACPI: Added _OSI(Linux-Dell-Video) [ 0.541982] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) [ 0.547352] ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) [ 0.557371] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.564162] ACPI: Interpreter enabled [ 0.567781] ACPI: Using GIC for interrupt routing [ 0.573402] ARMH0011:00: ttyAMA0 at MMIO 0xeffec000 (irq = 12, base_baud = 0) is a SBSA [ 0.582668] printk: console [ttyAMA0] enabled [ 0.582668] printk: console [ttyAMA0] enabled [ 0.591051] printk: bootconsole [pl11] disabled [ 0.591051] printk: bootconsole [pl11] disabled [ 0.599182] ARMH0011:01: ttyAMA1 at MMIO 0xeffeb000 (irq = 13, base_baud = 0) is a SBSA [ 0.605700] iommu: Default domain type: Translated [ 0.609247] iommu: DMA domain TLB invalidation policy: strict mode [ 0.613697] vgaarb: loaded [ 0.615756] pps_core: LinuxPPS API ver. 1 registered [ 0.620155] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.627469] PTP clock support registered [ 0.630713] Registered efivars operations [ 0.634048] No ACPI PMU IRQ for CPU0 [ 0.636678] No ACPI PMU IRQ for CPU1 [ 0.640049] clocksource: Switched to clocksource arch_sys_counter [ 0.650651] VFS: Disk quotas dquot_6.6.0 [ 0.653848] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.659502] pnp: PnP ACPI init [ 0.661883] pnp: PnP ACPI: found 0 devices [ 0.667782] NET: Registered PF_INET protocol family [ 0.671848] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) [ 0.678476] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) [ 0.686146] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) [ 0.692527] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) [ 0.699254] TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) [ 0.704983] TCP: Hash tables configured (established 32768 bind 32768) [ 0.709718] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) [ 0.715693] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) [ 0.721407] NET: Registered PF_UNIX/PF_LOCAL protocol family [ 0.725917] PCI: CLS 0 bytes, default 64 [ 0.738096] hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 1 counters available [ 0.744096] kvm [1]: HYP mode not available [ 0.939331] Initialise system trusted keyrings [ 0.942895] workingset: timestamp_bits=39 max_order=20 bucket_order=0 [ 0.948882] Key type asymmetric registered [ 0.952362] Asymmetric key parser 'x509' registered [ 0.956024] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) [ 0.962350] io scheduler mq-deadline registered [ 0.966197] io scheduler kyber registered [ 0.969287] io scheduler bfq registered [ 0.973381] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 0.979037] thunder_xcv, ver 1.0 [ 0.982076] thunder_bgx, ver 1.0 [ 0.984635] nicpf, ver 1.0 [ 0.986926] nicvf, ver 1.0 [ 0.989549] rtc-efi rtc-efi.0: registered as rtc0 [ 0.993560] rtc-efi rtc-efi.0: setting system clock to 2023-10-02T20:35:49 UTC (1696278949) [ 1.000827] efifb: probing for efifb [ 1.003766] efifb: framebuffer at 0x40000000, using 3072k, total 3072k [ 1.009152] efifb: mode is 1024x768x32, linelength=4096, pages=1 [ 1.014233] efifb: scrolling: redraw [ 1.017112] efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 [ 1.023410] Console: switching to colour frame buffer device 128x48 [ 1.029189] fb0: EFI VGA frame buffer device [ 1.032647] SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... [ 1.037987] hid: raw HID events driver (C) Jiri Kosina [ 1.042349] NET: Registered PF_INET6 protocol family [ 1.046827] Segment Routing with IPv6 [ 1.049948] In-situ OAM (IOAM) with IPv6 [ 1.053455] NET: Registered PF_PACKET protocol family [ 1.057571] Key type dns_resolver registered [ 1.061567] registered taskstats version 1 [ 1.064816] Loading compiled-in X.509 certificates [ 1.099279] Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.15.132-flatcar: 3a2a38edc68cb70dc60ec0223a6460557b3bb28d' [ 1.109836] Key type .fscrypt registered [ 1.113122] Key type fscrypt-provisioning registered [ 1.117339] ima: No TPM chip found, activating TPM-bypass! [ 1.122140] ima: Allocated hash algorithm: sha1 [ 1.125616] ima: No architecture policies found [ 1.133963] Freeing unused kernel memory: 34560K [ 1.137954] Run /init as init process [ 1.163344] 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.189251] systemd[1]: Detected virtualization microsoft. [ 1.194771] systemd[1]: Detected architecture arm64. [ 1.199091] systemd[1]: Running in initrd. Welcome to dracut-053 (Initramfs)! [ 1.206968] systemd[1]: No hostname configured, using default hostname. [ 1.212573] systemd[1]: Hostname set to . [ 1.217173] systemd[1]: Initializing machine ID from random generator. [ 1.369510] systemd[1]: Queued start job for default target initrd.target. [ 1.376966] systemd[1]: Started systemd-ask-password-console.path. [ OK ] Started systemd-ask-password-console.path. [ 1.387696] systemd[1]: Reached target cryptsetup.target. [ OK ] Reached target cryptsetup.target. [ 1.397099] systemd[1]: Reached target paths.target. [ OK ] Reached target paths.target. [ 1.405292] systemd[1]: Reached target slices.target. [ OK ] Reached target slices.target. [ 1.415200] systemd[1]: Reached target swap.target. [ OK ] Reached target swap.target. [ 1.424528] systemd[1]: Reached target timers.target. [ OK ] Reached target timers.target. [ 1.434669] systemd[1]: Listening on iscsid.socket. [ OK ] Listening on iscsid.socket. [ 1.444126] systemd[1]: Listening on iscsiuio.socket. [ OK ] Listening on iscsiuio.socket. [ 1.454410] systemd[1]: Listening on systemd-journald-audit.socket. [ OK ] Listening on systemd-journald-audit.socket. [ 1.465210] systemd[1]: Listening on systemd-journald-dev-log.socket. [ OK ] Listening on systemd-journald-dev-log.socket. [ 1.476761] systemd[1]: Listening on systemd-journald.socket. [ OK ] Listening on systemd-journald.socket. [ 1.487191] systemd[1]: Listening on systemd-networkd.socket. [ OK ] Listening on systemd-networkd.socket. [ 1.498254] systemd[1]: Listening on systemd-udevd-control.socket. [ OK ] Listening on systemd-udevd-control.socket. [ 1.508758] systemd[1]: Listening on systemd-udevd-kernel.socket. [ OK ] Listening on systemd-udevd-kernel.socket. [ 1.519582] systemd[1]: Reached target sockets.target. [ OK ] Reached target sockets.target. [ 1.529451] systemd[1]: Starting kmod-static-nodes.service... Starting kmod-static-nodes.service... [ 1.539193] systemd[1]: Finished network-cleanup.service. [ OK ] Finished network-cleanup.service. [ 1.549707] systemd[1]: Starting systemd-fsck-usr.service... Starting systemd-fsck-usr.service... [ 1.560851] systemd[1]: Starting systemd-journald.service... Starting systemd-journald.service... [ 1.571458] systemd[1]: Starting systemd-modules-load.service... Starting systemd-modules-load.service... [ 1.582881] systemd[1]: Starting systemd-resolved.service... Starting systemd-resolved.service... [ 1.595230] systemd[1]: Starting systemd-vconsole-setup.service... Starting systemd-vconsole-setup.service... [ 1.621748] systemd[1]: Started systemd-journald.service. [ 1.228689] systemd-modules-load[277]: Inserted module 'overlay'[ 1.628028] bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. [ 1.643719] Bridge firewalling registered [ 1.652376] SCSI subsystem initialized [ OK ] Started systemd-journald.service. [ 1.263384] systemd-resolved[278]: Positive Trust Anchors: [ 1.275868] systemd-resolved[278]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d[ 1.664959] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. [ 1.672753] audit: type=1130 audit(1696278950.170: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.683353] device-mapper: uevent: version 1.0.3 [ 1.315800] systemd-resolved[278]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test[ 1.705086] device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com [ OK ] Started systemd-resolved.service. [ 1.361206] systemd-modules-load[277]: Inserted module 'br_netfilter'[ 1.755944] audit: type=1130 audit(1696278950.262: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.388144] systemd-resolved[278]: Defaulting to hostname 'linux'. [ OK ] Finished kmod-static-nodes.service. [ 1.394268] systemd[1]: Started systemd-resolved.service. [ 1.792711] audit: type=1130 audit(1696278950.294: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.421912] systemd-modules-load[277]: Inserted module 'dm_multipath' [ OK ] Finished systemd-modules-load.service.[ 1.825947] audit: type=1130 audit(1696278950.321: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' [ 1.432234] systemd[1]: Finished kmod-static-nodes.service. [ OK ] Finished systemd-vconsole-setup.service. [ 1.458315] systemd[1]: Finished systemd-fsck-usr.service. [ OK ] Reached target nss-lookup.target.[ 1.861111] audit: type=1130 audit(1696278950.348: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' [ 1.467705] systemd[1]: Finished systemd-modules-load.service.[ 1.885147] audit: type=1130 audit(1696278950.358:7): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Starting dracut-cmdline-ask.service... [ 1.513977] systemd[1]: Finished systemd-vconsole-setup.service. [ 1.527077] systemd[1]: Reached target nss-lookup.target. [ 1.531346] systemd[1]: Starting dracut-cmdline-ask.service... Starting systemd-sysctl.service... [ 1.539928] systemd[1]: Starting systemd-sysctl.service... [ 1.546199] systemd[1]: Starting systemd-tmpfiles-setup-dev.service... Starting systemd-tmpfiles-setup-dev.service... [ OK ] Finished systemd-sysctl.service. [ 1.562364] systemd[1]: Finished systemd-sysctl.service.[ 1.952668] audit: type=1130 audit(1696278950.458:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Finished dracut-cmdline-ask.service. [ 1.584103] systemd[1]: Finished dracut-cmdline-ask.service. [ OK ] Finished systemd-tmpfiles-setup-dev.service. [ 1.593434] systemd[1]: Finished systemd-tmpfiles-setup-dev.service.[ 1.987986] audit: type=1130 audit(1696278950.483:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 2.007460] audit: type=1130 audit(1696278950.493:10): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Starting dracut-cmdline.service... [ 1.618061] systemd[1]: Starting dracut-cmdline.service... [ 1.650914] dracut-cmdline[298]: dracut-dracut-053 [ 1.656434] dracut-cmdline[298]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=tty1 console=ttyAMA0,115200n8 earlycon=pl011,0xeffec000 flatcar.first_boot=detected acpi=force flatcar.oem.id=azure flatcar.autologin verity.usrhash=684fe6a2259d7fb96810743ab87aaaa03d9f185b113bd6990a64d1079e5672ca [ 2.170452] Loading iSCSI transport class v2.0-870. [ 2.182993] iscsi: registered transport (tcp) [ 2.200014] iscsi: registered transport (qla4xxx) [ 2.204194] QLogic iSCSI HBA Driver [ OK ] Finished dracut-cmdline.service. [ 1.896241] systemd[1]: Finished dracut-cmdline.service. Starting dracut-pre-udev.service... [ 1.904563] systemd[1]: Starting dracut-pre-udev.service... [ 2.350051] raid6: neonx8 gen() 13817 MB/s [ 2.372050] raid6: neonx8 xor() 10832 MB/s [ 2.392052] raid6: neonx4 gen() 13498 MB/s [ 2.412052] raid6: neonx4 xor() 11097 MB/s [ 2.433070] raid6: neonx2 gen() 13105 MB/s [ 2.453051] raid6: neonx2 xor() 10300 MB/s [ 2.473050] raid6: neonx1 gen() 10533 MB/s [ 2.494051] raid6: neonx1 xor() 8789 MB/s [ 2.514054] raid6: int64x8 gen() 6294 MB/s [ 2.534052] raid6: int64x8 xor() 3550 MB/s [ 2.555052] raid6: int64x4 gen() 7211 MB/s [ 2.575053] raid6: int64x4 xor() 3856 MB/s [ 2.595051] raid6: int64x2 gen() 6155 MB/s [ 2.616051] raid6: int64x2 xor() 3322 MB/s [ 2.636052] raid6: int64x1 gen() 5047 MB/s [ 2.656050] raid6: int64x1 xor() 2647 MB/s [ 2.660955] raid6: using algorithm neonx8 gen() 13817 MB/s [ 2.665690] raid6: .... xor() 10832 MB/s, rmw enabled [ 2.670593] raid6: using neon recovery algorithm [ 2.683525] xor: measuring software checksum speed [ 2.688710] 8regs : 17293 MB/sec [ 2.692913] 32regs : 20755 MB/sec [ 2.697035] arm64_neon : 27816 MB/sec [ 2.700729] xor: using function: arm64_neon (27816 MB/sec) [ 2.753127] Btrfs loaded, crc32c=crc32c-generic, zoned=no, fsverity=no [ OK ] Finished dracut-pre-udev.service. [ 2.392119] systemd[1]: Finished dracut-pre-udev.service. Starting systemd-udevd.service... [ 2.399958] systemd[1]: Starting systemd-udevd.service... [ 2.419810] systemd-udevd[474]: Using default interface naming scheme 'v252'. [ OK ] Started systemd-udevd.service. [ 2.433875] systemd[1]: Started systemd-udevd.service. Starting dracut-pre-trigger.service... [ 2.448636] systemd[1]: Starting dracut-pre-trigger.service... [ 2.465826] dracut-pre-trigger[495]: rd.md=0: removing MD RAID activation [ OK ] Finished dracut-pre-trigger.service. [ 2.517316] systemd[1]: Finished dracut-pre-trigger.service. Starting systemd-udev-trigger.service... [ 2.526447] systemd[1]: Starting systemd-udev-trigger.service... [ OK ] Finished systemd-udev-trigger.service. [ 2.572050] systemd[1]: Finished systemd-udev-trigger.service. [ 3.014041] hv_vmbus: Vmbus version:5.3 [ 3.021661] hv_vmbus: registering driver hyperv_keyboard [ 3.023195] input: AT Translated Set 2 keyboard as /devices/LNXSYSTM:00/LNXSYBUS:00/ACPI0004:00/VMBUS:00/d34b2567-b9b6-42b9-8778-0a4ec0b955bf/serio0/input/input0 [ 3.027582] hv_vmbus: registering driver hv_netvsc [ 3.028598] hv_vmbus: registering driver hid_hyperv [ 3.029110] input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input1 [ 3.029115] hid-generic 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on [ 3.034104] hv_vmbus: registering driver hv_storvsc [ 3.035039] scsi host0: storvsc_host_t [ 3.035499] scsi 0:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 [ 3.035751] scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 0 [ 3.038267] scsi host1: storvsc_host_t [ 3.111839] sd 0:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB) [ 3.115393] sr 0:0:0:2: [sr0] scsi-1 drive [ 3.121165] sd 0:0:0:0: [sda] 4096-byte physical blocks [ 3.125348] cdrom: Uniform CD-ROM driver Revision: 3.20 [ 3.129706] sd 0:0:0:0: [sda] Write Protect is off [ 3.137426] sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA [ 3.146896] sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 [ 3.151046] hv_netvsc 0022487c-1de1-0022-487c-1de10022487c eth0: VF slot 1 added [ 3.159863] sd 0:0:0:0: [sda] Attached SCSI disk [ 3.168020] hv_vmbus: registering driver hv_pci [ 3.173451] hv_pci 596f8133-f428-4a3e-b472-3405dc1a95f1: PCI VMBus probing: Using version 0x10004 [ 3.186645] hv_pci 596f8133-f428-4a3e-b472-3405dc1a95f1: PCI host bridge to bus f428:00 [ 3.193264] pci_bus f428:00: root bus resource [mem 0xfc0000000-0xfc00fffff window] [ 3.200197] pci_bus f428:00: No busn resource found for root bus, will use [bus 00-ff] [ 3.210278] pci f428:00:02.0: [15b3:1018] type 00 class 0x020000 [ 3.221706] pci f428:00:02.0: reg 0x10: [mem 0xfc0000000-0xfc00fffff 64bit pref] [ 3.444510] pci f428:00:02.0: enabling Extended Tags [ 3.459160] pci f428:00:02.0: 0.000 Gb/s available PCIe bandwidth, limited by Unknown x0 link at f428:00:02.0 (capable of 126.016 Gb/s with 8.0 GT/s PCIe x16 link) [ 3.471587] pci_bus f428:00: busn_res: [bus 00-ff] end is updated to 00 [ 3.477460] pci f428:00:02.0: BAR 0: assigned [mem 0xfc0000000-0xfc00fffff 64bit pref] [ 3.518967] mlx5_core f428:00:02.0: firmware version: 16.31.2424 [ 3.687947] mlx5_core f428:00:02.0: MLX5E: StrdRq(1) RqSz(8) StrdSz(2048) RxCqeCmprss(0) [ 3.376411] systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device. [ OK ] Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device. [ 3.778284] BTRFS: device label OEM devid 1 transid 12 /dev/sda6 scanned by (udev-worker) (541) [ OK ] Found device dev-disk-by\x2dlabel-OEM.device. [ 3.416219] systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. [ 3.838315] hv_netvsc 0022487c-1de1-0022-487c-1de10022487c eth0: VF registering: eth1 [ 3.845862] mlx5_core f428:00:02.0 eth1: joined to eth0 [ 3.858288] mlx5_core f428:00:02.0 enP62504s1: renamed from eth1 [ 3.569397] systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device. [ OK ] Found device dev-disk-by\x2dlabel-ROOT.device. [ OK ] Found device dev-disk-by\x…2d8e26\x2d6cce9662f132.device. [ 3.591966] systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device. [ OK ] Found device dev-disk-by\x2dpartlabel-USR\x2dA.device. [ 3.605838] systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device. [ 3.617130] systemd[1]: Starting disk-uuid.service... Starting disk-uuid.service... [ 4.020697] sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 [ 4.029961] sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 [ 5.036794] sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 [ 4.655587] disk-uuid[599]: The operation has completed successfully. [ OK ] Finished disk-uuid.service. [ 4.726929] systemd[1]: disk-uuid.service: Deactivated successfully. [ 4.736075] systemd[1]: Finished disk-uuid.service. Starting verity-setup.service... [ 4.739600] systemd[1]: Starting verity-setup.service... [ 5.163739] device-mapper: verity: sha256 using implementation "sha256-ce" [ OK ] Found device dev-mapper-usr.device. [ 5.008912] systemd[1]: Found device dev-mapper-usr.device. Mounting sysusr-usr.mount... [ OK ] Finished verity-setup.service. [ 5.026119] systemd[1]: Mounting sysusr-usr.mount... [ 5.032955] systemd[1]: Finished verity-setup.service. [ 5.465155] EXT4-fs (dm-0): mounted filesystem without journal. Opts: norecovery. Quota mode: none. [ OK ] Mounted sysusr-usr.mount. [ 5.084688] systemd[1]: Mounted sysusr-usr.mount. Starting ignition-setup.service... Starting parse-ip-for-networkd.service... [ 5.091849] systemd[1]: afterburn-network-kargs.service was skipped because no trigger condition checks were met. [ 5.112495] systemd[1]: Starting ignition-setup.service... [ 5.116832] systemd[1]: Starting parse-ip-for-networkd.service... [ 5.512321] BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm [ 5.518847] BTRFS info (device sda6): using free space tree [ 5.523296] BTRFS info (device sda6): has skinny extents [ 5.216747] systemd[1]: mnt-oem.mount: Deactivated successfully. [ OK ] Finished parse-ip-for-networkd.service. [ 5.274496] systemd[1]: Finished parse-ip-for-networkd.service.[ 5.668467] kauditd_printk_skb: 10 callbacks suppressed [ 5.668470] audit: type=1130 audit(1696278954.174:21): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=parse-ip-for-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 5.695743] audit: type=1334 audit(1696278954.184:22): prog-id=9 op=LOAD Starting systemd-networkd.service... [ 5.292651] systemd[1]: Starting systemd-networkd.service... [ 5.336630] systemd-networkd[870]: lo: Link UP [ OK ] Started systemd-networkd.service. [ 5.344093] systemd-networkd[870]: lo: Gained carrier[ 5.733870] audit: type=1130 audit(1696278954.239:23): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Reached target network.target. [ 5.362844] systemd-networkd[870]: Enumeration completed Starting iscsiuio.service... [ 5.372801] systemd-networkd[870]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. [ OK ] Started iscsiuio.service. [ 5.383763] systemd[1]: Started systemd-networkd.service.[ 5.781071] audit: type=1130 audit(1696278954.282:24): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=iscsiuio comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 5.406656] systemd[1]: Reached target network.target. Starting iscsid.service... [ 5.411512] systemd[1]: Starting iscsiuio.service... [ OK ] Started iscsid.service. [ 5.418694] iscsid[875]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi[ 5.811244] audit: type=1130 audit(1696278954.317:25): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=iscsid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Starting dracut-initqueue.service... [ 5.444223] iscsid[875]: 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.865792] audit: type=1130 audit(1696278954.371:26): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 5.471776] iscsid[875]: 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. [ OK ] Reached target remote-cryptsetup.target. [ 5.516887] iscsid[875]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. [ OK ] Reached target remote-fs.target. [ 5.522411] iscsid[875]: If using hardware iscsi like qla4xxx this message can be ignored. [ 5.533061] iscsid[875]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi[ 5.929716] mlx5_core f428:00:02.0 enP62504s1: Link up Starting dracut-pre-mount.service... [ OK ] Finished ignition-setup.service. [ 5.946471] audit: type=1130 audit(1696278954.452: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.544952] iscsid[875]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf [ 5.581512] systemd[1]: Started iscsiuio.service. [ 5.585210] systemd[1]: Starting iscsid.service... [ 5.588912] systemd[1]: Started iscsid.service. [ 5.592459] systemd[1]: Starting dracut-initqueue.service... [ 5.596703] systemd[1]: Finished dracut-initqueue.service. [ 5.601536] systemd[1]: Reached target remote-fs-pre.target. Starting ignition-fetch-offline.service... [ OK ] Finished dracut-pre-mount.service. [ 5.615276] systemd[1]: Reached target remote-cryptsetup.target.[ 6.005254] audit: type=1130 audit(1696278954.510: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' [ 6.026148] hv_netvsc 0022487c-1de1-0022-487c-1de10022487c eth0: Data path switched to VF: enP62504s1 [ 6.026449] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 5.635161] systemd[1]: Reached target remote-fs.target. [ 5.655758] systemd[1]: Starting dracut-pre-mount.service... [ 5.660093] systemd[1]: Finished ignition-setup.service. [ 5.665115] systemd[1]: Starting ignition-fetch-offline.service... [ 5.669764] systemd[1]: Finished dracut-pre-mount.service. [ 5.673921] systemd-networkd[870]: enP62504s1: Link UP [ 5.677928] systemd-networkd[870]: eth0: Link UP [ 5.681395] systemd-networkd[870]: eth0: Gained carrier [ 5.685309] systemd-networkd[870]: enP62504s1: Gained carrier [ 5.689682] systemd-networkd[870]: eth0: DHCPv4 address 10.200.20.34/24, gateway 10.200.20.1 acquired from 168.63.129.16 [ 7.071374] systemd-networkd[870]: eth0: Gained IPv6LL [* ] Job ignition-fetch-offline.service/start running (6s / no limit) M [** ] Job ignition-fetch-offline.service/start running (7s / no limit) [ 8.796603] ignition[890]: Ignition 2.14.0 [ 8.799876] ignition[890]: Stage: fetch-offline [ 8.803443] ignition[890]: reading system config file "/usr/lib/ignition/base.d/base.ign" [ 8.934448] ignition[890]: no config dir at "/usr/lib/ignition/base.platform.d/azure" M [ OK ] Finished ignition-fetch-offline.service. [ 9.335824] audit: type=1130 audit(1696278957.841: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' Starting ignition-fetch.service... [ 8.947437] systemd[1]: Finished ignition-fetch-offline.service. [ 8.972357] systemd[1]: Starting ignition-fetch.service... [ 8.976697] ignition[890]: no config URL provided [ 8.980663] ignition[890]: reading system config file "/usr/lib/ignition/user.ign" [ 8.986222] ignition[890]: no config at "/usr/lib/ignition/user.ign" [ 8.991505] ignition[890]: failed to fetch config: resource requires networking [ 8.997665] ignition[890]: Ignition finished successfully [ 9.002115] ignition[897]: Ignition 2.14.0 [ 9.005402] ignition[897]: Stage: fetch [ 9.008575] ignition[897]: reading system config file "/usr/lib/ignition/base.d/base.ign" [ 9.014972] ignition[897]: no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 9.020988] ignition[897]: no config URL provided [ 9.024656] ignition[897]: reading system config file "/usr/lib/ignition/user.ign" [ 9.032246] ignition[897]: no config at "/usr/lib/ignition/user.ign" [ 9.037281] ignition[897]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 [ 9.046016] ignition[897]: GET result: OK [ 9.049102] ignition[897]: config has been read from IMDS userdata [ 9.056390] ignition[897]: fetched base config from "system" [ 9.061916] ignition[897]: fetched base config from "system" [ OK ] Finished ignition-fetch.service. [ 9.066018] ignition[897]: fetch: fetch complete[ 9.462558] audit: type=1130 audit(1696278957.965:30): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 9.090846] [897]: fetched user config from "azure" [ 9.094457] ignition[897]: fetch: fetch passed Starting ignition-kargs.service... [ 9.097780] systemd[1]: Finished ignition-fetch.service. [ 9.107722] ignition[897]: Ignition finished successfully [ 9.112106] systemd[1]: Starting ignition-kargs.service... [ OK ] Finished ignition-kargs.service. [ 9.117174] ignition[903]: Ignition 2.14.0 Starting ignition-disks.service... [ 9.124083] systemd[1]: Finished ignition-kargs.service. [ 9.131951] ignition[903]: Stage: kargs [ 9.135096] systemd[1]: Starting ignition-disks.service... [ 9.139721] ignition[903]: reading system config file "/usr/lib/ignition/base.d/base.ign" [ 9.145775] ignition[903]: no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 9.151863] ignition[903]: kargs: kargs passed [ OK ] Finished ignition-disks.service. [ 9.155097] systemd[1]: Finished ignition-disks.service. [ OK ] Reached target initrd-root-device.target. [ 9.163133] ignition[903]: Ignition finished successfully [ OK ] Reached target local-fs-pre.target. [ 9.171672] systemd[1]: Reached target initrd-root-device.target. [ OK ] Reached target local-fs.target. [ 9.181352] ignition[909]: Ignition 2.14.0 [ OK ] Reached target sysinit.target. [ 9.188600] systemd[1]: Reached target local-fs-pre.target. [ OK ] Reached target basic.target. [ 9.196711] ignition[909]: Stage: disks Starting systemd-fsck-root.service... [ 9.203358] systemd[1]: Reached target local-fs.target. [ 9.211388] ignition[909]: reading system config file "/usr/lib/ignition/base.d/base.ign" [ 9.218640] systemd[1]: Reached target sysinit.target. [ 9.222847] systemd[1]: Reached target basic.target. [ 9.226700] ignition[909]: no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 9.232525] systemd[1]: Starting systemd-fsck-root.service... [ 9.236917] ignition[909]: disks: disks passed [ 9.240271] ignition[909]: Ignition finished successfully [ 9.288879] systemd-fsck[917]: ROOT: clean, 603/7326000 files, 481067/7359488 blocks [ OK ] Finished systemd-fsck-root.service. [ 9.302796] systemd[1]: Finished systemd-fsck-root.service. Mounting sysroot.mount... [ 9.311836] systemd[1]: Mounting sysroot.mount... [ 9.719561] EXT4-fs (sda9): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none. [ OK ] Mounted sysroot.mount. [ 9.343354] systemd[1]: Mounted sysroot.mount. [ OK ] Reached target initrd-root-fs.target. [ 9.346746] systemd[1]: Reached target initrd-root-fs.target. Mounting sysroot-usr.mount... [ 9.384114] systemd[1]: Mounting sysroot-usr.mount... Starting flatcar-metadata-hostname.service... [ OK ] Reached target ignition-diskful.target. [ 9.387815] systemd[1]: Starting flatcar-metadata-hostname.service... [ OK ] Mounted sysroot-usr.mount. [ 9.402069] systemd[1]: ignition-remount-sysroot.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). [ 9.415399] systemd[1]: Reached target ignition-diskful.target. [ 9.419828] systemd[1]: Mounted sysroot-usr.mount. Mounting sysroot-usr-share-oem.mount... [ 9.442081] systemd[1]: Mounting sysroot-usr-share-oem.mount... Starting initrd-setup-root.service... [ 9.447227] systemd[1]: Starting initrd-setup-root.service... [ 9.851696] BTRFS: device label OEM devid 1 transid 14 /dev/sda6 scanned by mount (928) [ 9.859731] BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm [ 9.866305] BTRFS info (device sda6): using free space tree [ 9.477604] initrd-setup-root[933]: cut: /sysroot/etc/passwd: No such file or directory[ 9.872238] BTRFS info (device sda6): has skinny extents [ OK ] Mounted sysroot-usr-share-oem.mount. [ 9.505068] systemd[1]: Mounted sysroot-usr-share-oem.mount. [ 9.531918] initrd-setup-root[959]: cut: /sysroot/etc/group: No such file or directory [ 9.544423] initrd-setup-root[967]: cut: /sysroot/etc/shadow: No such file or directory [ 9.557736] initrd-setup-root[975]: cut: /sysroot/etc/gshadow: No such file or directory [ OK ] Finished initrd-setup-root.service. [ 9.966987] systemd[1]: Finished initrd-setup-root.service. Starting ignition-mount.service... Starting sysroot-boot.service... [ 9.975686] systemd[1]: Starting ignition-mount.service... [ 9.991215] systemd[1]: Starting sysroot-boot.service... [ 9.999524] systemd[1]: sysusr-usr-share-oem.mount: Deactivated successfully. [ 10.005820] systemd[1]: sysroot-usr-share-oem.mount: Deactivated successfully. [ OK ] Finished sysroot-boot.service. [ 10.022224] systemd[1]: Finished sysroot-boot.service. [ 10.043453] ignition[996]: INFO : Ignition 2.14.0 [ 10.049040] ignition[996]: INFO : Stage: mount [ 10.052678] ignition[996]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" [ 10.059952] ignition[996]: DEBUG : parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63 [ 10.076257] ignition[996]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" [ OK ] Finished ignition-mount.service. [ 10.086679] ignition[996]: INFO : mount: mount passed [ 10.091847] ignition[996]: INFO : Ignition finished successfully [ 10.096687] systemd[1]: Finished ignition-mount.service. [ 10.889223] coreos-metadata[927]: Oct 02 20:35:59.784 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 [ 10.897031] coreos-metadata[927]: Oct 02 20:35:59.792 INFO Fetch successful [ 10.925512] coreos-metadata[927]: Oct 02 20:35:59.820 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 [ 10.939918] coreos-metadata[927]: Oct 02 20:35:59.835 INFO Fetch successful [ OK ] Finished flatcar-metadata-hostname.service. [ 10.949940] coreos-metadata[927]: Oct 02 20:35:59.836 INFO wrote hostname ci-3510.3.0-a-1c190d86ff to /sysroot/etc/hostname[ 11.347399] kauditd_printk_skb: 6 callbacks suppressed [ 11.347403] audit: type=1130 audit(1696278959.845:37): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=flatcar-metadata-hostname comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Starting ignition-files.service... [ 10.981140] systemd[1]: Finished flatcar-metadata-hostname.service. Mounting sysroot-usr-share-oem.mount... [ 10.988052] systemd[1]: Starting ignition-files.service... [ 10.996495] systemd[1]: Mounting sysroot-usr-share-oem.mount... [ 11.392715] BTRFS: device label OEM devid 1 transid 15 /dev/sda6 scanned by mount (1006) [ 11.401040] BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm [ 11.407368] BTRFS info (device sda6): using free space tree [ 11.411979] BTRFS info (device sda6): has skinny extents [ OK ] Mounted sysroot-usr-share-oem.mount. [ 11.032451] systemd[1]: Mounted sysroot-usr-share-oem.mount. [ 11.052680] ignition[1025]: INFO : Ignition 2.14.0 [ 11.058899] ignition[1025]: INFO : Stage: files [ 11.062682] ignition[1025]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" [ 11.069785] ignition[1025]: DEBUG : parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63 [ 11.083933] ignition[1025]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 11.090558] ignition[1025]: DEBUG : files: compiled without relabeling support, skipping [ 11.099059] ignition[1025]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" [ 11.106737] ignition[1025]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" [ 11.170776] ignition[1025]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" [ 11.178179] ignition[1025]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" [ 11.191674] ignition[1025]: wrote ssh authorized keys file for user: core [ 11.196681] ignition[1025]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" [ 11.205724] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/opt/cni-plugins-linux-arm64-v1.1.1.tgz" [ 11.216545] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(3): GET https://github.com/containernetworking/plugins/releases/download/v1.1.1/cni-plugins-linux-arm64-v1.1.1.tgz: attempt #1 [ 11.493712] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(3): GET result: OK [ 11.712470] ignition[1025]: DEBUG : files: createFilesystemsFiles: createFiles: op(3): file matches expected sum of: 6b5df61a53601926e4b5a9174828123d555f592165439f541bc117c68781f41c8bd30dccd52367e406d104df849bcbcfb72d9c4bafda4b045c59ce95d0ca0742 [ 11.730294] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/opt/cni-plugins-linux-arm64-v1.1.1.tgz" [ 11.741695] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/opt/crictl-v1.26.0-linux-arm64.tar.gz" [ 11.751929] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(4): GET https://github.com/kubernetes-sigs/cri-tools/releases/download/v1.26.0/crictl-v1.26.0-linux-arm64.tar.gz: attempt #1 [ 12.014390] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(4): GET result: OK [ 12.319778] ignition[1025]: DEBUG : files: createFilesystemsFiles: createFiles: op(4): file matches expected sum of: 4c7e4541123cbd6f1d6fec1f827395cd58d65716c0998de790f965485738b6d6257c0dc46fd7f66403166c299f6d5bf9ff30b6e1ff9afbb071f17005e834518c [ 12.336253] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/opt/crictl-v1.26.0-linux-arm64.tar.gz" [ 12.346772] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing file "/sysroot/opt/bin/kubeadm" [ 12.355843] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(5): GET https://storage.googleapis.com/kubernetes-release/release/v1.26.5/bin/linux/arm64/kubeadm: attempt #1 [ 12.473907] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(5): GET result: OK [*** ] Job ignition-files.service/start running (12s / no limit) [ 13.988080] mlx5_core f428:00:02.0: poll_health:739:(pid 0): device's health compromised - reached miss count M [ *** ] Job ignition-files.service/start running (12s / no limit) M [ *** ] Job ignition-files.service/start running (13s / no limit) M [ ***] Job ignition-files.service/start running (13s / no limit) [ 14.933064] ignition[1025]: DEBUG : files: createFilesystemsFiles: createFiles: op(5): file matches expected sum of: 46c9f489062bdb84574703f7339d140d7e42c9c71b367cd860071108a3c1d38fabda2ef69f9c0ff88f7c80e88d38f96ab2248d4c9a6c9c60b0a4c20fd640d0db [ 14.949231] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing file "/sysroot/opt/bin/kubeadm" [ 14.958019] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/opt/bin/kubelet" [ 14.966864] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET https://storage.googleapis.com/kubernetes-release/release/v1.26.5/bin/linux/arm64/kubelet: attempt #1 [ 15.004252] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET result: OK M [ **] Job ignition-files.service/start running (14s / no limit) M [ *] Job ignition-files.service/start running (14s / no limit) M [ **] Job ignition-files.service/start running (15s / no limit) M [ ***] Job ignition-files.service/start running (15s / no limit) M [ *** ] Job ignition-files.service/start running (16s / no limit) M [ *** ] Job ignition-files.service/start running (16s / no limit) M [*** ] Job ignition-files.service/start running (17s / no limit) M [** ] Job ignition-files.service/start running (17s / no limit) M [* ] Job ignition-files.service/start running (18s / no limit) M [** ] Job ignition-files.service/start running (18s / no limit) M [*** ] Job ignition-files.service/start running (19s / no limit) M [ *** ] Job ignition-files.service/start running (19s / no limit) [ 20.723377] ignition[1025]: DEBUG : files: createFilesystemsFiles: createFiles: op(6): file matches expected sum of: 0e4ee1f23bf768c49d09beb13a6b5fad6efc8e3e685e7c5610188763e3af55923fb46158b5e76973a0f9a055f9b30d525b467c53415f965536adc2f04d9cf18d [ 20.740452] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/opt/bin/kubelet" [ 20.749833] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(7): [started] writing file "/sysroot/opt/bin/kubectl" [ 20.759742] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(7): GET https://storage.googleapis.com/kubernetes-release/release/v1.26.5/bin/linux/arm64/kubectl: attempt #1 [ 20.777716] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(7): GET result: OK M [ *** ] Job ignition-files.service/start running (20s / no limit) [ 21.627975] ignition[1025]: DEBUG : files: createFilesystemsFiles: createFiles: op(7): file matches expected sum of: 3672fda0beebbbd636a2088f427463cbad32683ea4fbb1df61650552e63846b6a47db803ccb70c3db0a8f24746a23a5632bdc15a3fb78f4f7d833e7f86763c2a M [ ***] Job ignition-files.service/start running (20s / no limit) [ 21.644410] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(7): [finished] writing file "/sysroot/opt/bin/kubectl"[ 22.042955] BTRFS info: devid 1 device path /dev/sda6 changed to /dev/disk/by-label/OEM scanned by ignition (1030) [ 21.667599] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(8): [started] writing file "/sysroot/etc/docker/daemon.json" [ 21.679520] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(8): [finished] writing file "/sysroot/etc/docker/daemon.json" [ 21.690925] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(9): [started] writing file "/sysroot/home/core/install.sh" [ 21.700862] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(9): [finished] writing file "/sysroot/home/core/install.sh" [ 21.711212] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(a): [started] writing file "/sysroot/home/core/nginx.yaml" M [ OK ] Finished ignition-files.service. [ 21.721913] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(a): [finished] writing file "/sysroot/home/core/nginx.yaml"[ 22.125965] audit: type=1130 audit(1696278970.621:38): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Starting initrd-setup-root-after-ignition.service... [ 21.756742] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(b): [started] writing file "/sysroot/etc/systemd/system/waagent.service" Starting ignition-quench.service... [ 21.771687] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(b): oem config not found in "/usr/share/oem", looking on oem partition [ 21.782918] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(b): op(c): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3152429018" [ OK ] Finished ignition-quench.service. [ 21.793680] ignition[1025]: CRITICAL : files: createFilesystemsFiles: createFiles: op(b): op(c): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3152429018": device or resource busy[ 22.200668] audit: type=1130 audit(1696278970.693: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' [ 22.218088] audit: type=1131 audit(1696278970.693: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' [ 21.826796] ignition[1025]: ERROR : files: createFilesystemsFiles: createFiles: op(b): failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem3152429018", trying btrfs: device or resource busy [ OK ] Finished initrd-setup-root-after-ignition.service. [ 22.254725] audit: type=1130 audit(1696278970.760: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. [ 21.895369] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(b): op(d): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3152429018" [ 21.906097] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(b): op(d): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3152429018" Starting initrd-parse-etc.service... [ 21.916862] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(b): op(e): [started] unmounting "/mnt/oem3152429018" [ 21.932091] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(b): op(e): [finished] unmounting "/mnt/oem3152429018" [ 21.943200] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(b): [finished] writing file "/sysroot/etc/systemd/system/waagent.service" [ OK ] Finished initrd-parse-etc.service. [ 21.953433] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(f): [started] writing file "/sysroot/etc/systemd/system/nvidia.service"[ 22.346990] audit: type=1130 audit(1696278970.853: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' [ 21.982886] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(f): oem config not found in "/usr/share/oem", looking on oem partition [ OK ] Reached target initrd-fs.target. [ 21.996496] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(f): op(10): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1862602722" [ 22.401305] audit: type=1131 audit(1696278970.880:43): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Reached target initrd.target. Starting dracut-pre-pivot.service... [ 22.036974] ignition[1025]: CRITICAL : files: createFilesystemsFiles: createFiles: op(f): op(10): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1862602722": device or resource busy [ 22.050586] ignition[1025]: ERROR : files: createFilesystemsFiles: createFiles: op(f): failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem1862602722", trying btrfs: device or resource busy [ OK ] Finished dracut-pre-pivot.service. [ 22.459450] audit: type=1130 audit(1696278970.965:44): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 22.089757] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(f): op(11): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1862602722" [ 22.102464] systemd[1]: mnt-oem3152429018.mount: Deactivated successfully. [ 22.107888] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(f): op(11): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1862602722" Starting initrd-cleanup.service... [ 22.123123] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(f): op(12): [started] unmounting "/mnt/oem1862602722" [ OK ] Stopped target nss-lookup.target. [ 22.132628] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(f): op(12): [finished] unmounting "/mnt/oem1862602722" [ OK ] Stopped target remote-cryptsetup.target. [ 22.146657] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(f): [finished] writing file "/sysroot/etc/systemd/system/nvidia.service" [ OK ] Stopped target timers.target. [ 22.162058] ignition[1025]: INFO : files: op(13): [started] processing unit "waagent.service" [ OK ] Stopped dracut-pre-pivot.service. [ 22.172696] ignition[1025]: INFO : files: op(13): [finished] processing unit "waagent.service"[ 22.566239] audit: type=1131 audit(1696278971.072:45): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 22.198440] ignition[1025]: INFO : files: op(14): [started] processing unit "nvidia.service" [ OK ] Stopped target initrd.target. [ 22.207734] ignition[1025]: INFO : files: op(14): [finished] processing unit "nvidia.service" [ OK ] Stopped target basic.target. [ 22.218169] ignition[1025]: INFO : files: op(15): [started] processing unit "prepare-cni-plugins.service" [ OK ] Stopped target ignition-complete.target. [ 22.229302] ignition[1025]: INFO : files: op(15): op(16): [started] writing unit "prepare-cni-plugins.service" at "/sysroot/etc/systemd/system/prepare-cni-plugins.service" [ OK ] Stopped target ignition-diskful.target. [ 22.246537] ignition[1025]: INFO : files: op(15): op(16): [finished] writing unit "prepare-cni-plugins.service" at "/sysroot/etc/systemd/system/prepare-cni-plugins.service" [ OK ] Stopped target initrd-root-device.target. [ 22.261703] ignition[1025]: INFO : files: op(15): [finished] processing unit "prepare-cni-plugins.service" [ OK ] Stopped target remote-fs.target. [ 22.274221] ignition[1025]: INFO : files: op(17): [started] processing unit "prepare-critools.service" [ OK ] Stopped target remote-fs-pre.target. [ 22.285288] ignition[1025]: INFO : files: op(17): op(18): [started] writing unit "prepare-critools.service" at "/sysroot/etc/systemd/system/prepare-critools.service" [ OK ] Stopped target sysinit.target. [ 22.300497] ignition[1025]: INFO : files: op(17): op(18): [finished] writing unit "prepare-critools.service" at "/sysroot/etc/systemd/system/prepare-critools.service" [ OK ] Stopped target local-fs.target. [ 22.315672] ignition[1025]: INFO : files: op(17): [finished] processing unit "prepare-critools.service" [ OK ] Stopped target local-fs-pre.target. [ 22.328298] ignition[1025]: INFO : files: op(19): [started] setting preset to enabled for "nvidia.service" [ OK ] Stopped target swap.target. [ 22.340781] ignition[1025]: INFO : files: op(19): [finished] setting preset to enabled for "nvidia.service" [ OK ] Stopped dracut-pre-mount.service. [ 22.352796] ignition[1025]: INFO : files: op(1a): [started] setting preset to enabled for "prepare-cni-plugins.service"[ 22.746431] audit: type=1131 audit(1696278971.252:46): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 22.380019] ignition[1025]: INFO : files: op(1a): [finished] setting preset to enabled for "prepare-cni-plugins.service" [ OK ] Stopped target cryptsetup.target. [ 22.391184] systemd[1]: Finished ignition-files.service. [ OK ] Stopped dracut-initqueue.service. [ 22.399302] ignition[1025]: INFO : files: op(1b): [started] setting preset to enabled for "prepare-critools.service"[ 22.792954] audit: type=1131 audit(1696278971.298:47): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 22.425011] ignition[1025]: INFO : files: op(1b): [finished] setting preset to enabled for "prepare-critools.service" [ OK ] Stopped initrd-setup-root-after-ignition.service. [ 22.434178] ignition[1025]: INFO : files: op(1c): [started] setting preset to enabled for "waagent.service" [ OK ] Stopped ignition-files.service. [ 22.446478] ignition[1025]: INFO : files: op(1c): [finished] setting preset to enabled for "waagent.service" [ OK ] Stopped flatcar-metadata-hostname.service. [ 22.457050] ignition[1025]: INFO : files: createResultFile: createFiles: op(1d): [started] writing file "/sysroot/etc/.ignition-result.json" [ 22.473268] ignition[1025]: INFO : files: createResultFile: createFiles: op(1d): [finished] writing file "/sysroot/etc/.ignition-result.json" Stopping ignition-mount.service... [ 22.485657] ignition[1025]: INFO : files: files passed [ 22.494408] ignition[1025]: INFO : Ignition finished successfully [ 22.500505] initrd-setup-root-after-ignition[1050]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Stopping iscsiuio.service... [ 22.508808] systemd[1]: Starting initrd-setup-root-after-ignition.service... Stopping sysroot-boot.service... [ OK ] Stopped systemd-udev-trigger.service. [ 22.517442] systemd[1]: torcx-profile-populate.service was skipped because of an unmet condition check (ConditionPathExists=/sysroot/etc/torcx/next-profile). [ 22.541764] systemd[1]: Starting ignition-quench.service... [ OK ] Stopped dracut-pre-trigger.service. [ 22.546269] systemd[1]: ignition-quench.service: Deactivated successfully. [ 22.555801] systemd[1]: Finished ignition-quench.service. [ 22.562635] systemd[1]: Finished initrd-setup-root-after-ignition.service. [ OK ] Stopped iscsiuio.service. [ OK ] Stopped ignition-mount.service. [ 22.577695] systemd[1]: Reached target ignition-complete.target. [ OK ] Stopped ignition-disks.service. [ 22.582447] ignition[1063]: INFO : Ignition 2.14.0 [ OK ] Stopped ignition-kargs.service. [ 22.591212] ignition[1063]: INFO : Stage: umount [ OK ] Stopped ignition-fetch.service. [ 22.599532] ignition[1063]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" [ OK ] Stopped target network.target. [ OK ] Stopped ignition-fetch-offline.service. [ 22.611643] ignition[1063]: DEBUG : parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63 [ OK ] Stopped target paths.target. [ 22.635028] ignition[1063]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 22.645620] ignition[1063]: INFO : umount: umount passed [ OK ] Stopped systemd-ask-password-console.path. [ 22.650333] ignition[1063]: INFO : Ignition finished successfully [ OK ] Stopped target slices.target. [ 22.661369] systemd[1]: Starting initrd-parse-etc.service... [ OK ] Stopped target sockets.target. [ 22.670409] systemd[1]: initrd-parse-etc.service: Deactivated successfully. [ OK ] Closed iscsid.socket. [ 22.679540] systemd[1]: Finished initrd-parse-etc.service. [ OK ] Closed iscsiuio.socket. [ 22.687619] systemd[1]: Reached target initrd-fs.target. [ OK ] Stopped ignition-setup.service. [ 22.695554] systemd[1]: Reached target initrd.target. Stopping systemd-networkd.service... [ 22.703900] systemd[1]: dracut-mount.service was skipped because no trigger condition checks were met. Stopping systemd-resolved.service... [ 22.715173] systemd[1]: Starting dracut-pre-pivot.service... [ OK ] Stopped sysroot-boot.service. [ OK ] Stopped systemd-networkd.service. [ 22.725077] systemd[1]: Finished dracut-pre-pivot.service. [ OK ] Closed systemd-networkd.socket. [ 22.739509] systemd[1]: Starting initrd-cleanup.service... [ OK ] Stopped initrd-setup-root.service. [ 22.748241] systemd[1]: Stopped target nss-lookup.target. [ 22.757926] systemd[1]: Stopped target remote-cryptsetup.target. Stopping network-cleanup.service... [ 22.762880] systemd[1]: Stopped target timers.target. [ OK ] Stopped parse-ip-for-networkd.service. [ 22.770291] systemd[1]: dracut-pre-pivot.service: Deactivated successfully. [ OK ] Stopped systemd-sysctl.service. [ 22.780746] systemd[1]: Stopped dracut-pre-pivot.service. [ OK ] Stopped systemd-modules-load.service. [ 22.788697] systemd[1]: Stopped target initrd.target. Stopping systemd-udevd.service... [ 22.797364] systemd[1]: Stopped target basic.target. [ OK ] Stopped systemd-resolved.service. [ 22.805890] systemd[1]: Stopped target ignition-complete.target. [ OK ] Stopped systemd-udevd.service. [ 22.815162] systemd[1]: Stopped target ignition-diskful.target. [ OK ] Finished initrd-cleanup.service. [ 22.823485] systemd[1]: Stopped target initrd-root-device.target. [ OK ] Closed systemd-udevd-control.socket. [ OK ] Closed systemd-udevd-kernel.socket. [ 22.832338] systemd[1]: Stopped target remote-fs.target. [ OK ] Stopped dracut-pre-udev.service. [ 22.847012] systemd[1]: Stopped target remote-fs-pre.target. [ OK ] Stopped dracut-cmdline.service. [ 22.855393] systemd[1]: Stopped target sysinit.target. [ OK ] Stopped dracut-cmdline-ask.service. [ 22.863656] systemd[1]: Stopped target local-fs.target. Starting initrd-udevadm-cleanup-db.service... [ OK ] Stopped systemd-tmpfiles-setup-dev.service. [ OK ] Stopped kmod-static-nodes.service. [ 22.872045] systemd[1]: Stopped target local-fs-pre.target. [ OK ] Stopped systemd-vconsole-setup.service. [ 22.891741] systemd[1]: Stopped target swap.target. [ OK ] Finished initrd-udevadm-cleanup-db.service. [ 22.899958] systemd[1]: dracut-pre-mount.service: Deactivated successfully. [ 22.910774] systemd[1]: Stopped dracut-pre-mount.service. [ 22.915033] systemd[1]: Stopped target cryptsetup.target. [ 22.919371] systemd[1]: dracut-initqueue.service: Deactivated successfully. [ 22.924848] systemd[1]: Stopped dracut-initqueue.service. [ 22.928889] systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. [ 22.935345] systemd[1]: Stopped initrd-setup-root-after-ignition.service. [ 22.940479] systemd[1]: ignition-files.service: Deactivated successfully.[ 23.335380] hv_netvsc 0022487c-1de1-0022-487c-1de10022487c eth0: Data path switched from VF: enP62504s1 [ 22.955593] systemd[1]: Stopped ignition-files.service. [ 22.959901] systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. [ 22.965545] systemd[1]: Stopped flatcar-metadata-hostname.service. [ 22.970255] systemd[1]: Stopping ignition-mount.service... [ 22.974223] systemd[1]: Stopping iscsiuio.service... [ 22.977771] systemd[1]: Stopping sysroot-boot.service... [ 22.981618] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. [ 22.987259] systemd[1]: Stopped systemd-udev-trigger.service. [ 22.991609] systemd[1]: dracut-pre-trigger.service: Deactivated successfully. [ 22.996869] systemd[1]: Stopped dracut-pre-trigger.service. [ 23.001397] systemd[1]: iscsiuio.service: Deactivated successfully. [ 23.005950] systemd[1]: Stopped iscsiuio.service. [ 23.009384] systemd[1]: ignition-mount.service: Deactivated successfully. [ 23.014592] systemd[1]: Stopped ignition-mount.service. [ 23.018509] systemd[1]: ignition-disks.service: Deactivated successfully. [ 23.023635] systemd[1]: Stopped ignition-disks.service. [ 23.027394] systemd[1]: ignition-kargs.service: Deactivated successfully. [ 23.032496] systemd[1]: Stopped ignition-kargs.service. [ 23.036412] systemd[1]: ignition-fetch.service: Deactivated successfully. [ 23.041247] systemd[1]: Stopped ignition-fetch.service. [ 23.045022] systemd[1]: Stopped target network.target. [ 23.048860] systemd[1]: ignition-fetch-offline.service: Deactivated successfully. [ 23.054238] systemd[1]: Stopped ignition-fetch-offline.service. [ 23.058502] systemd[1]: Stopped target paths.target. [ 23.062408] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. [ 23.068399] systemd[1]: Stopped systemd-ask-password-console.path. [ 23.073016] systemd[1]: Stopped target slices.target. [ 23.076839] systemd[1]: Stopped target sockets.target. [ 23.080847] systemd[1]: iscsid.socket: Deactivated successfully. [ OK ] Stopped network-cleanup.service. [ 23.085434] systemd[1]: Closed iscsid.socket. [ OK ] Reached target initrd-switch-root.target. [ 23.093261] systemd[1]: iscsiuio.socket: Deactivated successfully. Starting initrd-switch-root.service... [ 23.102574] systemd[1]: Closed iscsiuio.socket. [ 23.110953] systemd[1]: ignition-setup.service: Deactivated successfully. [ 23.119194] systemd[1]: Stopped ignition-setup.service. [ 23.123372] systemd[1]: Stopping systemd-networkd.service... [ 23.128177] systemd[1]: Stopping systemd-resolved.service... [ 23.132501] systemd-networkd[870]: eth0: DHCPv6 lease lost [ 23.136674] systemd[1]: sysroot-boot.mount: Deactivated successfully. [ 23.142049] systemd[1]: sysroot-boot.service: Deactivated successfully. [ 23.539109] systemd-journald[276]: Received SIGTERM from PID 1 (n/a). [ 23.156666] systemd[1]: Stopped sysroot-boot.service. [ 25.549550] SELinux: Class mctp_socket not defined in policy. [ 25.555573] SELinux: Class anon_inode not defined in policy. [ 25.560398] SELinux: the above unknown classes and permissions will be allowed [ 25.568335] SELinux: policy capability network_peer_controls=1 [ 25.573303] SELinux: policy capability open_perms=1 [ 25.577529] SELinux: policy capability extended_socket_class=1 [ 25.582434] SELinux: policy capability always_check_network=0 [ 25.587397] SELinux: policy capability cgroup_seclabel=1 [ 25.591959] SELinux: policy capability nnp_nosuid_transition=1 [ 25.597253] SELinux: policy capability genfs_seclabel_symlinks=0 [ 25.602523] SELinux: policy capability ioctl_skip_cloexec=0 [ 25.643250] systemd[1]: Successfully loaded SELinux policy in 229.735ms. [ 26.161275] systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 26.872ms. [ 26.248696] 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) [ 26.275221] systemd[1]: Detected virtualization microsoft. [ 26.279701] systemd[1]: Detected architecture arm64. [ 26.283941] systemd[1]: Detected first boot. Welcome to Flatcar Container Linux by Kinvolk 3510.3.0 (LTS 2023)! [ 26.308143] systemd[1]: Hostname set to . [ 26.341097] systemd[1]: Initializing machine ID from random generator. [ 33.719183] systemd[1]: Populated /etc with preset unit settings. [ 34.166043] systemd[1]: /usr/lib/systemd/system/locksmithd.service:8: Unit uses CPUShares=; please use CPUWeight= instead. Support for CPUShares= will be removed soon. [ 34.181205] systemd[1]: /usr/lib/systemd/system/locksmithd.service:9: Unit uses MemoryLimit=; please use MemoryMax= instead. Support for MemoryLimit= will be removed soon. [ 34.238670] 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. [ 34.308700] kauditd_printk_skb: 40 callbacks suppressed [ 34.308704] audit: type=1334 audit(1696278982.814:88): prog-id=12 op=LOAD [ 34.322165] audit: type=1334 audit(1696278982.814:89): prog-id=3 op=UNLOAD [ 34.328965] audit: type=1334 audit(1696278982.822:90): prog-id=13 op=LOAD [ 34.335390] audit: type=1334 audit(1696278982.828:91): prog-id=14 op=LOAD [ 34.341705] audit: type=1334 audit(1696278982.828:92): prog-id=4 op=UNLOAD [ 34.343386] systemd[1]: iscsid.service: Deactivated successfully. [ 34.347950] audit: type=1334 audit(1696278982.828:93): prog-id=5 op=UNLOAD [ 34.353837] systemd[1]: Stopped iscsid.service. [ 34.362088] audit: type=1334 audit(1696278982.834:94): prog-id=15 op=LOAD [ OK ] Stopped iscsid.service.[ 34.372955] audit: type=1334 audit(1696278982.834:95): prog-id=12 op=UNLOAD [ 34.383270] systemd[1]: initrd-switch-root.service: Deactivated successfully. [ 34.383324] audit: type=1334 audit(1696278982.841:96): prog-id=16 op=LOAD [ 34.389931] systemd[1]: Stopped initrd-switch-root.service. [ 34.396053] audit: type=1334 audit(1696278982.847:97): prog-id=17 op=LOAD [ OK ] Stopped initrd-switch-root.service. [ 34.415046] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 34.423218] systemd[1]: Created slice system-addon\x2dconfig.slice. [ OK ] Created slice system-addon\x2dconfig.slice. [ 34.433747] systemd[1]: Created slice system-addon\x2drun.slice. [ OK ] Created slice system-addon\x2drun.slice. [ 34.444850] systemd[1]: Created slice system-getty.slice. [ OK ] Created slice system-getty.slice. [ 34.454671] systemd[1]: Created slice system-modprobe.slice. [ OK ] Created slice system-modprobe.slice. [ 34.465448] systemd[1]: Created slice system-serial\x2dgetty.slice. [ OK ] Created slice system-serial\x2dgetty.slice. [ 34.476951] systemd[1]: Created slice system-system\x2dcloudinit.slice. [ OK ] Created slice system-system\x2dcloudinit.slice. [ 34.487868] systemd[1]: Created slice system-systemd\x2dfsck.slice. [ OK ] Created slice system-systemd\x2dfsck.slice. [ 34.498376] systemd[1]: Created slice user.slice. [ OK ] Created slice user.slice. [ 34.507881] systemd[1]: Started systemd-ask-password-console.path. [ OK ] Started systemd-ask-password-console.path. [ 34.519134] systemd[1]: Started systemd-ask-password-wall.path. [ OK ] Started systemd-ask-password-wall.path. [ 34.530355] systemd[1]: Set up automount boot.automount. [ OK ] Set up automount boot.automount. [ 34.539255] systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount. [ OK ] Set up automount proc-sys-fs-binfmt_misc.automount. [ 34.551641] systemd[1]: Stopped target initrd-switch-root.target. [ OK ] Stopped target initrd-switch-root.target. [ 34.562449] systemd[1]: Stopped target initrd-fs.target. [ OK ] Stopped target initrd-fs.target. [ 34.571707] systemd[1]: Stopped target initrd-root-fs.target. [ OK ] Stopped target initrd-root-fs.target. [ 34.581674] systemd[1]: Reached target integritysetup.target. [ OK ] Reached target integritysetup.target. [ 34.592393] systemd[1]: Reached target remote-cryptsetup.target. [ OK ] Reached target remote-cryptsetup.target. [ 34.603109] systemd[1]: Reached target remote-fs.target. [ OK ] Reached target remote-fs.target. [ 34.612965] systemd[1]: Reached target slices.target. [ OK ] Reached target slices.target. [ 34.621820] systemd[1]: Reached target swap.target. [ OK ] Reached target swap.target. [ 34.630537] systemd[1]: Reached target torcx.target. [ OK ] Reached target torcx.target. [ 34.640211] systemd[1]: Reached target veritysetup.target. [ OK ] Reached target veritysetup.target. [ 34.653601] systemd[1]: Listening on systemd-coredump.socket. [ OK ] Listening on systemd-coredump.socket. [ 34.663751] systemd[1]: Listening on systemd-initctl.socket. [ OK ] Listening on systemd-initctl.socket. [ 34.673538] systemd[1]: Listening on systemd-networkd.socket. [ OK ] Listening on systemd-networkd.socket. [ 34.683118] systemd[1]: Listening on systemd-udevd-control.socket. [ OK ] Listening on systemd-udevd-control.socket. [ 34.693085] systemd[1]: Listening on systemd-udevd-kernel.socket. [ OK ] Listening on systemd-udevd-kernel.socket. [ 34.704390] systemd[1]: Listening on systemd-userdbd.socket. [ OK ] Listening on systemd-userdbd.socket. [ 34.715007] systemd[1]: Mounting dev-hugepages.mount... Mounting dev-hugepages.mount... [ 34.724597] systemd[1]: Mounting dev-mqueue.mount... Mounting dev-mqueue.mount... [ 34.733174] systemd[1]: Mounting media.mount... Mounting media.mount... [ 34.741235] systemd[1]: Mounting sys-kernel-debug.mount... Mounting sys-kernel-debug.mount... [ 34.750835] systemd[1]: Mounting sys-kernel-tracing.mount... Mounting sys-kernel-tracing.mount... [ 34.761592] systemd[1]: Mounting tmp.mount... Mounting tmp.mount... [ 34.771101] systemd[1]: Starting flatcar-tmpfiles.service... Starting flatcar-tmpfiles.service... [ 34.781607] systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. [ 34.794916] systemd[1]: Starting kmod-static-nodes.service... Starting kmod-static-nodes.service... [ 34.806448] systemd[1]: Starting modprobe@configfs.service... Starting modprobe@configfs.service... [ 34.816501] systemd[1]: Starting modprobe@dm_mod.service... Starting modprobe@dm_mod.service... [ 34.825719] systemd[1]: Starting modprobe@drm.service... Starting modprobe@drm.service... [ 34.835379] systemd[1]: Starting modprobe@efi_pstore.service... Starting modprobe@efi_pstore.service... [ 34.844965] systemd[1]: Starting modprobe@fuse.service... Starting modprobe@fuse.service... [ 34.858741] systemd[1]: Starting modprobe@loop.service... Starting modprobe@loop.service... [ 34.869840] systemd[1]: setup-nsswitch.service was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). [ 34.880555] systemd[1]: systemd-fsck-root.service: Deactivated successfully. [ 34.888155] systemd[1]: Stopped systemd-fsck-root.service. [ OK ] Stopped systemd-fsck-root.service. [ 34.897835] systemd[1]: systemd-fsck-usr.service: Deactivated successfully. [ 34.904179] systemd[1]: Stopped systemd-fsck-usr.service. [ OK ] Stopped systemd-fsck-usr.service. [ 34.914683] systemd[1]: Stopped systemd-journald.service. [ OK ] Stopped systemd-journald.service.[ 34.919726] fuse: init (API version 7.34) [ 34.927082] systemd[1]: systemd-journald.service: Consumed 3.073s CPU time. [ 34.935807] systemd[1]: Starting systemd-journald.service... Starting systemd-journald.service... [ 34.949801] loop: module loaded [ 34.966744] systemd[1]: Starting systemd-modules-load.service... Starting systemd-modules-load.service... [ 34.979366] systemd[1]: Starting systemd-network-generator.service... Starting systemd-network-generator.service... [ 34.990816] systemd[1]: Starting systemd-remount-fs.service... Starting systemd-remount-fs.service... [ 35.001874] systemd[1]: Starting systemd-udev-trigger.service... Starting systemd-udev-trigger.service... [ 35.014405] systemd[1]: verity-setup.service: Deactivated successfully. [ 35.024166] systemd[1]: Stopped verity-setup.service. [ OK ] Stopped verity-setup.service. [ 35.035859] systemd[1]: Mounted dev-hugepages.mount. [ OK ] Mounted dev-hugepages.mount. [ 35.044819] systemd[1]: Mounted dev-mqueue.mount. [ OK ] Mounted dev-mqueue.mount. [ 35.054262] systemd[1]: Mounted media.mount. [ OK ] Mounted media.mount. [ 35.063696] systemd[1]: Mounted sys-kernel-debug.mount. [ OK ] Mounted sys-kernel-debug.mount. [ 35.072930] systemd[1]: Started systemd-journald.service. [ OK ] Started systemd-journald.service. [ OK ] Mounted sys-kernel-tracing.mount. [ OK ] Mounted tmp.mount. [ OK ] Finished flatcar-tmpfiles.service. [ OK ] Finished kmod-static-nodes.service. [ OK ] Finished modprobe@configfs.service. [ OK ] Finished modprobe@dm_mod.service. [ OK ] Finished modprobe@drm.service. [ OK ] Finished modprobe@efi_pstore.service. [ OK ] Finished modprobe@fuse.service. [ OK ] Finished modprobe@loop.service. [ OK ] Finished systemd-modules-load.service. [ OK ] Finished systemd-network-generator.service. [ OK ] Finished systemd-remount-fs.service. [ OK ] 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. [ 35.300534] systemd-journald[1199]: Received client request to flush runtime journal. [ OK ] Finished systemd-sysctl.service. [ OK ] Finished systemd-journal-flush.service. [ OK ] Finished systemd-sysusers.service. Starting systemd-tmpfiles-setup-dev.service... [ OK ] Finished systemd-tmpfiles-setup-dev.service. [ OK ] Finished systemd-hwdb-update.service. Starting systemd-udevd.service... [ OK ] Started systemd-udevd.service. Starting systemd-networkd.service... Starting systemd-userdbd.service... [ 36.675723] mousedev: PS/2 mouse device common for all mice [ 36.686280] hv_vmbus: registering driver hv_balloon [ OK ] Started systemd-userdbd.service. [ 36.697364] hv_vmbus: registering driver hyperv_fb [ 36.701544] hv_balloon: Using Dynamic Memory protocol version 2.0 [ 36.704283] hyperv_fb: Synthvid Version major 3, minor 5 [ 36.706521] hv_balloon: Memory hot add disabled on ARM64 [ 36.712391] hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 [ 36.723642] hv_utils: Registering HyperV Utility Driver [ 36.728742] Console: switching to colour dummy device 80x25 [ 36.728929] hv_vmbus: registering driver hv_utils [ 36.738156] Console: switching to colour frame buffer device 128x48 [ 36.744277] hv_utils: Heartbeat IC version 3.0 [ 36.747720] hv_utils: Shutdown IC version 3.2 [ 36.751360] hv_utils: TimeSync IC version 4.0 [ OK ] Started systemd-networkd.service. Starting systemd-networkd-wait-online.service... [ 37.028386] BTRFS info: devid 1 device path /dev/disk/by-label/OEM changed to /dev/sda6 scanned by (udev-worker) (1237) [ 37.054208] mlx5_core f428:00:02.0 enP62504s1: Link up [ OK ] Found device dev-disk-by\x2dlabel-OEM.device. [ OK ] Finished systemd-udev-settle.service. Starting lvm2-activation-early.service... [ 37.096081] hv_netvsc 0022487c-1de1-0022-487c-1de10022487c eth0: Data path switched to VF: enP62504s1 [ OK ] Finished lvm2-activation-early.service. [ OK ] Reached target cryptsetup.target. Starting lvm2-activation.service... [ OK ] Finished lvm2-activation.service. [ OK ] Reached target local-fs-pre.target. [ OK ] Reached target local-fs.target. [ OK ] Reached target machines.target. Starting ldconfig.service... Starting systemd-boot-update.service... Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service... Starting systemd-machine-id-commit.service... Starting systemd-tmpfiles-setup.service... Starting systemd-fsck@dev-…label-EFI\x2dSYSTEM.service... [ OK ] Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service. [ OK ] Finished systemd-machine-id-commit.service. [ OK ] Finished systemd-fsck@dev-…2dlabel-EFI\x2dSYSTEM.service. Mounting boot.mount... [ OK ] Mounted boot.mount. [ OK ] Finished systemd-boot-update.service. [ OK ] Finished systemd-networkd-wait-online.service. [ OK ] Finished systemd-tmpfiles-setup.service. Starting audit-rules.service... Starting clean-ca-certificates.service... Starting systemd-journal-catalog-update.service... Starting systemd-resolved.service... Starting systemd-timesyncd.service... Starting systemd-update-utmp.service... [ OK ] Finished clean-ca-certificates.service. [ OK ] Finished systemd-update-utmp.service. [ OK ] Finished systemd-journal-catalog-update.service. [ 39.316366] kauditd_printk_skb: 84 callbacks suppressed [ 39.316370] audit: type=1130 audit(1696278988.265:167): 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-timesyncd.service. [ 39.342672] audit: type=1130 audit(1696278988.291:168): 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 ] Reached target time-set.target. [ OK ] Started systemd-resolved.service. [ 39.463193] audit: type=1130 audit(1696278988.412:169): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Reached target network.target. [ OK ] Reached target network-online.target. [ OK ] Reached target nss-lookup.target. [ 39.560549] audit: type=1305 audit(1696278988.509:170): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 [ 39.571224] audit: type=1300 audit(1696278988.509:170): arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffee629180 a2=420 a3=0 items=0 ppid=1318 pid=1339 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="auditctl" exe="/usr/sbin/auditctl" subj=system_u:system_r:kernel_t:s0 key=(null) [ 39.593772] audit: type=1327 audit(1696278988.509:170): proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 [ OK ] Finished audit-rules.service. [* ] Job ldconfig.service/start running (7s / no limit) M [** ] Job ldconfig.service/start running (7s / no limit) M [*** ] Job ldconfig.service/start running (8s / no limit) M [ *** ] Job ldconfig.service/start running (8s / no limit) M [ *** ] Job ldconfig.service/start running (9s / no limit) M [ ***] Job ldconfig.service/start running (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 (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 [** ] Job ldconfig.service/start running (13s / no limit) M [* ] Job ldconfig.service/start running (14s / no limit) M [** ] Job ldconfig.service/start running (14s / no limit) M [*** ] Job ldconfig.service/start running (15s / 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. [ OK ] Finished motdgen.service. [ 50.045230] extend-filesystems[1350]: Found sda [ 50.048873] extend-filesystems[1350]: Found sda1 [ 50.052442] extend-filesystems[1350]: Found sda2 [ 50.056106] extend-filesystems[1350]: Found sda3 [ 50.059604] extend-filesystems[1350]: Found usr [ 50.063082] extend-filesystems[1350]: Found sda4 [ 50.066405] extend-filesystems[1350]: Found sda6 [ 50.069926] extend-filesystems[1350]: Found sda7 [ 50.073475] extend-filesystems[1350]: Found sda9 [ 50.076993] extend-filesystems[1350]: Checking size of /dev/sda9 [ 50.690892] extend-filesystems[1350]: Old size kept for /dev/sda9 [ OK ] Finished extend-filesystems.service. [ 50.702139] extend-filesystems[1350]: Found sr0 [ OK ] Started containerd.service. [ OK ] Finished update-ssh-keys-after-ignition.service. [ OK ] Finished prepare-critools.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-cni-plugins.service. [ OK ] Started update-engine.service. [ OK ] Started locksmithd.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.0-a-1c190d86ff (Linux aarch64 5.15.132-flatcar) 20:36:43 SSH host key: SHA256:GDmb3ae/h/5kRsQhtz5SWQvYLKaf0HRUCP3NXL1xaOU (RSA) SSH host key: SHA256:+UbSid621+uvwYuiLRDuhXwxvkL6CgwapfUDPjSTORo (ECDSA) SSH host key: SHA256:bBeJ4XmzFhgYPG31IooBuriYfYEPurp6FP7IzVee0yQ (ED25519) enP62504s1: eth0: 10.200.20.34 fe80::222:48ff:fe7c:1de1 ci-3510 login: core (automatic login) Last login: Mon Oct 2 20:36:45 UTC 2023 on tty1 Flatcar Container Linux by Kinvolk lts 3510.3.0 for Microsoft Azure /etc/flatcar/update.conf: GROUP=lts on the public update server may switch to a newer LTS stream, use GROUP=lts-STREAM or your own update server with a managed 'lts' group to stick to one stream (e.g., 2021) and opt-out of automatic major version updates. Read more: https://www.flatcar.org/docs/latest/setup/releases/switching-channels/#freezing-an-lts-stream [?2004hcore@ci-3510 ~ $ 2023-10-02T20:36:52.163123Z INFO Daemon Daemon Azure Linux Agent Version:2.6.0.2 2023-10-02T20:36:52.170427Z INFO Daemon Daemon OS: flatcar 3510.3.0 2023-10-02T20:36:52.175498Z INFO Daemon Daemon Python: 3.9.16 2023-10-02T20:36:52.181417Z INFO Daemon Daemon Run daemon 2023-10-02T20:36:52.186191Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='3510.3.0' 2023-10-02T20:36:52.207020Z 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. 2023-10-02T20:36:52.222373Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' 2023-10-02T20:36:52.232451Z INFO Daemon Daemon cloud-init is enabled: False 2023-10-02T20:36:52.237477Z INFO Daemon Daemon Using waagent for provisioning 2023-10-02T20:36:52.243732Z INFO Daemon Daemon Activate resource disk 2023-10-02T20:36:52.248702Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb 2023-10-02T20:36:52.263202Z INFO Daemon Daemon Found device: None 2023-10-02T20:36:52.267823Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology 2023-10-02T20:36:52.276284Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 2023-10-02T20:36:52.288280Z INFO Daemon Daemon Clean protocol and wireserver endpoint 2023-10-02T20:36:52.294218Z INFO Daemon Daemon Running default provisioning handler 2023-10-02T20:36:52.310523Z 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. 2023-10-02T20:36:52.326257Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' 2023-10-02T20:36:52.336091Z INFO Daemon Daemon cloud-init is enabled: False 2023-10-02T20:36:52.341089Z INFO Daemon Daemon Copying ovf-env.xml 2023-10-02T20:36:52.422429Z INFO Daemon Daemon Successfully mounted dvd 2023-10-02T20:36:52.565540Z INFO Daemon Daemon Detect protocol endpoint 2023-10-02T20:36:52.571223Z INFO Daemon Daemon Clean protocol and wireserver endpoint 2023-10-02T20:36:52.577264Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler 2023-10-02T20:36:52.584146Z INFO Daemon Daemon Test for route to 168.63.129.16 2023-10-02T20:36:52.590048Z INFO Daemon Daemon Route to 168.63.129.16 exists 2023-10-02T20:36:52.595290Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 2023-10-02T20:36:52.721867Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 2023-10-02T20:36:52.729167Z INFO Daemon Daemon Wire protocol version:2012-11-30 2023-10-02T20:36:52.734675Z INFO Daemon Daemon Server preferred version:2015-04-05 2023-10-02T20:36:53.199988Z INFO Daemon Daemon Initializing goal state during protocol detection 2023-10-02T20:36:53.218922Z INFO Daemon Daemon Forcing an update of the goal state.. 2023-10-02T20:36:53.224962Z INFO Daemon Daemon Fetching goal state [incarnation 1] 2023-10-02T20:36:53.313909Z INFO Daemon Daemon Found private key matching thumbprint 96E73459C46BA3662DD73E07899B2530C5F3E5EB 2023-10-02T20:36:53.323719Z INFO Daemon Daemon Certificate with thumbprint 8AFA15F3B8891666EB4B9AC1DF34FEE19466A235 has no matching private key. 2023-10-02T20:36:53.333565Z INFO Daemon Daemon Fetch goal state completed 2023-10-02T20:36:53.380616Z INFO Daemon Daemon Fetched new vmSettings [correlation ID: 0b3a1a71-82c9-47a6-9efc-1f652f432066 New eTag: 7308764824478201307] 2023-10-02T20:36:53.391383Z INFO Daemon Daemon Status Blob type 'None' is not valid, assuming BlockBlob 2023-10-02T20:36:53.406388Z INFO Daemon Daemon Starting provisioning 2023-10-02T20:36:53.411683Z INFO Daemon Daemon Handle ovf-env.xml. 2023-10-02T20:36:53.416527Z INFO Daemon Daemon Set hostname [ci-3510.3.0-a-1c190d86ff] 2023-10-02T20:36:53.469123Z INFO Daemon Daemon Publish hostname [ci-3510.3.0-a-1c190d86ff] 2023-10-02T20:36:53.476040Z INFO Daemon Daemon Examine /proc/net/route for primary interface 2023-10-02T20:36:53.483210Z INFO Daemon Daemon Primary interface is [eth0] 2023-10-02T20:36:53.554509Z INFO Daemon Daemon Create user account if not exists 2023-10-02T20:36:53.561386Z INFO Daemon Daemon User core already exists, skip useradd 2023-10-02T20:36:53.569467Z INFO Daemon Daemon Configure sudoer 2023-10-02T20:36:53.574850Z INFO Daemon Daemon Configure sshd 2023-10-02T20:36:53.579807Z INFO Daemon Daemon Deploy ssh public key. 2023-10-02T20:36:54.813203Z INFO Daemon Daemon Provisioning complete 2023-10-02T20:36:54.835056Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping 2023-10-02T20:36:54.841702Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. [ 84.809054] hv_balloon: Max. dynamic memory size: 4096 MB [ 118.960667] Initializing XFRM netlink socket [ 145.190912] SELinux: Context system_u:object_r:container_file_t:s0 is not valid (left unmapped). [ 184.943694] cni0: port 1(veth798434cc) entered blocking state [ 184.948710] cni0: port 1(veth798434cc) entered disabled state [ 184.953042] device veth798434cc entered promiscuous mode [ 184.957606] cni0: port 1(veth798434cc) entered blocking state [ 184.961925] cni0: port 1(veth798434cc) entered forwarding state [ 184.966647] cni0: port 1(veth798434cc) entered disabled state [ 184.974814] IPv6: ADDRCONF(NETDEV_CHANGE): veth798434cc: link becomes ready [ 184.979846] cni0: port 1(veth798434cc) entered blocking state [ 184.983994] cni0: port 1(veth798434cc) entered forwarding state [ 187.914848] cni0: port 2(vetheb63dc02) entered blocking state [ 187.919483] cni0: port 2(vetheb63dc02) entered disabled state [ 187.925958] device vetheb63dc02 entered promiscuous mode [ 187.935035] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 187.939565] IPv6: ADDRCONF(NETDEV_CHANGE): vetheb63dc02: link becomes ready [ 187.944878] cni0: port 2(vetheb63dc02) entered blocking state [ 187.949222] cni0: port 2(vetheb63dc02) entered forwarding state