[=3hWelcome to GRUB! check_signatures=no cmddevice=hd0,gpt1 cmdpath=(hd0,gpt1)/EFI/BOOT color_highlight=black/light-gray color_normal=light-gray/black feature_200_final=y feature_all_video_module=y feature_chainloader_bpb=y feature_default_font_path=y feature_menuentry_id=y feature_menuentry_options=y feature_nativedisk_cmd=y feature_ntldr=y feature_platform_search_hint=y feature_timeout_style=y grub_cpu=arm64 grub_platform=efi lang= locale_dir= net_default_ip=(null) net_default_mac=(null) net_default_server= pager= prefix=(memdisk) pxe_default_server= root=hd0,gpt1 secondary_locale_dir= error: serial port `com0' isn't found. error: terminal `serial' isn't found. error: terminal `serial' isn't found. GNU GRUB version 2.02 ┌────────────────────────────────────────────────────────────────────────────┐││││││││││││││││││││││││││└────────────────────────────────────────────────────────────────────────────┘ Use the ▲ and ▼ keys to select which entry is highlighted. Press enter to boot the selected OS, `e' to edit the commands before booting or `c' for a command-line.  *Flatcar default  Flatcar USR-A  Flatcar USR-B             The highlighted entry will be executed automatically in 1s.  The highlighted entry will be executed automatically in 0s.  Booting `Flatcar default' EFI stub: Booting Linux Kernel... EFI stub: Using DTB from configuration table EFI stub: Exiting boot services... [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] [ 0.000000] Linux version 5.15.148-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 11.3.1_p20221209 p3) 11.3.1 20221209, GNU ld (Gentoo 2.39 p5) 2.39.0) #1 SMP PREEMPT Fri Feb 9 17:24:35 -00 2024 [ 0.000000] earlycon: pl11 at MMIO 0x00000000effec000 (options '') [ 0.000000] printk: bootconsole [pl11] enabled [ 0.000000] efi: EFI v2.70 by EDK II [ 0.000000] efi: ACPI 2.0=0x3fd89018 SMBIOS=0x3fd66000 SMBIOS 3.0=0x3fd64000 MEMATTR=0x3ef3c198 RNG=0x3fd89998 MEMRESERVE=0x37e73f98 [ 0.000000] random: crng init done [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x000000003FD89018 000024 (v02 VRTUAL) [ 0.000000] ACPI: XSDT 0x000000003FD89F18 00006C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: FACP 0x000000003FD89C18 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: DSDT 0x000000003EBD2018 01DEC0 (v02 MSFTVM DSDT01 00000001 MSFT 05000000) [ 0.000000] ACPI: DBG2 0x000000003FD89B18 000072 (v00 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: GTDT 0x000000003FD89D98 000060 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: OEM0 0x000000003FD89098 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: SPCR 0x000000003FD89A98 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: APIC 0x000000003FD89818 0000FC (v04 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: SRAT 0x000000003FD89198 000234 (v03 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: PPTT 0x000000003FD89418 000120 (v01 VRTUAL MICROSFT 00000000 MSFT 00000000) [ 0.000000] ACPI: BGRT 0x000000003FD89E98 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) [ 0.000000] ACPI: SPCR: console: pl011,mmio32,0xeffec000,115200 [ 0.000000] NUMA: Failed to initialise from firmware [ 0.000000] NUMA: Faking a node at [mem 0x0000000000000000-0x00000001bfffffff] [ 0.000000] NUMA: NODE_DATA [mem 0x1bf7f2900-0x1bf7f7fff] [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000000000-0x00000000ffffffff] [ 0.000000] DMA32 empty [ 0.000000] Normal [mem 0x0000000100000000-0x00000001bfffffff] [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000000000-0x00000000007fffff] [ 0.000000] node 0: [mem 0x0000000000824000-0x000000003ec80fff] [ 0.000000] node 0: [mem 0x000000003ec81000-0x000000003eca9fff] [ 0.000000] node 0: [mem 0x000000003ecaa000-0x000000003fd29fff] [ 0.000000] node 0: [mem 0x000000003fd2a000-0x000000003fd7dfff] [ 0.000000] node 0: [mem 0x000000003fd7e000-0x000000003fd89fff] [ 0.000000] node 0: [mem 0x000000003fd8a000-0x000000003fd8dfff] [ 0.000000] node 0: [mem 0x000000003fd8e000-0x000000003fffffff] [ 0.000000] node 0: [mem 0x0000000100000000-0x00000001bfffffff] [ 0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x00000001bfffffff] [ 0.000000] On node 0, zone DMA: 36 pages in unavailable ranges [ 0.000000] psci: probing for conduit method from ACPI. [ 0.000000] psci: PSCIv1.1 detected in firmware. [ 0.000000] psci: Using standard PSCI v0.2 function IDs [ 0.000000] psci: MIGRATE_INFO_TYPE not supported. [ 0.000000] psci: SMC Calling Convention v1.4 [ 0.000000] ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x0 -> Node -1 [ 0.000000] ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x1 -> Node -1 [ 0.000000] percpu: Embedded 29 pages/cpu s79960 r8192 d30632 u118784 [ 0.000000] Detected PIPT I-cache on CPU0 [ 0.000000] CPU features: detected: GIC system register CPU interface [ 0.000000] CPU features: detected: Hardware dirty bit management [ 0.000000] CPU features: detected: Spectre-BHB [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI) [ 0.000000] CPU features: detected: ARM erratum 1418040 [ 0.000000] CPU features: detected: ARM erratum 1542419 (kernel portion) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1032156 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=tty1 console=ttyAMA0,115200n8 earlycon=pl011,0xeffec000 flatcar.first_boot=detected acpi=force flatcar.oem.id=azure flatcar.autologin verity.usrhash=680ffc8c0dfb23738bd19ec96ea37b5bbadfb5cebf23767d1d52c89a6d5c00b4 [ 0.000000] Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. [ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) [ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) [ 0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off [ 0.000000] software IO TLB: mapped [mem 0x000000003abd2000-0x000000003ebd2000] (64MB) [ 0.000000] Memory: 3991936K/4194160K available (9792K kernel code, 2092K rwdata, 7556K rodata, 34688K init, 778K bss, 202224K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 [ 0.000000] trace event string verifier disabled [ 0.000000] rcu: Preemptible hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. [ 0.000000] Trampoline variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 [ 0.000000] GICv3: 960 SPIs implemented [ 0.000000] GICv3: 0 Extended SPIs implemented [ 0.000000] GICv3: Distributor has no Range Selector support [ 0.000000] Root IRQ handler: gic_handle_irq [ 0.000000] GICv3: 16 PPIs implemented [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000effee000 [ 0.000000] ITS: No ITS available, not enabling LPIs [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040 [ 0.000000] arch_timer: cp15 timer(s) running at 25.00MHz (virt). [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns [ 0.012709] Console: colour dummy device 80x25 [ 0.020037] printk: console [tty1] enabled [ 0.025127] ACPI: Core revision 20210730 [ 0.030378] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) [ 0.043430] pid_max: default: 32768 minimum: 301 [ 0.049219] LSM: Security Framework initializing [ 0.054895] SELinux: Initializing. [ 0.059237] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) [ 0.069297] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) [ 0.079385] Hyper-V: privilege flags low 0x2e7f, high 0x3a8030, hints 0xe, misc 0x31e1 [ 0.089735] Hyper-V: Host Build 10.0.22477.1369-1-0 [ 0.095844] rcu: Hierarchical SRCU implementation. [ 0.101464] Remapping and enabling EFI services. [ 0.106918] smp: Bringing up secondary CPUs ... [ 0.113007] Detected PIPT I-cache on CPU1 [ 0.113041] GICv3: CPU1: found redistributor 1 region 1:0x00000000f000e000 [ 0.113123] arch_timer: Enabling local workaround for ARM erratum 1418040 [ 0.113179] CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] [ 0.113237] smp: Brought up 1 node, 2 CPUs [ 0.146210] SMP: Total of 2 processors activated. [ 0.151793] CPU features: detected: 32-bit EL0 Support [ 0.157991] CPU features: detected: Instruction cache invalidation not required for I/D coherence [ 0.167714] CPU features: detected: Data cache clean to the PoU not required for I/D coherence [ 0.177525] CPU features: detected: CRC32 instructions [ 0.183499] CPU features: detected: RCpc load-acquire (LDAPR) [ 0.190733] CPU features: detected: LSE atomic instructions [ 0.197769] CPU features: detected: Privileged Access Never [ 0.254455] CPU: All CPU(s) started at EL1 [ 0.259133] alternatives: patching kernel code [ 0.264751] devtmpfs: initialized [ 0.268690] KASLR enabled [ 0.271839] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.283614] futex hash table entries: 512 (order: 3, 32768 bytes, linear) [ 0.291184] pinctrl core: initialized pinctrl subsystem [ 0.297625] SMBIOS 3.1.0 present. [ 0.305640] DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 07/12/2023 [ 0.319717] NET: Registered PF_NETLINK/PF_ROUTE protocol family [ 0.328137] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.337340] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.347348] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.357570] audit: initializing netlink subsys (disabled) [ 0.365148] audit: type=2000 audit(0.092:1): state=initialized audit_enabled=0 res=1 [ 0.365229] thermal_sys: Registered thermal governor 'step_wise' [ 0.374496] cpuidle: using governor menu [ 0.387254] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. [ 0.395856] ASID allocator initialised with 32768 entries [ 0.402596] ACPI: bus type PCI registered [ 0.407583] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.415944] Serial: AMBA PL011 UART driver [ 0.422259] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.431174] HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages [ 0.439348] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.448186] HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages [ 0.575990] cryptd: max_cpu_qlen set to 1000 [ 0.584270] alg: No test for fips(ansi_cprng) (fips_ansi_cprng) [ 0.592266] ACPI: Added _OSI(Module Device) [ 0.597675] ACPI: Added _OSI(Processor Device) [ 0.603483] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.609439] ACPI: Added _OSI(Processor Aggregator Device) [ 0.616259] ACPI: Added _OSI(Linux-Dell-Video) [ 0.621483] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) [ 0.627933] ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) [ 0.639128] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.647104] ACPI: Interpreter enabled [ 0.651554] ACPI: Using GIC for interrupt routing [ 0.657909] ARMH0011:00: ttyAMA0 at MMIO 0xeffec000 (irq = 12, base_baud = 0) is a SBSA [ 0.667775] printk: console [ttyAMA0] enabled [ 0.667775] printk: console [ttyAMA0] enabled [ 0.676985] printk: bootconsole [pl11] disabled [ 0.676985] printk: bootconsole [pl11] disabled [ 0.687041] ARMH0011:01: ttyAMA1 at MMIO 0xeffeb000 (irq = 13, base_baud = 0) is a SBSA [ 0.694259] iommu: Default domain type: Translated [ 0.698473] iommu: DMA domain TLB invalidation policy: strict mode [ 0.703859] vgaarb: loaded [ 0.706096] pps_core: LinuxPPS API ver. 1 registered [ 0.710586] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.719069] PTP clock support registered [ 0.722346] Registered efivars operations [ 0.725886] No ACPI PMU IRQ for CPU0 [ 0.728990] No ACPI PMU IRQ for CPU1 [ 0.732281] clocksource: Switched to clocksource arch_sys_counter [ 0.743328] VFS: Disk quotas dquot_6.6.0 [ 0.747090] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.753253] pnp: PnP ACPI init [ 0.756217] pnp: PnP ACPI: found 0 devices [ 0.761907] NET: Registered PF_INET protocol family [ 0.766157] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) [ 0.773294] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) [ 0.780642] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) [ 0.787718] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) [ 0.795048] TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) [ 0.801378] TCP: Hash tables configured (established 32768 bind 32768) [ 0.807599] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) [ 0.813664] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) [ 0.820268] NET: Registered PF_UNIX/PF_LOCAL protocol family [ 0.824963] PCI: CLS 0 bytes, default 64 [ 0.837329] hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 1 counters available [ 0.844206] kvm [1]: HYP mode not available [ 1.024971] Initialise system trusted keyrings [ 1.028950] workingset: timestamp_bits=39 max_order=20 bucket_order=0 [ 1.035690] Key type asymmetric registered [ 1.039307] Asymmetric key parser 'x509' registered [ 1.044039] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) [ 1.050548] io scheduler mq-deadline registered [ 1.054444] io scheduler kyber registered [ 1.058034] io scheduler bfq registered [ 1.062216] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 1.067919] thunder_xcv, ver 1.0 [ 1.070966] thunder_bgx, ver 1.0 [ 1.074236] nicpf, ver 1.0 [ 1.076860] nicvf, ver 1.0 [ 1.079736] rtc-efi rtc-efi.0: registered as rtc0 [ 1.083964] rtc-efi rtc-efi.0: setting system clock to 2024-02-09T18:36:53 UTC (1707503813) [ 1.091464] efifb: probing for efifb [ 1.094438] efifb: framebuffer at 0x40000000, using 3072k, total 3072k [ 1.099937] efifb: mode is 1024x768x32, linelength=4096, pages=1 [ 1.105286] efifb: scrolling: redraw [ 1.108322] efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 [ 1.115283] Console: switching to colour frame buffer device 128x48 [ 1.121876] fb0: EFI VGA frame buffer device [ 1.125749] SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... [ 1.131325] hid: raw HID events driver (C) Jiri Kosina [ 1.135566] NET: Registered PF_INET6 protocol family [ 1.139750] Segment Routing with IPv6 [ 1.142985] In-situ OAM (IOAM) with IPv6 [ 1.146260] NET: Registered PF_PACKET protocol family [ 1.150385] Key type dns_resolver registered [ 1.154582] registered taskstats version 1 [ 1.158117] Loading compiled-in X.509 certificates [ 1.191553] Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.15.148-flatcar: 947a80114e81e2815f6db72a0d388260762488f9' [ 1.202636] Key type .fscrypt registered [ 1.206091] Key type fscrypt-provisioning registered [ 1.210336] ima: No TPM chip found, activating TPM-bypass! [ 1.215265] ima: Allocated hash algorithm: sha1 [ 1.219229] ima: No architecture policies found [ 1.228111] Freeing unused kernel memory: 34688K [ 1.232356] Run /init as init process [ 1.253974] 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.283101] systemd[1]: Detected virtualization microsoft. [ 1.289354] systemd[1]: Detected architecture arm64. [ 1.294181] systemd[1]: Running in initrd. Welcome to dracut-053 (Initramfs)! [ 1.302381] systemd[1]: No hostname configured, using default hostname. [ 1.307818] systemd[1]: Hostname set to . [ 1.312885] systemd[1]: Initializing machine ID from random generator. [ 1.404155] systemd[1]: Queued start job for default target initrd.target. [ 1.411983] systemd[1]: Started systemd-ask-password-console.path. [ OK ] Started systemd-ask-password-console.path. [ 1.425682] systemd[1]: Reached target cryptsetup.target. [ OK ] Reached target cryptsetup.target. [ 1.435882] systemd[1]: Reached target paths.target. [ OK ] Reached target paths.target. [ 1.445687] systemd[1]: Reached target slices.target. [ OK ] Reached target slices.target. [ 1.455793] systemd[1]: Reached target swap.target. [ OK ] Reached target swap.target. [ 1.465957] systemd[1]: Reached target timers.target. [ OK ] Reached target timers.target. [ 1.477150] systemd[1]: Listening on iscsid.socket. [ OK ] Listening on iscsid.socket. [ 1.490631] systemd[1]: Listening on iscsiuio.socket. [ OK ] Listening on iscsiuio.socket. [ 1.505038] systemd[1]: Listening on systemd-journald-audit.socket. [ OK ] Listening on systemd-journald-audit.socket. [ 1.519603] systemd[1]: Listening on systemd-journald-dev-log.socket. [ OK ] Listening on systemd-journald-dev-log.socket. [ 1.538987] systemd[1]: Listening on systemd-journald.socket. [ OK ] Listening on systemd-journald.socket. [ 1.552014] systemd[1]: Listening on systemd-networkd.socket. [ OK ] Listening on systemd-networkd.socket. [ 1.565603] systemd[1]: Listening on systemd-udevd-control.socket. [ OK ] Listening on systemd-udevd-control.socket. [ 1.579840] systemd[1]: Listening on systemd-udevd-kernel.socket. [ OK ] Listening on systemd-udevd-kernel.socket. [ 1.594518] systemd[1]: Reached target sockets.target. [ OK ] Reached target sockets.target. [ 1.606664] systemd[1]: Starting kmod-static-nodes.service... Starting kmod-static-nodes.service... [ 1.619042] systemd[1]: Finished network-cleanup.service. [ OK ] Finished network-cleanup.service. [ 1.632922] systemd[1]: Starting systemd-fsck-usr.service... Starting systemd-fsck-usr.service... [ 1.645439] systemd[1]: Starting systemd-journald.service... Starting systemd-journald.service... [ 1.659383] systemd[1]: Starting systemd-modules-load.service... Starting systemd-modules-load.service... [ 1.673805] systemd[1]: Starting systemd-resolved.service... Starting systemd-resolved.service... [ 1.224078] systemd-modules-load[277]: Inserted module 'overlay'[ 1.695405] systemd[1]: Starting systemd-vconsole-setup.service... [ 1.709499] bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Starting systemd-vconsole-setup.service...[ 1.728843] Bridge firewalling registered [ 1.261596] systemd-modules-load[277]: Inserted module 'br_netfilter'[ 1.735781] systemd[1]: Started systemd-journald.service. [ 1.277679] systemd-resolved[278]: Positive Trust Anchors: [ OK ] Started systemd-journald.service. [ 1.764005] SCSI subsystem initialized [ 1.283307] systemd-resolved[278]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d[ 1.779336] audit: type=1130 audit(1707503814.185:2): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Started systemd-resolved.service.[ 1.802950] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. [ 1.814342] audit: type=1130 audit(1707503814.229:3): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 1.815839] device-mapper: uevent: version 1.0.3 [ 1.326261] systemd-resolved[278]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test [ 1.877151] device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com [ OK ] Finished kmod-static-nodes.service. [ 1.890783] audit: type=1130 audit(1707503814.306:4): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Finished systemd-fsck-usr.service. [ 1.449661] systemd-resolved[278]: Defaulting to hostname 'linux'.[ 1.926760] audit: type=1130 audit(1707503814.336:5): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Finished systemd-modules-load.service. [ 1.951020] audit: type=1130 audit(1707503814.366:6): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Finished systemd-vconsole-setup.service. [ 1.510576] systemd[1]: Started systemd-resolved.service. [ OK ] Reached target nss-lookup.target. [ 1.515649] systemd[1]: Finished kmod-static-nodes.service.[ 1.992741] audit: type=1130 audit(1707503814.402:7): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Starting dracut-cmdline-ask.service... [ 1.555271] systemd[1]: Finished systemd-fsck-usr.service. [ 1.570140] systemd-modules-load[277]: Inserted module 'dm_multipath' Starting systemd-sysctl.service... [ 1.576060] systemd[1]: Finished systemd-modules-load.service. [ 1.587442] systemd[1]: Finished systemd-vconsole-setup.service. Starting systemd-tmpfiles-setup-dev.service... [ 1.593053] systemd[1]: Reached target nss-lookup.target. [ OK ] Finished dracut-cmdline-ask.service. [ 2.082626] audit: type=1130 audit(1707503814.498: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.605151] systemd[1]: Starting dracut-cmdline-ask.service... [ OK ] Finished systemd-sysctl.service. [ 1.635156] systemd[1]: Starting systemd-sysctl.service... [ 2.116538] audit: type=1130 audit(1707503814.527:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Finished systemd-tmpfiles-setup-dev.service. [ 1.664358] systemd[1]: Starting systemd-tmpfiles-setup-dev.service...[ 2.143615] audit: type=1130 audit(1707503814.559:10): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 1.697970] systemd[1]: Finished dracut-cmdline-ask.service. [ 1.705939] systemd[1]: Finished systemd-sysctl.service. Starting dracut-cmdline.service... [ 1.711247] systemd[1]: Finished systemd-tmpfiles-setup-dev.service. [ 1.724545] systemd[1]: Starting dracut-cmdline.service... [ 1.731231] dracut-cmdline[298]: dracut-dracut-053 [ 1.736509] dracut-cmdline[298]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=tty1 console=ttyAMA0,115200n8 earlycon=pl011,0xeffec000 flatcar.first_boot=detected acpi=force flatcar.oem.id=azure flatcar.autologin verity.usrhash=680ffc8c0dfb23738bd19ec96ea37b5bbadfb5cebf23767d1d52c89a6d5c00b4 [ 2.292043] Loading iSCSI transport class v2.0-870. [ 2.305986] iscsi: registered transport (tcp) [ 2.322948] iscsi: registered transport (qla4xxx) [ 2.328075] QLogic iSCSI HBA Driver [ OK ] Finished dracut-cmdline.service. [ 1.895116] systemd[1]: Finished dracut-cmdline.service. [ 1.900179] systemd[1]: Starting dracut-pre-udev.service... Starting dracut-pre-udev.service... [ 2.416284] raid6: neonx8 gen() 13807 MB/s [ 2.438284] raid6: neonx8 xor() 10825 MB/s [ 2.460283] raid6: neonx4 gen() 13557 MB/s [ 2.481283] raid6: neonx4 xor() 11318 MB/s [ 2.502287] raid6: neonx2 gen() 13095 MB/s [ 2.525283] raid6: neonx2 xor() 10244 MB/s [ 2.546283] raid6: neonx1 gen() 10510 MB/s [ 2.567284] raid6: neonx1 xor() 8790 MB/s [ 2.590294] raid6: int64x8 gen() 6284 MB/s [ 2.611283] raid6: int64x8 xor() 3550 MB/s [ 2.632285] raid6: int64x4 gen() 7261 MB/s [ 2.655285] raid6: int64x4 xor() 3854 MB/s [ 2.676285] raid6: int64x2 gen() 6153 MB/s [ 2.697283] raid6: int64x2 xor() 3323 MB/s [ 2.720284] raid6: int64x1 gen() 5041 MB/s [ 2.741285] raid6: int64x1 xor() 2647 MB/s [ 2.746543] raid6: using algorithm neonx8 gen() 13807 MB/s [ 2.752825] raid6: .... xor() 10825 MB/s, rmw enabled [ 2.758368] raid6: using neon recovery algorithm [ 2.772789] xor: measuring software checksum speed [ 2.778483] 8regs : 17300 MB/sec [ 2.783445] 32regs : 20755 MB/sec [ 2.788183] arm64_neon : 27750 MB/sec [ 2.792743] xor: using function: arm64_neon (27750 MB/sec) [ 2.848395] Btrfs loaded, crc32c=crc32c-generic, zoned=no, fsverity=no [ OK ] Finished dracut-pre-udev.service. [ 2.393452] systemd[1]: Finished dracut-pre-udev.service. Starting systemd-udevd.service... [ 2.404763] systemd[1]: Starting systemd-udevd.service... [ 2.421368] systemd-udevd[475]: Using default interface naming scheme 'v252'. [ OK ] Started systemd-udevd.service. [ 2.434488] systemd[1]: Started systemd-udevd.service. Starting dracut-pre-trigger.service... [ 2.443761] systemd[1]: Starting dracut-pre-trigger.service... [ 2.455138] dracut-pre-trigger[496]: rd.md=0: removing MD RAID activation [ OK ] Finished dracut-pre-trigger.service. [ 2.488078] systemd[1]: Finished dracut-pre-trigger.service. [ 2.499169] systemd[1]: Starting systemd-udev-trigger.service... Starting systemd-udev-trigger.service... [ OK ] Finished systemd-udev-trigger.service. [ 2.535158] systemd[1]: Finished systemd-udev-trigger.service. [ 3.049516] hv_vmbus: Vmbus version:5.3 [ 3.057644] hv_vmbus: registering driver hyperv_keyboard [ 3.066168] hv_vmbus: registering driver hid_hyperv [ 3.072505] input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input0 [ 3.081508] hid-generic 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on [ 3.097967] input: AT Translated Set 2 keyboard as /devices/LNXSYSTM:00/LNXSYBUS:00/ACPI0004:00/VMBUS:00/d34b2567-b9b6-42b9-8778-0a4ec0b955bf/serio0/input/input1 [ 3.113273] hv_vmbus: registering driver hv_storvsc [ 3.119009] hv_vmbus: registering driver hv_netvsc [ 3.124970] scsi host0: storvsc_host_t [ 3.128697] scsi host1: storvsc_host_t [ 3.133817] scsi 0:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 [ 3.141729] scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 0 [ 3.164941] sr 0:0:0:2: [sr0] scsi-1 drive [ 3.172209] cdrom: Uniform CD-ROM driver Revision: 3.20 [ 3.181312] sd 0:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB) [ 3.188482] sd 0:0:0:0: [sda] 4096-byte physical blocks [ 3.194017] sd 0:0:0:0: [sda] Write Protect is off [ 3.198835] sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA [ 3.208546] sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 [ 3.215046] sd 0:0:0:0: [sda] Attached SCSI disk [ 3.224299] hv_netvsc 000d3a6f-3492-000d-3a6f-3492000d3a6f eth0: VF slot 1 added [ 3.234539] hv_vmbus: registering driver hv_pci [ 3.240696] hv_pci 5264bb68-1341-485d-93a0-e50989fa46a3: PCI VMBus probing: Using version 0x10004 [ 3.253916] hv_pci 5264bb68-1341-485d-93a0-e50989fa46a3: PCI host bridge to bus 1341:00 [ 3.261521] pci_bus 1341:00: root bus resource [mem 0xfc0000000-0xfc00fffff window] [ 3.274954] pci_bus 1341:00: No busn resource found for root bus, will use [bus 00-ff] [ 3.285326] pci 1341:00:02.0: [15b3:1018] type 00 class 0x020000 [ 3.297443] pci 1341:00:02.0: reg 0x10: [mem 0xfc0000000-0xfc00fffff 64bit pref] [ 3.324249] pci 1341:00:02.0: enabling Extended Tags [ 3.339312] pci 1341:00:02.0: 0.000 Gb/s available PCIe bandwidth, limited by Unknown x0 link at 1341:00:02.0 (capable of 126.016 Gb/s with 8.0 GT/s PCIe x16 link) [ 3.356230] pci_bus 1341:00: busn_res: [bus 00-ff] end is updated to 00 [ 3.363938] pci 1341:00:02.0: BAR 0: assigned [mem 0xfc0000000-0xfc00fffff 64bit pref] [ 3.408264] mlx5_core 1341:00:02.0: firmware version: 16.30.1284 [ 3.563085] mlx5_core 1341:00:02.0: MLX5E: StrdRq(1) RqSz(8) StrdSz(2048) RxCqeCmprss(0) [ 3.621128] hv_netvsc 000d3a6f-3492-000d-3a6f-3492000d3a6f eth0: VF registering: eth1 [ 3.630550] mlx5_core 1341:00:02.0 eth1: joined to eth0 [ 3.642850] mlx5_core 1341:00:02.0 enP4929s1: renamed from eth1 [ OK ] Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device. [ 3.272517] systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device. [ 3.769861] BTRFS: device label OEM devid 1 transid 12 /dev/sda6 scanned by (udev-worker) (531) [ OK ] Found device dev-disk-by\x2dlabel-OEM.device. [ 3.321768] systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. [ OK ] Found device dev-disk-by\x…2d8e26\x2d6cce9662f132.device. [ OK ] Found device dev-disk-by\x2dpartlabel-USR\x2dA.device. [ 3.490988] systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device. [ 3.520215] systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device. [ OK ] Found device dev-disk-by\x2dlabel-ROOT.device. [ 3.528069] systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device. Starting disk-uuid.service... [ 3.540023] systemd[1]: Starting disk-uuid.service... [ 4.024539] sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 [ 4.035324] sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 [ 5.044500] sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 [ 4.582154] disk-uuid[602]: The operation has completed successfully. [ 4.642432] systemd[1]: disk-uuid.service: Deactivated successfully. [ OK ] Finished disk-uuid.service. [ 4.648304] systemd[1]: Finished disk-uuid.service. Starting verity-setup.service... [ 4.659697] systemd[1]: Starting verity-setup.service... [ 5.164361] device-mapper: verity: sha256 using implementation "sha256-ce" [ OK ] Found device dev-mapper-usr.device. [ 4.936443] systemd[1]: Found device dev-mapper-usr.device. Mounting sysusr-usr.mount... [ OK ] Finished verity-setup.service. [ 4.946169] systemd[1]: Mounting sysusr-usr.mount... [ 4.960977] systemd[1]: Finished verity-setup.service. [ 5.476306] EXT4-fs (dm-0): mounted filesystem without journal. Opts: norecovery. Quota mode: none. [ OK ] Mounted sysusr-usr.mount. [ 5.015271] systemd[1]: Mounted sysusr-usr.mount. Starting ignition-setup.service... Starting parse-ip-for-networkd.service... [ 5.506874] BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm [ 5.026703] systemd[1]: afterburn-network-kargs.service was skipped because no trigger condition checks were met.[ 5.514133] BTRFS info (device sda6): using free space tree [ 5.527138] BTRFS info (device sda6): has skinny extents [ 5.055694] systemd[1]: Starting ignition-setup.service... [ 5.067559] systemd[1]: Starting parse-ip-for-networkd.service... [ OK ] Finished parse-ip-for-networkd.service. [ 5.129039] systemd[1]: Finished parse-ip-for-networkd.service.[ 5.603615] kauditd_printk_skb: 10 callbacks suppressed [ 5.603618] audit: type=1130 audit(1707503818.019:21): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=parse-ip-for-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 5.164590] systemd[1]: Starting systemd-networkd.service...[ 5.637651] audit: type=1334 audit(1707503818.030:22): prog-id=9 op=LOAD Starting systemd-networkd.service... [ 5.190148] systemd[1]: mnt-oem.mount: Deactivated successfully. [ 5.203519] systemd-networkd[846]: lo: Link UP [ OK ] Started systemd-networkd.service. [ 5.209090] systemd-networkd[846]: lo: Gained carrier[ 5.689241] audit: type=1130 audit(1707503818.100:23): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Reached target network.target. [ 5.244991] systemd-networkd[846]: Enumeration completed [ 5.254470] systemd[1]: Started systemd-networkd.service. Starting iscsiuio.service... [ 5.260410] systemd-networkd[846]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. [ OK ] Started iscsiuio.service. [ 5.273660] systemd[1]: Reached target network.target.[ 5.754067] audit: type=1130 audit(1707503818.165:24): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=iscsiuio comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Starting iscsid.service... [ 5.313674] systemd[1]: Starting iscsiuio.service... [ 5.318846] iscsid[855]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi [ OK ] Started iscsid.service. [ 5.803990] audit: type=1130 audit(1707503818.219:25): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=iscsid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 5.353591] iscsid[855]: 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 dracut-initqueue.service... [ 5.379377] iscsid[855]: into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier]. [ 5.397946] iscsid[855]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6.[ 5.875688] mlx5_core 1341:00:02.0 enP4929s1: Link up [ 5.410973] iscsid[855]: If using hardware iscsi like qla4xxx this message can be ignored. [ OK ] Finished dracut-initqueue.service. [ 5.419384] iscsid[855]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi[ 5.896659] audit: type=1130 audit(1707503818.312:26): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 5.924832] hv_netvsc 000d3a6f-3492-000d-3a6f-3492000d3a6f eth0: Data path switched to VF: enP4929s1 [ 5.452580] iscsid[855]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf[ 5.942914] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 5.478473] systemd[1]: Started iscsiuio.service. [ OK ] Reached target remote-fs-pre.target. [ 5.483459] systemd[1]: Starting iscsid.service... [ OK ] Reached target remote-cryptsetup.target. [ 5.493727] systemd[1]: Started iscsid.service. [ OK ] Reached target remote-fs.target. [ 5.503820] systemd[1]: Starting dracut-initqueue.service... Starting dracut-pre-mount.service... [ 5.514615] systemd[1]: Finished dracut-initqueue.service. [ 5.529815] systemd[1]: Reached target remote-fs-pre.target. [ 5.535767] systemd-networkd[846]: enP4929s1: Link UP [ 5.541633] systemd-networkd[846]: eth0: Link UP [ OK ] Finished dracut-pre-mount.service. [ 5.546028] systemd-networkd[846]: eth0: Gained carrier[ 6.022627] audit: type=1130 audit(1707503818.438:27): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 5.573400] systemd[1]: Reached target remote-cryptsetup.target. [ 5.581411] systemd-networkd[846]: enP4929s1: Gained carrier [ 5.587049] systemd[1]: Reached target remote-fs.target. [ 5.592645] systemd[1]: Starting dracut-pre-mount.service... [ 5.598542] systemd-networkd[846]: eth0: DHCPv4 address 10.200.20.24/24, gateway 10.200.20.1 acquired from 168.63.129.16 [ 5.609059] systemd[1]: Finished dracut-pre-mount.service. [ OK ] Finished ignition-setup.service. [ 5.617455] systemd[1]: Finished ignition-setup.service.[ 6.096070] audit: type=1130 audit(1707503818.510:28): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Starting ignition-fetch-offline.service... [ 5.647650] systemd[1]: Starting ignition-fetch-offline.service... [ 6.943439] systemd-networkd[846]: eth0: Gained IPv6LL [* ] Job ignition-fetch-offline.service/start running (6s / no limit) M [** ] Job ignition-fetch-offline.service/start running (7s / no limit) [ 8.557676] ignition[870]: Ignition 2.14.0 [ 8.561585] ignition[870]: Stage: fetch-offline [ 8.565465] ignition[870]: reading system config file "/usr/lib/ignition/base.d/base.ign" [ 8.631831] ignition[870]: no config dir at "/usr/lib/ignition/base.platform.d/azure" M [*** ] Job ignition-fetch-offline.service/start running (7s / no limit) [ 8.641140] ignition[870]: no config URL provided M [ OK ] Finished ignition-fetch-offline.service. [ 8.653328] ignition[870]: reading system config file "/usr/lib/ignition/user.ign"[ 9.131174] audit: type=1130 audit(1707503821.546:29): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch-offline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Starting ignition-fetch.service... [ 8.684921] systemd[1]: Finished ignition-fetch-offline.service. [ 8.697803] ignition[870]: no config at "/usr/lib/ignition/user.ign" [ 8.703682] systemd[1]: Starting ignition-fetch.service... [ 8.708894] ignition[870]: failed to fetch config: resource requires networking [ 8.716115] ignition[870]: Ignition finished successfully [ 8.721056] ignition[876]: Ignition 2.14.0 [ 8.725028] ignition[876]: Stage: fetch [ 8.728600] ignition[876]: reading system config file "/usr/lib/ignition/base.d/base.ign" [ 8.744690] ignition[876]: no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 8.756324] ignition[876]: no config URL provided [ 8.761681] ignition[876]: reading system config file "/usr/lib/ignition/user.ign" [ 8.769512] ignition[876]: no config at "/usr/lib/ignition/user.ign" [ 8.777840] ignition[876]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 [ 8.791750] ignition[876]: GET result: OK [ 8.796815] ignition[876]: config has been read from IMDS userdata [ 8.810709] ignition[876]: fetched base config from "system" [ OK ] Finished ignition-fetch.service. [ 8.823124] ignition[876]: fetched base config from "system"[ 9.299845] audit: type=1130 audit(1707503821.710: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' [ 8.850065] ignition[876]: fetch: fetch complete Starting ignition-kargs.service... [ 8.855186] [876]: fetched user config from "azure" [ 8.865395] ignition[876]: fetch: fetch passed [ 8.870626] systemd[1]: Finished ignition-fetch.service. [ 8.877028] ignition[876]: Ignition finished successfully [ OK ] Finished ignition-kargs.service. [ 8.890104] systemd[1]: Starting ignition-kargs.service... [ 8.896166] ignition[882]: Ignition 2.14.0 [ 8.901659] systemd[1]: Finished ignition-kargs.service. Starting ignition-disks.service... [ 8.907361] ignition[882]: Stage: kargs [ 8.919179] systemd[1]: Starting ignition-disks.service... [ 8.924469] ignition[882]: reading system config file "/usr/lib/ignition/base.d/base.ign" [ OK ] Finished ignition-disks.service. [ 8.931994] systemd[1]: Finished ignition-disks.service. [ OK ] Reached target initrd-root-device.target. [ 8.942282] ignition[882]: no config dir at "/usr/lib/ignition/base.platform.d/azure" [ OK ] Reached target local-fs-pre.target. [ 8.954515] systemd[1]: Reached target initrd-root-device.target. [ OK ] Reached target local-fs.target. [ 8.965380] ignition[882]: kargs: kargs passed [ OK ] Reached target sysinit.target. [ 8.973925] systemd[1]: Reached target local-fs-pre.target. [ OK ] Reached target basic.target. [ 8.983900] ignition[882]: Ignition finished successfully Starting systemd-fsck-root.service... [ 8.993422] systemd[1]: Reached target local-fs.target. [ 9.007867] ignition[888]: Ignition 2.14.0 [ 9.011795] systemd[1]: Reached target sysinit.target. [ 9.016343] ignition[888]: Stage: disks [ 9.019699] systemd[1]: Reached target basic.target. [ 9.024289] ignition[888]: reading system config file "/usr/lib/ignition/base.d/base.ign" [ 9.031796] systemd[1]: Starting systemd-fsck-root.service... [ 9.036685] ignition[888]: no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 9.043586] ignition[888]: disks: disks passed [ 9.047458] ignition[888]: Ignition finished successfully [ 9.057228] systemd-fsck[896]: ROOT: clean, 602/7326000 files, 481069/7359488 blocks [ OK ] Finished systemd-fsck-root.service. [ 9.075226] systemd[1]: Finished systemd-fsck-root.service. [ 9.082721] systemd[1]: Mounting sysroot.mount... Mounting sysroot.mount... [ 9.566202] EXT4-fs (sda9): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none. [ OK ] Mounted sysroot.mount. [ 9.106525] systemd[1]: Mounted sysroot.mount. [ OK ] Reached target initrd-root-fs.target. [ 9.115264] systemd[1]: Reached target initrd-root-fs.target. Mounting sysroot-usr.mount... [ 9.153378] systemd[1]: Mounting sysroot-usr.mount... Starting flatcar-metadata-hostname.service... [ OK ] Reached target ignition-diskful.target. [ 9.161080] systemd[1]: Starting flatcar-metadata-hostname.service... [ OK ] Mounted sysroot-usr.mount. [ 9.179438] systemd[1]: ignition-remount-sysroot.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). [ 9.195533] systemd[1]: Reached target ignition-diskful.target. [ 9.201076] systemd[1]: Mounted sysroot-usr.mount. Mounting sysroot-usr-share-oem.mount... [ 9.231636] systemd[1]: Mounting sysroot-usr-share-oem.mount... [ 9.240144] systemd[1]: Starting initrd-setup-root.service... Starting initrd-setup-root.service... [ 9.724008] BTRFS: device label OEM devid 1 transid 14 /dev/sda6 scanned by mount (907) [ 9.733982] BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm [ 9.270945] initrd-setup-root[912]: cut: /sysroot/etc/passwd: No such file or directory[ 9.749517] BTRFS info (device sda6): using free space tree [ 9.755355] BTRFS info (device sda6): has skinny extents [ 9.293878] systemd[1]: Mounted sysroot-usr-share-oem.mount. [ OK ] Mounted sysroot-usr-share-oem.mount. [ 9.308346] initrd-setup-root[938]: cut: /sysroot/etc/group: No such file or directory [ 9.319843] initrd-setup-root[946]: cut: /sysroot/etc/shadow: No such file or directory [ 9.351872] initrd-setup-root[954]: cut: /sysroot/etc/gshadow: No such file or directory [ OK ] Finished initrd-setup-root.service. [ 9.804760] systemd[1]: Finished initrd-setup-root.service. [ 9.815508] systemd[1]: Starting ignition-mount.service... Starting ignition-mount.service... Starting sysroot-boot.service... [ 9.827291] systemd[1]: Starting sysroot-boot.service... [ 9.838549] systemd[1]: sysusr-usr-share-oem.mount: Deactivated successfully. [ 9.845307] systemd[1]: sysroot-usr-share-oem.mount: Deactivated successfully. [ 9.870155] ignition[976]: INFO : Ignition 2.14.0 [ OK ] Finished sysroot-boot.service. [ 9.883403] ignition[976]: INFO : Stage: mount [ OK ] Finished ignition-mount.service. [ 9.888278] systemd[1]: Finished sysroot-boot.service. [ 9.898292] ignition[976]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" [ 9.906270] ignition[976]: DEBUG : parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63 [ 9.922488] ignition[976]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 9.931281] ignition[976]: INFO : mount: mount passed [ 9.935973] ignition[976]: INFO : Ignition finished successfully [ 9.941460] systemd[1]: Finished ignition-mount.service. [ 10.363461] coreos-metadata[906]: Feb 09 18:37:03.250 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 [ 10.375606] coreos-metadata[906]: Feb 09 18:37:03.262 INFO Fetch successful [ 10.408256] coreos-metadata[906]: Feb 09 18:37:03.295 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 [ 10.435738] coreos-metadata[906]: Feb 09 18:37:03.323 INFO Fetch successful [ OK ] Finished flatcar-metadata-hostname.service. [ 10.446080] coreos-metadata[906]: Feb 09 18:37:03.330 INFO wrote hostname ci-3510.3.2-a-132224a944 to /sysroot/etc/hostname[ 10.932769] kauditd_printk_skb: 6 callbacks suppressed [ 10.932772] audit: type=1130 audit(1707503823.338:37): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=flatcar-metadata-hostname comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Starting ignition-files.service... [ 10.487404] systemd[1]: Finished flatcar-metadata-hostname.service. Mounting sysroot-usr-share-oem.mount... [ 10.496304] systemd[1]: Starting ignition-files.service... [ 10.508579] systemd[1]: Mounting sysroot-usr-share-oem.mount... [ 10.987483] BTRFS: device label OEM devid 1 transid 15 /dev/sda6 scanned by mount (986) [ 10.998998] BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm [ 11.006506] BTRFS info (device sda6): using free space tree [ 11.011970] BTRFS info (device sda6): has skinny extents [ OK ] Mounted sysroot-usr-share-oem.mount. [ 10.551123] systemd[1]: Mounted sysroot-usr-share-oem.mount. [ 10.566857] ignition[1005]: INFO : Ignition 2.14.0 [ 10.572681] ignition[1005]: INFO : Stage: files [ 10.577842] ignition[1005]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" [ 10.585806] ignition[1005]: DEBUG : parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63 [ 10.601935] ignition[1005]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 10.609936] ignition[1005]: DEBUG : files: compiled without relabeling support, skipping [ 10.617478] ignition[1005]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" [ 10.627802] ignition[1005]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" [ 10.672337] ignition[1005]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" [ 10.682808] ignition[1005]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" [ 10.693396] ignition[1005]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" [ 10.703279] ignition[1005]: wrote ssh authorized keys file for user: core [ 10.709871] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar-cgroupv1" [ 10.722541] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar-cgroupv1" [ 10.735948] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/opt/cni-plugins-linux-arm64-v1.1.1.tgz" [ 10.749334] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(4): GET https://github.com/containernetworking/plugins/releases/download/v1.1.1/cni-plugins-linux-arm64-v1.1.1.tgz: attempt #1 [ 11.053490] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(4): GET result: OK [ 11.268864] ignition[1005]: DEBUG : files: createFilesystemsFiles: createFiles: op(4): file matches expected sum of: 6b5df61a53601926e4b5a9174828123d555f592165439f541bc117c68781f41c8bd30dccd52367e406d104df849bcbcfb72d9c4bafda4b045c59ce95d0ca0742 [ 11.289348] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/opt/cni-plugins-linux-arm64-v1.1.1.tgz" [ 11.301940] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing file "/sysroot/opt/crictl-v1.26.0-linux-arm64.tar.gz" [ 11.313977] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(5): GET https://github.com/kubernetes-sigs/cri-tools/releases/download/v1.26.0/crictl-v1.26.0-linux-arm64.tar.gz: attempt #1 [ 11.542110] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(5): GET result: OK [ 11.683199] ignition[1005]: DEBUG : files: createFilesystemsFiles: createFiles: op(5): file matches expected sum of: 4c7e4541123cbd6f1d6fec1f827395cd58d65716c0998de790f965485738b6d6257c0dc46fd7f66403166c299f6d5bf9ff30b6e1ff9afbb071f17005e834518c [ 11.703031] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing file "/sysroot/opt/crictl-v1.26.0-linux-arm64.tar.gz" [ 11.717366] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/opt/bin/kubeadm" [ 11.729980] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET https://dl.k8s.io/release/v1.26.5/bin/linux/arm64/kubeadm: attempt #1 [ 11.885942] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET result: OK [ 12.187735] ignition[1005]: DEBUG : files: createFilesystemsFiles: createFiles: op(6): file matches expected sum of: 46c9f489062bdb84574703f7339d140d7e42c9c71b367cd860071108a3c1d38fabda2ef69f9c0ff88f7c80e88d38f96ab2248d4c9a6c9c60b0a4c20fd640d0db [ 12.208097] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/opt/bin/kubeadm" [ 12.219587] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(7): [started] writing file "/sysroot/opt/bin/kubelet" [ 12.230633] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(7): GET https://dl.k8s.io/release/v1.26.5/bin/linux/arm64/kubelet: attempt #1 [ 12.264133] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(7): GET result: OK [ *** ] Job ignition-files.service/start running (11s / no limit) [ 12.978380] ignition[1005]: DEBUG : files: createFilesystemsFiles: createFiles: op(7): file matches expected sum of: 0e4ee1f23bf768c49d09beb13a6b5fad6efc8e3e685e7c5610188763e3af55923fb46158b5e76973a0f9a055f9b30d525b467c53415f965536adc2f04d9cf18d [ 12.998563] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(7): [finished] writing file "/sysroot/opt/bin/kubelet"[ 13.474248] BTRFS info: devid 1 device path /dev/sda6 changed to /dev/disk/by-label/OEM scanned by ignition (1008) [ 13.019055] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(8): [started] writing file "/sysroot/home/core/install.sh" [ 13.033301] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(8): [finished] writing file "/sysroot/home/core/install.sh" [ 13.047529] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(9): [started] writing file "/sysroot/etc/docker/daemon.json" [ 13.059609] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(9): [finished] writing file "/sysroot/etc/docker/daemon.json" [ 13.072523] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(a): [started] writing file "/sysroot/etc/flatcar/update.conf" M [ OK ] Finished ignition-files.service. [ 13.084373] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(a): [finished] writing file "/sysroot/etc/flatcar/update.conf"[ 13.561623] audit: type=1130 audit(1707503825.977: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' [ 13.118947] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(b): [started] writing file "/sysroot/etc/systemd/system/waagent.service" Starting initrd-setup-root-after-ignition.service... [ 13.134442] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(b): oem config not found in "/usr/share/oem", looking on oem partition [ 13.156081] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(b): op(c): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem4141151816" Starting ignition-quench.service... [ 13.169477] ignition[1005]: CRITICAL : files: createFilesystemsFiles: createFiles: op(b): op(c): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem4141151816": device or resource busy [ 13.191851] ignition[1005]: ERROR : files: createFilesystemsFiles: createFiles: op(b): failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem4141151816", trying btrfs: device or resource busy [ OK ] Finished ignition-quench.service. [ 13.207184] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(b): op(d): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem4141151816"[ 13.697242] audit: type=1130 audit(1707503826.099:39): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Finished initrd-setup-root-after-ignition.service.[ 13.724265] audit: type=1131 audit(1707503826.099:40): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 13.246542] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(b): op(d): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem4141151816"[ 13.754909] audit: type=1130 audit(1707503826.156:41): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Reached target ignition-complete.target. [ 13.304690] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(b): op(e): [started] unmounting "/mnt/oem4141151816" Starting initrd-parse-etc.service... [ 13.325678] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(b): op(e): [finished] unmounting "/mnt/oem4141151816" [ OK ] Finished initrd-parse-etc.service. [ 13.337670] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(b): [finished] writing file "/sysroot/etc/systemd/system/waagent.service"[ 13.826528] audit: type=1130 audit(1707503826.230:42): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 13.845915] audit: type=1131 audit(1707503826.230:43): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Reached target initrd-fs.target. [ 13.392600] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(f): [started] writing file "/sysroot/etc/systemd/system/nvidia.service" [ OK ] Reached target initrd.target. [ 13.411908] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(f): oem config not found in "/usr/share/oem", looking on oem partition [ 13.429954] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(f): op(10): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem563506526" Starting dracut-pre-pivot.service... [ 13.443525] ignition[1005]: CRITICAL : files: createFilesystemsFiles: createFiles: op(f): op(10): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem563506526": device or resource busy [ 13.465361] ignition[1005]: ERROR : files: createFilesystemsFiles: createFiles: op(f): failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem563506526", trying btrfs: device or resource busy [ 13.483605] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(f): op(11): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem563506526" [ OK ] Finished dracut-pre-pivot.service. [ 13.978769] audit: type=1130 audit(1707503826.394:44): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 13.507528] systemd[1]: mnt-oem4141151816.mount: Deactivated successfully. [ 13.538665] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(f): op(11): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem563506526" Starting initrd-cleanup.service... [ 13.552229] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(f): op(12): [started] unmounting "/mnt/oem563506526" [ OK ] Finished initrd-cleanup.service. [ 13.569646] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(f): op(12): [finished] unmounting "/mnt/oem563506526"[ 14.046651] audit: type=1130 audit(1707503826.462:45): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 13.606709] ignition[1005]: INFO : files: createFilesystemsFiles: createFiles: op(f): [finished] writing file "/sysroot/etc/systemd/system/nvidia.service" [ 14.094128] audit: type=1131 audit(1707503826.496:46): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Stopped target nss-lookup.target. [ 13.641621] ignition[1005]: INFO : files: op(13): [started] processing unit "waagent.service" [ OK ] Stopped target remote-cryptsetup.target. [ 13.657362] ignition[1005]: INFO : files: op(13): [finished] processing unit "waagent.service" [ OK ] Stopped target timers.target. [ 13.671886] ignition[1005]: INFO : files: op(14): [started] processing unit "nvidia.service" [ OK ] Stopped dracut-pre-pivot.service. [ 13.684761] ignition[1005]: INFO : files: op(14): [finished] processing unit "nvidia.service" [ OK ] Stopped target initrd.target. [ 13.697680] ignition[1005]: INFO : files: op(15): [started] processing unit "containerd.service" [ OK ] Stopped target basic.target. [ 13.710071] ignition[1005]: INFO : files: op(15): op(16): [started] writing systemd drop-in "10-use-cgroupfs.conf" at "/sysroot/etc/systemd/system/containerd.service.d/10-use-cgroupfs.conf" [ OK ] Stopped target ignition-complete.target. [ 13.730284] ignition[1005]: INFO : files: op(15): op(16): [finished] writing systemd drop-in "10-use-cgroupfs.conf" at "/sysroot/etc/systemd/system/containerd.service.d/10-use-cgroupfs.conf" [ OK ] Stopped target ignition-diskful.target. [ 13.751758] ignition[1005]: INFO : files: op(15): [finished] processing unit "containerd.service" [ OK ] Stopped target initrd-root-device.target. [ 13.766016] ignition[1005]: INFO : files: op(17): [started] processing unit "prepare-cni-plugins.service" [ OK ] Stopped target remote-fs.target. [ 13.780954] ignition[1005]: INFO : files: op(17): op(18): [started] writing unit "prepare-cni-plugins.service" at "/sysroot/etc/systemd/system/prepare-cni-plugins.service" [ OK ] Stopped target remote-fs-pre.target. [ 13.800207] ignition[1005]: INFO : files: op(17): op(18): [finished] writing unit "prepare-cni-plugins.service" at "/sysroot/etc/systemd/system/prepare-cni-plugins.service" [ OK ] Stopped target sysinit.target. [ 13.818551] ignition[1005]: INFO : files: op(17): [finished] processing unit "prepare-cni-plugins.service" [ OK ] Stopped target local-fs.target. [ 13.832079] ignition[1005]: INFO : files: op(19): [started] processing unit "prepare-critools.service" [ OK ] Stopped target local-fs-pre.target. [ 13.845749] ignition[1005]: INFO : files: op(19): op(1a): [started] writing unit "prepare-critools.service" at "/sysroot/etc/systemd/system/prepare-critools.service" [ OK ] Stopped target swap.target. [ 13.865060] systemd[1]: mnt-oem563506526.mount: Deactivated successfully. [ OK ] Stopped dracut-pre-mount.service. [ 13.875917] ignition[1005]: INFO : files: op(19): op(1a): [finished] writing unit "prepare-critools.service" at "/sysroot/etc/systemd/system/prepare-critools.service" [ OK ] Stopped target cryptsetup.target. [ 13.896178] ignition[1005]: INFO : files: op(19): [finished] processing unit "prepare-critools.service" [ OK ] Stopped dracut-initqueue.service. [ 13.910163] ignition[1005]: INFO : files: op(1b): [started] setting preset to enabled for "prepare-cni-plugins.service" [ OK ] Stopped initrd-setup-root-after-ignition.service. [ 13.925425] ignition[1005]: INFO : files: op(1b): [finished] setting preset to enabled for "prepare-cni-plugins.service" [ OK ] Stopped ignition-files.service. [ 13.941642] ignition[1005]: INFO : files: op(1c): [started] setting preset to enabled for "prepare-critools.service" [ OK ] Stopped flatcar-metadata-hostname.service. [ 13.956995] ignition[1005]: INFO : files: op(1c): [finished] setting preset to enabled for "prepare-critools.service" Stopping ignition-mount.service... Stopping iscsid.service... [ 13.975567] ignition[1005]: INFO : files: op(1d): [started] setting preset to enabled for "waagent.service" Stopping sysroot-boot.service... [ OK ] Stopped systemd-udev-trigger.service. [ 13.995226] ignition[1005]: INFO : files: op(1d): [finished] setting preset to enabled for "waagent.service" [ OK ] Stopped dracut-pre-trigger.service. [ 14.017724] ignition[1005]: INFO : files: op(1e): [started] setting preset to enabled for "nvidia.service" [ OK ] Stopped iscsid.service. [ 14.032665] ignition[1005]: INFO : files: op(1e): [finished] setting preset to enabled for "nvidia.service" [ OK ] Stopped ignition-mount.service. [ 14.046758] ignition[1005]: INFO : files: createResultFile: createFiles: op(1f): [started] writing file "/sysroot/etc/.ignition-result.json" [ 14.063876] ignition[1005]: INFO : files: createResultFile: createFiles: op(1f): [finished] writing file "/sysroot/etc/.ignition-result.json" [ OK ] Stopped ignition-disks.service. [ 14.075639] ignition[1005]: INFO : files: files passed [ OK ] Stopped ignition-kargs.service. [ 14.088346] ignition[1005]: INFO : Ignition finished successfully [ OK ] Stopped ignition-fetch.service. [ 14.102403] initrd-setup-root-after-ignition[1030]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory [ OK ] Stopped ignition-fetch-offline.service. [ 14.123806] systemd[1]: Finished ignition-files.service. [ OK ] Stopped target paths.target. [ 14.135423] iscsid[855]: iscsid shutting down. [ 14.144934] systemd[1]: Starting initrd-setup-root-after-ignition.service... [ OK ] Stopped systemd-ask-password-console.path. [ 14.151865] systemd[1]: torcx-profile-populate.service was skipped because of an unmet condition check (ConditionPathExists=/sysroot/etc/torcx/next-profile). [ OK ] Stopped target slices.target. [ 14.180923] systemd[1]: Starting ignition-quench.service... [ OK ] Stopped target sockets.target. [ 14.193417] systemd[1]: ignition-quench.service: Deactivated successfully. [ 14.209366] systemd[1]: Finished ignition-quench.service. [ OK ] Closed iscsid.socket. [ 14.214330] systemd[1]: Finished initrd-setup-root-after-ignition.service. [ OK ] Stopped ignition-setup.service. [ 14.225013] ignition[1043]: INFO : Ignition 2.14.0 [ 14.236517] ignition[1043]: INFO : Stage: umount Stopping iscsiuio.service... [ 14.241266] ignition[1043]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" [ OK ] Stopped iscsiuio.service. [ 14.255352] ignition[1043]: DEBUG : parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63 [ OK ] Stopped target network.target. [ 14.276341] ignition[1043]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" [ OK ] Closed iscsiuio.socket. [ 14.290248] ignition[1043]: INFO : umount: umount passed Stopping systemd-networkd.service... [ 14.300250] ignition[1043]: INFO : Ignition finished successfully Stopping systemd-resolved.service... [ 14.310356] systemd[1]: Reached target ignition-complete.target. [ OK ] Stopped systemd-networkd.service. [ 14.322070] systemd[1]: Starting initrd-parse-etc.service... [ OK ] Stopped systemd-resolved.service. [ 14.332288] systemd[1]: initrd-parse-etc.service: Deactivated successfully. [ OK ] Closed systemd-networkd.socket. [ 14.344681] systemd[1]: Finished initrd-parse-etc.service. [ 14.354927] systemd[1]: Reached target initrd-fs.target. Stopping network-cleanup.service... [ 14.360588] systemd[1]: Reached target initrd.target. [ OK ] Stopped parse-ip-for-networkd.service. [ 14.370746] systemd[1]: dracut-mount.service was skipped because no trigger condition checks were met. [ OK ] Stopped systemd-sysctl.service. [ 14.385593] systemd[1]: Starting dracut-pre-pivot.service... [ OK ] Stopped systemd-modules-load.service. [ 14.396120] systemd[1]: Finished dracut-pre-pivot.service. Stopping systemd-udevd.service... [ 14.406644] systemd[1]: Starting initrd-cleanup.service... [ 14.418097] systemd[1]: initrd-cleanup.service: Deactivated successfully. [ 14.424428] systemd[1]: Finished initrd-cleanup.service. [ OK ] Stopped systemd-udevd.service. [ 14.430159] systemd[1]: Stopped target nss-lookup.target. [ OK ] Closed systemd-udevd-control.socket. [ 14.440542] systemd[1]: Stopped target remote-cryptsetup.target. [ OK ] Closed systemd-udevd-kernel.socket. [ 14.450826] systemd[1]: Stopped target timers.target. [ 14.932272] hv_netvsc 000d3a6f-3492-000d-3a6f-3492000d3a6f eth0: Data path switched from VF: enP4929s1 [ OK ] Stopped dracut-pre-udev.service. [ 14.471315] systemd[1]: dracut-pre-pivot.service: Deactivated successfully. [ OK ] Stopped dracut-cmdline.service. [ 14.482497] systemd[1]: Stopped dracut-pre-pivot.service. [ OK ] Stopped dracut-cmdline-ask.service. [ 14.491701] systemd[1]: Stopped target initrd.target. [ 14.501633] systemd[1]: Stopped target basic.target. Starting initrd-udevadm-cleanup-db.service... [ 14.507120] systemd[1]: Stopped target ignition-complete.target. [ OK ] Stopped systemd-tmpfiles-setup-dev.service. [ 14.517712] systemd[1]: Stopped target ignition-diskful.target. [ OK ] Stopped kmod-static-nodes.service. [ 14.531156] systemd[1]: Stopped target initrd-root-device.target. [ OK ] Stopped systemd-vconsole-setup.service. [ 14.541820] systemd[1]: Stopped target remote-fs.target. [ OK ] Finished initrd-udevadm-cleanup-db.service. [ 14.552852] systemd[1]: Stopped target remote-fs-pre.target. [ 14.563548] systemd[1]: Stopped target sysinit.target. [ OK ] Stopped network-cleanup.service. [ 14.568189] systemd[1]: Stopped target local-fs.target. [ 14.577237] systemd[1]: Stopped target local-fs-pre.target. [ 14.582121] systemd[1]: Stopped target swap.target. [ 14.586372] systemd[1]: dracut-pre-mount.service: Deactivated successfully. [ 14.592201] systemd[1]: Stopped dracut-pre-mount.service. [ 14.596839] systemd[1]: Stopped target cryptsetup.target. [ 14.601373] systemd[1]: dracut-initqueue.service: Deactivated successfully. [ 14.607160] systemd[1]: Stopped dracut-initqueue.service. [ 14.611459] systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. [ 14.618742] systemd[1]: Stopped initrd-setup-root-after-ignition.service. [ 14.625041] systemd[1]: ignition-files.service: Deactivated successfully. [ 14.631198] systemd[1]: Stopped ignition-files.service. [ 14.635860] systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. [ 14.642536] systemd[1]: Stopped flatcar-metadata-hostname.service. [ 14.648863] systemd[1]: Stopping ignition-mount.service... [ 14.654118] systemd[1]: Stopping iscsid.service... [ 14.658257] systemd[1]: Stopping sysroot-boot.service... [ 14.663724] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. [ 14.669830] systemd[1]: Stopped systemd-udev-trigger.service. [ 14.675669] systemd[1]: dracut-pre-trigger.service: Deactivated successfully. [ 14.682326] systemd[1]: Stopped dracut-pre-trigger.service. [ 14.687896] systemd[1]: iscsid.service: Deactivated successfully. [ 14.694426] systemd[1]: Stopped iscsid.service. [ 14.699061] systemd[1]: ignition-mount.service: Deactivated successfully. [ 14.705470] systemd[1]: Stopped ignition-mount.service. [ 14.713200] systemd[1]: ignition-disks.service: Deactivated successfully. [ 14.719383] systemd[1]: Stopped ignition-disks.service. [ 14.724368] systemd[1]: ignition-kargs.service: Deactivated successfully. [ 14.730703] systemd[1]: Stopped ignition-kargs.service. [ 14.735590] systemd[1]: ignition-fetch.service: Deactivated successfully. [ 14.742147] systemd[1]: Stopped ignition-fetch.service. [ 14.746921] systemd[1]: ignition-fetch-offline.service: Deactivated successfully. [ 14.753696] systemd[1]: Stopped ignition-fetch-offline.service. [ 14.759916] systemd[1]: Stopped target paths.target. [ 14.764624] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. [ 14.771691] systemd[1]: Stopped systemd-ask-password-console.path. [ 14.777491] systemd[1]: Stopped target slices.target. [ 14.782509] systemd[1]: Stopped target sockets.target. [ 14.787367] systemd[1]: iscsid.socket: Deactivated successfully. [ 14.792934] systemd[1]: Closed iscsid.socket. [ 14.797052] systemd[1]: ignition-setup.service: Deactivated successfully. [ 14.803925] systemd[1]: Stopped ignition-setup.service. [ 14.809046] systemd[1]: Stopping iscsiuio.service... [ 14.813501] systemd[1]: sysroot-boot.mount: Deactivated successfully. [ 14.819668] systemd[1]: iscsiuio.service: Deactivated successfully. [ 14.825633] systemd[1]: Stopped iscsiuio.service. [ 14.830427] systemd[1]: Stopped target network.target. [ 14.835891] systemd[1]: iscsiuio.socket: Deactivated successfully. [ 14.841924] systemd[1]: Closed iscsiuio.socket. [ 14.846161] systemd[1]: Stopping systemd-networkd.service... [ 14.852903] systemd[1]: Stopping systemd-resolved.service... [ OK ] Stopped sysroot-boot.service. [ 14.858495] systemd-networkd[846]: eth0: DHCPv6 lease lost [ OK ] Reached target initrd-switch-root.target. [ 14.869546] systemd[1]: systemd-networkd.service: Deactivated successfully. [ 14.882107] systemd[1]: Stopped systemd-networkd.service. [ OK ] Stopped initrd-setup-root.service. [ 14.886813] systemd[1]: systemd-resolved.service: Deactivated successfully. Starting initrd-switch-root.service... [ 14.898966] systemd[1]: Stopped systemd-resolved.service. [ 14.914200] systemd[1]: systemd-networkd.socket: Deactivated successfully. [ 14.920415] systemd[1]: Closed systemd-networkd.socket. [ 14.924998] systemd[1]: Stopping network-cleanup.service... [ 14.930193] systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. [ 14.937172] systemd[1]: Stopped parse-ip-for-networkd.service. [ 14.942470] systemd[1]: systemd-sysctl.service: Deactivated successfully. [ 14.948988] systemd[1]: Stopped systemd-sysctl.service. [ 14.953455] systemd[1]: systemd-modules-load.service: Deactivated successfully. [ 14.960769] systemd[1]: Stopped systemd-modules-load.service. [ 14.966555] systemd[1]: Stopping systemd-udevd.service... [ 14.971999] systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. [ 14.980787] systemd[1]: systemd-udevd.service: Deactivated successfully. [ 14.986770] systemd[1]: Stopped systemd-udevd.service. [ 14.991506] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. [ 14.997779] systemd[1]: Closed systemd-udevd-control.socket. [ 15.002758] systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. [ 15.480634] systemd-journald[276]: Received SIGTERM from PID 1 (n/a). (flatcar) runtime switch to legacy cgroups [ 19.593753] SELinux: Class mctp_socket not defined in policy. [ 19.601462] SELinux: Class anon_inode not defined in policy. [ 19.607485] SELinux: the above unknown classes and permissions will be allowed [ 19.616667] SELinux: policy capability network_peer_controls=1 [ 19.623518] SELinux: policy capability open_perms=1 [ 19.629048] SELinux: policy capability extended_socket_class=1 [ 19.635131] SELinux: policy capability always_check_network=0 [ 19.641026] SELinux: policy capability cgroup_seclabel=1 [ 19.654337] SELinux: policy capability nnp_nosuid_transition=1 [ 19.660062] SELinux: policy capability genfs_seclabel_symlinks=0 [ 19.665905] SELinux: policy capability ioctl_skip_cloexec=0 [ 19.691022] kauditd_printk_skb: 41 callbacks suppressed [ 19.691025] audit: type=1403 audit(1707503832.106:88): auid=4294967295 ses=4294967295 lsm=selinux res=1 [ 19.712428] systemd[1]: Successfully loaded SELinux policy in 340.704ms. [ 20.404313] systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 23.454ms. [ 20.448656] 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) [ 20.479216] systemd[1]: Detected virtualization microsoft. [ 20.487931] systemd[1]: Detected architecture arm64. [ 20.493827] systemd[1]: Detected first boot. Welcome to Flatcar Container Linux by Kinvolk 3510.3.2 (LTS 2023)! [ 20.538533] systemd[1]: Hostname set to . [ 20.577027] systemd[1]: Initializing machine ID from random generator. [ 21.990911] SELinux: Context system_u:object_r:container_file_t:s0:c1022,c1023 is not valid (left unmapped). [ 22.002854] audit: type=1400 audit(1707503834.406:89): avc: denied { associate } for pid=1093 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" [ 22.030982] audit: type=1300 audit(1707503834.406:89): arch=c00000b7 syscall=5 success=yes exit=0 a0=4000022244 a1=40000282b8 a2=40000264c0 a3=32 items=0 ppid=1076 pid=1093 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) [ 22.067720] audit: type=1327 audit(1707503834.406:89): proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61 [ 22.095128] audit: type=1400 audit(1707503834.421:90): avc: denied { associate } for pid=1093 comm="torcx-generator" name="usr" scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 [ 22.115037] audit: type=1300 audit(1707503834.421:90): arch=c00000b7 syscall=34 success=yes exit=0 a0=ffffffffffffff9c a1=4000022329 a2=1ed a3=0 items=2 ppid=1076 pid=1093 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) [ 22.148444] audit: type=1307 audit(1707503834.421:90): cwd="/" [ 22.154184] audit: type=1302 audit(1707503834.421:90): item=0 name=(null) inode=2 dev=00:29 mode=040755 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:unlabeled_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 [ 22.173482] audit: type=1302 audit(1707503834.421:90): item=1 name=(null) inode=3 dev=00:29 mode=040755 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:unlabeled_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 [ 22.193899] audit: type=1327 audit(1707503834.421:90): proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61 [ 27.619886] systemd[1]: Populated /etc with preset unit settings. [ 28.354290] systemd[1]: /usr/lib/systemd/system/locksmithd.service:8: Unit uses CPUShares=; please use CPUWeight= instead. Support for CPUShares= will be removed soon. [ 28.371200] systemd[1]: /usr/lib/systemd/system/locksmithd.service:9: Unit uses MemoryLimit=; please use MemoryMax= instead. Support for MemoryLimit= will be removed soon. [ 28.425605] 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. [ 28.467456] systemd[1]: Queued start job for default target multi-user.target. [ 28.481233] systemd[1]: Created slice system-addon\x2dconfig.slice. [ OK ] Created slice system-addon\x2dconfig.slice. [ 28.495724] systemd[1]: Created slice system-addon\x2drun.slice. [ OK ] Created slice system-addon\x2drun.slice. [ 28.509687] systemd[1]: Created slice system-getty.slice. [ OK ] Created slice system-getty.slice. [ 28.521847] systemd[1]: Created slice system-modprobe.slice. [ OK ] Created slice system-modprobe.slice. [ 28.533777] systemd[1]: Created slice system-serial\x2dgetty.slice. [ OK ] Created slice system-serial\x2dgetty.slice. [ 28.546949] systemd[1]: Created slice system-system\x2dcloudinit.slice. [ OK ] Created slice system-system\x2dcloudinit.slice. [ 28.562490] systemd[1]: Created slice system-systemd\x2dfsck.slice. [ OK ] Created slice system-systemd\x2dfsck.slice. [ 28.575385] systemd[1]: Created slice user.slice. [ OK ] Created slice user.slice. [ 28.585572] systemd[1]: Started systemd-ask-password-console.path. [ OK ] Started systemd-ask-password-console.path. [ 28.597508] systemd[1]: Started systemd-ask-password-wall.path. [ OK ] Started systemd-ask-password-wall.path. [ 28.609468] systemd[1]: Set up automount boot.automount. [ OK ] Set up automount boot.automount. [ 28.620826] systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount. [ OK ] Set up automount proc-sys-fs-binfmt_misc.automount. [ 28.634059] systemd[1]: Reached target integritysetup.target. [ OK ] Reached target integritysetup.target. [ 28.645698] systemd[1]: Reached target remote-cryptsetup.target. [ OK ] Reached target remote-cryptsetup.target. [ 28.659682] systemd[1]: Reached target remote-fs.target. [ OK ] Reached target remote-fs.target. [ 28.671229] systemd[1]: Reached target slices.target. [ OK ] Reached target slices.target. [ 28.683228] systemd[1]: Reached target swap.target. [ OK ] Reached target swap.target. [ 28.694380] systemd[1]: Reached target torcx.target. [ OK ] Reached target torcx.target. [ 28.704564] systemd[1]: Reached target veritysetup.target. [ OK ] Reached target veritysetup.target. [ 28.716899] systemd[1]: Listening on systemd-coredump.socket. [ OK ] Listening on systemd-coredump.socket. [ 28.731562] systemd[1]: Listening on systemd-initctl.socket. [ OK ] Listening on systemd-initctl.socket. [ 28.743739] audit: type=1400 audit(1707503841.159:91): avc: denied { audit_read } for pid=1 comm="systemd" capability=37 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1 [ 28.743757] systemd[1]: Listening on systemd-journald-audit.socket. [ 28.764139] audit: type=1335 audit(1707503841.159:92): pid=1 uid=0 auid=4294967295 tty=(none) ses=4294967295 subj=system_u:system_r:kernel_t:s0 comm="systemd" exe="/usr/lib/systemd/systemd" nl-mcgrp=1 op=connect res=1 [ OK ] Listening on systemd-journald-audit.socket. [ 28.800434] systemd[1]: Listening on systemd-journald-dev-log.socket. [ OK ] Listening on systemd-journald-dev-log.socket. [ 28.820779] systemd[1]: Listening on systemd-journald.socket. [ OK ] Listening on systemd-journald.socket. [ 28.835045] systemd[1]: Listening on systemd-networkd.socket. [ OK ] Listening on systemd-networkd.socket. [ 28.849588] systemd[1]: Listening on systemd-udevd-control.socket. [ OK ] Listening on systemd-udevd-control.socket. [ 28.866638] systemd[1]: Listening on systemd-udevd-kernel.socket. [ OK ] Listening on systemd-udevd-kernel.socket. [ 28.880573] systemd[1]: Listening on systemd-userdbd.socket. [ OK ] Listening on systemd-userdbd.socket. [ 28.895416] systemd[1]: Mounting dev-hugepages.mount... Mounting dev-hugepages.mount... [ 28.907877] systemd[1]: Mounting dev-mqueue.mount... Mounting dev-mqueue.mount... [ 28.920921] systemd[1]: Mounting media.mount... Mounting media.mount... [ 28.931851] systemd[1]: Mounting sys-kernel-debug.mount... Mounting sys-kernel-debug.mount... [ 28.944621] systemd[1]: Mounting sys-kernel-tracing.mount... Mounting sys-kernel-tracing.mount... [ 28.958143] systemd[1]: Mounting tmp.mount... Mounting tmp.mount... [ 28.967547] systemd[1]: Starting flatcar-tmpfiles.service... Starting flatcar-tmpfiles.service... [ 28.981076] systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. [ 28.995924] systemd[1]: Starting kmod-static-nodes.service... Starting kmod-static-nodes.service... [ 29.008733] systemd[1]: Starting modprobe@configfs.service... Starting modprobe@configfs.service... [ 29.020863] systemd[1]: Starting modprobe@dm_mod.service... Starting modprobe@dm_mod.service... [ 29.033629] systemd[1]: Starting modprobe@drm.service... Starting modprobe@drm.service... [ 29.044580] systemd[1]: Starting modprobe@efi_pstore.service... Starting modprobe@efi_pstore.service... [ 29.056831] systemd[1]: Starting modprobe@fuse.service... Starting modprobe@fuse.service... [ 29.070089] systemd[1]: Starting modprobe@loop.service... Starting modprobe@loop.service... [ 29.081954] systemd[1]: setup-nsswitch.service was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). [ 29.095505] systemd[1]: systemd-journald.service: unit configures an IP firewall, but the local system does not support BPF/cgroup firewalling. [ 29.109970] systemd[1]: (This warning is only shown for the first unit using IP firewalling.) [ 29.119140] loop: module loaded [ 29.120868] systemd[1]: Starting systemd-journald.service... Starting systemd-journald.service... [ 29.154558] systemd[1]: Starting systemd-modules-load.service... Starting systemd-modules-load.service... [ 29.169490] systemd[1]: Starting systemd-network-generator.service... Starting systemd-network-generator.service...[ 29.179555] fuse: init (API version 7.34) [ 29.188475] systemd[1]: Starting systemd-remount-fs.service... Starting systemd-remount-fs.service... [ 29.202548] systemd[1]: Starting systemd-udev-trigger.service... Starting systemd-udev-trigger.service... [ 29.221871] systemd[1]: Mounted dev-hugepages.mount. [ OK ] Mounted dev-hugepages.mount. [ 29.233241] systemd[1]: Mounted dev-mqueue.mount. [ OK ] Mounted dev-mqueue.mount. [ 29.247310] audit: type=1305 audit(1707503841.661:93): op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 [ 29.263871] systemd[1]: Started systemd-journald.service. [ OK ] Started systemd-journald.service. [ 29.276695] audit: type=1300 audit(1707503841.661:93): arch=c00000b7 syscall=211 success=yes exit=60 a0=6 a1=ffffde4ae2f0 a2=4000 a3=1 items=0 ppid=1 pid=1195 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="systemd-journal" exe="/usr/lib/systemd/systemd-journald" subj=system_u:system_r:kernel_t:s0 key=(null) [ OK ] Mounted media.mount. [ OK ] Mounted sys-kernel-debug.mount. [ OK ] Mounted sys-kernel-tracing.mount. [ OK ] Mounted tmp.mount. [ OK ] Finished flatcar-tmpfiles.service.[ 29.331724] audit: type=1327 audit(1707503841.661:93): proctitle="/usr/lib/systemd/systemd-journald" [ OK ] Finished kmod-static-nodes.service.[ 29.347952] audit: type=1130 audit(1707503841.724:94): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Finished modprobe@configfs.service.[ 29.374976] audit: type=1130 audit(1707503841.761:95): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=flatcar-tmpfiles comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Finished modprobe@dm_mod.service.[ 29.403415] audit: type=1130 audit(1707503841.789:96): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Finished modprobe@drm.service.[ 29.430528] audit: type=1130 audit(1707503841.816:97): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@configfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Finished modprobe@efi_pstore.service.[ 29.457788] audit: type=1131 audit(1707503841.816:98): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@configfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Finished modprobe@fuse.service. [ OK ] Finished modprobe@loop.service. [ OK ] Finished systemd-modules-load.service. [ OK ] Finished systemd-network-generator.service. [ OK ] Finished systemd-remount-fs.service. [ OK ] Finished systemd-udev-trigger.service. [ OK ] Reached target network-pre.target. Mounting sys-fs-fuse-connections.mount... Mounting sys-kernel-config.mount... Starting systemd-hwdb-update.service... Starting systemd-journal-flush.service... Starting systemd-random-seed.service... Starting systemd-sysctl.service... Starting systemd-sysusers.service... Starting systemd-udev-settle.service... [ OK ] Mounted sys-fs-fuse-connections.mount. [ OK ] Mounted sys-kernel-config.mount. [ 29.600089] systemd-journald[1195]: Received client request to flush runtime journal. [ OK ] Finished systemd-random-seed.service. [ OK ] Reached target first-boot-complete.target. [ OK ] Finished systemd-sysctl.service. [ OK ] Finished systemd-journal-flush.service. [ OK ] Finished systemd-sysusers.service. Starting systemd-tmpfiles-setup-dev.service... [ OK ] Finished systemd-tmpfiles-setup-dev.service. [ OK ] Finished systemd-hwdb-update.service. Starting systemd-udevd.service... [ OK ] Started systemd-udevd.service. Starting systemd-networkd.service... [ OK ] Found device dev-ttyAMA0.device. [ 31.064375] mousedev: PS/2 mouse device common for all mice [ 31.095972] hv_vmbus: registering driver hyperv_fb [ 31.102725] hyperv_fb: Synthvid Version major 3, minor 5 [ 31.108706] hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 [ 31.119182] Console: switching to colour dummy device 80x25 [ 31.125578] Console: switching to colour frame buffer device 128x48 [ 31.145088] hv_utils: Registering HyperV Utility Driver [ 31.150712] hv_vmbus: registering driver hv_balloon [ 31.153296] hv_vmbus: registering driver hv_utils [ 31.159749] hv_balloon: Using Dynamic Memory protocol version 2.0 [ 31.159940] hv_utils: Heartbeat IC version 3.0 [ 31.165685] hv_balloon: Memory hot add disabled on ARM64 [ 31.170741] hv_utils: Shutdown IC version 3.2 [ 31.184644] hv_utils: TimeSync IC version 4.0 Starting systemd-userdbd.service... [ OK ] Started systemd-userdbd.service. [ 31.326578] BTRFS info: devid 1 device path /dev/disk/by-label/OEM changed to /dev/sda6 scanned by (udev-worker) (1267) [ OK ] Finished systemd-udev-settle.service. Starting lvm2-activation-early.service... [ 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... [ OK ] Started systemd-networkd.service. Starting systemd-networkd-wait-online.service... [ OK ] Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service. Starting systemd-fsck@dev-…label-EFI\x2dSYSTEM.service... [ 31.891431] mlx5_core 1341:00:02.0 enP4929s1: Link up [ 31.916525] hv_netvsc 000d3a6f-3492-000d-3a6f-3492000d3a6f eth0: Data path switched to VF: enP4929s1 [ OK ] Finished systemd-machine-id-commit.service. [ OK ] Finished systemd-fsck@dev-…2dlabel-EFI\x2dSYSTEM.service. Mounting boot.mount... [ OK ] Mounted boot.mount. [ OK ] Finished systemd-boot-update.service. [ OK ] Finished systemd-tmpfiles-setup.service. Starting audit-rules.service... Starting clean-ca-certificates.service... Starting systemd-journal-catalog-update.service... Starting systemd-resolved.service... Starting systemd-timesyncd.service... Starting systemd-update-utmp.service... [ OK ] Finished clean-ca-certificates.service. [ OK ] Finished systemd-update-utmp.service. [ OK ] Finished systemd-networkd-wait-online.service. [ OK ] Started systemd-timesyncd.service. [ OK ] Reached target time-set.target. [ OK ] Finished systemd-journal-catalog-update.service. [ OK ] Started systemd-resolved.service. [ OK ] Reached target network.target. [ OK ] Reached target network-online.target. [ OK ] Reached target nss-lookup.target. [ OK ] Finished audit-rules.service. [* ] Job ldconfig.service/start running (6s / no limit) M [** ] 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. [ OK ] Finished motdgen.service. [ 39.664435] extend-filesystems[1399]: Found sda [ 39.670303] extend-filesystems[1399]: Found sda1 [ 39.678093] extend-filesystems[1399]: Found sda2 [ 39.698304] extend-filesystems[1399]: Found sda3 [ 39.730502] extend-filesystems[1399]: Found usr [ 39.748160] extend-filesystems[1399]: Found sda4 [ OK ] Finished extend-filesystems.service. [ 39.776230] extend-filesystems[1399]: Found sda6 [ 39.832097] extend-filesystems[1399]: Found sda7 [ OK ] Finished update-ssh-keys-after-ignition.service. [ 39.851685] extend-filesystems[1399]: Found sda9 [ OK ] Started dbus.service. [ 39.908452] extend-filesystems[1399]: Checking size of /dev/sda9 [ OK ] Reached target system-config.target. [ OK ] Reached target user-config.target. [ 39.945939] extend-filesystems[1399]: Old size kept for /dev/sda9 [ OK ] Started containerd.service. [ 39.993420] extend-filesystems[1399]: Found sr0 [ OK ] Started systemd-logind.service. [ OK ] Finished prepare-critools.service. [ OK ] Started update-engine.service. [ OK ] Started locksmithd.service. [ OK ] Finished prepare-cni-plugins.service. [ OK ] Finished sshd-keygen.service. Starting issuegen.service... [ OK ] Started waagent.service. [ OK ] Finished issuegen.service. Starting systemd-user-sessions.service... [ OK ] Finished systemd-user-sessions.service. [ OK ] Started getty@tty1.service. [ OK ] Started serial-getty@ttyAMA0.service. [ OK ] Reached target getty.target. [ OK ] Reached target multi-user.target. Starting systemd-update-utmp-runlevel.service... [ OK ] Finished systemd-update-utmp-runlevel.service. This is ci-3510.3.2-a-132224a944 (Linux aarch64 5.15.148-flatcar) 18:37:34 SSH host key: SHA256:oQ7kk2eCzJ6nMDHZXHRH2NsKmXECreLnyJ1xdncways (RSA) SSH host key: SHA256:zplWj1Td43szGRWBn1YfJ+3eW1k9GiOD3LLkDfbtdXE (ED25519) SSH host key: SHA256:s3zm0KMXh7QZWPdXrfHd/jbAPZP0FVOkZiWeaLZfCP8 (ECDSA) enP4929s1: eth0: 10.200.20.24 fe80::20d:3aff:fe6f:3492 ci-3510 login: core (automatic login) Flatcar Container Linux by Kinvolk lts 3510.3.2 for Microsoft Azure Warning: using legacy cgroups Read more: https://kinvolk.io/docs/flatcar-container-linux/latest/container-runtimes/switching-to-unified-cgroups [?2004hcore@ci-3510 ~ $ 2024-02-09T18:37:39.669027Z INFO Daemon Daemon Azure Linux Agent Version:2.6.0.2 2024-02-09T18:37:39.677006Z INFO Daemon Daemon OS: flatcar 3510.3.2 2024-02-09T18:37:39.682709Z INFO Daemon Daemon Python: 3.9.16 2024-02-09T18:37:39.688277Z INFO Daemon Daemon Run daemon 2024-02-09T18:37:39.693657Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='3510.3.2' 2024-02-09T18:37:39.712656Z INFO Daemon Daemon Unable to get cloud-init enabled status from systemctl: Command '['systemctl', 'is-enabled', 'cloud-init-local.service']' returned non-zero exit status 1. 2024-02-09T18:37:39.731136Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' 2024-02-09T18:37:39.743929Z INFO Daemon Daemon cloud-init is enabled: False 2024-02-09T18:37:39.750231Z INFO Daemon Daemon Using waagent for provisioning 2024-02-09T18:37:39.757492Z INFO Daemon Daemon Activate resource disk 2024-02-09T18:37:39.763312Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb 2024-02-09T18:37:39.779052Z INFO Daemon Daemon Found device: None 2024-02-09T18:37:39.785002Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology 2024-02-09T18:37:39.795500Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 2024-02-09T18:37:39.809676Z INFO Daemon Daemon Clean protocol and wireserver endpoint 2024-02-09T18:37:39.816821Z INFO Daemon Daemon Running default provisioning handler 2024-02-09T18:37:39.831379Z INFO Daemon Daemon Unable to get cloud-init enabled status from systemctl: Command '['systemctl', 'is-enabled', 'cloud-init-local.service']' returned non-zero exit status 1. 2024-02-09T18:37:39.849457Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' 2024-02-09T18:37:39.861806Z INFO Daemon Daemon cloud-init is enabled: False 2024-02-09T18:37:39.869079Z INFO Daemon Daemon Copying ovf-env.xml 2024-02-09T18:37:39.963261Z INFO Daemon Daemon Successfully mounted dvd 2024-02-09T18:37:40.031621Z INFO Daemon Daemon Detect protocol endpoint 2024-02-09T18:37:40.037852Z INFO Daemon Daemon Clean protocol and wireserver endpoint 2024-02-09T18:37:40.044805Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler 2024-02-09T18:37:40.052828Z INFO Daemon Daemon Test for route to 168.63.129.16 2024-02-09T18:37:40.060045Z INFO Daemon Daemon Route to 168.63.129.16 exists 2024-02-09T18:37:40.066275Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 2024-02-09T18:37:40.149855Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 2024-02-09T18:37:40.158500Z INFO Daemon Daemon Wire protocol version:2012-11-30 2024-02-09T18:37:40.164845Z INFO Daemon Daemon Server preferred version:2015-04-05 2024-02-09T18:37:40.617375Z INFO Daemon Daemon Initializing goal state during protocol detection 2024-02-09T18:37:40.635565Z INFO Daemon Daemon Forcing an update of the goal state.. 2024-02-09T18:37:40.642968Z INFO Daemon Daemon Fetching goal state [incarnation 1] 2024-02-09T18:37:40.717024Z INFO Daemon Daemon Found private key matching thumbprint 09CC324AC58C8B3188BF4515E1F41AAE3638A489 2024-02-09T18:37:40.727097Z INFO Daemon Daemon Certificate with thumbprint 74AC96A8422302EC79129BB13D39C321EBFFD7AC has no matching private key. 2024-02-09T18:37:40.739035Z INFO Daemon Daemon Fetch goal state completed 2024-02-09T18:37:40.786136Z INFO Daemon Daemon Fetched new vmSettings [correlation ID: 028a9224-a29b-4046-b9d3-99b04994c5a1 New eTag: 14550873600814090447] 2024-02-09T18:37:40.799272Z INFO Daemon Daemon Status Blob type 'None' is not valid, assuming BlockBlob 2024-02-09T18:37:40.816612Z INFO Daemon Daemon Starting provisioning 2024-02-09T18:37:40.823594Z INFO Daemon Daemon Handle ovf-env.xml. 2024-02-09T18:37:40.831890Z INFO Daemon Daemon Set hostname [ci-3510.3.2-a-132224a944] 2024-02-09T18:37:40.887707Z INFO Daemon Daemon Publish hostname [ci-3510.3.2-a-132224a944] 2024-02-09T18:37:40.895688Z INFO Daemon Daemon Examine /proc/net/route for primary interface 2024-02-09T18:37:40.903730Z INFO Daemon Daemon Primary interface is [eth0] 2024-02-09T18:37:40.967481Z INFO Daemon Daemon Create user account if not exists 2024-02-09T18:37:40.977177Z INFO Daemon Daemon User core already exists, skip useradd 2024-02-09T18:37:40.985928Z INFO Daemon Daemon Configure sudoer 2024-02-09T18:37:40.992288Z INFO Daemon Daemon Configure sshd 2024-02-09T18:37:40.997734Z INFO Daemon Daemon Deploy ssh public key. 2024-02-09T18:37:42.241203Z INFO Daemon Daemon Provisioning complete 2024-02-09T18:37:42.263509Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping 2024-02-09T18:37:42.271377Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. [ 79.331133] hv_balloon: Max. dynamic memory size: 4096 MB [ 95.011122] SELinux: Context system_u:object_r:container_file_t:s0 is not valid (left unmapped). [ 124.609027] WARNING: Unprivileged eBPF is enabled, data leaks possible via Spectre v2 BHB attacks! [ 125.014815] Initializing XFRM netlink socket [ 125.020837] WARNING: Unprivileged eBPF is enabled, data leaks possible via Spectre v2 BHB attacks! [ 126.665830] IPv6: ADDRCONF(NETDEV_CHANGE): cilium_net: link becomes ready [ 126.672274] IPv6: ADDRCONF(NETDEV_CHANGE): cilium_host: link becomes ready [ 127.130699] NET: Registered PF_ALG protocol family [ 127.789727] IPv6: ADDRCONF(NETDEV_CHANGE): lxc_health: link becomes ready [ 128.290794] eth0: renamed from tmp4cd07 [ 128.309740] IPv6: ADDRCONF(NETDEV_CHANGE): lxc9036f281c102: link becomes ready [ 143.165713] eth0: renamed from tmpdb58f [ 143.174797] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 143.180489] IPv6: ADDRCONF(NETDEV_CHANGE): lxc36ef280728bc: link becomes ready [ 158.369246] FS-Cache: Loaded [ 158.437012] RPC: Registered named UNIX socket transport module. [ 158.448519] RPC: Registered udp transport module. [ 158.456068] RPC: Registered tcp transport module. [ 158.463348] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 158.559320] FS-Cache: Netfs 'nfs' registered for caching [ 158.723088] NFS: Registering the id_resolver key type [ 158.731114] Key type id_resolver registered [ 158.737498] Key type id_legacy registered [ 159.282382] eth0: renamed from tmp1c55f [ 159.290631] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 159.296340] IPv6: ADDRCONF(NETDEV_CHANGE): lxcdd56b6956477: link becomes ready [ 174.958655] alg: No test for seqiv(rfc4106(gcm(aes))) (seqiv(rfc4106(gcm-aes-ce))) [ 177.524746] IPv6: ADDRCONF(NETDEV_CHANGE): lxc_health: link becomes ready