[=3hWelcome to GRUB! check_signatures=no cmddevice=hd0,gpt1 cmdpath=(hd0,gpt1)/EFI/BOOT color_highlight=black/light-gray color_normal=light-gray/black feature_200_final=y feature_all_video_module=y feature_chainloader_bpb=y feature_default_font_path=y feature_menuentry_id=y feature_menuentry_options=y feature_nativedisk_cmd=y feature_ntldr=y feature_platform_search_hint=y feature_timeout_style=y grub_cpu=arm64 grub_platform=efi lang= locale_dir= net_default_ip=(null) net_default_mac=(null) net_default_server= pager= prefix=(memdisk) pxe_default_server= root=hd0,gpt1 secondary_locale_dir= error: serial port `com0' isn't found. error: terminal `serial' isn't found. error: terminal `serial' isn't found. GNU GRUB version 2.02 ┌────────────────────────────────────────────────────────────────────────────┐││││││││││││││││││││││││││└────────────────────────────────────────────────────────────────────────────┘ Use the ▲ and ▼ keys to select which entry is highlighted. Press enter to boot the selected OS, `e' to edit the commands before booting or `c' for a command-line.  *Flatcar default  Flatcar USR-A  Flatcar USR-B             The highlighted entry will be executed automatically in 1s.  The highlighted entry will be executed automatically in 0s.  Booting `Flatcar default' EFI stub: Booting Linux Kernel... EFI stub: Using DTB from configuration table EFI stub: Exiting boot services... [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] [ 0.000000] Linux version 5.15.154-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 11.3.1_p20221209 p3) 11.3.1 20221209, GNU ld (Gentoo 2.39 p5) 2.39.0) #1 SMP PREEMPT Fri Apr 12 17:21:24 -00 2024 [ 0.000000] earlycon: pl11 at MMIO 0x00000000effec000 (options '') [ 0.000000] printk: bootconsole [pl11] enabled [ 0.000000] efi: EFI v2.70 by EDK II [ 0.000000] efi: ACPI 2.0=0x3fd89018 SMBIOS=0x3fd66000 SMBIOS 3.0=0x3fd64000 MEMATTR=0x3ef3c198 RNG=0x3fd89998 MEMRESERVE=0x37b33f98 [ 0.000000] random: crng init done [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x000000003FD89018 000024 (v02 VRTUAL) [ 0.000000] ACPI: XSDT 0x000000003FD89F18 00006C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: FACP 0x000000003FD89C18 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: DSDT 0x000000003EBD2018 01DEC0 (v02 MSFTVM DSDT01 00000001 MSFT 05000000) [ 0.000000] ACPI: DBG2 0x000000003FD89B18 000072 (v00 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: GTDT 0x000000003FD89D98 000060 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: OEM0 0x000000003FD89098 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: SPCR 0x000000003FD89A98 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: APIC 0x000000003FD89818 0000FC (v04 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: SRAT 0x000000003FD89198 000234 (v03 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: PPTT 0x000000003FD89418 000120 (v01 VRTUAL MICROSFT 00000000 MSFT 00000000) [ 0.000000] ACPI: BGRT 0x000000003FD89E98 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: SPCR: console: pl011,mmio32,0xeffec000,115200 [ 0.000000] NUMA: Failed to initialise from firmware [ 0.000000] NUMA: Faking a node at [mem 0x0000000000000000-0x00000001bfffffff] [ 0.000000] NUMA: NODE_DATA [mem 0x1bf7f2900-0x1bf7f7fff] [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000000000-0x00000000ffffffff] [ 0.000000] DMA32 empty [ 0.000000] Normal [mem 0x0000000100000000-0x00000001bfffffff] [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000000000-0x00000000007fffff] [ 0.000000] node 0: [mem 0x0000000000824000-0x000000003ec80fff] [ 0.000000] node 0: [mem 0x000000003ec81000-0x000000003eca9fff] [ 0.000000] node 0: [mem 0x000000003ecaa000-0x000000003fd29fff] [ 0.000000] node 0: [mem 0x000000003fd2a000-0x000000003fd7dfff] [ 0.000000] node 0: [mem 0x000000003fd7e000-0x000000003fd89fff] [ 0.000000] node 0: [mem 0x000000003fd8a000-0x000000003fd8dfff] [ 0.000000] node 0: [mem 0x000000003fd8e000-0x000000003fffffff] [ 0.000000] node 0: [mem 0x0000000100000000-0x00000001bfffffff] [ 0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x00000001bfffffff] [ 0.000000] On node 0, zone DMA: 36 pages in unavailable ranges [ 0.000000] psci: probing for conduit method from ACPI. [ 0.000000] psci: PSCIv1.1 detected in firmware. [ 0.000000] psci: Using standard PSCI v0.2 function IDs [ 0.000000] psci: MIGRATE_INFO_TYPE not supported. [ 0.000000] psci: SMC Calling Convention v1.4 [ 0.000000] ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x0 -> Node -1 [ 0.000000] ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x1 -> Node -1 [ 0.000000] percpu: Embedded 30 pages/cpu s83032 r8192 d31656 u122880 [ 0.000000] Detected PIPT I-cache on CPU0 [ 0.000000] CPU features: detected: GIC system register CPU interface [ 0.000000] CPU features: detected: Hardware dirty bit management [ 0.000000] CPU features: detected: Spectre-BHB [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI) [ 0.000000] CPU features: detected: ARM erratum 1418040 [ 0.000000] CPU features: detected: ARM erratum 1542419 (kernel portion) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1032156 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=tty1 console=ttyAMA0,115200n8 earlycon=pl011,0xeffec000 flatcar.first_boot=detected acpi=force flatcar.oem.id=azure flatcar.autologin verity.usrhash=c0b96868344262519ffdb2dae3782c942008a0fecdbc0bc85d2e170bd2e8b8a8 [ 0.000000] Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. [ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) [ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) [ 0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off [ 0.000000] software IO TLB: mapped [mem 0x000000003abd2000-0x000000003ebd2000] (64MB) [ 0.000000] Memory: 3990264K/4194160K available (9792K kernel code, 2092K rwdata, 7568K rodata, 36352K init, 777K bss, 203896K 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.007821] Console: colour dummy device 80x25 [ 0.012216] printk: console [tty1] enabled [ 0.016150] ACPI: Core revision 20210730 [ 0.020014] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) [ 0.029893] pid_max: default: 32768 minimum: 301 [ 0.034445] LSM: Security Framework initializing [ 0.038955] SELinux: Initializing. [ 0.042296] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) [ 0.049473] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) [ 0.057334] Hyper-V: privilege flags low 0x2e7f, high 0x3a8030, hints 0xe, misc 0x31e1 [ 0.065158] Hyper-V: Host Build 10.0.22477.1369-1-0 [ 0.069833] rcu: Hierarchical SRCU implementation. [ 0.074599] Remapping and enabling EFI services. [ 0.079389] smp: Bringing up secondary CPUs ... [ 0.083940] Detected PIPT I-cache on CPU1 [ 0.083963] GICv3: CPU1: found redistributor 1 region 1:0x00000000f000e000 [ 0.084011] arch_timer: Enabling local workaround for ARM erratum 1418040 [ 0.084051] CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] [ 0.084106] smp: Brought up 1 node, 2 CPUs [ 0.111861] SMP: Total of 2 processors activated. [ 0.116353] CPU features: detected: 32-bit EL0 Support [ 0.121245] CPU features: detected: Instruction cache invalidation not required for I/D coherence [ 0.129889] CPU features: detected: Data cache clean to the PoU not required for I/D coherence [ 0.138306] CPU features: detected: CRC32 instructions [ 0.143753] CPU features: detected: RCpc load-acquire (LDAPR) [ 0.149424] CPU features: detected: LSE atomic instructions [ 0.154764] CPU features: detected: Privileged Access Never [ 0.204482] CPU: All CPU(s) started at EL1 [ 0.208378] alternatives: patching kernel code [ 0.213238] devtmpfs: initialized [ 0.216502] KASLR enabled [ 0.219007] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.228413] futex hash table entries: 512 (order: 3, 32768 bytes, linear) [ 0.234874] pinctrl core: initialized pinctrl subsystem [ 0.240081] SMBIOS 3.1.0 present. [ 0.243248] DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 11/28/2023 [ 0.253179] NET: Registered PF_NETLINK/PF_ROUTE protocol family [ 0.258977] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.265779] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.273269] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.280741] audit: initializing netlink subsys (disabled) [ 0.286096] audit: type=2000 audit(0.086:1): state=initialized audit_enabled=0 res=1 [ 0.286181] thermal_sys: Registered thermal governor 'step_wise' [ 0.293655] cpuidle: using governor menu [ 0.304041] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. [ 0.310826] ASID allocator initialised with 32768 entries [ 0.316278] ACPI: bus type PCI registered [ 0.320069] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.326250] Serial: AMBA PL011 UART driver [ 0.330874] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.337284] HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages [ 0.343851] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.351118] HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages [ 0.477164] cryptd: max_cpu_qlen set to 1000 [ 0.484378] alg: No test for fips(ansi_cprng) (fips_ansi_cprng) [ 0.490967] ACPI: Added _OSI(Module Device) [ 0.495812] ACPI: Added _OSI(Processor Device) [ 0.500728] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.505661] ACPI: Added _OSI(Processor Aggregator Device) [ 0.511246] ACPI: Added _OSI(Linux-Dell-Video) [ 0.515709] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) [ 0.520720] ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) [ 0.530603] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.537012] ACPI: Interpreter enabled [ 0.540444] ACPI: Using GIC for interrupt routing [ 0.545464] ARMH0011:00: ttyAMA0 at MMIO 0xeffec000 (irq = 12, base_baud = 0) is a SBSA [ 0.553238] printk: console [ttyAMA0] enabled [ 0.553238] printk: console [ttyAMA0] enabled [ 0.560543] printk: bootconsole [pl11] disabled [ 0.560543] printk: bootconsole [pl11] disabled [ 0.568312] ARMH0011:01: ttyAMA1 at MMIO 0xeffeb000 (irq = 13, base_baud = 0) is a SBSA [ 0.574461] iommu: Default domain type: Translated [ 0.577811] iommu: DMA domain TLB invalidation policy: strict mode [ 0.582014] vgaarb: loaded [ 0.583973] pps_core: LinuxPPS API ver. 1 registered [ 0.587615] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.593932] PTP clock support registered [ 0.596643] Registered efivars operations [ 0.599396] No ACPI PMU IRQ for CPU0 [ 0.602019] No ACPI PMU IRQ for CPU1 [ 0.604696] clocksource: Switched to clocksource arch_sys_counter [ 0.614944] VFS: Disk quotas dquot_6.6.0 [ 0.617936] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.622864] pnp: PnP ACPI init [ 0.625044] pnp: PnP ACPI: found 0 devices [ 0.629792] NET: Registered PF_INET protocol family [ 0.633392] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) [ 0.639198] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) [ 0.645293] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) [ 0.651229] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) [ 0.656845] TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) [ 0.662514] TCP: Hash tables configured (established 32768 bind 32768) [ 0.667329] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) [ 0.672309] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) [ 0.677485] NET: Registered PF_UNIX/PF_LOCAL protocol family [ 0.681800] PCI: CLS 0 bytes, default 64 [ 0.693790] hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 1 counters available [ 0.699448] kvm [1]: HYP mode not available [ 0.885983] Initialise system trusted keyrings [ 0.889335] workingset: timestamp_bits=39 max_order=20 bucket_order=0 [ 0.895105] Key type asymmetric registered [ 0.897924] Asymmetric key parser 'x509' registered [ 0.901258] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) [ 0.907964] io scheduler mq-deadline registered [ 0.911287] io scheduler kyber registered [ 0.914338] io scheduler bfq registered [ 0.917974] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 0.923566] thunder_xcv, ver 1.0 [ 0.925902] thunder_bgx, ver 1.0 [ 0.928111] nicpf, ver 1.0 [ 0.929984] nicvf, ver 1.0 [ 0.932149] rtc-efi rtc-efi.0: registered as rtc0 [ 0.935814] rtc-efi rtc-efi.0: setting system clock to 2024-04-12T18:31:47 UTC (1712946707) [ 0.941617] efifb: probing for efifb [ 0.944109] efifb: framebuffer at 0x40000000, using 3072k, total 3072k [ 0.948540] efifb: mode is 1024x768x32, linelength=4096, pages=1 [ 0.952771] efifb: scrolling: redraw [ 0.955176] efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 [ 0.960910] Console: switching to colour frame buffer device 128x48 [ 0.966512] fb0: EFI VGA frame buffer device [ 0.969524] SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... [ 0.973984] hid: raw HID events driver (C) Jiri Kosina [ 0.977610] NET: Registered PF_INET6 protocol family [ 0.981284] Segment Routing with IPv6 [ 0.983998] In-situ OAM (IOAM) with IPv6 [ 0.986728] NET: Registered PF_PACKET protocol family [ 0.990245] Key type dns_resolver registered [ 0.993317] registered taskstats version 1 [ 0.996165] Loading compiled-in X.509 certificates [ 1.028879] Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.15.154-flatcar: 8c258d82bbd8df4a9da2c0ea4108142f04be6b34' [ 1.037312] Key type .fscrypt registered [ 1.039921] Key type fscrypt-provisioning registered [ 1.043318] ima: No TPM chip found, activating TPM-bypass! [ 1.047270] ima: Allocated hash algorithm: sha1 [ 1.050757] ima: No architecture policies found [ 1.059398] Freeing unused kernel memory: 36352K [ 1.062916] Run /init as init process [ 1.081820] 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.104465] systemd[1]: Detected virtualization microsoft. [ 1.109971] systemd[1]: Detected architecture arm64. [ 1.113809] systemd[1]: Running in initrd. Welcome to dracut-053 (Initramfs)! [ 1.120629] systemd[1]: No hostname configured, using default hostname. [ 1.125921] systemd[1]: Hostname set to . [ 1.129973] systemd[1]: Initializing machine ID from random generator. [ 1.224600] systemd[1]: Queued start job for default target initrd.target. [ 1.231454] systemd[1]: Started systemd-ask-password-console.path. [ OK ] Started systemd-ask-password-console.path. [ 1.241591] systemd[1]: Reached target cryptsetup.target. [ OK ] Reached target cryptsetup.target. [ 1.250363] systemd[1]: Reached target paths.target. [ OK ] Reached target paths.target. [ 1.258787] systemd[1]: Reached target slices.target. [ OK ] Reached target slices.target. [ 1.266813] systemd[1]: Reached target swap.target. [ OK ] Reached target swap.target. [ 1.274502] systemd[1]: Reached target timers.target. [ OK ] Reached target timers.target. [ 1.282610] systemd[1]: Listening on iscsid.socket. [ OK ] Listening on iscsid.socket. [ 1.291385] systemd[1]: Listening on iscsiuio.socket. [ OK ] Listening on iscsiuio.socket. [ 1.299854] systemd[1]: Listening on systemd-journald-audit.socket. [ OK ] Listening on systemd-journald-audit.socket. [ 1.309807] systemd[1]: Listening on systemd-journald-dev-log.socket. [ OK ] Listening on systemd-journald-dev-log.socket. [ 1.320037] systemd[1]: Listening on systemd-journald.socket. [ OK ] Listening on systemd-journald.socket. [ 1.329055] systemd[1]: Listening on systemd-networkd.socket. [ OK ] Listening on systemd-networkd.socket. [ 1.339439] systemd[1]: Listening on systemd-udevd-control.socket. [ OK ] Listening on systemd-udevd-control.socket. [ 1.349202] systemd[1]: Listening on systemd-udevd-kernel.socket. [ OK ] Listening on systemd-udevd-kernel.socket. [ 1.358667] systemd[1]: Reached target sockets.target. [ OK ] Reached target sockets.target. [ 1.368429] systemd[1]: Starting kmod-static-nodes.service... Starting kmod-static-nodes.service... [ 1.376951] systemd[1]: Finished network-cleanup.service. [ OK ] Finished network-cleanup.service. [ 1.387137] systemd[1]: Starting systemd-fsck-usr.service... Starting systemd-fsck-usr.service... [ 1.396736] systemd[1]: Starting systemd-journald.service... Starting systemd-journald.service... [ 1.406316] systemd[1]: Starting systemd-modules-load.service... Starting systemd-modules-load.service... [ 1.417274] systemd[1]: Starting systemd-resolved.service... Starting systemd-resolved.service... [ 1.438542] systemd[1]: Starting systemd-vconsole-setup.service... [ 1.092082] systemd-modules-load[237]: Inserted module 'overlay' Starting systemd-vconsole-setup.service... [ 1.458789] systemd[1]: Started systemd-journald.service. [ 1.459573] bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. [ OK ] Started systemd-journald.service. [ 1.479449] audit: type=1130 audit(1712946708.043: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.496800] Bridge firewalling registered [ OK ] Finished kmod-static-nodes.service. [ 1.148690] systemd[1]: Finished kmod-static-nodes.service.[ 1.508729] audit: type=1130 audit(1712946708.068:3): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Finished systemd-fsck-usr.service. [ 1.172730] systemd-resolved[238]: Positive Trust Anchors:[ 1.533281] audit: type=1130 audit(1712946708.092:4): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 1.198351] systemd-resolved[238]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d [ OK ] Started systemd-resolved.service.[ 1.557928] SCSI subsystem initialized [ 1.212660] systemd-resolved[238]: 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.603881] audit: type=1130 audit(1712946708.167:5): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Finished systemd-vconsole-setup.service.[ 1.629002] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. [ 1.270701] systemd-resolved[238]: Defaulting to hostname 'linux'. [ OK ] Reached target nss-lookup.target. [ 1.648845] audit: type=1130 audit(1712946708.203:6): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 1.663380] device-mapper: uevent: version 1.0.3 [ 1.293069] systemd[1]: Finished systemd-fsck-usr.service.[ 1.668538] device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com [ 1.327028] systemd-modules-load[237]: Inserted module 'br_netfilter' [ 1.333166] systemd[1]: Started systemd-resolved.service. Starting dracut-cmdline-ask.service... [ 1.336967] systemd[1]: Finished systemd-vconsole-setup.service. [ 1.347976] systemd[1]: Reached target nss-lookup.target. Starting systemd-tmpfiles-setup-dev.service... [ 1.352460] systemd[1]: Starting dracut-cmdline-ask.service... [ 1.365473] systemd-modules-load[237]: Inserted module 'dm_multipath' [ OK ] Finished systemd-modules-load.service. [ 1.370255] systemd[1]: Starting systemd-tmpfiles-setup-dev.service...[ 1.730853] audit: type=1130 audit(1712946708.290:7): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Finished dracut-cmdline-ask.service. [ 1.395421] systemd[1]: Finished systemd-modules-load.service. [ OK ] Finished systemd-tmpfiles-setup-dev.service. [ 1.760196] audit: type=1130 audit(1712946708.315:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 1.403920] systemd[1]: Finished dracut-cmdline-ask.service. Starting dracut-cmdline.service...[ 1.782890] audit: type=1130 audit(1712946708.339:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Starting systemd-sysctl.service... [ 1.427983] systemd[1]: Finished systemd-tmpfiles-setup-dev.service. [ OK ] Finished systemd-sysctl.service. [ 1.463634] systemd[1]: Starting dracut-cmdline.service...[ 1.819953] audit: type=1130 audit(1712946708.378:10): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 1.485349] dracut-cmdline[256]: dracut-dracut-053 [ 1.488995] dracut-cmdline[256]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=tty1 console=t [ 1.510717] dracut-cmdline[256]: tyAMA0,115200n8 earlycon=pl011,0xeffec000 flatcar.first_boot=detected acpi=force flatcar.oem.id=azure flatcar.autologin verity.usrhash=c0b96868344262519ffdb2dae3782c942008a0fecdbc0bc85d2e170bd2e8b8a8 [ 1.527251] systemd[1]: Starting systemd-sysctl.service... [ 1.532543] systemd[1]: Finished systemd-sysctl.service.[ 1.884363] Loading iSCSI transport class v2.0-870. [ 1.905437] iscsi: registered transport (tcp) [ 1.923280] iscsi: registered transport (qla4xxx) [ 1.927441] QLogic iSCSI HBA Driver [ OK ] Finished dracut-cmdline.service. [ 1.614947] systemd[1]: Finished dracut-cmdline.service. Starting dracut-pre-udev.service... [ 1.623134] systemd[1]: Starting dracut-pre-udev.service... [ 2.020698] raid6: neonx8 gen() 13812 MB/s [ 2.041700] raid6: neonx8 xor() 10825 MB/s [ 2.061721] raid6: neonx4 gen() 13545 MB/s [ 2.082697] raid6: neonx4 xor() 11112 MB/s [ 2.102698] raid6: neonx2 gen() 12950 MB/s [ 2.122697] raid6: neonx2 xor() 10393 MB/s [ 2.143698] raid6: neonx1 gen() 10527 MB/s [ 2.163697] raid6: neonx1 xor() 8790 MB/s [ 2.184698] raid6: int64x8 gen() 6270 MB/s [ 2.205698] raid6: int64x8 xor() 3544 MB/s [ 2.225707] raid6: int64x4 gen() 7190 MB/s [ 2.245700] raid6: int64x4 xor() 3859 MB/s [ 2.266700] raid6: int64x2 gen() 6149 MB/s [ 2.286698] raid6: int64x2 xor() 3322 MB/s [ 2.306700] raid6: int64x1 gen() 5049 MB/s [ 2.327700] raid6: int64x1 xor() 2646 MB/s [ 2.331340] raid6: using algorithm neonx8 gen() 13812 MB/s [ 2.336284] raid6: .... xor() 10825 MB/s, rmw enabled [ 2.340755] raid6: using neon recovery algorithm [ 2.353619] xor: measuring software checksum speed [ 2.359597] 8regs : 17300 MB/sec [ 2.363722] 32regs : 20744 MB/sec [ 2.367620] arm64_neon : 27920 MB/sec [ 2.371293] xor: using function: arm64_neon (27920 MB/sec) [ 2.425388] Btrfs loaded, crc32c=crc32c-generic, zoned=no, fsverity=no [ OK ] Finished dracut-pre-udev.service. [ 2.090929] systemd[1]: Finished dracut-pre-udev.service. Starting systemd-udevd.service... [ 2.100360] systemd[1]: Starting systemd-udevd.service... [ 2.117367] systemd-udevd[436]: Using default interface naming scheme 'v252'. [ OK ] Started systemd-udevd.service. [ 2.129227] systemd[1]: Started systemd-udevd.service. Starting dracut-pre-trigger.service... [ 2.138813] systemd[1]: Starting dracut-pre-trigger.service... [ 2.152129] dracut-pre-trigger[455]: rd.md=0: removing MD RAID activation [ OK ] Finished dracut-pre-trigger.service. [ 2.182143] systemd[1]: Finished dracut-pre-trigger.service. [ 2.190635] systemd[1]: Starting systemd-udev-trigger.service... Starting systemd-udev-trigger.service... [ OK ] Finished systemd-udev-trigger.service. [ 2.225688] systemd[1]: Finished systemd-udev-trigger.service. [ 2.634712] hv_vmbus: Vmbus version:5.3 [ 2.649510] hv_vmbus: registering driver hv_storvsc [ 2.654466] hv_vmbus: registering driver hv_netvsc [ 2.658430] hv_vmbus: registering driver hyperv_keyboard [ 2.663074] hv_vmbus: registering driver hid_hyperv [ 2.667850] scsi host0: storvsc_host_t [ 2.671334] input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input0 [ 2.675728] scsi 0:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 [ 2.685545] scsi host1: storvsc_host_t [ 2.685753] hid-generic 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on [ 2.690566] scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 0 [ 2.704669] input: AT Translated Set 2 keyboard as /devices/LNXSYSTM:00/LNXSYBUS:00/ACPI0004:00/VMBUS:00/d34b2567-b9b6-42b9-8778-0a4ec0b955bf/serio0/input/input1 [ 2.730527] sd 0:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB) [ 2.737505] sd 0:0:0:0: [sda] 4096-byte physical blocks [ 2.742050] sd 0:0:0:0: [sda] Write Protect is off [ 2.746100] sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA [ 2.754511] sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 [ 2.759134] sd 0:0:0:0: [sda] Attached SCSI disk [ 2.767776] sr 0:0:0:2: [sr0] scsi-1 drive [ 2.770969] cdrom: Uniform CD-ROM driver Revision: 3.20 [ 2.787641] hv_netvsc 002248b3-ec0b-0022-48b3-ec0b002248b3 eth0: VF slot 1 added [ 2.798937] hv_vmbus: registering driver hv_pci [ 2.804924] hv_pci b55dbe7a-160e-49bf-b649-17c96df5952c: PCI VMBus probing: Using version 0x10004 [ 2.816587] hv_pci b55dbe7a-160e-49bf-b649-17c96df5952c: PCI host bridge to bus 160e:00 [ 2.822795] pci_bus 160e:00: root bus resource [mem 0xfc0000000-0xfc00fffff window] [ 2.828637] pci_bus 160e:00: No busn resource found for root bus, will use [bus 00-ff] [ 2.836334] pci 160e:00:02.0: [15b3:1018] type 00 class 0x020000 [ 2.846487] pci 160e:00:02.0: reg 0x10: [mem 0xfc0000000-0xfc00fffff 64bit pref] [ 2.871868] pci 160e:00:02.0: enabling Extended Tags [ 2.883818] pci 160e:00:02.0: 0.000 Gb/s available PCIe bandwidth, limited by Unknown x0 link at 160e:00:02.0 (capable of 126.016 Gb/s with 8.0 GT/s PCIe x16 link) [ 2.895844] pci_bus 160e:00: busn_res: [bus 00-ff] end is updated to 00 [ 2.901021] pci 160e:00:02.0: BAR 0: assigned [mem 0xfc0000000-0xfc00fffff 64bit pref] [ 2.942255] mlx5_core 160e:00:02.0: firmware version: 16.30.1284 [ 3.098973] mlx5_core 160e:00:02.0: MLX5E: StrdRq(1) RqSz(8) StrdSz(2048) RxCqeCmprss(0) [ 3.154197] hv_netvsc 002248b3-ec0b-0022-48b3-ec0b002248b3 eth0: VF registering: eth1 [ 3.160369] mlx5_core 160e:00:02.0 eth1: joined to eth0 [ 3.171843] mlx5_core 160e:00:02.0 enP5646s1: renamed from eth1 [ 2.978351] systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device. [ OK ] Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device. [ 3.365652] BTRFS: device label OEM devid 1 transid 12 /dev/sda6 scanned by (udev-worker) (493) [ OK ] Found device dev-disk-by\x2dlabel-OEM.device. [ 3.035324] systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. [ OK ] Found device dev-disk-by\x…2d8e26\x2d6cce9662f132.device. [ 3.192758] 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.205816] systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device. [ OK ] Found device dev-disk-by\x2dlabel-ROOT.device. Starting disk-uuid.service... [ 3.216309] systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device. [ 3.232808] systemd[1]: Starting disk-uuid.service... [ 3.593797] sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 [ 3.602766] sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 [ 4.611396] sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 [ 4.265065] disk-uuid[563]: The operation has completed successfully. [ OK ] Finished disk-uuid.service. [ 4.320516] systemd[1]: disk-uuid.service: Deactivated successfully. Starting verity-setup.service... [ 4.330830] systemd[1]: Finished disk-uuid.service. [ 4.336364] systemd[1]: Starting verity-setup.service... [ 4.715472] device-mapper: verity: sha256 using implementation "sha256-ce" [ OK ] Found device dev-mapper-usr.device. [ 4.562682] systemd[1]: Found device dev-mapper-usr.device. [ 4.571308] systemd[1]: Mounting sysusr-usr.mount... Mounting sysusr-usr.mount... [ OK ] Finished verity-setup.service. [ 4.580071] systemd[1]: Finished verity-setup.service. [ 4.979266] EXT4-fs (dm-0): mounted filesystem without journal. Opts: norecovery. Quota mode: none. [ OK ] Mounted sysusr-usr.mount. [ 4.636654] systemd[1]: Mounted sysusr-usr.mount. Starting ignition-setup.service... Starting parse-ip-for-networkd.service... [ 4.644248] systemd[1]: afterburn-network-kargs.service was skipped because no trigger condition checks were met. [ 4.661500] systemd[1]: Starting ignition-setup.service... [ 4.666015] systemd[1]: Starting parse-ip-for-networkd.service... [ 5.022208] BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm [ 5.028660] BTRFS info (device sda6): using free space tree [ 5.033354] BTRFS info (device sda6): has skinny extents [ OK ] Finished parse-ip-for-networkd.service. [ 4.734738] systemd[1]: Finished parse-ip-for-networkd.service. Starting systemd-networkd.service... [ 4.745064] systemd[1]: Starting systemd-networkd.service... [ 4.767621] systemd-networkd[804]: lo: Link UP [ OK ] Started systemd-networkd.service. [ OK ] Reached target network.target. [ 4.777514] systemd[1]: mnt-oem.mount: Deactivated successfully. [ 4.786859] systemd-networkd[804]: lo: Gained carrier Starting iscsiuio.service... [ 4.790563] systemd-networkd[804]: Enumeration completed [ OK ] Started iscsiuio.service. [ 4.798442] systemd[1]: Started systemd-networkd.service. Starting iscsid.service... [ 4.806796] systemd[1]: Reached target network.target. [ 4.819379] systemd[1]: Starting iscsiuio.service... [ 4.823451] systemd-networkd[804]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. [ OK ] Started iscsid.service. [ OK ] Finished ignition-setup.service. [ 4.835465] iscsid[813]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Starting dracut-initqueue.service... [ 4.852074] iscsid[813]: 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 Starting ignition-fetch-offline.service... [ 4.872858] iscsid[813]: into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier]. [ 4.893798] iscsid[813]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. [ OK ] Finished dracut-initqueue.service. [ 4.900071] iscsid[813]: If using hardware iscsi like qla4xxx this message can be ignored. [ OK ] Reached target remote-fs-pre.target. [ 4.911910] iscsid[813]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi [ OK ] Reached target remote-cryptsetup.target. [ 4.923775] iscsid[813]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf [ OK ] Reached target remote-fs.target. [ 4.935528] systemd[1]: Started iscsiuio.service. Starting dracut-pre-mount.service... [ 4.944154] systemd[1]: Starting iscsid.service... [ 4.956553] systemd[1]: Started iscsid.service. [ 4.960655] systemd[1]: Finished ignition-setup.service. [ 4.965141] systemd[1]: Starting dracut-initqueue.service... [ OK ] Finished dracut-pre-mount.service. [ 4.969219] systemd[1]: Starting ignition-fetch-offline.service... [ 4.978342] systemd[1]: Finished dracut-initqueue.service.[ 5.330192] mlx5_core 160e:00:02.0 enP5646s1: Link up [ 4.986114] systemd[1]: Reached target remote-fs-pre.target. [ 4.992056] systemd[1]: Reached target remote-cryptsetup.target. [ 4.996236] systemd[1]: Reached target remote-fs.target. [ 5.000066] systemd[1]: Starting dracut-pre-mount.service... [ 5.004518] systemd[1]: Finished dracut-pre-mount.service. [ 5.368949] hv_netvsc 002248b3-ec0b-0022-48b3-ec0b002248b3 eth0: Data path switched to VF: enP5646s1 [ 5.376454] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 5.030929] systemd-networkd[804]: enP5646s1: Link UP [ 5.035703] systemd-networkd[804]: eth0: Link UP [ 5.039365] systemd-networkd[804]: eth0: Gained carrier [ 5.043748] systemd-networkd[804]: enP5646s1: Gained carrier [ 5.057099] systemd-networkd[804]: eth0: DHCPv4 address 10.200.20.42/24, gateway 10.200.20.1 acquired from 168.63.129.16 [ 6.687745] systemd-networkd[804]: eth0: Gained IPv6LL [* ] Job ignition-fetch-offline.service/start running (6s / no limit) [ 7.265104] ignition[817]: Ignition 2.14.0 [ 7.268256] ignition[817]: Stage: fetch-offline [ 7.271533] ignition[817]: reading system config file "/usr/lib/ignition/base.d/base.ign" [ 7.408244] ignition[817]: no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 7.414356] ignition[817]: no config URL provided M [ OK ] Finished ignition-fetch-offline.service. [ 7.420769] ignition[817]: reading system config file "/usr/lib/ignition/user.ign"[ 7.783082] kauditd_printk_skb: 18 callbacks suppressed [ 7.783086] audit: type=1130 audit(1712946714.341: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' [ 7.452671] systemd[1]: Finished ignition-fetch-offline.service. Starting ignition-fetch.service... [ 7.457198] ignition[817]: no config at "/usr/lib/ignition/user.ign" [ 7.469109] systemd[1]: Starting ignition-fetch.service... [ 7.473744] ignition[817]: failed to fetch config: resource requires networking [ 7.479776] ignition[817]: Ignition finished successfully [ 7.484351] ignition[834]: Ignition 2.14.0 [ 7.488049] ignition[834]: Stage: fetch [ 7.490858] ignition[834]: reading system config file "/usr/lib/ignition/base.d/base.ign" [ 7.496712] ignition[834]: no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 7.502394] ignition[834]: no config URL provided [ 7.506088] ignition[834]: reading system config file "/usr/lib/ignition/user.ign" [ 7.513387] ignition[834]: fetched base config from "system" [ OK ] Finished ignition-fetch.service. [ 7.517663] ignition[834]: no config at "/usr/lib/ignition/user.ign"[ 7.877806] audit: type=1130 audit(1712946714.437: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' [ 7.542434] [834]: fetched base config from "system" Starting ignition-kargs.service... [ 7.546551] ignition[834]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 [ 7.561362] [834]: fetched user config from "azure" [ 7.565296] ignition[834]: GET result: OK [ OK ] Finished ignition-kargs.service. [ 7.569075] systemd[1]: Finished ignition-fetch.service.[ 7.924322] audit: type=1130 audit(1712946714.488:31): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-kargs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Starting ignition-disks.service... [ 7.590084] ignition[834]: config has been read from IMDS userdata [ 7.599815] systemd[1]: Starting ignition-kargs.service... [ OK ] Finished ignition-disks.service. [ 7.614919] systemd[1]: Finished ignition-kargs.service. [ 7.971272] audit: type=1130 audit(1712946714.531:32): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-disks comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Reached target initrd-root-device.target. [ 7.619791] ignition[834]: fetch: fetch complete [ OK ] Reached target local-fs-pre.target. [ 7.645761] systemd[1]: Starting ignition-disks.service... [ OK ] Reached target local-fs.target. [ 7.654385] ignition[834]: fetch: fetch passed [ OK ] Reached target sysinit.target. [ 7.662428] systemd[1]: Finished ignition-disks.service. [ OK ] Reached target basic.target. [ 7.670610] ignition[834]: Ignition finished successfully [ 7.679017] systemd[1]: Reached target initrd-root-device.target. Starting systemd-fsck-root.service... [ 7.684066] ignition[840]: Ignition 2.14.0 [ 7.693421] systemd[1]: Reached target local-fs-pre.target. [ 7.697800] ignition[840]: Stage: kargs [ 7.700693] systemd[1]: Reached target local-fs.target. [ 7.704812] ignition[840]: reading system config file "/usr/lib/ignition/base.d/base.ign" [ 7.710790] systemd[1]: Reached target sysinit.target. [ 7.714603] systemd[1]: Reached target basic.target. [ 7.718642] ignition[840]: no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 7.724896] systemd[1]: Starting systemd-fsck-root.service... [ 7.729408] ignition[840]: kargs: kargs passed [ 7.732966] ignition[840]: Ignition finished successfully [ 7.737169] ignition[846]: Ignition 2.14.0 [ 7.740481] ignition[846]: Stage: disks [ 7.743464] ignition[846]: reading system config file "/usr/lib/ignition/base.d/base.ign" [ 7.749442] ignition[846]: no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 7.755063] ignition[846]: disks: disks passed [ 7.758191] ignition[846]: Ignition finished successfully [ 7.777782] systemd-fsck[854]: ROOT: clean, 612/7326000 files, 481074/7359488 blocks [ OK ] Finished systemd-fsck-root.service. [ 7.787422] systemd[1]: Finished systemd-fsck-root.service.[ 8.142711] audit: type=1130 audit(1712946714.706:33): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mounting sysroot.mount... [ 7.814593] systemd[1]: Mounting sysroot.mount... [ 8.178078] EXT4-fs (sda9): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none. [ 7.835023] systemd[1]: Mounted sysroot.mount. [ OK ] Mounted sysroot.mount. [ OK ] Reached target initrd-root-fs.target. [ 7.841858] systemd[1]: Reached target initrd-root-fs.target. Mounting sysroot-usr.mount... [ 7.879546] systemd[1]: Mounting sysroot-usr.mount... Starting flatcar-metadata-hostname.service... [ OK ] Reached target ignition-diskful.target. [ 7.884315] systemd[1]: Starting flatcar-metadata-hostname.service... [ OK ] Mounted sysroot-usr.mount. [ 7.899326] systemd[1]: ignition-remount-sysroot.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). [ 7.913715] systemd[1]: Reached target ignition-diskful.target. [ 7.918237] systemd[1]: Mounted sysroot-usr.mount. Mounting sysroot-usr-share-oem.mount... [ 7.949898] systemd[1]: Mounting sysroot-usr-share-oem.mount... [ 7.956208] systemd[1]: Starting initrd-setup-root.service... Starting initrd-setup-root.service... [ 8.317606] BTRFS: device label OEM devid 1 transid 14 /dev/sda6 scanned by mount (864) [ 8.325819] BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm [ 8.332256] BTRFS info (device sda6): using free space tree [ 8.336839] BTRFS info (device sda6): has skinny extents [ 7.980627] initrd-setup-root[869]: cut: /sysroot/etc/passwd: No such file or directory [ OK ] Mounted sysroot-usr-share-oem.mount. [ 7.999375] systemd[1]: Mounted sysroot-usr-share-oem.mount. [ 8.011388] initrd-setup-root[895]: cut: /sysroot/etc/group: No such file or directory [ 8.032762] initrd-setup-root[903]: cut: /sysroot/etc/shadow: No such file or directory [ 8.041427] initrd-setup-root[911]: cut: /sysroot/etc/gshadow: No such file or directory [ OK ] Finished initrd-setup-root.service. [ 8.618187] systemd[1]: Finished initrd-setup-root.service.[ 8.974410] audit: type=1130 audit(1712946715.538:34): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Starting ignition-mount.service... [ 8.644970] systemd[1]: Starting ignition-mount.service... [ 8.654018] systemd[1]: Starting sysroot-boot.service... Starting sysroot-boot.service... [ 8.663299] systemd[1]: sysusr-usr-share-oem.mount: Deactivated successfully. [ 8.668917] systemd[1]: sysroot-usr-share-oem.mount: Deactivated successfully. [ OK ] Finished sysroot-boot.service. [ 8.680555] systemd[1]: Finished sysroot-boot.service.[ 9.040318] audit: type=1130 audit(1712946715.600:35): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 8.773040] ignition[933]: INFO : Ignition 2.14.0 [ 8.782187] ignition[933]: INFO : Stage: mount [ 8.786743] ignition[933]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" [ 8.793883] ignition[933]: DEBUG : parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63 [ 8.807226] ignition[933]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" [ OK ] Finished ignition-mount.service. [ 8.813466] ignition[933]: INFO : mount: mount passed[ 9.169412] audit: type=1130 audit(1712946715.733:36): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 8.835986] ignition[933]: INFO : Ignition finished successfully [ 8.843085] systemd[1]: Finished ignition-mount.service. [ 9.252296] coreos-metadata[863]: Apr 12 18:31:56.167 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 [ 9.262325] coreos-metadata[863]: Apr 12 18:31:56.178 INFO Fetch successful [ 9.296299] coreos-metadata[863]: Apr 12 18:31:56.212 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 [ 9.309719] coreos-metadata[863]: Apr 12 18:31:56.225 INFO Fetch successful [ 9.328118] coreos-metadata[863]: Apr 12 18:31:56.243 INFO wrote hostname ci-3510.3.3-a-1633230817 to /sysroot/etc/hostname [ OK ] Finished flatcar-metadata-hostname.service. [ 9.337078] systemd[1]: Finished flatcar-metadata-hostname.service.[ 9.698031] audit: type=1130 audit(1712946716.257: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... [ 9.363859] systemd[1]: Starting ignition-files.service... Mounting sysroot-usr-share-oem.mount... [ 9.369036] systemd[1]: Mounting sysroot-usr-share-oem.mount... [ 9.731665] BTRFS: device label OEM devid 1 transid 15 /dev/sda6 scanned by mount (942) [ 9.738733] BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm [ 9.744936] BTRFS info (device sda6): using free space tree [ 9.750261] BTRFS info (device sda6): has skinny extents [ OK ] Mounted sysroot-usr-share-oem.mount. [ 9.408151] systemd[1]: Mounted sysroot-usr-share-oem.mount. [ 9.422123] ignition[961]: INFO : Ignition 2.14.0 [ 9.425904] ignition[961]: INFO : Stage: files [ 9.429452] ignition[961]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" [ 9.436325] ignition[961]: DEBUG : parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63 [ 9.449122] ignition[961]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 9.455688] ignition[961]: DEBUG : files: compiled without relabeling support, skipping [ 9.462117] ignition[961]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" [ 9.469618] ignition[961]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" [ 9.513468] ignition[961]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" [ 9.521204] ignition[961]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" [ 9.528426] ignition[961]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" [ 9.535796] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/opt/cni-plugins-linux-arm64-v1.3.0.tgz" [ 9.546463] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(3): GET https://github.com/containernetworking/plugins/releases/download/v1.3.0/cni-plugins-linux-arm64-v1.3.0.tgz: attempt #1 [ 9.561315] ignition[961]: wrote ssh authorized keys file for user: core [ 9.875103] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(3): GET result: OK [ 10.157720] ignition[961]: DEBUG : files: createFilesystemsFiles: createFiles: op(3): file matches expected sum of: b2b7fb74f1b3cb8928f49e5bf9d4bc686e057e837fac3caf1b366d54757921dba80d70cc010399b274d136e8dee9a25b1ad87cdfdc4ffcf42cf88f3e8f99587a [ 10.174977] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/opt/cni-plugins-linux-arm64-v1.3.0.tgz" [ 10.186614] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/opt/crictl-v1.27.0-linux-arm64.tar.gz" [ 10.197244] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(4): GET https://github.com/kubernetes-sigs/cri-tools/releases/download/v1.27.0/crictl-v1.27.0-linux-arm64.tar.gz: attempt #1 [ 10.447383] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(4): GET result: OK [ 10.588410] ignition[961]: DEBUG : files: createFilesystemsFiles: createFiles: op(4): file matches expected sum of: db062e43351a63347871e7094115be2ae3853afcd346d47f7b51141da8c3202c2df58d2e17359322f632abcb37474fd7fdb3b7aadbc5cfd5cf6d3bad040b6251 [ 10.605024] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/opt/crictl-v1.27.0-linux-arm64.tar.gz" [ 10.615936] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing file "/sysroot/opt/bin/kubeadm" [ 10.624683] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(5): GET https://dl.k8s.io/release/v1.28.1/bin/linux/arm64/kubeadm: attempt #1 [ 10.806626] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(5): GET result: OK [ 11.137879] ignition[961]: DEBUG : files: createFilesystemsFiles: createFiles: op(5): file matches expected sum of: 5a08b81f9cc82d3cce21130856ca63b8dafca9149d9775dd25b376eb0f18209aa0e4a47c0a6d7e6fb1316aacd5d59dec770f26c09120c866949d70bc415518b3 [ 11.154357] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing file "/sysroot/opt/bin/kubeadm" [ 11.163647] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/opt/bin/kubelet" [ 11.175028] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET https://dl.k8s.io/release/v1.28.1/bin/linux/arm64/kubelet: attempt #1 [ 11.192502] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET result: OK [** ] Job ignition-files.service/start running (10s / no limit) [ 11.816083] ignition[961]: DEBUG : files: createFilesystemsFiles: createFiles: op(6): file matches expected sum of: 5a898ef543a6482895101ea58e33602e3c0a7682d322aaf08ac3dc8a5a3c8da8f09600d577024549288f8cebb1a86f9c79927796b69a3d8fe989ca8f12b147d6 [ 11.832014] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/opt/bin/kubelet"[ 12.192938] BTRFS info: devid 1 device path /dev/sda6 changed to /dev/disk/by-label/OEM scanned by ignition (966) [ 11.849041] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(7): [started] writing file "/sysroot/home/core/install.sh" [ 11.860587] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(7): [finished] writing file "/sysroot/home/core/install.sh" [ 11.870966] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(8): [started] writing file "/sysroot/etc/docker/daemon.json" [ 11.881282] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(8): [finished] writing file "/sysroot/etc/docker/daemon.json" [ 11.891466] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(9): [started] writing file "/sysroot/etc/flatcar/update.conf" [ 11.901359] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(9): [finished] writing file "/sysroot/etc/flatcar/update.conf" [ 11.912227] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(a): [started] writing file "/sysroot/etc/systemd/system/waagent.service" M [ OK ] Finished ignition-files.service. [ 11.922481] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(a): oem config not found in "/usr/share/oem", looking on oem partition[ 12.289162] audit: type=1130 audit(1712946718.843: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... [ 11.958283] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(a): op(b): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3252836293" Starting ignition-quench.service... [ 11.972671] ignition[961]: CRITICAL : files: createFilesystemsFiles: createFiles: op(a): op(b): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3252836293": device or resource busy [ OK ] Finished ignition-quench.service. [ 11.989078] ignition[961]: ERROR : files: createFilesystemsFiles: createFiles: op(a): failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem3252836293", trying btrfs: device or resource busy [ 12.009943] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(a): op(c): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3252836293" [ OK ] Finished initrd-setup-root-after-ignition.service. [ 12.022024] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(a): op(c): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3252836293" [ OK ] Reached target ignition-complete.target. [ 12.040463] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(a): op(d): [started] unmounting "/mnt/oem3252836293" Starting initrd-parse-etc.service... [ 12.061405] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(a): op(d): [finished] unmounting "/mnt/oem3252836293" [ 12.071515] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(a): [finished] writing file "/sysroot/etc/systemd/system/waagent.service" [ OK ] Finished initrd-parse-etc.service. [ 12.081832] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(e): [started] writing file "/sysroot/etc/systemd/system/nvidia.service" [ OK ] Reached target initrd-fs.target. [ 12.096387] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(e): oem config not found in "/usr/share/oem", looking on oem partition [ OK ] Reached target initrd.target. [ 12.111281] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(e): op(f): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3545706697" Starting dracut-pre-pivot.service... [ 12.130492] ignition[961]: CRITICAL : files: createFilesystemsFiles: createFiles: op(e): op(f): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3545706697": device or resource busy [ 12.146067] ignition[961]: ERROR : files: createFilesystemsFiles: createFiles: op(e): failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem3545706697", trying btrfs: device or resource busy [ 12.161715] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(e): op(10): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3545706697" [ 12.175660] systemd[1]: mnt-oem3252836293.mount: Deactivated successfully. [ 12.182688] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(e): op(10): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3545706697" [ 12.195263] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(e): op(11): [started] unmounting "/mnt/oem3545706697" [ OK ] Finished dracut-pre-pivot.service. [ 12.205421] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(e): op(11): [finished] unmounting "/mnt/oem3545706697" Starting initrd-cleanup.service... [ 12.225517] ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(e): [finished] writing file "/sysroot/etc/systemd/system/nvidia.service" [ 12.237113] ignition[961]: INFO : files: op(12): [started] processing unit "waagent.service" [ OK ] Stopped target nss-lookup.target. [ 12.244832] ignition[961]: INFO : files: op(12): [finished] processing unit "waagent.service" [ OK ] Stopped target remote-cryptsetup.target. [ 12.257305] ignition[961]: INFO : files: op(13): [started] processing unit "nvidia.service" [ OK ] Stopped target timers.target. [ 12.269910] ignition[961]: INFO : files: op(13): [finished] processing unit "nvidia.service" [ OK ] Stopped dracut-pre-pivot.service. [ 12.281760] ignition[961]: INFO : files: op(14): [started] processing unit "prepare-cni-plugins.service" [ OK ] Stopped target initrd.target. [ 12.294944] ignition[961]: INFO : files: op(14): op(15): [started] writing unit "prepare-cni-plugins.service" at "/sysroot/etc/systemd/system/prepare-cni-plugins.service" [ OK ] Stopped target basic.target. [ 12.312415] ignition[961]: INFO : files: op(14): op(15): [finished] writing unit "prepare-cni-plugins.service" at "/sysroot/etc/systemd/system/prepare-cni-plugins.service" [ OK ] Stopped target ignition-complete.target. [ 12.329527] ignition[961]: INFO : files: op(14): [finished] processing unit "prepare-cni-plugins.service" [ OK ] Stopped target ignition-diskful.target. [ 12.343049] ignition[961]: INFO : files: op(16): [started] processing unit "prepare-critools.service" [ OK ] Stopped target initrd-root-device.target. [ 12.356240] ignition[961]: INFO : files: op(16): op(17): [started] writing unit "prepare-critools.service" at "/sysroot/etc/systemd/system/prepare-critools.service" [ OK ] Stopped target remote-fs.target. [ 12.373805] ignition[961]: INFO : files: op(16): op(17): [finished] writing unit "prepare-critools.service" at "/sysroot/etc/systemd/system/prepare-critools.service" [ OK ] Stopped target remote-fs-pre.target. [ 12.392675] ignition[961]: INFO : files: op(16): [finished] processing unit "prepare-critools.service" [ OK ] Stopped target sysinit.target. [ 12.407603] ignition[961]: INFO : files: op(18): [started] setting preset to enabled for "prepare-critools.service" [ OK ] Stopped target local-fs.target. [ 12.421214] ignition[961]: INFO : files: op(18): [finished] setting preset to enabled for "prepare-critools.service" [ OK ] Stopped target local-fs-pre.target. [ 12.435136] ignition[961]: INFO : files: op(19): [started] setting preset to enabled for "waagent.service" [ OK ] Stopped target swap.target. [ 12.448121] ignition[961]: INFO : files: op(19): [finished] setting preset to enabled for "waagent.service" [ OK ] Stopped dracut-pre-mount.service. [ 12.460950] systemd[1]: Finished ignition-files.service.[ 12.817445] kauditd_printk_skb: 7 callbacks suppressed [ 12.817448] audit: type=1131 audit(1712946719.381: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' [ 12.474385] ignition[961]: INFO : files: op(1a): [started] setting preset to enabled for "nvidia.service" [ OK ] Stopped target cryptsetup.target. [ 12.501414] ignition[961]: INFO : files: op(1a): [finished] setting preset to enabled for "nvidia.service" [ OK ] Stopped dracut-initqueue.service. [ 12.514307] ignition[961]: INFO : files: op(1b): [started] setting preset to enabled for "prepare-cni-plugins.service"[ 12.870857] audit: type=1131 audit(1712946719.434: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' [ 12.543898] ignition[961]: INFO : files: op(1b): [finished] setting preset to enabled for "prepare-cni-plugins.service" [ OK ] Stopped initrd-setup-root-after-ignition.service. [ 12.555517] ignition[961]: INFO : files: createResultFile: createFiles: op(1c): [started] writing file "/sysroot/etc/.ignition-result.json" [ 12.923361] audit: type=1131 audit(1712946719.477:48): 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 ] Stopped ignition-files.service. [ 12.945630] audit: type=1131 audit(1712946719.509:49): 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' [ OK ] Stopped flatcar-metadata-hostname.service. [ 12.624299] ignition[961]: INFO : files: createResultFile: createFiles: op(1c): [finished] writing file "/sysroot/etc/.ignition-result.json"[ 12.986342] audit: type=1131 audit(1712946719.550:50): 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' [ 12.653224] ignition[961]: INFO : files: files passed [ 12.657779] ignition[961]: INFO : Ignition finished successfully [ 12.663197] systemd[1]: Starting initrd-setup-root-after-ignition.service... [ 12.668897] initrd-setup-root-after-ignition[986]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory [ 12.677785] systemd[1]: torcx-profile-populate.service was skipped because of an unmet condition check (ConditionPathExists=/sysroot/etc/torcx/next-profile). Stopping ignition-mount.service... Stopping iscsid.service... [ OK ] Stopped kmod-static-nodes.service. [ 12.698908] iscsid[813]: iscsid shutting down. [ 13.059761] audit: type=1131 audit(1712946719.619:51): 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' [ 12.708155] systemd[1]: Starting ignition-quench.service... Stopping sysroot-boot.service... [ OK ] Stopped systemd-udev-trigger.service. [ 12.740105] systemd[1]: ignition-quench.service: Deactivated successfully. [ OK ] Stopped dracut-pre-trigger.service. [ 12.752686] systemd[1]: Finished ignition-quench.service.[ 13.109928] audit: type=1131 audit(1712946719.667:52): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 12.783463] systemd[1]: Finished initrd-setup-root-after-ignition.service. [ 13.143750] audit: type=1131 audit(1712946719.701:53): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Stopped iscsid.service. [ 12.810195] systemd[1]: Reached target ignition-complete.target. [ 13.173739] audit: type=1131 audit(1712946719.731:54): 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' [ OK ] Stopped ignition-mount.service. [ 12.841698] systemd[1]: Starting initrd-parse-etc.service... [ 13.202588] audit: type=1131 audit(1712946719.761:55): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Stopped ignition-disks.service. [ 12.868086] ignition[999]: INFO : Ignition 2.14.0 [ OK ] Stopped ignition-kargs.service. [ 12.878649] ignition[999]: INFO : Stage: umount [ OK ] Stopped ignition-fetch.service. [ 12.888065] ignition[999]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" [ OK ] Stopped ignition-fetch-offline.service. [ 12.901170] ignition[999]: DEBUG : parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63 [ 12.921376] ignition[999]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" [ OK ] Stopped target paths.target. [ 12.928526] ignition[999]: INFO : umount: umount passed [ 12.938680] ignition[999]: INFO : Ignition finished successfully [ OK ] Stopped systemd-ask-password-console.path. [ 12.944055] systemd[1]: initrd-parse-etc.service: Deactivated successfully. [ OK ] Stopped target slices.target. [ 12.959865] systemd[1]: Finished initrd-parse-etc.service. [ OK ] Stopped target sockets.target. [ 12.968874] systemd[1]: Reached target initrd-fs.target. [ 12.978826] systemd[1]: Reached target initrd.target. [ OK ] Closed iscsid.socket. [ 12.983343] systemd[1]: dracut-mount.service was skipped because no trigger condition checks were met. [ 12.995459] systemd[1]: Starting dracut-pre-pivot.service... [ 13.000266] systemd[1]: Finished dracut-pre-pivot.service. [ OK ] Stopped ignition-setup.service. [ 13.004923] systemd[1]: Starting initrd-cleanup.service... [ 13.015310] systemd[1]: Stopped target nss-lookup.target. Stopping iscsiuio.service... [ 13.019908] systemd[1]: Stopped target remote-cryptsetup.target. [ OK ] Stopped iscsiuio.service. [ 13.029395] systemd[1]: Stopped target timers.target. [ OK ] Finished initrd-cleanup.service. [ 13.037957] systemd[1]: dracut-pre-pivot.service: Deactivated successfully. [ OK ] Stopped target network.target. [ 13.048433] systemd[1]: Stopped dracut-pre-pivot.service. [ OK ] Closed iscsiuio.socket. [ 13.057482] systemd[1]: Stopped target initrd.target. Stopping systemd-networkd.service... [ 13.065888] systemd[1]: Stopped target basic.target. [ 13.075132] systemd[1]: Stopped target ignition-complete.target. Stopping systemd-resolved.service... [ 13.081587] systemd[1]: Stopped target ignition-diskful.target. [ OK ] Stopped systemd-resolved.service. [ 13.091422] systemd[1]: Stopped target initrd-root-device.target. [ OK ] Stopped systemd-networkd.service. [ 13.101994] systemd[1]: Stopped target remote-fs.target. [ OK ] Closed systemd-networkd.socket. [ 13.112375] systemd[1]: Stopped target remote-fs-pre.target. Stopping network-cleanup.service... [ OK ] Stopped parse-ip-for-networkd.service. [ 13.122023] systemd[1]: Stopped target sysinit.target. [ OK ] Stopped systemd-sysctl.service. [ 13.136838] systemd[1]: Stopped target local-fs.target. [ OK ] Stopped systemd-modules-load.service. [ 13.146674] systemd[1]: Stopped target local-fs-pre.target. Stopping systemd-udevd.service... [ 13.159444] systemd[1]: Stopped target swap.target. [ OK ] Stopped sysroot-boot.service. [ 13.166449] systemd[1]: dracut-pre-mount.service: Deactivated successfully. [ OK ] Stopped systemd-udevd.service. [ 13.175425] systemd[1]: Stopped dracut-pre-mount.service. [ OK ] Closed systemd-udevd-control.socket. [ OK ] Closed systemd-udevd-kernel.socket. [ 13.183193] systemd[1]: Stopped target cryptsetup.target. [ OK ] Stopped dracut-pre-udev.service. [ 13.198854] systemd[1]: dracut-initqueue.service: Deactivated successfully. [ OK ] Stopped dracut-cmdline.service. [ 13.208247] systemd[1]: Stopped dracut-initqueue.service. [ OK ] Stopped dracut-cmdline-ask.service. [ 13.216184] systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. [ OK ] Stopped initrd-setup-root.service. [ 13.226606] systemd[1]: Stopped initrd-setup-root-after-ignition.service. [ 13.587567] hv_netvsc 002248b3-ec0b-0022-48b3-ec0b002248b3 eth0: Data path switched from VF: enP5646s1 Starting initrd-udevadm-cleanup-db.service... [ 13.244623] systemd[1]: ignition-files.service: Deactivated successfully. [ OK ] Stopped systemd-vconsole-setup.service. [ 13.254603] systemd[1]: Stopped ignition-files.service. [ OK ] Finished initrd-udevadm-cleanup-db.service. [ 13.262909] systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. [ 13.274407] systemd[1]: Stopped flatcar-metadata-hostname.service. [ 13.279699] systemd[1]: Stopping ignition-mount.service... [ 13.284415] systemd[1]: Stopping iscsid.service... [ 13.288722] systemd[1]: kmod-static-nodes.service: Deactivated successfully. [ 13.294732] systemd[1]: Stopped kmod-static-nodes.service. [ 13.299481] systemd[1]: Stopping sysroot-boot.service... [ 13.304246] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. [ 13.311299] systemd[1]: Stopped systemd-udev-trigger.service. [ 13.316949] systemd[1]: dracut-pre-trigger.service: Deactivated successfully. [ 13.323039] systemd[1]: Stopped dracut-pre-trigger.service. [ 13.327773] systemd[1]: iscsid.service: Deactivated successfully. [ 13.333083] systemd[1]: Stopped iscsid.service. [ 13.337627] systemd[1]: ignition-mount.service: Deactivated successfully. [ 13.344401] systemd[1]: Stopped ignition-mount.service. [ OK ] Stopped network-cleanup.service. [ 13.349545] systemd[1]: ignition-disks.service: Deactivated successfully. [ OK ] Reached target initrd-switch-root.target. [ 13.360731] systemd[1]: Stopped ignition-disks.service. [ 13.370897] systemd[1]: ignition-kargs.service: Deactivated successfully. Starting initrd-switch-root.service... [ 13.377027] systemd[1]: Stopped ignition-kargs.service. [ 13.386306] systemd[1]: ignition-fetch.service: Deactivated successfully. [ 13.392396] systemd[1]: Stopped ignition-fetch.service. [ 13.396931] systemd[1]: ignition-fetch-offline.service: Deactivated successfully. [ 13.403229] systemd[1]: Stopped ignition-fetch-offline.service. [ 13.411383] systemd[1]: Stopped target paths.target. [ 13.415637] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. [ 13.773347] systemd-journald[236]: Received SIGTERM from PID 1 (n/a). [ 16.363291] SELinux: Class mctp_socket not defined in policy. [ 16.369715] SELinux: Class anon_inode not defined in policy. [ 16.374687] SELinux: the above unknown classes and permissions will be allowed [ 16.382563] SELinux: policy capability network_peer_controls=1 [ 16.388114] SELinux: policy capability open_perms=1 [ 16.392412] SELinux: policy capability extended_socket_class=1 [ 16.397455] SELinux: policy capability always_check_network=0 [ 16.402318] SELinux: policy capability cgroup_seclabel=1 [ 16.406805] SELinux: policy capability nnp_nosuid_transition=1 [ 16.411657] SELinux: policy capability genfs_seclabel_symlinks=0 [ 16.418134] SELinux: policy capability ioctl_skip_cloexec=0 [ 16.474205] systemd[1]: Successfully loaded SELinux policy in 314.836ms. [ 17.394736] systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 23.365ms. [ 18.256831] systemd[1]: systemd 252 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL -ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE -TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified) [ 18.283434] systemd[1]: Detected virtualization microsoft. [ 18.289785] systemd[1]: Detected architecture arm64. [ 18.294479] systemd[1]: Detected first boot. Welcome to Flatcar Container Linux by Kinvolk 3510.3.3 (LTS 2023)! [ 18.334747] systemd[1]: Hostname set to . [ 18.375074] systemd[1]: Initializing machine ID from random generator. [ 18.427334] kauditd_printk_skb: 26 callbacks suppressed [ 18.427337] audit: type=1400 audit(1712946724.990:82): avc: denied { bpf } for pid=1 comm="systemd" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1 [ 18.448847] audit: type=1400 audit(1712946724.994:83): avc: denied { perfmon } for pid=1 comm="systemd" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1 [ 18.465003] audit: type=1334 audit(1712946724.997:84): prog-id=10 op=LOAD [ 18.471407] audit: type=1334 audit(1712946724.997:85): prog-id=10 op=UNLOAD [ 18.479084] audit: type=1334 audit(1712946725.012:86): prog-id=11 op=LOAD [ 18.485002] audit: type=1334 audit(1712946725.012:87): prog-id=11 op=UNLOAD [ 19.529178] SELinux: Context system_u:object_r:container_file_t:s0:c1022,c1023 is not valid (left unmapped). [ 19.537998] audit: type=1400 audit(1712946726.092:88): avc: denied { associate } for pid=1032 comm="torcx-generator" name="docker" dev="tmpfs" ino=2 scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 srawcon="system_u:object_r:container_file_t:s0:c1022,c1023" [ 19.559834] audit: type=1300 audit(1712946726.092:88): arch=c00000b7 syscall=5 success=yes exit=0 a0=40000222fc a1=40000283d8 a2=4000026840 a3=32 items=0 ppid=1015 pid=1032 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="torcx-generator" exe="/usr/lib/systemd/system-generators/torcx-generator" subj=system_u:system_r:kernel_t:s0 key=(null) [ 19.588380] audit: type=1327 audit(1712946726.092:88): proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61 [ 19.611408] audit: type=1400 audit(1712946726.102:89): avc: denied { associate } for pid=1032 comm="torcx-generator" name="bin" scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 [ 41.529597] systemd[1]: Populated /etc with preset unit settings. [ 42.217286] systemd[1]: /usr/lib/systemd/system/locksmithd.service:8: Unit uses CPUShares=; please use CPUWeight= instead. Support for CPUShares= will be removed soon. [ 42.230528] systemd[1]: /usr/lib/systemd/system/locksmithd.service:9: Unit uses MemoryLimit=; please use MemoryMax= instead. Support for MemoryLimit= will be removed soon. [ 42.361612] 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. [ 42.448591] kauditd_printk_skb: 5 callbacks suppressed [ 42.448594] audit: type=1334 audit(1712946749.011:90): prog-id=12 op=LOAD [ 42.459972] audit: type=1334 audit(1712946749.011:91): prog-id=3 op=UNLOAD [ 42.465407] audit: type=1334 audit(1712946749.017:92): prog-id=13 op=LOAD [ 42.470823] audit: type=1334 audit(1712946749.023:93): prog-id=14 op=LOAD [ 42.476288] audit: type=1334 audit(1712946749.023:94): prog-id=4 op=UNLOAD [ 42.481914] audit: type=1334 audit(1712946749.023:95): prog-id=5 op=UNLOAD [ 42.487433] audit: type=1334 audit(1712946749.028:96): prog-id=15 op=LOAD [ 42.493419] audit: type=1334 audit(1712946749.028:97): prog-id=12 op=UNLOAD [ 42.494712] systemd[1]: initrd-switch-root.service: Deactivated successfully. [ 42.499406] audit: type=1334 audit(1712946749.034:98): prog-id=16 op=LOAD [ 42.499409] audit: type=1334 audit(1712946749.039:99): prog-id=17 op=LOAD [ 42.518390] systemd[1]: Stopped initrd-switch-root.service. [ OK ] Stopped initrd-switch-root.service. [ 42.528994] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 42.537259] systemd[1]: Created slice system-addon\x2dconfig.slice. [ OK ] Created slice system-addon\x2dconfig.slice. [ 42.548170] systemd[1]: Created slice system-addon\x2drun.slice. [ OK ] Created slice system-addon\x2drun.slice. [ 42.560034] systemd[1]: Created slice system-getty.slice. [ OK ] Created slice system-getty.slice. [ 42.570329] systemd[1]: Created slice system-modprobe.slice. [ OK ] Created slice system-modprobe.slice. [ 42.580804] systemd[1]: Created slice system-serial\x2dgetty.slice. [ OK ] Created slice system-serial\x2dgetty.slice. [ 42.591592] systemd[1]: Created slice system-system\x2dcloudinit.slice. [ OK ] Created slice system-system\x2dcloudinit.slice. [ 42.604052] systemd[1]: Created slice system-systemd\x2dfsck.slice. [ OK ] Created slice system-systemd\x2dfsck.slice. [ 42.615605] systemd[1]: Created slice user.slice. [ OK ] Created slice user.slice. [ 42.623727] systemd[1]: Started systemd-ask-password-console.path. [ OK ] Started systemd-ask-password-console.path. [ 42.633763] systemd[1]: Started systemd-ask-password-wall.path. [ OK ] Started systemd-ask-password-wall.path. [ 42.643567] systemd[1]: Set up automount boot.automount. [ OK ] Set up automount boot.automount. [ 42.652665] systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount. [ OK ] Set up automount proc-sys-fs-binfmt_misc.automount. [ 42.664032] systemd[1]: Stopped target initrd-switch-root.target. [ OK ] Stopped target initrd-switch-root.target. [ 42.674666] systemd[1]: Stopped target initrd-fs.target. [ OK ] Stopped target initrd-fs.target. [ 42.683617] systemd[1]: Stopped target initrd-root-fs.target. [ OK ] Stopped target initrd-root-fs.target. [ 42.693346] systemd[1]: Reached target integritysetup.target. [ OK ] Reached target integritysetup.target. [ 42.702715] systemd[1]: Reached target remote-cryptsetup.target. [ OK ] Reached target remote-cryptsetup.target. [ 42.712498] systemd[1]: Reached target remote-fs.target. [ OK ] Reached target remote-fs.target. [ 42.721108] systemd[1]: Reached target slices.target. [ OK ] Reached target slices.target. [ 42.730516] systemd[1]: Reached target swap.target. [ OK ] Reached target swap.target. [ 42.738565] systemd[1]: Reached target torcx.target. [ OK ] Reached target torcx.target. [ 42.746857] systemd[1]: Reached target veritysetup.target. [ OK ] Reached target veritysetup.target. [ 42.757203] systemd[1]: Listening on systemd-coredump.socket. [ OK ] Listening on systemd-coredump.socket. [ 42.766815] systemd[1]: Listening on systemd-initctl.socket. [ OK ] Listening on systemd-initctl.socket. [ 42.777252] systemd[1]: Listening on systemd-networkd.socket. [ OK ] Listening on systemd-networkd.socket. [ 42.813310] systemd[1]: Listening on systemd-udevd-control.socket. [ OK ] Listening on systemd-udevd-control.socket. [ 42.825952] systemd[1]: Listening on systemd-udevd-kernel.socket. [ OK ] Listening on systemd-udevd-kernel.socket. [ 42.835873] systemd[1]: Listening on systemd-userdbd.socket. [ OK ] Listening on systemd-userdbd.socket. [ 42.846016] systemd[1]: Mounting dev-hugepages.mount... Mounting dev-hugepages.mount... [ 42.854751] systemd[1]: Mounting dev-mqueue.mount... Mounting dev-mqueue.mount... [ 42.863393] systemd[1]: Mounting media.mount... Mounting media.mount... [ 42.872410] systemd[1]: Mounting sys-kernel-debug.mount... Mounting sys-kernel-debug.mount... [ 42.881565] systemd[1]: Mounting sys-kernel-tracing.mount... Mounting sys-kernel-tracing.mount... [ 42.891419] systemd[1]: Mounting tmp.mount... Mounting tmp.mount... [ 42.899184] systemd[1]: Starting flatcar-tmpfiles.service... Starting flatcar-tmpfiles.service... [ 42.907993] systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. [ 42.920092] systemd[1]: Starting kmod-static-nodes.service... Starting kmod-static-nodes.service... [ 42.930619] systemd[1]: Starting modprobe@configfs.service... Starting modprobe@configfs.service... [ 42.940728] systemd[1]: Starting modprobe@dm_mod.service... Starting modprobe@dm_mod.service... [ 42.950326] systemd[1]: Starting modprobe@drm.service... Starting modprobe@drm.service... [ 42.959276] systemd[1]: Starting modprobe@efi_pstore.service... Starting modprobe@efi_pstore.service... [ 42.970167] systemd[1]: Starting modprobe@fuse.service... Starting modprobe@fuse.service... [ 42.980088] systemd[1]: Starting modprobe@loop.service... Starting modprobe@loop.service... [ 42.988726] systemd[1]: setup-nsswitch.service was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). [ 42.999281] systemd[1]: systemd-fsck-root.service: Deactivated successfully. [ 43.004849] systemd[1]: Stopped systemd-fsck-root.service. [ OK ] Stopped systemd-fsck-root.service. [ 43.014893] systemd[1]: systemd-fsck-usr.service: Deactivated successfully. [ 43.015275] fuse: init (API version 7.34) [ 43.020339] systemd[1]: Stopped systemd-fsck-usr.service. [ OK ] Stopped systemd-fsck-usr.service. [ 43.034995] systemd[1]: Stopped systemd-journald.service. [ OK ] Stopped systemd-journald.service. [ 43.044258] systemd[1]: systemd-journald.service: Consumed 3.038s CPU time. [ 43.050488] loop: module loaded [ 43.053862] systemd[1]: Starting systemd-journald.service... Starting systemd-journald.service... [ 43.077480] systemd[1]: Starting systemd-modules-load.service... Starting systemd-modules-load.service... [ 43.087626] systemd[1]: Starting systemd-network-generator.service... Starting systemd-network-generator.service... [ 43.098739] systemd[1]: Starting systemd-remount-fs.service... Starting systemd-remount-fs.service... [ 43.111579] systemd[1]: Starting systemd-udev-trigger.service... Starting systemd-udev-trigger.service... [ 43.121131] systemd[1]: verity-setup.service: Deactivated successfully. [ 43.126499] systemd[1]: Stopped verity-setup.service. [ OK ] Stopped verity-setup.service. [ 43.136845] systemd[1]: Mounted dev-hugepages.mount. [ OK ] Mounted dev-hugepages.mount. [ 43.145193] systemd[1]: Mounted dev-mqueue.mount. [ OK ] Mounted dev-mqueue.mount. [ 43.152897] systemd[1]: Mounted media.mount. [ OK ] Mounted media.mount. [ 43.161299] systemd[1]: Mounted sys-kernel-debug.mount. [ OK ] Mounted sys-kernel-debug.mount. [ 43.170150] 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-network-generator.service. [ OK ] Finished systemd-remount-fs.service. [ OK ] Reached target network-pre.target. Mounting sys-fs-fuse-connections.mount... Mounting sys-kernel-config.mount... Starting systemd-hwdb-update.service... Starting systemd-journal-flush.service... Starting systemd-random-seed.service... Starting systemd-sysusers.service... [ OK ] Finished systemd-modules-load.service. [ OK ] Finished systemd-udev-trigger.service. [ OK ] Mounted sys-fs-fuse-connections.mount. [ OK ] Mounted sys-kernel-config.mount. Starting systemd-sysctl.service... Starting systemd-udev-settle.service... [ OK ] Finished systemd-random-seed.service. [ OK ] Reached target first-boot-complete.target. [ 43.364513] systemd-journald[1138]: Received client request to flush runtime journal. [ OK ] Finished systemd-sysctl.service. [ OK ] Finished systemd-journal-flush.service. [ OK ] Finished systemd-sysusers.service. [ OK ] Finished systemd-hwdb-update.service. Starting systemd-udevd.service... [ OK ] Started systemd-udevd.service. Starting systemd-networkd.service... [ 45.473718] mousedev: PS/2 mouse device common for all mice [ 45.483858] hv_vmbus: registering driver hv_balloon [ 45.492788] hv_balloon: Using Dynamic Memory protocol version 2.0 [ 45.498495] hv_balloon: Memory hot add disabled on ARM64 [ 45.522313] hv_vmbus: registering driver hyperv_fb [ 45.528063] hv_utils: Registering HyperV Utility Driver [ 45.534336] hyperv_fb: Synthvid Version major 3, minor 5 [ 45.539004] hv_vmbus: registering driver hv_utils [ 45.543728] hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 [ 45.546854] hv_utils: Heartbeat IC version 3.0 [ 45.554733] Console: switching to colour dummy device 80x25 [ 45.559240] hv_utils: Shutdown IC version 3.2 [ 45.562876] hv_utils: TimeSync IC version 4.0 [ 45.566797] Console: switching to colour frame buffer device 128x48 [ 45.573260] systemd-journald[1138]: Time jumped backwards, rotating. Starting systemd-userdbd.service... [ OK ] Started systemd-userdbd.service. [ 45.945869] BTRFS info: devid 1 device path /dev/disk/by-label/OEM changed to /dev/sda6 scanned by (udev-worker) (1168) [ OK ] Started systemd-networkd.service. Starting systemd-networkd-wait-online.service... [ OK ] Found device dev-disk-by\x2dlabel-OEM.device. [ OK ] Finished systemd-udev-settle.service. Starting lvm2-activation-early.service... [ 46.041803] mlx5_core 160e:00:02.0 enP5646s1: Link up [ 46.064908] hv_netvsc 002248b3-ec0b-0022-48b3-ec0b002248b3 eth0: Data path switched to VF: enP5646s1 [ 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-machine-id-commit.service. [ OK ] Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service. [ OK ] Finished systemd-fsck@dev-…2dlabel-EFI\x2dSYSTEM.service. Mounting boot.mount... [ OK ] Mounted boot.mount. [ OK ] Finished systemd-boot-update.service. [ OK ] Finished systemd-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 ] Started systemd-timesyncd.service. [ OK ] Reached target time-set.target. [ OK ] Started systemd-resolved.service. [ OK ] Reached target network.target. [ OK ] Reached target nss-lookup.target. [ OK ] Finished systemd-journal-catalog-update.service. [ 47.559628] kauditd_printk_skb: 92 callbacks suppressed [ 47.559631] audit: type=1305 audit(1712946753.702:175): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 [ OK ] Finished audit-rules.service.[ 47.574714] audit: type=1300 audit(1712946753.702:175): arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffe393aff0 a2=420 a3=0 items=0 ppid=1251 pid=1272 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) [ 47.599507] audit: type=1327 audit(1712946753.702:175): proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 [ OK ] Finished systemd-networkd-wait-online.service. [ OK ] Reached target network-online.target. [* ] 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 [ 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. [ 53.775478] extend-filesystems[1283]: Found sda [ 53.779356] extend-filesystems[1283]: Found sda1 [ 53.782791] extend-filesystems[1283]: Found sda2 [ 53.786864] extend-filesystems[1283]: Found sda3 [ 53.791315] extend-filesystems[1283]: Found usr [ 53.795077] extend-filesystems[1283]: Found sda4 [ OK ] Finished motdgen.service. [ 53.803956] extend-filesystems[1283]: Found sda6 [ 53.807701] extend-filesystems[1283]: Found sda7 [ 53.815927] extend-filesystems[1283]: Found sda9 [ 53.820071] extend-filesystems[1283]: Checking size of /dev/sda9 [ OK ] Started dbus.service. [ OK ] Reached target system-config.target. [ OK ] Reached target user-config.target. [ OK ] Finished update-ssh-keys-after-ignition.service. [ 53.990782] extend-filesystems[1283]: Old size kept for /dev/sda9 [ OK ] Started systemd-logind.service. [ OK ] Finished extend-filesystems.service. [ 54.010424] extend-filesystems[1283]: Found sr0 [ OK ] Started containerd.service. [ OK ] Started update-engine.service. [ OK ] Started locksmithd.service. [ OK ] Finished prepare-critools.service. [ OK ] Finished prepare-cni-plugins.service. [ OK ] Finished sshd-keygen.service. Starting issuegen.service... [ OK ] Started waagent.service. [ OK ] Finished issuegen.service. Starting systemd-user-sessions.service... [ OK ] Finished systemd-user-sessions.service. [ OK ] Started getty@tty1.service. [ OK ] Started serial-getty@ttyAMA0.service. [ OK ] Reached target getty.target. [ OK ] Reached target multi-user.target. Starting systemd-update-utmp-runlevel.service... [ OK ] Finished systemd-update-utmp-runlevel.service. This is ci-3510.3.3-a-1633230817 (Linux aarch64 5.15.154-flatcar) 18:32:42 SSH host key: SHA256:Ts/yZivHOwRSI6dE/KsH7xczeoc4JbQvode9/LLENBc (ED25519) SSH host key: SHA256:TkAUfDt09iDtZc1D85VHudKzTCffzyK8NJ4Mj+UPBq8 (RSA) SSH host key: SHA256:9I5ctjyKjNQ9t5BP0k3eEKJ59nadnrUSTpN98qbPVMA (ECDSA) enP5646s1: eth0: 10.200.20.42 fe80::222:48ff:feb3:ec0b ci-3510 login: core (automatic login) Flatcar Container Linux by Kinvolk lts 3510.3.3 for Microsoft Azure [?2004hcore@ci-3510 ~ $ 2024-04-12T18:32:48.746388Z INFO Daemon Daemon Azure Linux Agent Version:2.6.0.2 2024-04-12T18:32:48.753407Z INFO Daemon Daemon OS: flatcar 3510.3.3 2024-04-12T18:32:48.758346Z INFO Daemon Daemon Python: 3.9.16 2024-04-12T18:32:48.762892Z INFO Daemon Daemon Run daemon 2024-04-12T18:32:48.767196Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='3510.3.3' 2024-04-12T18:32:48.784210Z INFO Daemon Daemon Unable to get cloud-init enabled status from systemctl: Command '['systemctl', 'is-enabled', 'cloud-init-local.service']' returned non-zero exit status 1. 2024-04-12T18:32:48.799064Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' 2024-04-12T18:32:48.809129Z INFO Daemon Daemon cloud-init is enabled: False 2024-04-12T18:32:48.814270Z INFO Daemon Daemon Using waagent for provisioning 2024-04-12T18:32:48.820173Z INFO Daemon Daemon Activate resource disk 2024-04-12T18:32:48.824975Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb 2024-04-12T18:32:48.839125Z INFO Daemon Daemon Found device: None 2024-04-12T18:32:48.843894Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology 2024-04-12T18:32:48.852413Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 2024-04-12T18:32:48.865012Z INFO Daemon Daemon Clean protocol and wireserver endpoint 2024-04-12T18:32:48.871121Z INFO Daemon Daemon Running default provisioning handler 2024-04-12T18:32:48.884387Z INFO Daemon Daemon Unable to get cloud-init enabled status from systemctl: Command '['systemctl', 'is-enabled', 'cloud-init-local.service']' returned non-zero exit status 1. 2024-04-12T18:32:48.899375Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' 2024-04-12T18:32:48.909067Z INFO Daemon Daemon cloud-init is enabled: False 2024-04-12T18:32:48.914279Z INFO Daemon Daemon Copying ovf-env.xml 2024-04-12T18:32:48.992167Z INFO Daemon Daemon Successfully mounted dvd 2024-04-12T18:32:49.323832Z INFO Daemon Daemon Detect protocol endpoint 2024-04-12T18:32:49.329164Z INFO Daemon Daemon Clean protocol and wireserver endpoint 2024-04-12T18:32:49.335092Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler 2024-04-12T18:32:49.341845Z INFO Daemon Daemon Test for route to 168.63.129.16 2024-04-12T18:32:49.347416Z INFO Daemon Daemon Route to 168.63.129.16 exists 2024-04-12T18:32:49.352627Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 2024-04-12T18:32:49.447731Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 2024-04-12T18:32:49.454766Z INFO Daemon Daemon Wire protocol version:2012-11-30 2024-04-12T18:32:49.460159Z INFO Daemon Daemon Server preferred version:2015-04-05 2024-04-12T18:32:49.959572Z INFO Daemon Daemon Initializing goal state during protocol detection 2024-04-12T18:32:49.974749Z INFO Daemon Daemon Forcing an update of the goal state.. 2024-04-12T18:32:49.980506Z INFO Daemon Daemon Fetching goal state [incarnation 1] 2024-04-12T18:32:50.050428Z INFO Daemon Daemon Found private key matching thumbprint 483E4C9B5EC1E1C2B657B6E25CF8C4CB28E8F63D 2024-04-12T18:32:50.059175Z INFO Daemon Daemon Certificate with thumbprint AB28D43AB93025377631FEE6A6E0B15DE0F09D96 has no matching private key. 2024-04-12T18:32:50.069551Z INFO Daemon Daemon Fetch goal state completed 2024-04-12T18:32:50.107292Z INFO Daemon Daemon Fetched new vmSettings [correlation ID: d7aff00b-e513-498c-abed-dc41545d2bda New eTag: 15010281287988210061] 2024-04-12T18:32:50.118592Z INFO Daemon Daemon Status Blob type 'None' is not valid, assuming BlockBlob 2024-04-12T18:32:50.134048Z INFO Daemon Daemon Starting provisioning 2024-04-12T18:32:50.139744Z INFO Daemon Daemon Handle ovf-env.xml. 2024-04-12T18:32:50.144699Z INFO Daemon Daemon Set hostname [ci-3510.3.3-a-1633230817] 2024-04-12T18:32:50.184397Z INFO Daemon Daemon Publish hostname [ci-3510.3.3-a-1633230817] 2024-04-12T18:32:50.191191Z INFO Daemon Daemon Examine /proc/net/route for primary interface 2024-04-12T18:32:50.198195Z INFO Daemon Daemon Primary interface is [eth0] 2024-04-12T18:32:50.260185Z INFO Daemon Daemon Create user account if not exists 2024-04-12T18:32:50.266203Z INFO Daemon Daemon User core already exists, skip useradd 2024-04-12T18:32:50.272357Z INFO Daemon Daemon Configure sudoer 2024-04-12T18:32:50.277573Z INFO Daemon Daemon Configure sshd 2024-04-12T18:32:50.283697Z INFO Daemon Daemon Deploy ssh public key. 2024-04-12T18:32:51.497638Z INFO Daemon Daemon Provisioning complete 2024-04-12T18:32:51.517257Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping 2024-04-12T18:32:51.523973Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. [ 93.596009] hv_balloon: Max. dynamic memory size: 4096 MB [ 124.585091] SELinux: Context system_u:object_r:container_file_t:s0 is not valid (left unmapped). [ 142.879870] WARNING: Unprivileged eBPF is enabled, data leaks possible via Spectre v2 BHB attacks! [ 143.354421] Initializing XFRM netlink socket [ 143.359898] WARNING: Unprivileged eBPF is enabled, data leaks possible via Spectre v2 BHB attacks! [ 144.604918] IPv6: ADDRCONF(NETDEV_CHANGE): cilium_net: link becomes ready [ 144.610166] IPv6: ADDRCONF(NETDEV_CHANGE): cilium_host: link becomes ready [ 145.004050] NET: Registered PF_ALG protocol family [ 146.009109] IPv6: ADDRCONF(NETDEV_CHANGE): lxc_health: link becomes ready [ 146.452582] eth0: renamed from tmp98853 [ 146.461406] IPv6: ADDRCONF(NETDEV_CHANGE): lxcd3c569fc2a84: link becomes ready [ 161.331248] eth0: renamed from tmpc9110 [ 161.340696] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 161.345571] IPv6: ADDRCONF(NETDEV_CHANGE): lxc26a748c21afb: link becomes ready [ 176.596814] FS-Cache: Loaded [ 176.798574] RPC: Registered named UNIX socket transport module. [ 176.803245] RPC: Registered udp transport module. [ 176.806784] RPC: Registered tcp transport module. [ 176.810111] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 176.924201] FS-Cache: Netfs 'nfs' registered for caching [ 177.158880] NFS: Registering the id_resolver key type [ 177.163079] Key type id_resolver registered [ 177.166402] Key type id_legacy registered [ 177.782957] eth0: renamed from tmpacd03 [ 177.789020] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 177.794394] IPv6: ADDRCONF(NETDEV_CHANGE): lxcc0a4613fc0c7: link becomes ready [ 195.240594] alg: No test for seqiv(rfc4106(gcm(aes))) (seqiv(rfc4106(gcm-aes-ce))) [ 197.845323] IPv6: ADDRCONF(NETDEV_CHANGE): lxc_health: link becomes ready