[=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 0x1bf7f0900-0x1bf7f5fff] [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000000000-0x00000000ffffffff] [ 0.000000] DMA32 empty [ 0.000000] Normal [mem 0x0000000100000000-0x00000001bfffffff] [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000000000-0x00000000007fffff] [ 0.000000] node 0: [mem 0x0000000000824000-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: 3991928K/4194160K available (9792K kernel code, 2092K rwdata, 7556K rodata, 34688K init, 778K bss, 202232K 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.009698] Console: colour dummy device 80x25 [ 0.015066] printk: console [tty1] enabled [ 0.020025] ACPI: Core revision 20210730 [ 0.024990] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) [ 0.037212] pid_max: default: 32768 minimum: 301 [ 0.042683] LSM: Security Framework initializing [ 0.048389] SELinux: Initializing. [ 0.052484] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) [ 0.061386] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) [ 0.072291] Hyper-V: privilege flags low 0x2e7f, high 0x3a8030, hints 0xe, misc 0x31e1 [ 0.081707] Hyper-V: Host Build 10.0.22477.1369-1-0 [ 0.087425] rcu: Hierarchical SRCU implementation. [ 0.093077] Remapping and enabling EFI services. [ 0.098455] smp: Bringing up secondary CPUs ... [ 0.103950] Detected PIPT I-cache on CPU1 [ 0.103978] GICv3: CPU1: found redistributor 1 region 1:0x00000000f000e000 [ 0.104029] arch_timer: Enabling local workaround for ARM erratum 1418040 [ 0.104072] CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] [ 0.104126] smp: Brought up 1 node, 2 CPUs [ 0.137766] SMP: Total of 2 processors activated. [ 0.142962] CPU features: detected: 32-bit EL0 Support [ 0.148623] CPU features: detected: Instruction cache invalidation not required for I/D coherence [ 0.158400] CPU features: detected: Data cache clean to the PoU not required for I/D coherence [ 0.168828] CPU features: detected: CRC32 instructions [ 0.175385] CPU features: detected: RCpc load-acquire (LDAPR) [ 0.182531] CPU features: detected: LSE atomic instructions [ 0.189877] CPU features: detected: Privileged Access Never [ 0.246491] CPU: All CPU(s) started at EL1 [ 0.251487] alternatives: patching kernel code [ 0.262440] devtmpfs: initialized [ 0.266417] KASLR enabled [ 0.269685] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.281238] futex hash table entries: 512 (order: 3, 32768 bytes, linear) [ 0.288845] pinctrl core: initialized pinctrl subsystem [ 0.294661] SMBIOS 3.1.0 present. [ 0.298316] DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 07/12/2023 [ 0.309908] NET: Registered PF_NETLINK/PF_ROUTE protocol family [ 0.317051] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.324848] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.333525] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.342537] audit: initializing netlink subsys (disabled) [ 0.348521] audit: type=2000 audit(0.091:1): state=initialized audit_enabled=0 res=1 [ 0.348605] thermal_sys: Registered thermal governor 'step_wise' [ 0.356764] cpuidle: using governor menu [ 0.367760] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. [ 0.375119] ASID allocator initialised with 32768 entries [ 0.381569] ACPI: bus type PCI registered [ 0.386107] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.393701] Serial: AMBA PL011 UART driver [ 0.399300] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.407458] HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages [ 0.415772] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.423856] HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages [ 0.551610] cryptd: max_cpu_qlen set to 1000 [ 0.559352] alg: No test for fips(ansi_cprng) (fips_ansi_cprng) [ 0.566637] ACPI: Added _OSI(Module Device) [ 0.571789] ACPI: Added _OSI(Processor Device) [ 0.577038] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.582648] ACPI: Added _OSI(Processor Aggregator Device) [ 0.588978] ACPI: Added _OSI(Linux-Dell-Video) [ 0.594067] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) [ 0.600404] ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) [ 0.610816] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.617842] ACPI: Interpreter enabled [ 0.621757] ACPI: Using GIC for interrupt routing [ 0.627267] ARMH0011:00: ttyAMA0 at MMIO 0xeffec000 (irq = 12, base_baud = 0) is a SBSA [ 0.636203] printk: console [ttyAMA0] enabled [ 0.636203] printk: console [ttyAMA0] enabled [ 0.644544] printk: bootconsole [pl11] disabled [ 0.644544] printk: bootconsole [pl11] disabled [ 0.653881] ARMH0011:01: ttyAMA1 at MMIO 0xeffeb000 (irq = 13, base_baud = 0) is a SBSA [ 0.660664] iommu: Default domain type: Translated [ 0.664952] iommu: DMA domain TLB invalidation policy: strict mode [ 0.670165] vgaarb: loaded [ 0.672275] pps_core: LinuxPPS API ver. 1 registered [ 0.676380] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.684172] PTP clock support registered [ 0.687486] Registered efivars operations [ 0.690750] No ACPI PMU IRQ for CPU0 [ 0.693594] No ACPI PMU IRQ for CPU1 [ 0.696799] clocksource: Switched to clocksource arch_sys_counter [ 0.707647] VFS: Disk quotas dquot_6.6.0 [ 0.710878] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.716245] pnp: PnP ACPI init [ 0.718612] pnp: PnP ACPI: found 0 devices [ 0.724115] NET: Registered PF_INET protocol family [ 0.728721] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) [ 0.735774] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) [ 0.743061] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) [ 0.749425] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) [ 0.755792] TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) [ 0.762224] TCP: Hash tables configured (established 32768 bind 32768) [ 0.767617] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) [ 0.773232] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) [ 0.781635] NET: Registered PF_UNIX/PF_LOCAL protocol family [ 0.786335] PCI: CLS 0 bytes, default 64 [ 0.798850] hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 1 counters available [ 0.805331] kvm [1]: HYP mode not available [ 0.999048] Initialise system trusted keyrings [ 1.002586] workingset: timestamp_bits=39 max_order=20 bucket_order=0 [ 1.008905] Key type asymmetric registered [ 1.012446] Asymmetric key parser 'x509' registered [ 1.016152] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) [ 1.021937] io scheduler mq-deadline registered [ 1.025155] io scheduler kyber registered [ 1.028355] io scheduler bfq registered [ 1.032444] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 1.037788] thunder_xcv, ver 1.0 [ 1.040430] thunder_bgx, ver 1.0 [ 1.043048] nicpf, ver 1.0 [ 1.045119] nicvf, ver 1.0 [ 1.047585] rtc-efi rtc-efi.0: registered as rtc0 [ 1.051666] rtc-efi rtc-efi.0: setting system clock to 2024-02-09T18:29:07 UTC (1707503347) [ 1.058471] efifb: probing for efifb [ 1.061317] efifb: framebuffer at 0x40000000, using 3072k, total 3072k [ 1.066415] efifb: mode is 1024x768x32, linelength=4096, pages=1 [ 1.070611] efifb: scrolling: redraw [ 1.073414] efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 [ 1.079530] Console: switching to colour frame buffer device 128x48 [ 1.085339] fb0: EFI VGA frame buffer device [ 1.088375] SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... [ 1.093036] hid: raw HID events driver (C) Jiri Kosina [ 1.097570] NET: Registered PF_INET6 protocol family [ 1.101617] Segment Routing with IPv6 [ 1.104495] In-situ OAM (IOAM) with IPv6 [ 1.107486] NET: Registered PF_PACKET protocol family [ 1.111496] Key type dns_resolver registered [ 1.114852] registered taskstats version 1 [ 1.117820] Loading compiled-in X.509 certificates [ 1.150905] Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.15.148-flatcar: 947a80114e81e2815f6db72a0d388260762488f9' [ 1.160338] Key type .fscrypt registered [ 1.163395] Key type fscrypt-provisioning registered [ 1.167086] ima: No TPM chip found, activating TPM-bypass! [ 1.172595] ima: Allocated hash algorithm: sha1 [ 1.175804] ima: No architecture policies found [ 1.184268] Freeing unused kernel memory: 34688K [ 1.187695] Run /init as init process [ 1.207101] 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.231770] systemd[1]: Detected virtualization microsoft. [ 1.237882] systemd[1]: Detected architecture arm64. [ 1.242421] systemd[1]: Running in initrd. Welcome to dracut-053 (Initramfs)! [ 1.250459] systemd[1]: No hostname configured, using default hostname. [ 1.256061] systemd[1]: Hostname set to . [ 1.260415] systemd[1]: Initializing machine ID from random generator. [ 1.356190] systemd[1]: Queued start job for default target initrd.target. [ 1.363020] systemd[1]: Started systemd-ask-password-console.path. [ OK ] Started systemd-ask-password-console.path. [ 1.373121] systemd[1]: Reached target cryptsetup.target. [ OK ] Reached target cryptsetup.target. [ 1.381605] systemd[1]: Reached target paths.target. [ OK ] Reached target paths.target. [ 1.390200] systemd[1]: Reached target slices.target. [ OK ] Reached target slices.target. [ 1.398371] systemd[1]: Reached target swap.target. [ OK ] Reached target swap.target. [ 1.406685] systemd[1]: Reached target timers.target. [ OK ] Reached target timers.target. [ 1.416913] systemd[1]: Listening on iscsid.socket. [ OK ] Listening on iscsid.socket. [ 1.425672] systemd[1]: Listening on iscsiuio.socket. [ OK ] Listening on iscsiuio.socket. [ 1.434791] systemd[1]: Listening on systemd-journald-audit.socket. [ OK ] Listening on systemd-journald-audit.socket. [ 1.445812] systemd[1]: Listening on systemd-journald-dev-log.socket. [ OK ] Listening on systemd-journald-dev-log.socket. [ 1.457344] systemd[1]: Listening on systemd-journald.socket. [ OK ] Listening on systemd-journald.socket. [ 1.467264] systemd[1]: Listening on systemd-networkd.socket. [ OK ] Listening on systemd-networkd.socket. [ 1.478316] systemd[1]: Listening on systemd-udevd-control.socket. [ OK ] Listening on systemd-udevd-control.socket. [ 1.488644] systemd[1]: Listening on systemd-udevd-kernel.socket. [ OK ] Listening on systemd-udevd-kernel.socket. [ 1.500096] systemd[1]: Reached target sockets.target. [ OK ] Reached target sockets.target. [ 1.510250] systemd[1]: Starting kmod-static-nodes.service... Starting kmod-static-nodes.service... [ 1.521236] systemd[1]: Finished network-cleanup.service. [ OK ] Finished network-cleanup.service. [ 1.532449] systemd[1]: Starting systemd-fsck-usr.service... Starting systemd-fsck-usr.service... [ 1.542168] systemd[1]: Starting systemd-journald.service... Starting systemd-journald.service... [ 1.552381] systemd[1]: Starting systemd-modules-load.service... Starting systemd-modules-load.service... [ 1.563922] systemd[1]: Starting systemd-resolved.service... Starting systemd-resolved.service... [ 1.588939] systemd[1]: Starting systemd-vconsole-setup.service... [ 1.594892] bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. [ 1.168125] systemd-modules-load[277]: Inserted module 'overlay' Starting systemd-vconsole-setup.service... [ 1.616789] Bridge firewalling registered [ 1.617748] systemd[1]: Started systemd-journald.service. [ 1.183178] systemd-modules-load[277]: Inserted module 'br_netfilter' [ 1.199533] systemd-resolved[278]: Positive Trust Anchors: [ OK ] Started systemd-journald.service. [ 1.652105] SCSI subsystem initialized [ 1.208329] systemd-resolved[278]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d[ 1.656061] audit: type=1130 audit(1707503348.104: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.245494] 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.720575] audit: type=1130 audit(1707503348.136: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.720933] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. [ 1.747107] device-mapper: uevent: version 1.0.3 [ OK ] Finished kmod-static-nodes.service. [ 1.313792] systemd-resolved[278]: Defaulting to hostname 'linux'.[ 1.756772] audit: type=1130 audit(1707503348.204: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' [ 1.761292] device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com [ OK ] Finished systemd-fsck-usr.service. [ 1.350306] systemd[1]: Started systemd-resolved.service.[ 1.791844] audit: type=1130 audit(1707503348.239:5): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 1.372419] systemd[1]: Finished kmod-static-nodes.service. [ OK ] Finished systemd-modules-load.service. [ 1.378086] systemd[1]: Finished systemd-fsck-usr.service. [ OK ] Finished systemd-vconsole-setup.service. [ 1.386445] systemd-modules-load[277]: Inserted module 'dm_multipath' [ 1.833910] audit: type=1130 audit(1707503348.268:6): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Reached target nss-lookup.target. [ 1.412751] systemd[1]: Finished systemd-modules-load.service.[ 1.860296] audit: type=1130 audit(1707503348.277: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.439808] systemd[1]: Finished systemd-vconsole-setup.service. [ 1.452917] systemd[1]: Reached target nss-lookup.target. [ 1.458037] systemd[1]: Starting dracut-cmdline-ask.service... Starting systemd-sysctl.service... Starting systemd-tmpfiles-setup-dev.service... [ 1.462377] systemd[1]: Starting systemd-sysctl.service... [ 1.479603] systemd[1]: Starting systemd-tmpfiles-setup-dev.service... [ OK ] Finished systemd-sysctl.service. [ 1.930180] audit: type=1130 audit(1707503348.378:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Finished dracut-cmdline-ask.service. [ 1.510145] systemd[1]: Finished systemd-sysctl.service.[ 1.952767] audit: type=1130 audit(1707503348.400:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 1.536185] systemd[1]: Finished dracut-cmdline-ask.service. [ OK ] Finished systemd-tmpfiles-setup-dev.service. [ 1.543465] systemd[1]: Finished systemd-tmpfiles-setup-dev.service.[ 1.987847] audit: type=1130 audit(1707503348.435:10): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Starting dracut-cmdline.service... [ 1.575938] systemd[1]: Starting dracut-cmdline.service... [ 1.588767] dracut-cmdline[298]: dracut-dracut-053 [ 1.594210] 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.098768] Loading iSCSI transport class v2.0-870. [ 2.111779] iscsi: registered transport (tcp) [ 2.128997] iscsi: registered transport (qla4xxx) [ 2.133053] QLogic iSCSI HBA Driver [ OK ] Finished dracut-cmdline.service. [ 1.733657] systemd[1]: Finished dracut-cmdline.service. Starting dracut-pre-udev.service... [ 1.738447] systemd[1]: Starting dracut-pre-udev.service... [ 2.222803] raid6: neonx8 gen() 13817 MB/s [ 2.243806] raid6: neonx8 xor() 10832 MB/s [ 2.263803] raid6: neonx4 gen() 13539 MB/s [ 2.283802] raid6: neonx4 xor() 11315 MB/s [ 2.304802] raid6: neonx2 gen() 12928 MB/s [ 2.325804] raid6: neonx2 xor() 10281 MB/s [ 2.345822] raid6: neonx1 gen() 10472 MB/s [ 2.366800] raid6: neonx1 xor() 8803 MB/s [ 2.387799] raid6: int64x8 gen() 6291 MB/s [ 2.408800] raid6: int64x8 xor() 3550 MB/s [ 2.428802] raid6: int64x4 gen() 7259 MB/s [ 2.449802] raid6: int64x4 xor() 3850 MB/s [ 2.470800] raid6: int64x2 gen() 6155 MB/s [ 2.490799] raid6: int64x2 xor() 3324 MB/s [ 2.510804] raid6: int64x1 gen() 5044 MB/s [ 2.531802] raid6: int64x1 xor() 2647 MB/s [ 2.535614] raid6: using algorithm neonx8 gen() 13817 MB/s [ 2.540172] raid6: .... xor() 10832 MB/s, rmw enabled [ 2.544611] raid6: using neon recovery algorithm [ 2.557346] xor: measuring software checksum speed [ 2.562920] 8regs : 17297 MB/sec [ 2.566996] 32regs : 20755 MB/sec [ 2.571007] arm64_neon : 27741 MB/sec [ 2.574664] xor: using function: arm64_neon (27741 MB/sec) [ 2.628406] Btrfs loaded, crc32c=crc32c-generic, zoned=no, fsverity=no [ OK ] Finished dracut-pre-udev.service. [ 2.209088] systemd[1]: Finished dracut-pre-udev.service. Starting systemd-udevd.service... [ 2.215642] systemd[1]: Starting systemd-udevd.service... [ 2.233818] systemd-udevd[475]: Using default interface naming scheme 'v252'. [ OK ] Started systemd-udevd.service. [ 2.247592] systemd[1]: Started systemd-udevd.service. [ 2.252750] systemd[1]: Starting dracut-pre-trigger.service... Starting dracut-pre-trigger.service... [ 2.265422] dracut-pre-trigger[496]: rd.md=0: removing MD RAID activation [ OK ] Finished dracut-pre-trigger.service. [ 2.296963] systemd[1]: Finished dracut-pre-trigger.service. Starting systemd-udev-trigger.service... [ 2.306419] systemd[1]: Starting systemd-udev-trigger.service... [ OK ] Finished systemd-udev-trigger.service. [ 2.347894] systemd[1]: Finished systemd-udev-trigger.service. [ 2.826522] hv_vmbus: Vmbus version:5.3 [ 2.835263] hv_vmbus: registering driver hyperv_keyboard [ 2.841399] hv_vmbus: registering driver hid_hyperv [ 2.846883] input: AT Translated Set 2 keyboard as /devices/LNXSYSTM:00/LNXSYBUS:00/ACPI0004:00/VMBUS:00/d34b2567-b9b6-42b9-8778-0a4ec0b955bf/serio0/input/input0 [ 2.858985] input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input1 [ 2.866916] hid-generic 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on [ 2.882207] hv_vmbus: registering driver hv_netvsc [ 2.882732] hv_vmbus: registering driver hv_storvsc [ 2.891956] scsi host0: storvsc_host_t [ 2.892654] scsi host1: storvsc_host_t [ 2.895679] scsi 0:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 [ 2.906207] scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 0 [ 2.924615] sr 0:0:0:2: [sr0] scsi-1 drive [ 2.929171] cdrom: Uniform CD-ROM driver Revision: 3.20 [ 2.934413] sd 0:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB) [ 2.940156] sd 0:0:0:0: [sda] 4096-byte physical blocks [ 2.944633] sd 0:0:0:0: [sda] Write Protect is off [ 2.948855] sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA [ 2.960100] sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 [ 2.965359] sd 0:0:0:0: [sda] Attached SCSI disk [ 2.969210] hv_netvsc 002248b4-d16c-0022-48b4-d16c002248b4 eth0: VF slot 1 added [ 2.979563] hv_vmbus: registering driver hv_pci [ 2.984599] hv_pci f210efc3-fddd-4a34-b42e-924a0f33488b: PCI VMBus probing: Using version 0x10004 [ 2.997203] hv_pci f210efc3-fddd-4a34-b42e-924a0f33488b: PCI host bridge to bus fddd:00 [ 3.003659] pci_bus fddd:00: root bus resource [mem 0xfc0000000-0xfc00fffff window] [ 3.009739] pci_bus fddd:00: No busn resource found for root bus, will use [bus 00-ff] [ 3.034232] pci fddd:00:02.0: [15b3:1018] type 00 class 0x020000 [ 3.044973] pci fddd:00:02.0: reg 0x10: [mem 0xfc0000000-0xfc00fffff 64bit pref] [ 3.068250] pci fddd:00:02.0: enabling Extended Tags [ 3.078444] pci fddd:00:02.0: 0.000 Gb/s available PCIe bandwidth, limited by Unknown x0 link at fddd:00:02.0 (capable of 126.016 Gb/s with 8.0 GT/s PCIe x16 link) [ 3.090200] pci_bus fddd:00: busn_res: [bus 00-ff] end is updated to 00 [ 3.096506] pci fddd:00:02.0: BAR 0: assigned [mem 0xfc0000000-0xfc00fffff 64bit pref] [ 3.136990] mlx5_core fddd:00:02.0: firmware version: 16.30.1284 [ 3.291518] mlx5_core fddd:00:02.0: MLX5E: StrdRq(1) RqSz(8) StrdSz(2048) RxCqeCmprss(0) [ 3.355175] hv_netvsc 002248b4-d16c-0022-48b4-d16c002248b4 eth0: VF registering: eth1 [ 3.362637] mlx5_core fddd:00:02.0 eth1: joined to eth0 [ 3.375268] mlx5_core fddd:00:02.0 enP64989s1: renamed from eth1 [ 2.948083] systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device. [ OK ] Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device.[ 3.391247] BTRFS: device label OEM devid 1 transid 12 /dev/sda6 scanned by (udev-worker) (529) [ 2.984266] systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. [ OK ] Found device dev-disk-by\x2dlabel-OEM.device. [ OK ] Found device dev-disk-by\x2dlabel-ROOT.device. [ 3.122934] systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device. [ 3.300942] systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device. [ OK ] Found device dev-disk-by\x2dpartlabel-USR\x2dA.device. [ OK ] Found device dev-disk-by\x…2d8e26\x2d6cce9662f132.device. [ 3.313431] systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device. Starting disk-uuid.service... [ 3.331645] systemd[1]: Starting disk-uuid.service... [ 3.776682] sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 [ 3.796506] sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 [ 4.796985] sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 [ 4.365652] disk-uuid[600]: The operation has completed successfully. [ OK ] Finished disk-uuid.service. [ 4.419667] systemd[1]: disk-uuid.service: Deactivated successfully. [ 4.428555] systemd[1]: Finished disk-uuid.service. Starting verity-setup.service... [ 4.434186] systemd[1]: Starting verity-setup.service... [ 4.903540] device-mapper: verity: sha256 using implementation "sha256-ce" [ OK ] Found device dev-mapper-usr.device. [ 4.676109] systemd[1]: Found device dev-mapper-usr.device. Mounting sysusr-usr.mount... [ 4.684410] systemd[1]: Mounting sysusr-usr.mount... [ OK ] Finished verity-setup.service. [ 4.691404] systemd[1]: Finished verity-setup.service. [ 5.180711] EXT4-fs (dm-0): mounted filesystem without journal. Opts: norecovery. Quota mode: none. [ OK ] Mounted sysusr-usr.mount. [ 4.751891] systemd[1]: Mounted sysusr-usr.mount. Starting ignition-setup.service... Starting parse-ip-for-networkd.service... [ 4.759257] systemd[1]: afterburn-network-kargs.service was skipped because no trigger condition checks were met. [ 4.777657] systemd[1]: Starting ignition-setup.service... [ 4.782155] systemd[1]: Starting parse-ip-for-networkd.service... [ 5.229167] BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm [ 5.235538] BTRFS info (device sda6): using free space tree [ 5.240318] BTRFS info (device sda6): has skinny extents [ OK ] Finished parse-ip-for-networkd.service. [ 4.843081] systemd[1]: Finished parse-ip-for-networkd.service. Starting systemd-networkd.service... [ 4.851989] systemd[1]: Starting systemd-networkd.service... [ 4.877081] systemd-networkd[864]: lo: Link UP [ 4.881060] systemd-networkd[864]: lo: Gained carrier [ OK ] Started systemd-networkd.service. [ 4.886738] systemd-networkd[864]: Enumeration completed [ OK ] Reached target network.target. [ 4.895536] systemd[1]: Started systemd-networkd.service. [ 4.903568] systemd-networkd[864]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Starting iscsiuio.service... [ OK ] Started iscsiuio.service. [ 4.910408] systemd[1]: Reached target network.target. [ 4.925471] systemd[1]: Starting iscsiuio.service... Starting iscsid.service... [ 4.929481] iscsid[874]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi [ OK ] Started iscsid.service. [ 4.939672] iscsid[874]: 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... [ 4.966111] iscsid[874]: into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier]. [ OK ] Finished dracut-initqueue.service. [ OK ] Reached target remote-fs-pre.target. [ 4.988556] iscsid[874]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. [ OK ] Reached target remote-cryptsetup.target. [ 4.998761] iscsid[874]: If using hardware iscsi like qla4xxx this message can be ignored. [ OK ] Reached target remote-fs.target. [ 5.004747] iscsid[874]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi [ 5.453672] mlx5_core fddd:00:02.0 enP64989s1: Link up Starting dracut-pre-mount.service... [ 5.021120] iscsid[874]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf [ 5.037645] systemd[1]: Started iscsiuio.service. [ 5.041899] systemd[1]: Starting iscsid.service... [ OK ] Finished dracut-pre-mount.service. [ 5.045473] systemd[1]: mnt-oem.mount: Deactivated successfully. [ 5.054190] systemd[1]: Started iscsid.service.[ 5.493035] hv_netvsc 002248b4-d16c-0022-48b4-d16c002248b4 eth0: Data path switched to VF: enP64989s1 [ 5.064709] systemd[1]: Starting dracut-initqueue.service...[ 5.503064] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 5.074712] systemd[1]: Finished dracut-initqueue.service. [ 5.081146] systemd[1]: Reached target remote-fs-pre.target. [ 5.085449] systemd[1]: Reached target remote-cryptsetup.target. [ 5.090748] systemd[1]: Reached target remote-fs.target. [ 5.094872] systemd[1]: Starting dracut-pre-mount.service... [ 5.099762] systemd[1]: Finished dracut-pre-mount.service. [ 5.104084] systemd-networkd[864]: enP64989s1: Link UP [ 5.107834] systemd-networkd[864]: eth0: Link UP [ 5.111236] systemd-networkd[864]: eth0: Gained carrier [ 5.115059] systemd-networkd[864]: enP64989s1: Gained carrier [ 5.119505] systemd-networkd[864]: eth0: DHCPv4 address 10.200.20.30/24, gateway 10.200.20.1 acquired from 168.63.129.16 [ OK ] Finished ignition-setup.service. [ 5.175462] systemd[1]: Finished ignition-setup.service.[ 5.622226] kauditd_printk_skb: 17 callbacks suppressed Starting ignition-fetch-offline.service...[ 5.622229] audit: type=1130 audit(1707503352.065:28): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 5.188612] systemd[1]: Starting ignition-fetch-offline.service... [ 6.239323] systemd-networkd[864]: eth0: Gained IPv6LL [* ] Job ignition-fetch-offline.service/start running (6s / no limit) M [** ] Job ignition-fetch-offline.service/start running (7s / no limit) M [*** ] Job ignition-fetch-offline.service/start running (7s / no limit) [ 8.742393] ignition[891]: Ignition 2.14.0 [ 8.745941] ignition[891]: Stage: fetch-offline [ 8.749591] ignition[891]: reading system config file "/usr/lib/ignition/base.d/base.ign" [ 8.832383] ignition[891]: no config dir at "/usr/lib/ignition/base.platform.d/azure" M [ OK ] Finished ignition-fetch-offline.service. [ 8.842235] systemd[1]: Finished ignition-fetch-offline.service.[ 9.282376] audit: type=1130 audit(1707503355.730:29): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch-offline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 8.863875] ignition[891]: no config URL provided [ 8.869767] systemd[1]: Starting ignition-fetch.service... [ 8.874683] ignition[891]: reading system config file "/usr/lib/ignition/user.ign" Starting ignition-fetch.service... [ 8.881109] ignition[891]: no config at "/usr/lib/ignition/user.ign" [ 8.893828] ignition[891]: failed to fetch config: resource requires networking [ 8.900817] ignition[891]: Ignition finished successfully [ 8.905946] ignition[897]: Ignition 2.14.0 [ 8.909728] ignition[897]: Stage: fetch [ 8.913354] ignition[897]: reading system config file "/usr/lib/ignition/base.d/base.ign" [ 8.921120] ignition[897]: no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 8.928227] ignition[897]: no config URL provided [ 8.932296] ignition[897]: reading system config file "/usr/lib/ignition/user.ign" [ 8.938990] ignition[897]: no config at "/usr/lib/ignition/user.ign" [ 8.944590] ignition[897]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 [ 8.971104] ignition[897]: GET result: OK [ 8.975105] ignition[897]: config has been read from IMDS userdata [ 8.981479] ignition[897]: fetched base config from "system" [ OK ] Finished ignition-fetch.service. [ 8.986708] ignition[897]: fetch: fetch complete[ 9.433345] audit: type=1130 audit(1707503355.877:30): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 9.016465] [897]: fetched base config from "system" Starting ignition-kargs.service... [ 9.021510] ignition[897]: fetch: fetch passed [ 9.032325] [897]: fetched user config from "azure" [ 9.038681] ignition[897]: Ignition finished successfully [ 9.043679] systemd[1]: Finished ignition-fetch.service. [ OK ] Finished ignition-kargs.service. [ 9.048419] ignition[903]: Ignition 2.14.0[ 9.491046] audit: type=1130 audit(1707503355.939:31): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-kargs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Starting ignition-disks.service... [ 9.073763] systemd[1]: Starting ignition-kargs.service... [ 9.085282] ignition[903]: Stage: kargs [ OK ] Finished ignition-disks.service. [ 9.531138] audit: type=1130 audit(1707503355.979:32): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-disks comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Reached target initrd-root-device.target. [ 9.113181] systemd[1]: Finished ignition-kargs.service. [ OK ] Reached target local-fs-pre.target. [ 9.122806] ignition[903]: reading system config file "/usr/lib/ignition/base.d/base.ign" [ OK ] Reached target local-fs.target. [ 9.134108] systemd[1]: Starting ignition-disks.service... [ OK ] Reached target sysinit.target. [ 9.143192] systemd[1]: Finished ignition-disks.service. [ OK ] Reached target basic.target. [ 9.151729] ignition[903]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Starting systemd-fsck-root.service... [ 9.162194] systemd[1]: Reached target initrd-root-device.target. [ 9.178862] ignition[903]: kargs: kargs passed [ 9.182777] systemd[1]: Reached target local-fs-pre.target. [ 9.188025] ignition[903]: Ignition finished successfully [ 9.192973] systemd[1]: Reached target local-fs.target. [ 9.197373] ignition[909]: Ignition 2.14.0 [ 9.200542] systemd[1]: Reached target sysinit.target. [ 9.204654] ignition[909]: Stage: disks [ 9.207833] systemd[1]: Reached target basic.target. [ 9.211852] ignition[909]: reading system config file "/usr/lib/ignition/base.d/base.ign" [ 9.218421] systemd[1]: Starting systemd-fsck-root.service... [ 9.223153] ignition[909]: no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 9.229412] ignition[909]: disks: disks passed [ 9.233104] ignition[909]: Ignition finished successfully [ 9.247428] systemd-fsck[917]: ROOT: clean, 602/7326000 files, 481069/7359488 blocks [ OK ] Finished systemd-fsck-root.service. [ 9.697169] audit: type=1130 audit(1707503356.145:33): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 9.278175] systemd[1]: Finished systemd-fsck-root.service. Mounting sysroot.mount... [ 9.286518] systemd[1]: Mounting sysroot.mount... [ 9.728832] EXT4-fs (sda9): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none. [ OK ] Mounted sysroot.mount. [ 9.304185] systemd[1]: Mounted sysroot.mount. [ OK ] Reached target initrd-root-fs.target. [ 9.307820] systemd[1]: Reached target initrd-root-fs.target. Mounting sysroot-usr.mount... [ 9.345185] systemd[1]: Mounting sysroot-usr.mount... Starting flatcar-metadata-hostname.service... [ OK ] Reached target ignition-diskful.target. [ 9.350898] systemd[1]: Starting flatcar-metadata-hostname.service... [ OK ] Mounted sysroot-usr.mount. [ 9.366745] systemd[1]: ignition-remount-sysroot.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). [ 9.381700] systemd[1]: Reached target ignition-diskful.target. [ 9.387055] systemd[1]: Mounted sysroot-usr.mount. Mounting sysroot-usr-share-oem.mount... [ 9.435523] systemd[1]: Mounting sysroot-usr-share-oem.mount... [ 9.443725] systemd[1]: Starting initrd-setup-root.service... Starting initrd-setup-root.service... [ 9.892193] BTRFS: device label OEM devid 1 transid 14 /dev/sda6 scanned by mount (928) [ 9.901421] BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm [ 9.908488] BTRFS info (device sda6): using free space tree [ 9.470814] initrd-setup-root[933]: cut: /sysroot/etc/passwd: No such file or directory[ 9.914985] BTRFS info (device sda6): has skinny extents [ OK ] Mounted sysroot-usr-share-oem.mount. [ 9.492361] systemd[1]: Mounted sysroot-usr-share-oem.mount. [ 9.511241] initrd-setup-root[959]: cut: /sysroot/etc/group: No such file or directory [ 9.520513] initrd-setup-root[967]: cut: /sysroot/etc/shadow: No such file or directory [ 9.544751] initrd-setup-root[975]: cut: /sysroot/etc/gshadow: No such file or directory [ OK ] Finished initrd-setup-root.service. [ 9.971141] systemd[1]: Finished initrd-setup-root.service.[ 10.414287] audit: type=1130 audit(1707503356.862:34): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Starting ignition-mount.service... [ 10.001652] systemd[1]: Starting ignition-mount.service... Starting sysroot-boot.service... [ 10.013601] systemd[1]: Starting sysroot-boot.service... [ 10.023126] systemd[1]: sysusr-usr-share-oem.mount: Deactivated successfully. [ 10.029939] systemd[1]: sysroot-usr-share-oem.mount: Deactivated successfully. [ 10.046804] ignition[995]: INFO : Ignition 2.14.0 [ 10.051790] ignition[995]: INFO : Stage: mount [ OK ] Finished ignition-mount.service. [ 10.056729] ignition[995]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign"[ 10.500201] audit: type=1130 audit(1707503356.948:35): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 10.090646] ignition[995]: DEBUG : parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63 [ 10.106576] ignition[995]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 10.114919] ignition[995]: INFO : mount: mount passed [ 10.120025] ignition[995]: INFO : Ignition finished successfully [ OK ] Finished sysroot-boot.service. [ 10.125764] systemd[1]: Finished ignition-mount.service.[ 10.568694] audit: type=1130 audit(1707503357.016:36): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 10.152872] systemd[1]: Finished sysroot-boot.service. [ 10.548961] coreos-metadata[927]: Feb 09 18:29:17.434 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 [ 10.559272] coreos-metadata[927]: Feb 09 18:29:17.445 INFO Fetch successful [ 10.592258] coreos-metadata[927]: Feb 09 18:29:17.478 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 [ 10.615437] coreos-metadata[927]: Feb 09 18:29:17.501 INFO Fetch successful [ 10.621553] coreos-metadata[927]: Feb 09 18:29:17.507 INFO wrote hostname ci-3510.3.2-a-d8adaa7c7d to /sysroot/etc/hostname [ OK ] Finished flatcar-metadata-hostname.service. [ 10.632077] systemd[1]: Finished flatcar-metadata-hostname.service.[ 11.079312] audit: type=1130 audit(1707503357.522: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.660886] systemd[1]: Starting ignition-files.service... Mounting sysroot-usr-share-oem.mount... [ 10.669433] systemd[1]: Mounting sysroot-usr-share-oem.mount... [ 11.116512] BTRFS: device label OEM devid 1 transid 15 /dev/sda6 scanned by mount (1006) [ 11.124066] BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm [ 11.132352] BTRFS info (device sda6): using free space tree [ 11.137952] BTRFS info (device sda6): has skinny extents [ OK ] Mounted sysroot-usr-share-oem.mount. [ 10.710898] systemd[1]: Mounted sysroot-usr-share-oem.mount. [ 10.725302] ignition[1025]: INFO : Ignition 2.14.0 [ 10.730263] ignition[1025]: INFO : Stage: files [ 10.734538] ignition[1025]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" [ 10.742091] ignition[1025]: DEBUG : parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63 [ 10.755724] ignition[1025]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" [ 10.762853] ignition[1025]: DEBUG : files: compiled without relabeling support, skipping [ 10.769696] ignition[1025]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" [ 10.777662] ignition[1025]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" [ 10.823292] ignition[1025]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" [ 10.831825] ignition[1025]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" [ 10.846288] ignition[1025]: wrote ssh authorized keys file for user: core [ 10.852416] ignition[1025]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core"[ 11.294385] BTRFS info: devid 1 device path /dev/sda6 changed to /dev/disk/by-label/OEM scanned by ignition (1030) [ 10.869049] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" [ 10.881221] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" [ 10.894991] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/systemd/system/waagent.service" [ 10.906744] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(4): oem config not found in "/usr/share/oem", looking on oem partition [ 10.918605] systemd[1]: mnt-oem1479757371.mount: Deactivated successfully. [ OK ] Finished ignition-files.service. [ 10.923983] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(4): op(5): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1479757371"[ 11.378711] audit: type=1130 audit(1707503357.814:38): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Starting initrd-setup-root-after-ignition.service... [ 10.963844] ignition[1025]: CRITICAL : files: createFilesystemsFiles: createFiles: op(4): op(5): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1479757371": device or resource busy Starting ignition-quench.service... [ 10.979288] ignition[1025]: ERROR : files: createFilesystemsFiles: createFiles: op(4): failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem1479757371", trying btrfs: device or resource busy [ OK ] Finished ignition-quench.service. [ 11.442301] audit: type=1130 audit(1707503357.890: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' [ 10.998889] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(4): op(6): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1479757371" [ OK ] Finished initrd-setup-root-after-ignition.service.[ 11.475727] audit: type=1131 audit(1707503357.908: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' [ 11.032044] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(4): op(6): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1479757371" [ 11.506018] audit: type=1130 audit(1707503357.941: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. [ 11.068318] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(4): op(7): [started] unmounting "/mnt/oem1479757371" [ 11.103625] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(4): op(7): [finished] unmounting "/mnt/oem1479757371" Starting initrd-parse-etc.service... [ 11.113574] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/systemd/system/waagent.service" [ 11.129634] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(8): [started] writing file "/sysroot/etc/systemd/system/nvidia.service" [ 11.141529] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(8): oem config not found in "/usr/share/oem", looking on oem partition [ OK ] Finished initrd-parse-etc.service. [ 11.153031] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(8): op(9): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2814760408"[ 11.596175] audit: type=1130 audit(1707503358.044: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' [ 11.186644] ignition[1025]: CRITICAL : files: createFilesystemsFiles: createFiles: op(8): op(9): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2814760408": device or resource busy [ 11.641770] audit: type=1131 audit(1707503358.075: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. [ 11.220770] ignition[1025]: ERROR : files: createFilesystemsFiles: createFiles: op(8): failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem2814760408", trying btrfs: device or resource busy [ OK ] Reached target initrd.target. [ 11.247326] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(8): op(a): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2814760408" Starting dracut-pre-pivot.service... [ 11.268147] systemd[1]: Finished ignition-files.service. [ 11.273530] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(8): op(a): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2814760408" [ 11.286675] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(8): op(b): [started] unmounting "/mnt/oem2814760408" [ 11.297675] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(8): op(b): [finished] unmounting "/mnt/oem2814760408" [ 11.308522] ignition[1025]: INFO : files: createFilesystemsFiles: createFiles: op(8): [finished] writing file "/sysroot/etc/systemd/system/nvidia.service" [ OK ] Finished dracut-pre-pivot.service. [ 11.320112] ignition[1025]: INFO : files: op(c): [started] processing unit "waagent.service"[ 11.762755] audit: type=1130 audit(1707503358.210: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' [ 11.348428] ignition[1025]: INFO : files: op(c): [finished] processing unit "waagent.service" [ 11.358642] ignition[1025]: INFO : files: op(d): [started] processing unit "nvidia.service" Starting initrd-cleanup.service... [ 11.365606] ignition[1025]: INFO : files: op(d): [finished] processing unit "nvidia.service" [ 11.380156] ignition[1025]: INFO : files: op(e): [started] processing unit "flanneld.service" [ OK ] Stopped target nss-lookup.target. [ 11.387230] ignition[1025]: INFO : files: op(e): op(f): [started] writing systemd drop-in "50-network-config.conf" at "/sysroot/etc/systemd/system/flanneld.service.d/50-network-config.conf" [ OK ] Stopped target remote-cryptsetup.target. [ 11.406046] ignition[1025]: INFO : files: op(e): op(f): [finished] writing systemd drop-in "50-network-config.conf" at "/sysroot/etc/systemd/system/flanneld.service.d/50-network-config.conf" [ OK ] Stopped target timers.target. [ 11.423448] ignition[1025]: INFO : files: op(e): [finished] processing unit "flanneld.service" [ OK ] Stopped dracut-pre-pivot.service. [ 11.433937] ignition[1025]: INFO : files: op(10): [started] processing unit "etcd-member.service"[ 11.876630] audit: type=1131 audit(1707503358.324:45): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 11.460076] ignition[1025]: INFO : files: op(10): op(11): [started] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf" [ OK ] Stopped target initrd.target. [ 11.475360] ignition[1025]: INFO : files: op(10): op(11): [finished] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf" [ OK ] Stopped target basic.target. [ 11.492080] ignition[1025]: INFO : files: op(10): [finished] processing unit "etcd-member.service" [ OK ] Stopped target ignition-complete.target. [ 11.502864] ignition[1025]: INFO : files: op(12): [started] processing unit "flannel-docker-opts.service" [ OK ] Stopped target ignition-diskful.target. [ 11.514501] ignition[1025]: INFO : files: op(12): op(13): [started] writing systemd drop-in "retry.conf" at "/sysroot/etc/systemd/system/flannel-docker-opts.service.d/retry.conf" [ OK ] Stopped target initrd-root-device.target. [ 11.530800] systemd[1]: Starting initrd-setup-root-after-ignition.service... [ OK ] Stopped target remote-fs.target. [ 11.540378] ignition[1025]: INFO : files: op(12): op(13): [finished] writing systemd drop-in "retry.conf" at "/sysroot/etc/systemd/system/flannel-docker-opts.service.d/retry.conf" [ OK ] Stopped target remote-fs-pre.target. [ 11.556243] ignition[1025]: INFO : files: op(12): [finished] processing unit "flannel-docker-opts.service" [ OK ] Stopped target sysinit.target. [ 11.567713] ignition[1025]: INFO : files: op(14): [started] processing unit "docker.service" [ OK ] Stopped target local-fs.target. [ 11.578165] ignition[1025]: INFO : files: op(14): [finished] processing unit "docker.service" [ OK ] Stopped target local-fs-pre.target. [ 11.588526] ignition[1025]: INFO : files: op(15): [started] setting preset to enabled for "waagent.service" [ OK ] Stopped target swap.target. [ 11.600172] ignition[1025]: INFO : files: op(15): [finished] setting preset to enabled for "waagent.service" [ OK ] Stopped dracut-pre-mount.service. [ 11.611082] ignition[1025]: INFO : files: op(16): [started] setting preset to enabled for "nvidia.service"[ 12.060097] audit: type=1131 audit(1707503358.501:46): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ OK ] Stopped target cryptsetup.target. [ 11.639224] ignition[1025]: INFO : files: op(16): [finished] setting preset to enabled for "nvidia.service" [ OK ] Stopped dracut-initqueue.service. [ 11.650429] ignition[1025]: INFO : files: op(17): [started] setting preset to enabled for "flanneld.service" [ OK ] Stopped initrd-setup-root-after-ignition.service. [ 11.662370] ignition[1025]: INFO : files: op(17): [finished] setting preset to enabled for "flanneld.service" [ 11.674752] ignition[1025]: INFO : files: op(18): [started] setting preset to enabled for "etcd-member.service" [ OK ] Stopped ignition-files.service. [ 11.682205] ignition[1025]: INFO : files: op(18): [finished] setting preset to enabled for "etcd-member.service" [ OK ] Stopped flatcar-metadata-hostname.service. [ 11.693825] ignition[1025]: INFO : files: op(19): [started] setting preset to enabled for "docker.service" Stopping ignition-mount.service... [ 11.707728] ignition[1025]: INFO : files: op(19): [finished] setting preset to enabled for "docker.service" Stopping iscsid.service... [ 11.724272] ignition[1025]: INFO : files: createResultFile: createFiles: op(1a): [started] writing file "/sysroot/etc/.ignition-result.json" [ 11.738426] ignition[1025]: INFO : files: createResultFile: createFiles: op(1a): [finished] writing file "/sysroot/etc/.ignition-result.json" Stopping sysroot-boot.service... [ OK ] Stopped systemd-udev-trigger.service. [ 11.749935] ignition[1025]: INFO : files: files passed [ 11.762036] ignition[1025]: INFO : Ignition finished successfully [ OK ] Stopped dracut-pre-trigger.service. [ OK ] Stopped iscsid.service. [ 11.775725] systemd[1]: torcx-profile-populate.service was skipped because of an unmet condition check (ConditionPathExists=/sysroot/etc/torcx/next-profile). [ OK ] Finished initrd-cleanup.service. [ OK ] Stopped ignition-mount.service. [ 11.794962] iscsid[874]: iscsid shutting down. [ 11.800238] initrd-setup-root-after-ignition[1050]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory [ OK ] Stopped ignition-disks.service. [ 11.808244] systemd[1]: Starting ignition-quench.service... [ OK ] Stopped ignition-kargs.service. [ 11.816984] systemd[1]: ignition-quench.service: Deactivated successfully. [ OK ] Stopped ignition-fetch.service. [ 11.826266] systemd[1]: Finished ignition-quench.service. [ OK ] Stopped ignition-fetch-offline.service. [ 11.834189] systemd[1]: Finished initrd-setup-root-after-ignition.service. [ OK ] Stopped target paths.target. [ 11.843619] systemd[1]: Reached target ignition-complete.target. [ 11.851762] systemd[1]: Starting initrd-parse-etc.service... [ 11.855914] systemd[1]: initrd-parse-etc.service: Deactivated successfully. [ OK ] Stopped systemd-ask-password-console.path. [ 11.861071] ignition[1063]: INFO : Ignition 2.14.0 [ OK ] Stopped target slices.target. [ 11.869364] ignition[1063]: INFO : Stage: umount [ OK ] Stopped target sockets.target. [ 11.876780] ignition[1063]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" [ OK ] Closed iscsid.socket. [ 11.887271] ignition[1063]: DEBUG : parsing config with SHA512: 4824fd4a4e57848da530dc2b56e2d3e9f5f19634d1c84ef29f8fc49255520728d0377a861a375d7c8cb5301ed861ff4ede4b440b074b1d6a86e23be9cefc2f63 [ OK ] Stopped ignition-setup.service. [ 11.903262] ignition[1063]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Stopping iscsiuio.service... [ 11.914710] ignition[1063]: INFO : umount: umount passed [ OK ] Stopped iscsiuio.service. [ 11.921960] ignition[1063]: INFO : Ignition finished successfully [ OK ] Stopped sysroot-boot.service. [ 11.930305] systemd[1]: Finished initrd-parse-etc.service. [ OK ] Stopped target network.target. [ 11.938278] systemd[1]: Reached target initrd-fs.target. [ OK ] Closed iscsiuio.socket. [ 11.945854] systemd[1]: Reached target initrd.target. [ OK ] Stopped initrd-setup-root.service. [ 11.953743] systemd[1]: dracut-mount.service was skipped because no trigger condition checks were met. Stopping systemd-networkd.service... [ 11.965375] systemd[1]: Starting dracut-pre-pivot.service... Stopping systemd-resolved.service... [ 11.973247] systemd[1]: Finished dracut-pre-pivot.service. [ OK ] Stopped systemd-networkd.service. [ 11.982099] systemd[1]: Starting initrd-cleanup.service... [ OK ] Stopped systemd-resolved.service. [ 11.990754] systemd[1]: Stopped target nss-lookup.target. [ OK ] Closed systemd-networkd.socket. [ 11.999242] systemd[1]: Stopped target remote-cryptsetup.target. Stopping network-cleanup.service... [ OK ] Stopped parse-ip-for-networkd.service. [ 12.007457] systemd[1]: Stopped target timers.target. [ OK ] Stopped systemd-sysctl.service. [ 12.020072] systemd[1]: dracut-pre-pivot.service: Deactivated successfully. [ OK ] Stopped systemd-modules-load.service. [ 12.029033] systemd[1]: Stopped dracut-pre-pivot.service. Stopping systemd-udevd.service... [ 12.037679] systemd[1]: Stopped target initrd.target. [ 12.044801] systemd[1]: Stopped target basic.target. [ OK ] Stopped systemd-udevd.service. [ 12.049790] systemd[1]: Stopped target ignition-complete.target. [ OK ] Closed systemd-udevd-control.socket. [ 12.058323] systemd[1]: Stopped target ignition-diskful.target. [ OK ] Closed systemd-udevd-kernel.socket. [ 12.067163] systemd[1]: Stopped target initrd-root-device.target. [ OK ] Stopped dracut-pre-udev.service. [ 12.075651] systemd[1]: Stopped target remote-fs.target. [ OK ] Stopped dracut-cmdline.service.[ 12.525685] hv_netvsc 002248b4-d16c-0022-48b4-d16c002248b4 eth0: Data path switched from VF: enP64989s1 [ 12.083860] systemd[1]: Stopped target remote-fs-pre.target. [ OK ] Stopped dracut-cmdline-ask.service. [ 12.100818] systemd[1]: Stopped target sysinit.target. [ 12.109598] systemd[1]: Stopped target local-fs.target. [ 12.113636] systemd[1]: Stopped target local-fs-pre.target. Starting initrd-udevadm-cleanup-db.service... [ 12.117775] systemd[1]: Stopped target swap.target. [ OK ] Stopped systemd-tmpfiles-setup-dev.service. [ 12.126126] systemd[1]: dracut-pre-mount.service: Deactivated successfully. [ OK ] Stopped kmod-static-nodes.service. [ 12.136154] systemd[1]: Stopped dracut-pre-mount.service. [ OK ] Stopped systemd-vconsole-setup.service. [ 12.144362] systemd[1]: Stopped target cryptsetup.target. [ OK ] Finished initrd-udevadm-cleanup-db.service. [ 12.152859] systemd[1]: dracut-initqueue.service: Deactivated successfully. [ 12.163344] systemd[1]: Stopped dracut-initqueue.service. [ 12.167281] systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. [ 12.173895] systemd[1]: Stopped initrd-setup-root-after-ignition.service. [ OK ] Stopped network-cleanup.service. [ 12.178921] systemd[1]: ignition-files.service: Deactivated successfully. [ OK ] Reached target initrd-switch-root.target. [ 12.187841] systemd[1]: Stopped ignition-files.service. Starting initrd-switch-root.service... [ 12.198042] systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. [ 12.212599] systemd[1]: Stopped flatcar-metadata-hostname.service. [ 12.217441] systemd[1]: Stopping ignition-mount.service... [ 12.221593] systemd[1]: Stopping iscsid.service... [ 12.225129] systemd[1]: Stopping sysroot-boot.service... [ 12.228969] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. [ 12.234204] systemd[1]: Stopped systemd-udev-trigger.service. [ 12.238456] systemd[1]: dracut-pre-trigger.service: Deactivated successfully. [ 12.243565] systemd[1]: Stopped dracut-pre-trigger.service. [ 12.685371] systemd-journald[276]: Received SIGTERM from PID 1 (n/a). [ 12.254093] systemd[1]: iscsid.service: Deactivated successfully. [ 14.959877] SELinux: Class mctp_socket not defined in policy. [ 14.966195] SELinux: Class anon_inode not defined in policy. [ 14.971220] SELinux: the above unknown classes and permissions will be allowed [ 14.979105] SELinux: policy capability network_peer_controls=1 [ 14.984550] SELinux: policy capability open_perms=1 [ 14.988892] SELinux: policy capability extended_socket_class=1 [ 14.993974] SELinux: policy capability always_check_network=0 [ 14.999252] SELinux: policy capability cgroup_seclabel=1 [ 15.004269] SELinux: policy capability nnp_nosuid_transition=1 [ 15.010145] SELinux: policy capability genfs_seclabel_symlinks=0 [ 15.016626] SELinux: policy capability ioctl_skip_cloexec=0 [ 15.060011] systemd[1]: Successfully loaded SELinux policy in 307.145ms. [ 15.456479] systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 23.407ms. [ 15.512769] 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) [ 15.539004] systemd[1]: Detected virtualization microsoft. [ 15.543708] systemd[1]: Detected architecture arm64. [ 15.548235] systemd[1]: Detected first boot. Welcome to Flatcar Container Linux by Kinvolk 3510.3.2 (LTS 2023)! [ 15.577954] systemd[1]: Hostname set to . [ 15.612383] systemd[1]: Initializing machine ID from random generator. [ 16.913376] SELinux: Context system_u:object_r:container_file_t:s0:c1022,c1023 is not valid (left unmapped). [ 16.922310] kauditd_printk_skb: 42 callbacks suppressed [ 16.922312] audit: type=1400 audit(1707503363.361:89): avc: denied { associate } for pid=1096 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" [ 16.950698] audit: type=1300 audit(1707503363.361:89): arch=c00000b7 syscall=5 success=yes exit=0 a0=40000222a4 a1=40000282e8 a2=4000026700 a3=32 items=0 ppid=1079 pid=1096 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) [ 16.979711] audit: type=1327 audit(1707503363.361:89): proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61 [ 17.002384] audit: type=1400 audit(1707503363.370:90): avc: denied { associate } for pid=1096 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 [ 17.018868] audit: type=1300 audit(1707503363.370:90): arch=c00000b7 syscall=34 success=yes exit=0 a0=ffffffffffffff9c a1=4000022389 a2=1ed a3=0 items=2 ppid=1079 pid=1096 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) [ 17.047158] audit: type=1307 audit(1707503363.370:90): cwd="/" [ 17.051970] audit: type=1302 audit(1707503363.370:90): item=0 name=(null) inode=2 dev=00:1c mode=040755 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:unlabeled_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 [ 17.068272] audit: type=1302 audit(1707503363.370:90): item=1 name=(null) inode=3 dev=00:1c mode=040755 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:unlabeled_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 [ 17.085018] audit: type=1327 audit(1707503363.370:90): proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61 [ 30.965598] systemd[1]: Populated /etc with preset unit settings. [ 32.265779] systemd[1]: /usr/lib/systemd/system/locksmithd.service:8: Unit uses CPUShares=; please use CPUWeight= instead. Support for CPUShares= will be removed soon. [ 32.279145] systemd[1]: /usr/lib/systemd/system/locksmithd.service:9: Unit uses MemoryLimit=; please use MemoryMax= instead. Support for MemoryLimit= will be removed soon. [ 32.299191] 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. [ 32.675977] audit: type=1334 audit(1707503379.124:91): prog-id=12 op=LOAD [ 32.682758] audit: type=1334 audit(1707503379.124:92): prog-id=3 op=UNLOAD [ 32.688583] audit: type=1334 audit(1707503379.130:93): prog-id=13 op=LOAD [ 32.694327] audit: type=1334 audit(1707503379.136:94): prog-id=14 op=LOAD [ 32.700022] audit: type=1334 audit(1707503379.136:95): prog-id=4 op=UNLOAD [ 32.705666] audit: type=1334 audit(1707503379.136:96): prog-id=5 op=UNLOAD [ 32.707187] systemd[1]: initrd-switch-root.service: Deactivated successfully. [ 32.711458] audit: type=1334 audit(1707503379.142:97): prog-id=15 op=LOAD [ 32.718125] systemd[1]: Stopped initrd-switch-root.service. [ 32.723546] audit: type=1334 audit(1707503379.142:98): prog-id=12 op=UNLOAD [ 32.734108] audit: type=1334 audit(1707503379.148:99): prog-id=16 op=LOAD [ OK ] Stopped initrd-switch-root.service.[ 32.741195] audit: type=1334 audit(1707503379.153:100): prog-id=17 op=LOAD [ 32.749526] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 32.757612] systemd[1]: Created slice system-addon\x2dconfig.slice. [ OK ] Created slice system-addon\x2dconfig.slice. [ 32.768422] systemd[1]: Created slice system-addon\x2drun.slice. [ OK ] Created slice system-addon\x2drun.slice. [ 32.779142] systemd[1]: Created slice system-getty.slice. [ OK ] Created slice system-getty.slice. [ 32.788723] systemd[1]: Created slice system-modprobe.slice. [ OK ] Created slice system-modprobe.slice. [ 32.799526] systemd[1]: Created slice system-serial\x2dgetty.slice. [ OK ] Created slice system-serial\x2dgetty.slice. [ 32.810250] systemd[1]: Created slice system-system\x2dcloudinit.slice. [ OK ] Created slice system-system\x2dcloudinit.slice. [ 32.821311] systemd[1]: Created slice system-systemd\x2dfsck.slice. [ OK ] Created slice system-systemd\x2dfsck.slice. [ 32.831791] systemd[1]: Created slice user.slice. [ OK ] Created slice user.slice. [ 32.840272] systemd[1]: Started systemd-ask-password-console.path. [ OK ] Started systemd-ask-password-console.path. [ 32.850380] systemd[1]: Started systemd-ask-password-wall.path. [ OK ] Started systemd-ask-password-wall.path. [ 32.861323] systemd[1]: Set up automount boot.automount. [ OK ] Set up automount boot.automount. [ 32.871028] systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount. [ OK ] Set up automount proc-sys-fs-binfmt_misc.automount. [ 32.882239] systemd[1]: Stopped target initrd-switch-root.target. [ OK ] Stopped target initrd-switch-root.target. [ 32.892015] systemd[1]: Stopped target initrd-fs.target. [ OK ] Stopped target initrd-fs.target. [ 32.900724] systemd[1]: Stopped target initrd-root-fs.target. [ OK ] Stopped target initrd-root-fs.target. [ 32.909966] systemd[1]: Reached target integritysetup.target. [ OK ] Reached target integritysetup.target. [ 32.921079] systemd[1]: Reached target remote-cryptsetup.target. [ OK ] Reached target remote-cryptsetup.target. [ 32.930733] systemd[1]: Reached target remote-fs.target. [ OK ] Reached target remote-fs.target. [ 32.939382] systemd[1]: Reached target slices.target. [ OK ] Reached target slices.target. [ 32.947818] systemd[1]: Reached target swap.target. [ OK ] Reached target swap.target. [ 32.955750] systemd[1]: Reached target torcx.target. [ OK ] Reached target torcx.target. [ 32.965124] systemd[1]: Reached target veritysetup.target. [ OK ] Reached target veritysetup.target. [ 32.975256] systemd[1]: Listening on systemd-coredump.socket. [ OK ] Listening on systemd-coredump.socket. [ 32.984525] systemd[1]: Listening on systemd-initctl.socket. [ OK ] Listening on systemd-initctl.socket. [ 32.994065] systemd[1]: Listening on systemd-networkd.socket. [ OK ] Listening on systemd-networkd.socket. [ 33.003638] systemd[1]: Listening on systemd-udevd-control.socket. [ OK ] Listening on systemd-udevd-control.socket. [ 33.014578] systemd[1]: Listening on systemd-udevd-kernel.socket. [ OK ] Listening on systemd-udevd-kernel.socket. [ 33.024612] systemd[1]: Listening on systemd-userdbd.socket. [ OK ] Listening on systemd-userdbd.socket. [ 33.034943] systemd[1]: Mounting dev-hugepages.mount... Mounting dev-hugepages.mount... [ 33.043874] systemd[1]: Mounting dev-mqueue.mount... Mounting dev-mqueue.mount... [ 33.052815] systemd[1]: Mounting media.mount... Mounting media.mount... [ 33.061687] systemd[1]: Mounting sys-kernel-debug.mount... Mounting sys-kernel-debug.mount... [ 33.072014] systemd[1]: Mounting sys-kernel-tracing.mount... Mounting sys-kernel-tracing.mount... [ 33.082561] systemd[1]: Mounting tmp.mount... Mounting tmp.mount... [ 33.091490] systemd[1]: Starting flatcar-tmpfiles.service... Starting flatcar-tmpfiles.service... [ 33.101737] systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. [ 33.112400] systemd[1]: Starting kmod-static-nodes.service... Starting kmod-static-nodes.service... [ 33.122445] systemd[1]: Starting modprobe@configfs.service... Starting modprobe@configfs.service... [ 33.132324] systemd[1]: Starting modprobe@dm_mod.service... Starting modprobe@dm_mod.service... [ 33.141728] systemd[1]: Starting modprobe@drm.service... Starting modprobe@drm.service... [ 33.151110] systemd[1]: Starting modprobe@efi_pstore.service... Starting modprobe@efi_pstore.service... [ 33.162566] systemd[1]: Starting modprobe@fuse.service... Starting modprobe@fuse.service... [ 33.173697] systemd[1]: Starting modprobe@loop.service... Starting modprobe@loop.service... [ 33.182815] systemd[1]: setup-nsswitch.service was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). [ 33.192925] systemd[1]: systemd-fsck-root.service: Deactivated successfully. [ 33.198885] systemd[1]: Stopped systemd-fsck-root.service. [ OK ] Stopped systemd-fsck-root.service. [ 33.207807] systemd[1]: systemd-fsck-usr.service: Deactivated successfully. [ 33.214607] systemd[1]: Stopped systemd-fsck-usr.service. [ OK ] Stopped systemd-fsck-usr.service. [ 33.223612] systemd[1]: Stopped systemd-journald.service. [ OK ] Stopped systemd-journald.service. [ 33.235414] systemd[1]: systemd-journald.service: Consumed 2.804s CPU time. [ 33.241124] loop: module loaded [ 33.244861] systemd[1]: Starting systemd-journald.service... Starting systemd-journald.service... [ 33.529348] systemd[1]: Starting systemd-modules-load.service... Starting systemd-modules-load.service...[ 33.535575] fuse: init (API version 7.34) [ 33.543695] systemd[1]: Starting systemd-network-generator.service... Starting systemd-network-generator.service... [ 33.554369] systemd[1]: Starting systemd-remount-fs.service... Starting systemd-remount-fs.service... [ 33.564826] systemd[1]: Starting systemd-udev-trigger.service... Starting systemd-udev-trigger.service... [ 33.574283] systemd[1]: verity-setup.service: Deactivated successfully. [ 33.579771] systemd[1]: Stopped verity-setup.service. [ OK ] Stopped verity-setup.service. [ 33.590227] systemd[1]: Mounted dev-hugepages.mount. [ OK ] Mounted dev-hugepages.mount. [ 33.599296] systemd[1]: Mounted dev-mqueue.mount. [ OK ] Mounted dev-mqueue.mount. [ 33.607261] systemd[1]: Started systemd-journald.service. [ OK ] Started systemd-journald.service. [ OK ] Mounted media.mount. [ OK ] Mounted sys-kernel-debug.mount. [ OK ] Mounted sys-kernel-tracing.mount. [ OK ] Mounted tmp.mount. [ OK ] Finished flatcar-tmpfiles.service. [ OK ] Finished kmod-static-nodes.service. [ OK ] Finished modprobe@configfs.service. [ OK ] Finished modprobe@dm_mod.service. [ OK ] Finished modprobe@drm.service. [ OK ] Finished modprobe@efi_pstore.service. [ OK ] Finished modprobe@fuse.service. [ OK ] Finished modprobe@loop.service. Mounting sys-fs-fuse-connections.mount... Mounting sys-kernel-config.mount... [ OK ] Mounted sys-fs-fuse-connections.mount. [ OK ] Mounted sys-kernel-config.mount. [ OK ] Finished systemd-network-generator.service. [ OK ] Finished systemd-remount-fs.service. [ OK ] Reached target network-pre.target. Starting systemd-hwdb-update.service... Starting systemd-journal-flush.service... Starting systemd-random-seed.service... Starting systemd-sysusers.service... [ OK ] Finished systemd-udev-trigger.service. Starting systemd-udev-settle.service... [ 34.131294] systemd-journald[1202]: Received client request to flush runtime journal. [ OK ] Finished systemd-modules-load.service. Starting systemd-sysctl.service... [ OK ] Finished systemd-random-seed.service. [ OK ] Reached target first-boot-complete.target. [ OK ] Finished systemd-journal-flush.service. [ OK ] Finished systemd-sysctl.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. [ 37.883652] kauditd_printk_skb: 43 callbacks suppressed [ 37.883654] audit: type=1130 audit(1707503384.331:142): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-hwdb-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 37.906326] audit: type=1334 audit(1707503384.337:143): prog-id=21 op=LOAD [ 37.912036] audit: type=1334 audit(1707503384.354:144): prog-id=22 op=LOAD Starting systemd-udevd.service...[ 37.917384] audit: type=1334 audit(1707503384.354:145): prog-id=7 op=UNLOAD [ 37.926701] audit: type=1334 audit(1707503384.354:146): prog-id=8 op=UNLOAD [ OK ] Started systemd-udevd.service. [ 38.082834] audit: type=1130 audit(1707503384.530:147): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Starting systemd-networkd.service...[ 38.109939] audit: type=1334 audit(1707503384.556:148): prog-id=23 op=LOAD [ 38.193882] mousedev: PS/2 mouse device common for all mice [ 38.201887] audit: type=1400 audit(1707503384.649:149): avc: denied { confidentiality } for pid=1233 comm="(udev-worker)" lockdown_reason="use of tracefs" scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=lockdown permissive=1 [ 38.211284] hv_vmbus: registering driver hv_balloon [ 38.227078] hv_balloon: Using Dynamic Memory protocol version 2.0 [ 38.231991] hv_balloon: Memory hot add disabled on ARM64 [ 38.237481] audit: type=1334 audit(1707503384.685:150): prog-id=24 op=LOAD [ 38.245030] hv_vmbus: registering driver hyperv_fb [ 38.249828] audit: type=1334 audit(1707503384.697:151): prog-id=25 op=LOAD [ 38.255235] hyperv_fb: Synthvid Version major 3, minor 5 Starting systemd-userdbd.service... [ 38.265559] hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 [ 38.274528] Console: switching to colour dummy device 80x25 [ 38.280129] Console: switching to colour frame buffer device 128x48 [ 38.289202] hv_utils: Registering HyperV Utility Driver [ 38.293023] hv_vmbus: registering driver hv_utils [ 38.297159] hv_utils: Heartbeat IC version 3.0 [ 38.300659] hv_utils: Shutdown IC version 3.2 [ 38.303907] hv_utils: TimeSync IC version 4.0 [ 38.308569] systemd-journald[1202]: Time jumped backwards, rotating. [ OK ] Started systemd-userdbd.service. [ 38.556229] BTRFS info: devid 1 device path /dev/disk/by-label/OEM changed to /dev/sda6 scanned by (udev-worker) (1229) [ OK ] Found device dev-disk-by\x2dlabel-OEM.device. [ OK ] Finished systemd-udev-settle.service. Starting lvm2-activation-early.service... [ OK ] Started systemd-networkd.service. Starting systemd-networkd-wait-online.service... [ 38.725027] mlx5_core fddd:00:02.0 enP64989s1: Link up [ 38.748573] hv_netvsc 002248b4-d16c-0022-48b4-d16c002248b4 eth0: Data path switched to VF: enP64989s1 [ OK ] Finished lvm2-activation-early.service. [ OK ] Reached target cryptsetup.target. Starting lvm2-activation.service... [ OK ] Finished lvm2-activation.service. [ OK ] Reached target local-fs-pre.target. [ OK ] Reached target local-fs.target. [ OK ] Reached target machines.target. Starting ldconfig.service... Starting systemd-boot-update.service... Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service... Starting systemd-machine-id-commit.service... Starting systemd-tmpfiles-setup.service... Starting systemd-fsck@dev-…label-EFI\x2dSYSTEM.service... [ OK ] Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service. [ OK ] Finished systemd-machine-id-commit.service. [ OK ] Finished systemd-fsck@dev-…2dlabel-EFI\x2dSYSTEM.service. Mounting boot.mount... [ OK ] Mounted boot.mount. [ OK ] Finished systemd-boot-update.service. [ OK ] Finished systemd-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 systemd-update-utmp.service. [ OK ] Finished clean-ca-certificates.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 nss-lookup.target. [ OK ] Finished audit-rules.service. [ OK ] Finished systemd-networkd-wait-online.service. [ OK ] Reached target network-online.target. [* ] Job ldconfig.service/start running (10s / no limit) M [** ] Job ldconfig.service/start running (10s / no limit) M [*** ] Job ldconfig.service/start running (11s / no limit) M [ *** ] Job ldconfig.service/start running (11s / no limit) M [ *** ] Job ldconfig.service/start running (12s / no limit) M [ ***] Job ldconfig.service/start running (12s / no limit) M [ **] Job ldconfig.service/start running (13s / no limit) M [ *] Job ldconfig.service/start running (13s / no limit) M [ 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 coreos-metadata.service... Starting dbus.service... Starting enable-oem-cloudinit.service... Starting extend-filesystems.service... Starting motdgen.service... [ OK ] Started nvidia.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. [ 46.361853] extend-filesystems[1352]: Found sda [ 46.366364] extend-filesystems[1352]: Found sda1 [ OK ] Finished motdgen.service. [ 46.374382] extend-filesystems[1352]: Found sda2 [ 46.389235] extend-filesystems[1352]: Found sda3 [ 46.396329] extend-filesystems[1352]: Found usr [ 46.407142] extend-filesystems[1352]: Found sda4 [ OK ] Finished coreos-metadata.service. Starting etcd-member.service... [ 46.412389] extend-filesystems[1352]: Found sda6 [ 46.431937] extend-filesystems[1352]: Found sda7 [ 46.436394] extend-filesystems[1352]: Found sda9 [ 46.440457] extend-filesystems[1352]: Checking size of /dev/sda9 [ OK ] Finished update-ssh-keys-after-ignition.service. [ 46.480167] extend-filesystems[1352]: Old size kept for /dev/sda9 [ 46.485510] extend-filesystems[1352]: Found sr0 [ OK ] Finished extend-filesystems.service. [ OK ] Started containerd.service. Starting docker.service... [ OK ] Started dbus.service. [ OK ] Reached target system-config.target. [ OK ] Reached target user-config.target. [ OK ] Started systemd-logind.service. [ OK ] Started update-engine.service. [ OK ] Started locksmithd.service. [ 47.681324] Initializing XFRM netlink socket [ OK ] Started docker.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 ] Started docker-88946790f02…ede9181eabfcb2ada64efef.scope. This is ci-3510.3.2-a-d8adaa7c7d (Linux aarch64 5.15.148-flatcar) 18:30:01 SSH host key: SHA256:zyO66aIWzOvtLfq8WAidgrVs6HbeRSRVRLYk54oqtMs (RSA) SSH host key: SHA256:zAZ7dD7Kp3YUrb/YDGBOKaV2KB57wmd/C0+27sy5T34 (ED25519) SSH host key: SHA256:4F+GHxkqlR12rIYMaqf7u+LxYbtv7nInCCOxq5t/oZU (ECDSA) enP64989s1: eth0: 10.200.20.30 fe80::222:48ff:feb4:d16c ci-3510 login: core (automatic login) 2024-02-09T18:30:03.490350Z INFO Daemon Daemon Azure Linux Agent Version:2.6.0.2 2024-02-09T18:30:03.499062Z INFO Daemon Daemon OS: flatcar 3510.3.2 2024-02-09T18:30:03.504843Z INFO Daemon Daemon Python: 3.9.16 2024-02-09T18:30:03.510554Z INFO Daemon Daemon Run daemon 2024-02-09T18:30:03.516262Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='3510.3.2' 2024-02-09T18:30:03.535811Z 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:30:03.554285Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' 2024-02-09T18:30:03.565745Z INFO Daemon Daemon cloud-init is enabled: False 2024-02-09T18:30:03.572240Z INFO Daemon Daemon Using waagent for provisioning 2024-02-09T18:30:03.579220Z INFO Daemon Daemon Activate resource disk 2024-02-09T18:30:03.584766Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb 2024-02-09T18:30:03.601344Z INFO Daemon Daemon Found device: None 2024-02-09T18:30:03.607523Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology 2024-02-09T18:30:03.617630Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 2024-02-09T18:30:03.632637Z INFO Daemon Daemon Clean protocol and wireserver endpoint 2024-02-09T18:30:03.639429Z INFO Daemon Daemon Running default provisioning handler 2024-02-09T18:30:03.655232Z 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:30:03.674910Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' 2024-02-09T18:30:03.686587Z INFO Daemon Daemon cloud-init is enabled: False 2024-02-09T18:30:03.692759Z INFO Daemon Daemon Copying ovf-env.xml Flatcar Container Linux by Kinvolk lts 3510.3.2 for Microsoft Azure [?2004hcore@ci-3510 ~ $ 2024-02-09T18:30:03.794443Z INFO Daemon Daemon Successfully mounted dvd 2024-02-09T18:30:03.895949Z INFO Daemon Daemon Detect protocol endpoint 2024-02-09T18:30:03.901775Z INFO Daemon Daemon Clean protocol and wireserver endpoint 2024-02-09T18:30:03.908032Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler 2024-02-09T18:30:03.916113Z INFO Daemon Daemon Test for route to 168.63.129.16 2024-02-09T18:30:03.922256Z INFO Daemon Daemon Route to 168.63.129.16 exists 2024-02-09T18:30:03.927992Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 2024-02-09T18:30:04.368062Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 2024-02-09T18:30:04.375927Z INFO Daemon Daemon Wire protocol version:2012-11-30 2024-02-09T18:30:04.382553Z INFO Daemon Daemon Server preferred version:2015-04-05 2024-02-09T18:30:05.218372Z INFO Daemon Daemon Initializing goal state during protocol detection 2024-02-09T18:30:05.232478Z INFO Daemon Daemon Forcing an update of the goal state.. 2024-02-09T18:30:05.238822Z INFO Daemon Daemon Fetching goal state [incarnation 1] 2024-02-09T18:30:05.323998Z INFO Daemon Daemon Found private key matching thumbprint F265ED1E2F8F3F1371BF510E973034A4F93E0405 2024-02-09T18:30:05.333215Z INFO Daemon Daemon Certificate with thumbprint 2BEEDB9B6C7B0B267121160417D8A5D5652B91E8 has no matching private key. 2024-02-09T18:30:05.343477Z INFO Daemon Daemon Fetch goal state completed 2024-02-09T18:30:05.399880Z INFO Daemon Daemon Fetched new vmSettings [correlation ID: 62b3bcbb-758e-4243-8355-fa07e813ff3b New eTag: 3180950364167110] 2024-02-09T18:30:05.412240Z INFO Daemon Daemon Status Blob type 'None' is not valid, assuming BlockBlob 2024-02-09T18:30:05.430733Z INFO Daemon Daemon Starting provisioning 2024-02-09T18:30:05.436184Z INFO Daemon Daemon Handle ovf-env.xml. 2024-02-09T18:30:05.441471Z INFO Daemon Daemon Set hostname [ci-3510.3.2-a-d8adaa7c7d] 2024-02-09T18:30:05.501276Z INFO Daemon Daemon Publish hostname [ci-3510.3.2-a-d8adaa7c7d] 2024-02-09T18:30:05.508988Z INFO Daemon Daemon Examine /proc/net/route for primary interface 2024-02-09T18:30:05.516885Z INFO Daemon Daemon Primary interface is [eth0] 2024-02-09T18:30:05.582122Z INFO Daemon Daemon Create user account if not exists 2024-02-09T18:30:05.589133Z INFO Daemon Daemon User core already exists, skip useradd 2024-02-09T18:30:05.599475Z INFO Daemon Daemon Configure sudoer 2024-02-09T18:30:05.605555Z INFO Daemon Daemon Configure sshd 2024-02-09T18:30:05.611901Z INFO Daemon Daemon Deploy ssh public key. 2024-02-09T18:30:06.899940Z INFO Daemon Daemon Provisioning complete 2024-02-09T18:30:06.920011Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping 2024-02-09T18:30:06.926964Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. [ 86.341334] hv_balloon: Max. dynamic memory size: 4096 MB [ 115.873092] kauditd_printk_skb: 37 callbacks suppressed [ 115.873095] audit: type=1305 audit(1707503462.296:172): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 [ 115.927327] audit: type=1300 audit(1707503462.296:172): arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffd8fb6ec0 a2=420 a3=0 items=0 ppid=1 pid=2766 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="auditctl" exe="/usr/sbin/auditctl" subj=system_u:system_r:kernel_t:s0 key=(null) [ 115.952476] audit: type=1327 audit(1707503462.296:172): proctitle=2F7362696E2F617564697463746C002D44 [ 115.959849] audit: type=1131 audit(1707503462.333:173): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 115.985471] audit: type=1130 audit(1707503462.408:174): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 116.002606] audit: type=1106 audit(1707503462.409:175): pid=2762 uid=500 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' [ 116.023374] audit: type=1104 audit(1707503462.409:176): pid=2762 uid=500 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' [ 116.068819] audit: type=1106 audit(1707503462.491:177): pid=2759 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=10.200.12.6 addr=10.200.12.6 terminal=ssh res=success' [ 116.093034] audit: type=1104 audit(1707503462.491:178): pid=2759 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.200.12.6 addr=10.200.12.6 terminal=ssh res=success' [ 116.113561] audit: type=1131 audit(1707503462.494:179): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-10.200.20.30:22-10.200.12.6:59124 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'