2025-03-25T10:25:15.087024 [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x000f0510]
2025-03-25T10:25:15.087461 [ 0.000000] Linux version 6.14.0-rc7-next-20250324 (tuxmake@tuxmake) (aarch64-linux-gnu-gcc (Debian 13.3.0-12) 13.3.0, GNU ld (GNU Binutils for Debian) 2.44) #1 SMP PREEMPT @1742818529
2025-03-25T10:25:15.087549 [ 0.000000] KASLR enabled
2025-03-25T10:25:15.087624 [ 0.000000] random: crng init done
2025-03-25T10:25:15.087704 [ 0.000000] Machine model: linux,dummy-virt
2025-03-25T10:25:15.087793 [ 0.000000] efi: UEFI not found.
2025-03-25T10:25:15.087972 [ 0.000000] earlycon: pl11 at MMIO 0x0000000009000000 (options '')
2025-03-25T10:25:15.088106 [ 0.000000] printk: legacy bootconsole [pl11] enabled
2025-03-25T10:25:15.089130 [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT
2025-03-25T10:25:15.092098 [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000013fffffff]
2025-03-25T10:25:15.092830 [ 0.000000] NODE_DATA(0) allocated [mem 0x13f7f9000-0x13f7fb77f]
2025-03-25T10:25:15.095069 [ 0.000000] Zone ranges:
2025-03-25T10:25:15.095459 [ 0.000000] DMA [mem 0x0000000040000000-0x00000000ffffffff]
2025-03-25T10:25:15.095558 [ 0.000000] DMA32 empty
2025-03-25T10:25:15.095744 [ 0.000000] Normal [mem 0x0000000100000000-0x000000013fffffff]
2025-03-25T10:25:15.095846 [ 0.000000] Movable zone start for each node
2025-03-25T10:25:15.095952 [ 0.000000] Early memory node ranges
2025-03-25T10:25:15.096152 [ 0.000000] node 0: [mem 0x0000000040000000-0x000000013fffffff]
2025-03-25T10:25:15.096550 [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000013fffffff]
2025-03-25T10:25:15.121983 [ 0.000000] cma: Reserved 32 MiB at 0x0000000000000000
2025-03-25T10:25:15.123019 [ 0.000000] psci: probing for conduit method from DT.
2025-03-25T10:25:15.123257 [ 0.000000] psci: PSCIv1.1 detected in firmware.
2025-03-25T10:25:15.123346 [ 0.000000] psci: Using standard PSCI v0.2 function IDs
2025-03-25T10:25:15.123585 [ 0.000000] psci: Trusted OS migration not required
2025-03-25T10:25:15.123694 [ 0.000000] psci: SMC Calling Convention v1.0
2025-03-25T10:25:15.125829 [ 0.000000] percpu: Embedded 25 pages/cpu s62808 r8192 d31400 u102400
2025-03-25T10:25:15.126407 [ 0.000000] pcpu-alloc: s62808 r8192 d31400 u102400 alloc=25*4096
2025-03-25T10:25:15.126571 [ 0.000000] pcpu-alloc: [0] 0 [0] 1
2025-03-25T10:25:15.127706 [ 0.000000] Detected PIPT I-cache on CPU0
2025-03-25T10:25:15.129048 [ 0.000000] CPU features: detected: Address authentication (IMP DEF algorithm)
2025-03-25T10:25:15.129316 [ 0.000000] CPU features: detected: GIC system register CPU interface
2025-03-25T10:25:15.129439 [ 0.000000] CPU features: detected: HCRX_EL2 register
2025-03-25T10:25:15.129647 [ 0.000000] CPU features: detected: 52-bit Virtual Addressing (LPA2)
2025-03-25T10:25:15.129826 [ 0.000000] CPU features: detected: Virtualization Host Extensions
2025-03-25T10:25:15.130072 [ 0.000000] CPU features: detected: Memory Tagging Extension
2025-03-25T10:25:15.130223 [ 0.000000] CPU features: detected: Asymmetric MTE Tag Check Fault
2025-03-25T10:25:15.130516 [ 0.000000] CPU features: detected: Spectre-v4
2025-03-25T10:25:15.133573 [ 0.000000] alternatives: applying boot alternatives
2025-03-25T10:25:15.135951 [ 0.000000] Kernel command line: console=ttyAMA0,115200 rootwait root=/dev/vda debug verbose console_msg_format=syslog systemd.log_level=warning rw earlycon
2025-03-25T10:25:15.137936 <5>[ 0.000000] Unknown kernel command line parameters "verbose", will be passed to user space.
2025-03-25T10:25:15.139834 <6>[ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes
2025-03-25T10:25:15.141965 <6>[ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
2025-03-25T10:25:15.143135 <6>[ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
2025-03-25T10:25:15.143432 <6>[ 0.000000] software IO TLB: area num 2.
2025-03-25T10:25:15.193509 <6>[ 0.000000] software IO TLB: mapped [mem 0x00000000fa000000-0x00000000fe000000] (64MB)
2025-03-25T10:25:15.194818 <6>[ 0.000000] Fallback order for Node 0: 0
2025-03-25T10:25:15.194921 <6>[ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1048576
2025-03-25T10:25:15.195026 <6>[ 0.000000] Policy zone: Normal
2025-03-25T10:25:15.195572 <6>[ 0.000000] mem auto-init: stack:all(zero), heap alloc:off, heap free:off
2025-03-25T10:25:15.214780 <6>[ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
2025-03-25T10:25:15.221740 <6>[ 0.000000] rcu: Preemptible hierarchical RCU implementation.
2025-03-25T10:25:15.221849 <6>[ 0.000000] rcu: RCU event tracing is enabled.
2025-03-25T10:25:15.221951 <6>[ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2.
2025-03-25T10:25:15.222267 <6>[ 0.000000] Trampoline variant of Tasks RCU enabled.
2025-03-25T10:25:15.222347 <6>[ 0.000000] Tracing variant of Tasks RCU enabled.
2025-03-25T10:25:15.222643 <6>[ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
2025-03-25T10:25:15.222810 <6>[ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
2025-03-25T10:25:15.224018 <6>[ 0.000000] RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.
2025-03-25T10:25:15.224306 <6>[ 0.000000] RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.
2025-03-25T10:25:15.224839 <6>[ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
2025-03-25T10:25:15.230140 <6>[ 0.000000] GICv3: GIC: Using split EOI/Deactivate mode
2025-03-25T10:25:15.230454 <6>[ 0.000000] GICv3: 256 SPIs implemented
2025-03-25T10:25:15.230517 <6>[ 0.000000] GICv3: 0 Extended SPIs implemented
2025-03-25T10:25:15.231919 <6>[ 0.000000] Root IRQ handler: gic_handle_irq
2025-03-25T10:25:15.232102 <6>[ 0.000000] GICv3: GICv3 features: 16 PPIs
2025-03-25T10:25:15.232409 <6>[ 0.000000] GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0
2025-03-25T10:25:15.232821 <6>[ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000
2025-03-25T10:25:15.237483 <6>[ 0.000000] ITS [mem 0x08080000-0x0809ffff]
2025-03-25T10:25:15.238314 <6>[ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @100050000 (indirect, esz 8, psz 64K, shr 1)
2025-03-25T10:25:15.238654 <6>[ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @100060000 (flat, esz 8, psz 64K, shr 1)
2025-03-25T10:25:15.239336 <6>[ 0.000000] GICv3: using LPI property table @0x0000000100070000
2025-03-25T10:25:15.240048 <6>[ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000100080000
2025-03-25T10:25:15.242138 <6>[ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.
2025-03-25T10:25:15.248212 <6>[ 0.000000] arch_timer: cp15 timer(s) running at 1000.00MHz (phys).
2025-03-25T10:25:15.248626 <6>[ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
2025-03-25T10:25:15.249149 <6>[ 0.000056] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns
2025-03-25T10:25:15.263691 <6>[ 0.012900] Console: colour dummy device 80x25
2025-03-25T10:25:15.267194 <6>[ 0.017680] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)
2025-03-25T10:25:15.267575 <6>[ 0.018623] pid_max: default: 32768 minimum: 301
2025-03-25T10:25:15.269900 <6>[ 0.020762] LSM: initializing lsm=capability
2025-03-25T10:25:15.273023 <6>[ 0.023934] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
2025-03-25T10:25:15.273220 <6>[ 0.024204] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
2025-03-25T10:25:15.299425 <4>[ 0.050302] cacheinfo: Unable to detect cache hierarchy for CPU 0
2025-03-25T10:25:15.309854 <6>[ 0.060750] rcu: Hierarchical SRCU implementation.
2025-03-25T10:25:15.309957 <6>[ 0.060934] rcu: Max phase no-delay instances is 1000.
2025-03-25T10:25:15.311843 <6>[ 0.062774] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level
2025-03-25T10:25:15.315495 <6>[ 0.066389] fsl-mc MSI: its@8080000 domain created
2025-03-25T10:25:15.317589 <6>[ 0.068509] EFI services will not be available.
2025-03-25T10:25:15.319118 <6>[ 0.070070] smp: Bringing up secondary CPUs ...
2025-03-25T10:25:15.331338 <6>[ 0.074941] Detected PIPT I-cache on CPU1
2025-03-25T10:25:15.331613 <6>[ 0.076285] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000
2025-03-25T10:25:15.331931 <6>[ 0.077060] GICv3: CPU1: using allocated LPI pending table @0x0000000100090000
2025-03-25T10:25:15.332212 <6>[ 0.079074] CPU1: Booted secondary processor 0x0000000001 [0x000f0510]
2025-03-25T10:25:15.332332 <6>[ 0.082252] smp: Brought up 1 node, 2 CPUs
2025-03-25T10:25:15.332512 <6>[ 0.083546] SMP: Total of 2 processors activated.
2025-03-25T10:25:15.332675 <6>[ 0.083725] CPU: All CPU(s) started at EL2
2025-03-25T10:25:15.332932 <6>[ 0.083936] CPU features: detected: Branch Target Identification
2025-03-25T10:25:15.333098 <6>[ 0.084139] CPU features: detected: 32-bit EL0 Support
2025-03-25T10:25:15.333284 <6>[ 0.084305] CPU features: detected: 32-bit EL1 Support
2025-03-25T10:25:15.333506 <6>[ 0.084487] CPU features: detected: ARMv8.4 Translation Table Level
2025-03-25T10:25:15.333816 <6>[ 0.084719] CPU features: detected: Instruction cache invalidation not required for I/D coherence
2025-03-25T10:25:15.334117 <6>[ 0.085026] CPU features: detected: Data cache clean to the PoU not required for I/D coherence
2025-03-25T10:25:15.334374 <6>[ 0.085350] CPU features: detected: Common not Private translations
2025-03-25T10:25:15.334543 <6>[ 0.085573] CPU features: detected: CRC32 instructions
2025-03-25T10:25:15.334937 <6>[ 0.085745] CPU features: detected: Data independent timing control (DIT)
2025-03-25T10:25:15.335000 <6>[ 0.086053] CPU features: detected: E0PD
2025-03-25T10:25:15.335203 <6>[ 0.086202] CPU features: detected: Enhanced Counter Virtualization
2025-03-25T10:25:15.335638 <6>[ 0.086405] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)
2025-03-25T10:25:15.335692 <6>[ 0.086651] CPU features: detected: Enhanced Privileged Access Never
2025-03-25T10:25:15.335902 <6>[ 0.086894] CPU features: detected: Enhanced Virtualization Traps
2025-03-25T10:25:15.336076 <6>[ 0.087104] CPU features: detected: Fine Grained Traps
2025-03-25T10:25:15.336347 <6>[ 0.087335] CPU features: detected: Generic authentication (IMP DEF algorithm)
2025-03-25T10:25:15.336601 <6>[ 0.087593] CPU features: detected: RCpc load-acquire (LDAPR)
2025-03-25T10:25:15.336832 <6>[ 0.087812] CPU features: detected: 52-bit Virtual Addressing for KVM (LPA2)
2025-03-25T10:25:15.337020 <6>[ 0.088035] CPU features: detected: LSE atomic instructions
2025-03-25T10:25:15.337232 <6>[ 0.088218] CPU features: detected: Memory Copy and Memory Set instructions
2025-03-25T10:25:15.337413 <6>[ 0.088433] CPU features: detected: Privileged Access Never
2025-03-25T10:25:15.337586 <6>[ 0.088637] CPU features: detected: PMUv3
2025-03-25T10:25:15.337781 <6>[ 0.088787] CPU features: detected: RAS Extension Support
2025-03-25T10:25:15.337955 <6>[ 0.088983] CPU features: detected: Random Number Generator
2025-03-25T10:25:15.338135 <6>[ 0.089151] CPU features: detected: Speculation barrier (SB)
2025-03-25T10:25:15.338321 <6>[ 0.089338] CPU features: detected: Stage-2 Force Write-Back
2025-03-25T10:25:15.338567 <6>[ 0.089519] CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality
2025-03-25T10:25:15.338779 <6>[ 0.089769] CPU features: detected: TLB range maintenance instructions
2025-03-25T10:25:15.339071 <6>[ 0.089980] CPU features: detected: WFx with timeout
2025-03-25T10:25:15.339548 <6>[ 0.090431] CPU features: detected: Speculative Store Bypassing Safe (SSBS)
2025-03-25T10:25:15.339858 <6>[ 0.090639] CPU features: detected: Scalable Vector Extension
2025-03-25T10:25:15.349613 <6>[ 0.098669] alternatives: applying system-wide alternatives
2025-03-25T10:25:15.360688 <6>[ 0.111048] CPU features: detected: Hardware dirty bit management on CPU0-1
2025-03-25T10:25:15.360999 <6>[ 0.111962] SVE: maximum available vector length 256 bytes per vector
2025-03-25T10:25:15.361133 <6>[ 0.112158] SVE: default vector length 64 bytes per vector
2025-03-25T10:25:15.372278 <6>[ 0.122986] Memory: 3968692K/4194304K available (18240K kernel code, 5264K rwdata, 12488K rodata, 3264K init, 748K bss, 188664K reserved, 32768K cma-reserved)
2025-03-25T10:25:15.395115 <6>[ 0.145983] devtmpfs: initialized
2025-03-25T10:25:15.420098 <6>[ 0.170946] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
2025-03-25T10:25:15.420573 <6>[ 0.171535] posixtimers hash table entries: 1024 (order: 2, 16384 bytes, linear)
2025-03-25T10:25:15.420879 <6>[ 0.171855] futex hash table entries: 512 (order: 3, 32768 bytes, linear)
2025-03-25T10:25:15.422778 <6>[ 0.173695] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL
2025-03-25T10:25:15.422897 <6>[ 0.173916] 0 pages in range for non-PLT usage
2025-03-25T10:25:15.425534 <6>[ 0.173959] 514224 pages in range for PLT usage
2025-03-25T10:25:15.425611 <6>[ 0.176451] pinctrl core: initialized pinctrl subsystem
2025-03-25T10:25:15.435511 <6>[ 0.186438] DMI not present or invalid.
2025-03-25T10:25:15.448821 <6>[ 0.199729] NET: Registered PF_NETLINK/PF_ROUTE protocol family
2025-03-25T10:25:15.457399 <6>[ 0.208227] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations
2025-03-25T10:25:15.458145 <6>[ 0.209044] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
2025-03-25T10:25:15.458808 <6>[ 0.209739] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
2025-03-25T10:25:15.459157 <6>[ 0.210181] audit: initializing netlink subsys (disabled)
2025-03-25T10:25:15.460688 <5>[ 0.211637] audit: type=2000 audit(0.188:1): state=initialized audit_enabled=0 res=1
2025-03-25T10:25:15.464819 <6>[ 0.215699] thermal_sys: Registered thermal governor 'step_wise'
2025-03-25T10:25:15.465399 <6>[ 0.215741] thermal_sys: Registered thermal governor 'power_allocator'
2025-03-25T10:25:15.465450 <6>[ 0.216325] cpuidle: using governor menu
2025-03-25T10:25:15.466919 <6>[ 0.217870] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
2025-03-25T10:25:15.467637 <6>[ 0.218563] ASID allocator initialised with 65536 entries
2025-03-25T10:25:15.475038 <6>[ 0.225952] Serial: AMBA PL011 UART driver
2025-03-25T10:25:15.533512 <6>[ 0.284381] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 15, base_baud = 0) is a PL011 rev1
2025-03-25T10:25:15.535438 <6>[ 0.285943] printk: console [ttyAMA0] enabled
2025-03-25T10:25:15.535750 <6>[ 0.285943] printk: console [ttyAMA0] enabled
2025-03-25T10:25:15.535961 <6>[ 0.286997] printk: legacy bootconsole [pl11] disabled
2025-03-25T10:25:15.536110 <6>[ 0.286997] printk: legacy bootconsole [pl11] disabled
2025-03-25T10:25:15.552165 <6>[ 0.302272] HugeTLB: allocation took 0ms with hugepage_allocation_threads=1
2025-03-25T10:25:15.552505 <6>[ 0.302614] HugeTLB: allocation took 0ms with hugepage_allocation_threads=1
2025-03-25T10:25:15.552870 <6>[ 0.303350] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
2025-03-25T10:25:15.553307 <6>[ 0.303394] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page
2025-03-25T10:25:15.553687 <6>[ 0.303454] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages
2025-03-25T10:25:15.554053 <6>[ 0.303478] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page
2025-03-25T10:25:15.554353 <6>[ 0.303507] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
2025-03-25T10:25:15.554655 <6>[ 0.303522] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page
2025-03-25T10:25:15.555438 <6>[ 0.303542] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages
2025-03-25T10:25:15.555760 <6>[ 0.303556] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page
2025-03-25T10:25:15.564418 <6>[ 0.315232] ACPI: Interpreter disabled.
2025-03-25T10:25:15.573200 <6>[ 0.323926] iommu: Default domain type: Translated
2025-03-25T10:25:15.573679 <6>[ 0.324010] iommu: DMA domain TLB invalidation policy: strict mode
2025-03-25T10:25:15.575180 <5>[ 0.326059] SCSI subsystem initialized
2025-03-25T10:25:15.576106 <7>[ 0.326971] libata version 3.00 loaded.
2025-03-25T10:25:15.577357 <6>[ 0.328248] usbcore: registered new interface driver usbfs
2025-03-25T10:25:15.577587 <6>[ 0.328485] usbcore: registered new interface driver hub
2025-03-25T10:25:15.578015 <6>[ 0.328613] usbcore: registered new device driver usb
2025-03-25T10:25:15.580337 <6>[ 0.331139] pps_core: LinuxPPS API ver. 1 registered
2025-03-25T10:25:15.580776 <6>[ 0.331182] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
2025-03-25T10:25:15.581089 <6>[ 0.331307] PTP clock support registered
2025-03-25T10:25:15.581163 <6>[ 0.331870] EDAC MC: Ver: 3.0.0
2025-03-25T10:25:15.582465 <6>[ 0.333250] scmi_core: SCMI protocol bus registered
2025-03-25T10:25:15.585924 <6>[ 0.336723] FPGA manager framework
2025-03-25T10:25:15.586776 <6>[ 0.337535] Advanced Linux Sound Architecture Driver Initialized.
2025-03-25T10:25:15.595848 <6>[ 0.346663] vgaarb: loaded
2025-03-25T10:25:15.598678 <6>[ 0.349416] clocksource: Switched to clocksource arch_sys_counter
2025-03-25T10:25:15.601742 <5>[ 0.352300] VFS: Disk quotas dquot_6.6.0
2025-03-25T10:25:15.602219 <6>[ 0.352472] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
2025-03-25T10:25:15.604147 <6>[ 0.354775] pnp: PnP ACPI: disabled
2025-03-25T10:25:15.633583 <6>[ 0.384355] NET: Registered PF_INET protocol family
2025-03-25T10:25:15.635136 <6>[ 0.385821] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)
2025-03-25T10:25:15.640221 <6>[ 0.390788] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)
2025-03-25T10:25:15.640723 <6>[ 0.390945] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
2025-03-25T10:25:15.641127 <6>[ 0.391133] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)
2025-03-25T10:25:15.641530 <6>[ 0.391682] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)
2025-03-25T10:25:15.641832 <6>[ 0.392380] TCP: Hash tables configured (established 32768 bind 32768)
2025-03-25T10:25:15.642705 <6>[ 0.393540] UDP hash table entries: 2048 (order: 5, 131072 bytes, linear)
2025-03-25T10:25:15.643161 <6>[ 0.393867] UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear)
2025-03-25T10:25:15.644237 <6>[ 0.395109] NET: Registered PF_UNIX/PF_LOCAL protocol family
2025-03-25T10:25:15.646717 <6>[ 0.397557] RPC: Registered named UNIX socket transport module.
2025-03-25T10:25:15.646897 <6>[ 0.397623] RPC: Registered udp transport module.
2025-03-25T10:25:15.647082 <6>[ 0.397646] RPC: Registered tcp transport module.
2025-03-25T10:25:15.647534 <6>[ 0.397656] RPC: Registered tcp-with-tls transport module.
2025-03-25T10:25:15.647615 <6>[ 0.397665] RPC: Registered tcp NFSv4.1 backchannel transport module.
2025-03-25T10:25:15.650299 <6>[ 0.397773] PCI: CLS 0 bytes, default 64
2025-03-25T10:25:15.655212 <6>[ 0.406035] kvm [1]: nv: 566 coarse grained trap handlers
2025-03-25T10:25:15.656052 <6>[ 0.406960] kvm [1]: nv: 669 fine grained trap handlers
2025-03-25T10:25:15.657084 <6>[ 0.407991] kvm [1]: IPA Size Limit: 52 bits
2025-03-25T10:25:15.657811 <6>[ 0.408559] kvm [1]: GICv3: no GICV resource entry
2025-03-25T10:25:15.658096 <6>[ 0.408677] kvm [1]: disabling GICv2 emulation
2025-03-25T10:25:15.658437 <6>[ 0.408964] kvm [1]: GIC system register CPU interface enabled
2025-03-25T10:25:15.658836 <6>[ 0.409803] kvm [1]: vgic interrupt IRQ9
2025-03-25T10:25:15.659436 <6>[ 0.410330] kvm [1]: VHE mode initialized successfully
2025-03-25T10:25:15.664355 <5>[ 0.415183] Initialise system trusted keyrings
2025-03-25T10:25:15.665475 <6>[ 0.416289] workingset: timestamp_bits=42 max_order=20 bucket_order=0
2025-03-25T10:25:15.667322 <6>[ 0.418188] squashfs: version 4.0 (2009/01/31) Phillip Lougher
2025-03-25T10:25:15.668671 <5>[ 0.419525] NFS: Registering the id_resolver key type
2025-03-25T10:25:15.668845 <5>[ 0.419790] Key type id_resolver registered
2025-03-25T10:25:15.668960 <5>[ 0.419842] Key type id_legacy registered
2025-03-25T10:25:15.669420 <6>[ 0.420094] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
2025-03-25T10:25:15.669509 <6>[ 0.420165] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering...
2025-03-25T10:25:15.670121 <6>[ 0.420883] 9p: Installing v9fs 9p2000 file system support
2025-03-25T10:25:15.735140 <5>[ 0.485877] Key type asymmetric registered
2025-03-25T10:25:15.735396 <5>[ 0.485949] Asymmetric key parser 'x509' registered
2025-03-25T10:25:15.735840 <6>[ 0.486164] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 245)
2025-03-25T10:25:15.736045 <6>[ 0.486267] io scheduler mq-deadline registered
2025-03-25T10:25:15.736193 <6>[ 0.486439] io scheduler kyber registered
2025-03-25T10:25:15.736352 <6>[ 0.486704] io scheduler bfq registered
2025-03-25T10:25:15.764023 <6>[ 0.514755] pl061_gpio 9030000.pl061: PL061 GPIO chip registered
2025-03-25T10:25:15.768218 <6>[ 0.519048] ledtrig-cpu: registered to indicate activity on CPUs
2025-03-25T10:25:15.771494 <6>[ 0.522186] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:
2025-03-25T10:25:15.772067 <6>[ 0.522688] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000
2025-03-25T10:25:15.772383 <6>[ 0.523113] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000
2025-03-25T10:25:15.772700 <6>[ 0.523173] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000
2025-03-25T10:25:15.772992 <4>[ 0.523614] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits
2025-03-25T10:25:15.773441 <6>[ 0.524021] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]
2025-03-25T10:25:15.774445 <6>[ 0.525325] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00
2025-03-25T10:25:15.774840 <6>[ 0.525562] pci_bus 0000:00: root bus resource [bus 00-ff]
2025-03-25T10:25:15.774907 <6>[ 0.525621] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]
2025-03-25T10:25:15.775324 <6>[ 0.525677] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]
2025-03-25T10:25:15.775463 <6>[ 0.525693] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]
2025-03-25T10:25:15.776244 <6>[ 0.526866] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint
2025-03-25T10:25:15.779607 <6>[ 0.530248] pci 0000:00:01.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint
2025-03-25T10:25:15.779964 <6>[ 0.530503] pci 0000:00:01.0: BAR 0 [io 0x0000-0x007f]
2025-03-25T10:25:15.780264 <6>[ 0.530561] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]
2025-03-25T10:25:15.780637 <6>[ 0.530696] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
2025-03-25T10:25:15.783179 <6>[ 0.533825] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned
2025-03-25T10:25:15.783632 <6>[ 0.534137] pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff]: assigned
2025-03-25T10:25:15.783957 <6>[ 0.534199] pci 0000:00:01.0: BAR 0 [io 0x1000-0x107f]: assigned
2025-03-25T10:25:15.784172 <6>[ 0.534461] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]
2025-03-25T10:25:15.784394 <6>[ 0.534507] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]
2025-03-25T10:25:15.784736 <6>[ 0.534820] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]
2025-03-25T10:25:15.848818 <6>[ 0.599025] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)
2025-03-25T10:25:15.869764 <6>[ 0.620542] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
2025-03-25T10:25:15.878795 <6>[ 0.629593] msm_serial: driver initialized
2025-03-25T10:25:15.879639 <6>[ 0.630523] SuperH (H)SCI(F) driver initialized
2025-03-25T10:25:15.880007 <6>[ 0.630988] STM32 USART driver initialized
2025-03-25T10:25:15.905591 <6>[ 0.656358] loop: module loaded
2025-03-25T10:25:15.906576 <6>[ 0.657341] virtio_blk virtio0: 2/0/0 default/read/poll queues
2025-03-25T10:25:15.914945 <5>[ 0.665620] virtio_blk virtio0: [vda] 5345376 512-byte logical blocks (2.74 GB/2.55 GiB)
2025-03-25T10:25:15.927480 <6>[ 0.678221] megasas: 07.727.03.00-rc1
2025-03-25T10:25:15.932641 <5>[ 0.682835] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]
2025-03-25T10:25:15.934114 <6>[ 0.684270] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
2025-03-25T10:25:15.934734 <6>[ 0.684747] Intel/Sharp Extended Query Table at 0x0031
2025-03-25T10:25:15.935473 <6>[ 0.685648] Using buffer write method
2025-03-25T10:25:15.936182 <7>[ 0.685905] erase region 0: offset=0x0,size=0x40000,blocks=256
2025-03-25T10:25:15.936439 <5>[ 0.686078] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]
2025-03-25T10:25:15.936786 <6>[ 0.686634] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
2025-03-25T10:25:15.936988 <6>[ 0.686668] Intel/Sharp Extended Query Table at 0x0031
2025-03-25T10:25:15.937147 <6>[ 0.687296] Using buffer write method
2025-03-25T10:25:15.937357 <7>[ 0.687315] erase region 0: offset=0x0,size=0x40000,blocks=256
2025-03-25T10:25:15.937654 <5>[ 0.687379] Concatenating MTD devices:
2025-03-25T10:25:15.938860 <5>[ 0.687411] (0): "0.flash"
2025-03-25T10:25:15.938920 <5>[ 0.687459] (1): "0.flash"
2025-03-25T10:25:15.939081 <5>[ 0.687479] into device "0.flash"
2025-03-25T10:25:15.962323 <6>[ 0.713093] tun: Universal TUN/TAP device driver, 1.6
2025-03-25T10:25:15.965846 <6>[ 0.716564] thunder_xcv, ver 1.0
2025-03-25T10:25:15.966307 <6>[ 0.716690] thunder_bgx, ver 1.0
2025-03-25T10:25:15.966407 <6>[ 0.716785] nicpf, ver 1.0
2025-03-25T10:25:15.969305 <6>[ 0.719924] hns3: Hisilicon Ethernet Network Driver for Hip08 Family - version
2025-03-25T10:25:15.969688 <6>[ 0.719973] hns3: Copyright (c) 2017 Huawei Corporation.
2025-03-25T10:25:15.969957 <6>[ 0.720197] hclge is initializing
2025-03-25T10:25:15.970295 <6>[ 0.720301] e1000: Intel(R) PRO/1000 Network Driver
2025-03-25T10:25:15.970617 <6>[ 0.720313] e1000: Copyright (c) 1999-2006 Intel Corporation.
2025-03-25T10:25:15.971009 <6>[ 0.720430] e1000e: Intel(R) PRO/1000 Network Driver
2025-03-25T10:25:15.971158 <6>[ 0.720443] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
2025-03-25T10:25:15.971482 <6>[ 0.720740] igb: Intel(R) Gigabit Ethernet Network Driver
2025-03-25T10:25:15.971812 <6>[ 0.720877] igb: Copyright (c) 2007-2014 Intel Corporation.
2025-03-25T10:25:15.972181 <6>[ 0.721117] igbvf: Intel(R) Gigabit Virtual Function Network Driver
2025-03-25T10:25:15.972444 <6>[ 0.721274] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.
2025-03-25T10:25:15.972589 <6>[ 0.722065] sky2: driver version 1.30
2025-03-25T10:25:15.975716 <6>[ 0.726573] VFIO - User Level meta-driver version: 0.3
2025-03-25T10:25:15.983757 <6>[ 0.734555] usbcore: registered new interface driver usb-storage
2025-03-25T10:25:15.992981 <6>[ 0.743832] rtc-pl031 9010000.pl031: registered as rtc0
2025-03-25T10:25:15.993703 <6>[ 0.744319] rtc-pl031 9010000.pl031: setting system clock to 2025-03-25T10:25:15 UTC (1742898315)
2025-03-25T10:25:15.995904 <6>[ 0.746738] i2c_dev: i2c /dev entries driver
2025-03-25T10:25:16.014360 <6>[ 0.764948] sdhci: Secure Digital Host Controller Interface driver
2025-03-25T10:25:16.014616 <6>[ 0.765004] sdhci: Copyright(c) Pierre Ossman
2025-03-25T10:25:16.016495 <6>[ 0.767265] Synopsys Designware Multimedia Card Interface Driver
2025-03-25T10:25:16.019148 <6>[ 0.769929] sdhci-pltfm: SDHCI platform and OF driver helper
2025-03-25T10:25:16.028440 <6>[ 0.779210] usbcore: registered new interface driver usbhid
2025-03-25T10:25:16.028572 <6>[ 0.779269] usbhid: USB HID core driver
2025-03-25T10:25:16.039021 <6>[ 0.789536] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available
2025-03-25T10:25:16.051171 <6>[ 0.801966] NET: Registered PF_INET6 protocol family
2025-03-25T10:25:16.056892 <6>[ 0.807708] Segment Routing with IPv6
2025-03-25T10:25:16.057104 <6>[ 0.807994] In-situ OAM (IOAM) with IPv6
2025-03-25T10:25:16.057939 <6>[ 0.808553] NET: Registered PF_PACKET protocol family
2025-03-25T10:25:16.058975 <6>[ 0.809816] 9pnet: Installing 9P2000 support
2025-03-25T10:25:16.059300 <5>[ 0.810187] Key type dns_resolver registered
2025-03-25T10:25:16.087641 <6>[ 0.838434] registered taskstats version 1
2025-03-25T10:25:16.088659 <5>[ 0.839529] Loading compiled-in X.509 certificates
2025-03-25T10:25:16.115426 <6>[ 0.865340] Demotion targets for Node 0: null
2025-03-25T10:25:16.123458 <6>[ 0.874174] input: gpio-keys as /devices/platform/gpio-keys/input/input0
2025-03-25T10:25:16.128753 <6>[ 0.879544] clk: Disabling unused clocks
2025-03-25T10:25:16.129000 <6>[ 0.879904] PM: genpd: Disabling unused power domains
2025-03-25T10:25:16.129331 <6>[ 0.880240] ALSA device list:
2025-03-25T10:25:16.129719 <6>[ 0.880378] No soundcards found.
2025-03-25T10:25:16.157640 <6>[ 0.908202] EXT4-fs (vda): mounted filesystem db78a389-4e12-4f05-bb8b-e7b25b5f99d9 r/w with ordered data mode. Quota mode: none.
2025-03-25T10:25:16.157882 <6>[ 0.908548] VFS: Mounted root (ext4 filesystem) on device 254:0.
2025-03-25T10:25:16.159239 <6>[ 0.910114] devtmpfs: mounted
2025-03-25T10:25:16.456133 <6>[ 1.206267] Freeing unused kernel memory: 3264K
2025-03-25T10:25:16.456353 <6>[ 1.207193] Run /sbin/init as init process
2025-03-25T10:25:16.456486 <7>[ 1.207275] with arguments:
2025-03-25T10:25:16.456613 <7>[ 1.207311] /sbin/init
2025-03-25T10:25:16.456726 <7>[ 1.207335] verbose
2025-03-25T10:25:16.456856 <7>[ 1.207345] with environment:
2025-03-25T10:25:16.457219 <7>[ 1.207364] HOME=/
2025-03-25T10:25:16.457283 <7>[ 1.207417] TERM=linux
2025-03-25T10:25:16.781333 [!p]104[?7h
2025-03-25T10:25:16.781490 [0;1;39mWelcome to [0m[1mDebian GNU/Linux trixie/sid[0m[0;1;39m![0m
2025-03-25T10:25:16.781559
2025-03-25T10:25:18.522466 [[0;32m OK [0m] Created slice [0;1;39msystem-getty.slice[0m - Slice /system/getty.
2025-03-25T10:25:18.528050 [[0;32m OK [0m] Created slice [0;1;39msystem-modprobe.slice[0m - Slice /system/modprobe.
2025-03-25T10:25:18.533105 [[0;32m OK [0m] Created slice [0;1;39msystem-serial\x2dget…slice[0m - Slice /system/serial-getty.
2025-03-25T10:25:18.538836 [[0;32m OK [0m] Created slice [0;1;39msystem-xfs_scrub.sli…[0mxfs_scrub background service slice.
2025-03-25T10:25:18.543196 [[0;32m OK [0m] Created slice [0;1;39muser.slice[0m - User and Session Slice.
2025-03-25T10:25:18.545339 [[0;32m OK [0m] Started [0;1;39msystemd-ask-password-conso…[0mequests to Console Directory Watch.
2025-03-25T10:25:18.546586 [[0;32m OK [0m] Started [0;1;39msystemd-ask-password-wall.…[0md Requests to Wall Directory Watch.
2025-03-25T10:25:18.548605 Expecting device [0;1;39mdev-ttyAMA0.device[0m - /dev/ttyAMA0...
2025-03-25T10:25:18.549448 [[0;32m OK [0m] Reached target [0;1;39mpaths.target[0m - Path Units.
2025-03-25T10:25:18.550367 [[0;32m OK [0m] Reached target [0;1;39mremote-fs.target[0m - Remote File Systems.
2025-03-25T10:25:18.551126 [[0;32m OK [0m] Reached target [0;1;39mslices.target[0m - Slice Units.
2025-03-25T10:25:18.551930 [[0;32m OK [0m] Reached target [0;1;39mswap.target[0m - Swaps.
2025-03-25T10:25:18.563971 [[0;32m OK [0m] Listening on [0;1;39msystemd-creds.socket[0m - Credential Encryption/Decryption.
2025-03-25T10:25:18.566425 [[0;32m OK [0m] Listening on [0;1;39msystemd-initctl.socke…[0m- initctl Compatibility Named Pipe.
2025-03-25T10:25:18.568373 [[0;32m OK [0m] Listening on [0;1;39msystemd-journald-dev-…socket[0m - Journal Socket (/dev/log).
2025-03-25T10:25:18.570230 [[0;32m OK [0m] Listening on [0;1;39msystemd-journald.socket[0m - Journal Sockets.
2025-03-25T10:25:18.572276 [[0;32m OK [0m] Listening on [0;1;39msystemd-udevd-control.socket[0m - udev Control Socket.
2025-03-25T10:25:18.573596 [[0;32m OK [0m] Listening on [0;1;39msystemd-udevd-kernel.socket[0m - udev Kernel Socket.
2025-03-25T10:25:18.594417 Mounting [0;1;39mdev-hugepages.mount[0m - Huge Pages File System...
2025-03-25T10:25:18.607274 Mounting [0;1;39mdev-mqueue.mount[0m - POSIX Message Queue File System...
2025-03-25T10:25:18.623970 Mounting [0;1;39mrun-lock.mount[0m - Legacy Locks Directory /run/lock...
2025-03-25T10:25:18.639578 Mounting [0;1;39msys-kernel-debug.mount[0m - Kernel Debug File System...
2025-03-25T10:25:18.676226 Mounting [0;1;39mtmp.mount[0m - Temporary Directory /tmp...
2025-03-25T10:25:18.717906 Starting [0;1;39mkmod-static-nodes.service[0m…eate List of Static Device Nodes...
2025-03-25T10:25:18.743978 Starting [0;1;39mmodprobe@configfs.service[0m - Load Kernel Module configfs...
2025-03-25T10:25:18.771515 Starting [0;1;39mmodprobe@drm.service[0m - Load Kernel Module drm...
2025-03-25T10:25:18.823936 Starting [0;1;39mmodprobe@efi_pstore.servi…[0m - Load Kernel Module efi_pstore...
2025-03-25T10:25:18.835228 Starting [0;1;39mmodprobe@fuse.service[0m - Load Kernel Module fuse...
2025-03-25T10:25:18.862795 Starting [0;1;39msystemd-journald.service[0m - Journal Service...
2025-03-25T10:25:18.884294 Starting [0;1;39msystemd-modules-load.service[0m - Load Kernel Modules...
2025-03-25T10:25:18.900306 Starting [0;1;39msystemd-remount-fs.servic…[0munt Root and Kernel File Systems...
2025-03-25T10:25:18.956733 Starting [0;1;39msystemd-udev-load-credent…[0mLoad udev Rules from Credentials...
2025-03-25T10:25:18.980520 Starting [0;1;39msystemd-udev-trigger.service[0m - Coldplug All udev Devices...
2025-03-25T10:25:19.017974 [[0;32m OK [0m] Mounted [0;1;39mdev-hugepages.mount[0m - Huge Pages File System.
2025-03-25T10:25:19.024600 [[0;32m OK [0m] Mounted [0;1;39mdev-mqueue.mount[0m - POSIX Message Queue File System.
2025-03-25T10:25:19.026906 [[0;32m OK [0m] Mounted [0;1;39mrun-lock.mount[0m - Legacy Locks Directory /run/lock.
2025-03-25T10:25:19.028477 [[0;32m OK [0m] Mounted [0;1;39msys-kernel-debug.mount[0m - Kernel Debug File System.
2025-03-25T10:25:19.030303 [[0;32m OK [0m] Mounted [0;1;39mtmp.mount[0m - Temporary Directory /tmp.
2025-03-25T10:25:19.057615 [[0;32m OK [0m] Finished [0;1;39mkmod-static-nodes.service[0m…Create List of Static Device Nodes.
2025-03-25T10:25:19.074383 Starting [0;1;39msystemd-tmpfiles-setup-de…[0m Device Nodes in /dev gracefully...
2025-03-25T10:25:19.247821 [[0;32m OK [0m] Finished [0;1;39msystemd-remount-fs.servic…[0mmount Root and Kernel File Systems.
2025-03-25T10:25:19.265403 Starting [0;1;39msystemd-random-seed.service[0m - Load/Save OS Random Seed...
2025-03-25T10:25:19.334898 [[0;32m OK [0m] Finished [0;1;39msystemd-modules-load.service[0m - Load Kernel Modules.
2025-03-25T10:25:19.352724 Starting [0;1;39msystemd-sysctl.service[0m - Apply Kernel Variables...
2025-03-25T10:25:19.475974 [[0;32m OK [0m] Finished [0;1;39msystemd-udev-load-credent…[0m- Load udev Rules from Credentials.
2025-03-25T10:25:19.604058 [[0;32m OK [0m] Finished [0;1;39msystemd-random-seed.service[0m - Load/Save OS Random Seed.
2025-03-25T10:25:19.617901 [[0;32m OK [0m] Finished [0;1;39mmodprobe@configfs.service[0m - Load Kernel Module configfs.
2025-03-25T10:25:19.626172 [[0;32m OK [0m] Finished [0;1;39msystemd-tmpfiles-setup-de…[0mic Device Nodes in /dev gracefully.
2025-03-25T10:25:19.644621 Starting [0;1;39msystemd-sysusers.service[0m - Create System Users...
2025-03-25T10:25:19.695961 <6>[ 4.446002] fuse: init (API version 7.43)
2025-03-25T10:25:19.716008 [[0;32m OK [0m] Finished [0;1;39mmodprobe@efi_pstore.service[0m - Load Kernel Module efi_pstore.
2025-03-25T10:25:19.731002 [[0;32m OK [0m] Finished [0;1;39mmodprobe@fuse.service[0m - Load Kernel Module fuse.
2025-03-25T10:25:19.740838 [[0;32m OK [0m] Finished [0;1;39mmodprobe@drm.service[0m - Load Kernel Module drm.
2025-03-25T10:25:19.803856 [[0;32m OK [0m] Finished [0;1;39msystemd-sysctl.service[0m - Apply Kernel Variables.
2025-03-25T10:25:19.880550 [[0;32m OK [0m] Started [0;1;39msystemd-journald.service[0m - Journal Service.
2025-03-25T10:25:19.900314 Starting [0;1;39msystemd-journal-flush.ser…[0msh Journal to Persistent Storage...
2025-03-25T10:25:20.007326 [[0;32m OK [0m] Finished [0;1;39msystemd-sysusers.service[0m - Create System Users.
2025-03-25T10:25:20.087401 Mounting [0;1;39msys-fs-fuse-connections.mount[0m - FUSE Control File System...
2025-03-25T10:25:20.115334 Mounting [0;1;39msys-kernel-config.mount[0m - Kernel Configuration File System...
2025-03-25T10:25:20.132315 Starting [0;1;39msystemd-tmpfiles-setup-de…[0meate Static Device Nodes in /dev...
2025-03-25T10:25:20.251332 [[0;32m OK [0m] Mounted [0;1;39msys-fs-fuse-connections.mount[0m - FUSE Control File System.
2025-03-25T10:25:20.253369 [[0;32m OK [0m] Mounted [0;1;39msys-kernel-config.mount[0m - Kernel Configuration File System.
2025-03-25T10:25:20.391295 [[0;32m OK [0m] Finished [0;1;39msystemd-journal-flush.ser…[0mlush Journal to Persistent Storage.
2025-03-25T10:25:20.443853 [[0;32m OK [0m] Finished [0;1;39msystemd-tmpfiles-setup-de…[0mCreate Static Device Nodes in /dev.
2025-03-25T10:25:20.451425 [[0;32m OK [0m] Reached target [0;1;39mlocal-fs-pre.target[0m…Preparation for Local File Systems.
2025-03-25T10:25:20.452378 [[0;32m OK [0m] Reached target [0;1;39mlocal-fs.target[0m - Local File Systems.
2025-03-25T10:25:20.466769 [[0;32m OK [0m] Listening on [0;1;39msystemd-sysext.socket[0m… System Extension Image Management.
2025-03-25T10:25:20.484020 Starting [0;1;39msystemd-tmpfiles-setup.se…[0mate System Files and Directories...
2025-03-25T10:25:20.501374 Starting [0;1;39msystemd-udevd.service[0m - R…ager for Device Events and Files...
2025-03-25T10:25:20.823573 [[0;32m OK [0m] Finished [0;1;39msystemd-tmpfiles-setup.se…[0mreate System Files and Directories.
2025-03-25T10:25:20.840564 Starting [0;1;39mldconfig.service[0m - Rebuild Dynamic Linker Cache...
2025-03-25T10:25:20.864413 Starting [0;1;39msystemd-journal-catalog-u…ervice[0m - Rebuild Journal Catalog...
2025-03-25T10:25:21.272725 [[0;32m OK [0m] Started [0;1;39msystemd-udevd.service[0m - Ru…anager for Device Events and Files.
2025-03-25T10:25:21.479121 [[0;32m OK [0m] Finished [0;1;39msystemd-journal-catalog-u….service[0m - Rebuild Journal Catalog.
2025-03-25T10:25:21.566986 [[0;32m OK [0m] Finished [0;1;39mldconfig.service[0m - Rebuild Dynamic Linker Cache.
2025-03-25T10:25:21.583822 Starting [0;1;39msystemd-update-done.service[0m - Update is Completed...
2025-03-25T10:25:21.699190 [[0;32m OK [0m] Finished [0;1;39msystemd-update-done.service[0m - Update is Completed.
2025-03-25T10:25:22.987337 [[0;32m OK [0m] Finished [0;1;39msystemd-udev-trigger.service[0m - Coldplug All udev Devices.
2025-03-25T10:25:22.990990 [[0;32m OK [0m] Reached target [0;1;39msysinit.target[0m - System Initialization.
2025-03-25T10:25:22.999603 [[0;32m OK [0m] Started [0;1;39mapt-daily.timer[0m - Daily apt download activities.
2025-03-25T10:25:23.001229 [[0;32m OK [0m] Started [0;1;39mapt-daily-upgrade.timer[0m - …y apt upgrade and clean activities.
2025-03-25T10:25:23.003545 [[0;32m OK [0m] Started [0;1;39mdpkg-db-backup.timer[0m - Daily dpkg database backup timer.
2025-03-25T10:25:23.005813 [[0;32m OK [0m] Started [0;1;39me2scrub_all.timer[0m - Period…Metadata Check for All Filesystems.
2025-03-25T10:25:23.008148 [[0;32m OK [0m] Started [0;1;39mfstrim.timer[0m - Discard unused filesystem blocks once a week.
2025-03-25T10:25:23.009494 [[0;32m OK [0m] Started [0;1;39mlogrotate.timer[0m - Daily rotation of log files.
2025-03-25T10:25:23.010971 [[0;32m OK [0m] Started [0;1;39msystemd-tmpfiles-clean.tim…[0my Cleanup of Temporary Directories.
2025-03-25T10:25:23.013078 [[0;32m OK [0m] Started [0;1;39mxfs_scrub_all.timer[0m - Peri…Metadata Check for All Filesystems.
2025-03-25T10:25:23.013785 [[0;32m OK [0m] Reached target [0;1;39mtimers.target[0m - Timer Units.
2025-03-25T10:25:23.015842 [[0;32m OK [0m] Listening on [0;1;39mdbus.socket[0m - D-Bus System Message Bus Socket.
2025-03-25T10:25:23.017432 [[0;32m OK [0m] Listening on [0;1;39msystemd-hostnamed.socket[0m - Hostname Service Socket.
2025-03-25T10:25:23.018294 [[0;32m OK [0m] Reached target [0;1;39msockets.target[0m - Socket Units.
2025-03-25T10:25:23.019754 [[0;32m OK [0m] Reached target [0;1;39mbasic.target[0m - Basic System.
2025-03-25T10:25:23.039499 [[0;32m OK [0m] Started [0;1;39mcron.service[0m - Regular background program processing daemon.
2025-03-25T10:25:23.053919 Starting [0;1;39mdbus.service[0m - D-Bus System Message Bus...
2025-03-25T10:25:23.076883 Starting [0;1;39me2scrub_reap.service[0m - Re…ne ext4 Metadata Check Snapshots...
2025-03-25T10:25:23.124196 Starting [0;1;39msystemd-logind.service[0m - User Login Management...
2025-03-25T10:25:23.138733 Starting [0;1;39msystemd-user-sessions.service[0m - Permit User Sessions...
2025-03-25T10:25:23.432773 [[0;32m OK [0m] Finished [0;1;39msystemd-user-sessions.service[0m - Permit User Sessions.
2025-03-25T10:25:23.456690 [[0;32m OK [0m] Started [0;1;39mgetty@tty1.service[0m - Getty on tty1.
2025-03-25T10:25:23.479040 [[0;32m OK [0m] Started [0;1;39mdbus.service[0m - D-Bus System Message Bus.
2025-03-25T10:25:23.727071 [[0;32m OK [0m] Finished [0;1;39me2scrub_reap.service[0m - Re…line ext4 Metadata Check Snapshots.
2025-03-25T10:25:23.776919 [[0;32m OK [0m] Found device [0;1;39mdev-ttyAMA0.device[0m - /dev/ttyAMA0.
2025-03-25T10:25:23.793334 [[0;32m OK [0m] Started [0;1;39mserial-getty@ttyAMA0.service[0m - Serial Getty on ttyAMA0.
2025-03-25T10:25:23.795185 [[0;32m OK [0m] Reached target [0;1;39mgetty.target[0m - Login Prompts.
2025-03-25T10:25:24.103868 [[0;32m OK [0m] Started [0;1;39msystemd-logind.service[0m - User Login Management.
2025-03-25T10:25:24.105730 [[0;32m OK [0m] Reached target [0;1;39mmulti-user.target[0m - Multi-User System.
2025-03-25T10:25:24.109610 [[0;32m OK [0m] Reached target [0;1;39mgraphical.target[0m - Graphical Interface.
2025-03-25T10:25:25.882850 [!p]104[?7h[6n[32766;32766H[6n[!p]104[?7h[6n[32766;32766H[6n
2025-03-25T10:25:25.883012 Debian GNU/Linux trixie/sid runner-ykxhnyexq-project-40964107-concurrent-0 ttyAMA0
2025-03-25T10:25:25.883082
2025-03-25T10:25:25.985722 runner-ykxhnyexq-project-40964107-concurrent-0 login: root
2025-03-25T10:25:26.186952 Linux runner-ykxhnyexq-project-40964107-concurrent-0 6.14.0-rc7-next-20250324 #1 SMP PREEMPT @1742818529 aarch64
2025-03-25T10:25:26.188888
2025-03-25T10:25:26.189157 The programs included with the Debian GNU/Linux system are free software;
2025-03-25T10:25:26.189464 the exact distribution terms for each program are described in the
2025-03-25T10:25:26.189533 individual files in /usr/share/doc/*/copyright.
2025-03-25T10:25:26.189592
2025-03-25T10:25:26.189829 Debian GNU/Linux comes with ABSOLUTELY NO WARRANTY, to the extent
2025-03-25T10:25:26.189879 permitted by applicable law.
2025-03-25T10:25:28.203879 [?2004hroot@runner-ykxhnyexq-project-40964107-concurrent-0:~#
2025-03-25T10:25:28.307601 [?2004l
[?2004hroot@runner-ykxhnyexq-project-40964107-concurrent-0:~# #
2025-03-25T10:25:28.411523 [?2004l
[?2004hroot@runner-ykxhnyexq-project-40964107-concurrent-0:~# export SHELL=/bin/sh
2025-03-25T10:25:28.514873 [?2004l
[?2004hroot@runner-ykxhnyexq-project-40964107-concurrent-0:~# . /lava-1/environment
2025-03-25T10:25:28.620904 [?2004l
[?2004hroot@runner-ykxhnyexq-project-40964107-concurrent-0:~# /lava-1/bin/lava-test-runn
ner /lava-1/0
2025-03-25T10:25:28.728959 [?2004l
+ export TESTRUN_ID=0_kselftest-clone3
2025-03-25T10:25:28.729122 + cd /lava-1/0/tests/0_kselftest-clone3
2025-03-25T10:25:28.731310 + cat uuid
2025-03-25T10:25:28.738505 + UUID=1_1.1.3.1
2025-03-25T10:25:28.738772 + set +x
2025-03-25T10:25:28.739722 <8>[ 13.490409] <LAVA_SIGNAL_STARTRUN 0_kselftest-clone3 1_1.1.3.1>
2025-03-25T10:25:28.740161 + cd ./automated/linux/kselftest/
2025-03-25T10:25:28.744376 + ./kselftest.sh -c clone3 -T -t kselftest_armhf.tar.gz -s false -u -L -S skipfile-lkft.yaml -b -g -e production -p /opt/kselftests/default-in-kernel -n 1 -i 1 -E
2025-03-25T10:25:28.792582 INFO: Generating a skipfile based on /lava-1/0/tests/0_kselftest-clone3/automated/linux/kselftest/skipfile-lkft.yaml
2025-03-25T10:25:28.947227 INFO: Using the following generated skipfile contents (until EOF):
2025-03-25T10:25:28.952670 bpf:test_btf
2025-03-25T10:25:28.952967 bpf:test_progs
2025-03-25T10:25:28.953051 breakpoints:breakpoint_test
2025-03-25T10:25:28.953124 breakpoints:breakpoint_test_arm64
2025-03-25T10:25:28.953195 breakpoints:step_after_suspend_test
2025-03-25T10:25:28.953266 kmod:test_kmod.sh
2025-03-25T10:25:28.953320 kvm:get-reg-list
2025-03-25T10:25:28.953370 kvm:kvm_create_max_vcpus
2025-03-25T10:25:28.953419 mqueue:mq_open_tests
2025-03-25T10:25:28.953479 mqueue:mq_perf_tests
2025-03-25T10:25:28.953533 net:fib_nexthops.sh
2025-03-25T10:25:28.953583 net:msg_zerocopy.sh
2025-03-25T10:25:28.953630 net:rtnetlink.sh
2025-03-25T10:25:28.953689 net:run_afpackettests
2025-03-25T10:25:28.953742 net:tls
2025-03-25T10:25:28.953818 net:udpgro.sh
2025-03-25T10:25:28.953869 net:xfrm_policy.sh
2025-03-25T10:25:28.953932 netfilter:bridge_brouter.sh
2025-03-25T10:25:28.953984 netfilter:conntrack_icmp_related.sh
2025-03-25T10:25:28.954196 netfilter:nft_flowtable.sh
2025-03-25T10:25:28.954238 netfilter:nft_nat.sh
2025-03-25T10:25:28.954283 netfilter:nft_trans_stress.sh
2025-03-25T10:25:28.954328 pidfd:pidfd_wait
2025-03-25T10:25:28.954375 proc:proc-pid-vm
2025-03-25T10:25:28.954593 ptrace:vmaccess
2025-03-25T10:25:28.954637 rseq:run_param_test.sh
2025-03-25T10:25:28.954674 sync:sync_test
2025-03-25T10:25:28.954716 vm:run_vmtests
2025-03-25T10:25:28.954752 zram:zram.sh
2025-03-25T10:25:28.955990 INFO: EOF
2025-03-25T10:25:29.003505 INFO: Installing sed perl wget xz-utils iproute2 python3-tap
2025-03-25T10:25:29.318683 Ign:1 https://deb.debian.org/debian trixie InRelease
2025-03-25T10:25:30.323758 Ign:1 https://deb.debian.org/debian trixie InRelease
2025-03-25T10:25:32.328735 Ign:1 https://deb.debian.org/debian trixie InRelease
2025-03-25T10:25:36.334731 Err:1 https://deb.debian.org/debian trixie InRelease
2025-03-25T10:25:36.334897 Temporary failure resolving 'deb.debian.org'
2025-03-25T10:25:36.441163 Reading package lists...
2025-03-25T10:25:36.458305 W: Failed to fetch https://deb.debian.org/debian/dists/trixie/InRelease Temporary failure resolving 'deb.debian.org'
2025-03-25T10:25:36.458767 W: Some index files failed to download. They have been ignored, or old ones used instead.
2025-03-25T10:25:36.545619 Reading package lists...
2025-03-25T10:25:36.568048 Building dependency tree...
2025-03-25T10:25:36.571283 Reading state information...
2025-03-25T10:25:36.589745 sed is already the newest version (4.9-2+b1).
2025-03-25T10:25:36.590083 perl is already the newest version (5.40.0-8).
2025-03-25T10:25:36.590214 wget is already the newest version (1.24.5-2).
2025-03-25T10:25:36.590400 xz-utils is already the newest version (5.6.3-1+b1).
2025-03-25T10:25:36.590736 iproute2 is already the newest version (6.13.0-1).
2025-03-25T10:25:36.590810 python3-tap is already the newest version (3.2.1-1).
2025-03-25T10:25:36.673118 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
2025-03-25T10:25:36.699758 kselftests found on rootfs
2025-03-25T10:25:36.732644 skiplist:
2025-03-25T10:25:36.732739 ========================================
2025-03-25T10:25:36.733314 bpf:test_btf
2025-03-25T10:25:36.826016 bpf:test_progs
2025-03-25T10:25:36.846613 breakpoints:breakpoint_test
2025-03-25T10:25:36.865683 breakpoints:breakpoint_test_arm64
2025-03-25T10:25:36.888416 breakpoints:step_after_suspend_test
2025-03-25T10:25:36.907752 kmod:test_kmod.sh
2025-03-25T10:25:36.926280 kvm:get-reg-list
2025-03-25T10:25:36.945828 kvm:kvm_create_max_vcpus
2025-03-25T10:25:36.964969 mqueue:mq_open_tests
2025-03-25T10:25:36.983815 mqueue:mq_perf_tests
2025-03-25T10:25:37.003779 net:fib_nexthops.sh
2025-03-25T10:25:37.023546 net:msg_zerocopy.sh
2025-03-25T10:25:37.042407 net:rtnetlink.sh
2025-03-25T10:25:37.061646 net:run_afpackettests
2025-03-25T10:25:37.080942 net:tls
2025-03-25T10:25:37.100258 net:udpgro.sh
2025-03-25T10:25:37.120160 net:xfrm_policy.sh
2025-03-25T10:25:37.140519 netfilter:bridge_brouter.sh
2025-03-25T10:25:37.159368 netfilter:conntrack_icmp_related.sh
2025-03-25T10:25:37.177793 netfilter:nft_flowtable.sh
2025-03-25T10:25:37.196451 netfilter:nft_nat.sh
2025-03-25T10:25:37.215156 netfilter:nft_trans_stress.sh
2025-03-25T10:25:37.233375 pidfd:pidfd_wait
2025-03-25T10:25:37.253910 proc:proc-pid-vm
2025-03-25T10:25:37.272585 ptrace:vmaccess
2025-03-25T10:25:37.291877 rseq:run_param_test.sh
2025-03-25T10:25:37.311467 sync:sync_test
2025-03-25T10:25:37.330986 vm:run_vmtests
2025-03-25T10:25:37.351390 zram:zram.sh
2025-03-25T10:25:37.371132 ========================================
2025-03-25T10:25:37.408814 clone3:clone3
2025-03-25T10:25:37.409090 clone3:clone3_clear_sighand
2025-03-25T10:25:37.409174 clone3:clone3_set_tid
2025-03-25T10:25:37.409248 clone3:clone3_cap_checkpoint_restore
2025-03-25T10:25:37.419354 ============== Tests to run ===============
2025-03-25T10:25:37.423507 clone3:clone3
2025-03-25T10:25:37.423587 clone3:clone3_clear_sighand
2025-03-25T10:25:37.423662 clone3:clone3_set_tid
2025-03-25T10:25:37.423747 clone3:clone3_cap_checkpoint_restore
2025-03-25T10:25:37.424816 ===========End Tests to run ===============
2025-03-25T10:25:37.431993 shardfile-clone3 pass
2025-03-25T10:25:37.578434 <12>[ 22.329029] kselftest: Running tests in clone3
2025-03-25T10:25:37.594340 TAP version 13
2025-03-25T10:25:37.607308 1..4
2025-03-25T10:25:37.637234 # timeout set to 45
2025-03-25T10:25:37.637314 # selftests: clone3: clone3
2025-03-25T10:25:37.857272 # TAP version 13
2025-03-25T10:25:37.857359 # 1..19
2025-03-25T10:25:37.857794 # # clone3() syscall supported
2025-03-25T10:25:37.858450 # # Running test 'simple clone3()'
2025-03-25T10:25:37.859526 # # [349] Trying clone3() with flags 0 (size 0)
2025-03-25T10:25:37.860449 # # I am the parent (349). My child's pid is 350
2025-03-25T10:25:37.861075 # # I am the child, my PID is 350
2025-03-25T10:25:37.862403 # # [349] clone3() with flags says: 0 expected 0
2025-03-25T10:25:37.862849 # ok 1 simple clone3()
2025-03-25T10:25:37.863758 # # Running test 'clone3() in a new PID_NS'
2025-03-25T10:25:37.864812 # # [349] Trying clone3() with flags 0x20000000 (size 0)
2025-03-25T10:25:37.865863 # # I am the parent (349). My child's pid is 351
2025-03-25T10:25:37.866659 # # I am the child, my PID is 1
2025-03-25T10:25:37.867587 # # [349] clone3() with flags says: 0 expected 0
2025-03-25T10:25:37.868308 # ok 2 clone3() in a new PID_NS
2025-03-25T10:25:37.869040 # # Running test 'CLONE_ARGS_SIZE_VER0'
2025-03-25T10:25:37.870290 # # [349] Trying clone3() with flags 0 (size 64)
2025-03-25T10:25:37.871193 # # I am the parent (349). My child's pid is 352
2025-03-25T10:25:37.871920 # # I am the child, my PID is 352
2025-03-25T10:25:37.872983 # # [349] clone3() with flags says: 0 expected 0
2025-03-25T10:25:37.873537 # ok 3 CLONE_ARGS_SIZE_VER0
2025-03-25T10:25:37.874518 # # Running test 'CLONE_ARGS_SIZE_VER0 - 8'
2025-03-25T10:25:37.875513 # # [349] Trying clone3() with flags 0 (size 56)
2025-03-25T10:25:37.876784 # # Invalid argument - Failed to create new process
2025-03-25T10:25:37.877872 # # [349] clone3() with flags says: -22 expected -22
2025-03-25T10:25:37.878614 # ok 4 CLONE_ARGS_SIZE_VER0 - 8
2025-03-25T10:25:37.879552 # # Running test 'sizeof(struct clone_args) + 8'
2025-03-25T10:25:37.880649 # # [349] Trying clone3() with flags 0 (size 96)
2025-03-25T10:25:37.881739 # # I am the parent (349). My child's pid is 353
2025-03-25T10:25:37.882496 # # I am the child, my PID is 353
2025-03-25T10:25:37.883425 # # [349] clone3() with flags says: 0 expected 0
2025-03-25T10:25:37.884189 # ok 5 sizeof(struct clone_args) + 8
2025-03-25T10:25:37.885622 # # Running test 'exit_signal with highest 32 bits non-zero'
2025-03-25T10:25:37.886567 # # [349] Trying clone3() with flags 0 (size 0)
2025-03-25T10:25:37.887856 # # Invalid argument - Failed to create new process
2025-03-25T10:25:37.888951 # # [349] clone3() with flags says: -22 expected -22
2025-03-25T10:25:37.890061 # ok 6 exit_signal with highest 32 bits non-zero
2025-03-25T10:25:37.890989 # # Running test 'negative 32-bit exit_signal'
2025-03-25T10:25:37.892106 # # [349] Trying clone3() with flags 0 (size 0)
2025-03-25T10:25:37.893217 # # Invalid argument - Failed to create new process
2025-03-25T10:25:37.894449 # # [349] clone3() with flags says: -22 expected -22
2025-03-25T10:25:37.895216 # ok 7 negative 32-bit exit_signal
2025-03-25T10:25:37.896471 # # Running test 'exit_signal not fitting into CSIGNAL mask'
2025-03-25T10:25:37.897549 # # [349] Trying clone3() with flags 0 (size 0)
2025-03-25T10:25:37.898669 # # Invalid argument - Failed to create new process
2025-03-25T10:25:37.899929 # # [349] clone3() with flags says: -22 expected -22
2025-03-25T10:25:37.900882 # ok 8 exit_signal not fitting into CSIGNAL mask
2025-03-25T10:25:37.901947 # # Running test 'NSIG < exit_signal < CSIG'
2025-03-25T10:25:37.903025 # # [349] Trying clone3() with flags 0 (size 0)
2025-03-25T10:25:37.904109 # # Invalid argument - Failed to create new process
2025-03-25T10:25:37.905191 # # [349] clone3() with flags says: -22 expected -22
2025-03-25T10:25:37.905944 # ok 9 NSIG < exit_signal < CSIG
2025-03-25T10:25:37.907215 # # Running test 'Arguments sizeof(struct clone_args) + 8'
2025-03-25T10:25:37.908305 # # [349] Trying clone3() with flags 0 (size 96)
2025-03-25T10:25:37.909401 # # I am the parent (349). My child's pid is 354
2025-03-25T10:25:37.910117 # # I am the child, my PID is 354
2025-03-25T10:25:37.911204 # # [349] clone3() with flags says: 0 expected 0
2025-03-25T10:25:37.912151 # ok 10 Arguments sizeof(struct clone_args) + 8
2025-03-25T10:25:37.913578 # # Running test 'Arguments sizeof(struct clone_args) + 16'
2025-03-25T10:25:37.914741 # # [349] Trying clone3() with flags 0 (size 104)
2025-03-25T10:25:37.915964 # # Argument list too long - Failed to create new process
2025-03-25T10:25:37.917050 # # [349] clone3() with flags says: -7 expected -7
2025-03-25T10:25:37.918189 # ok 11 Arguments sizeof(struct clone_args) + 16
2025-03-25T10:25:37.919308 # # Running test 'Arguments sizeof(struct clone_arg) * 2'
2025-03-25T10:25:37.920442 # # [349] Trying clone3() with flags 0 (size 104)
2025-03-25T10:25:37.921527 # # Argument list too long - Failed to create new process
2025-03-25T10:25:37.922804 # # [349] clone3() with flags says: -7 expected -7
2025-03-25T10:25:37.923720 # ok 12 Arguments sizeof(struct clone_arg) * 2
2025-03-25T10:25:37.924635 # # Running test 'Arguments > page size'
2025-03-25T10:25:37.925715 # # [349] Trying clone3() with flags 0 (size 4104)
2025-03-25T10:25:37.926967 # # Argument list too long - Failed to create new process
2025-03-25T10:25:37.928171 # # [349] clone3() with flags says: -7 expected -7
2025-03-25T10:25:37.928831 # ok 13 Arguments > page size
2025-03-25T10:25:37.930120 # # Running test 'CLONE_ARGS_SIZE_VER0 in a new PID NS'
2025-03-25T10:25:37.931390 # # [349] Trying clone3() with flags 0x20000000 (size 64)
2025-03-25T10:25:37.932323 # # I am the parent (349). My child's pid is 355
2025-03-25T10:25:37.933069 # # I am the child, my PID is 1
2025-03-25T10:25:37.934174 # # [349] clone3() with flags says: 0 expected 0
2025-03-25T10:25:37.935151 # ok 14 CLONE_ARGS_SIZE_VER0 in a new PID NS
2025-03-25T10:25:37.936420 # # Running test 'CLONE_ARGS_SIZE_VER0 - 8 in a new PID NS'
2025-03-25T10:25:37.937703 # # [349] Trying clone3() with flags 0x20000000 (size 56)
2025-03-25T10:25:37.938794 # # Invalid argument - Failed to create new process
2025-03-25T10:25:37.940044 # # [349] clone3() with flags says: -22 expected -22
2025-03-25T10:25:37.941114 # ok 15 CLONE_ARGS_SIZE_VER0 - 8 in a new PID NS
2025-03-25T10:25:37.942534 # # Running test 'sizeof(struct clone_args) + 8 in a new PID NS'
2025-03-25T10:25:37.943780 # # [349] Trying clone3() with flags 0x20000000 (size 96)
2025-03-25T10:25:37.944893 # # I am the parent (349). My child's pid is 356
2025-03-25T10:25:37.945470 # # I am the child, my PID is 1
2025-03-25T10:25:37.946604 # # [349] clone3() with flags says: 0 expected 0
2025-03-25T10:25:37.947712 # ok 16 sizeof(struct clone_args) + 8 in a new PID NS
2025-03-25T10:25:37.948989 # # Running test 'Arguments > page size in a new PID NS'
2025-03-25T10:25:37.950246 # # [349] Trying clone3() with flags 0x20000000 (size 4104)
2025-03-25T10:25:37.951486 # # Argument list too long - Failed to create new process
2025-03-25T10:25:37.952748 # # [349] clone3() with flags says: -7 expected -7
2025-03-25T10:25:37.953671 # ok 17 Arguments > page size in a new PID NS
2025-03-25T10:25:37.954427 # # Running test 'New time NS'
2025-03-25T10:25:37.955517 # # [349] Trying clone3() with flags 0x80 (size 0)
2025-03-25T10:25:37.956094 # # I am the child, my PID is 357
2025-03-25T10:25:37.957177 # # I am the parent (349). My child's pid is 357
2025-03-25T10:25:37.958452 # # [349] clone3() with flags says: 0 expected 0
2025-03-25T10:25:37.958863 # ok 18 New time NS
2025-03-25T10:25:37.959786 # # Running test 'exit signal (SIGCHLD) in flags'
2025-03-25T10:25:37.960876 # # [349] Trying clone3() with flags 0x11 (size 0)
2025-03-25T10:25:37.962118 # # Invalid argument - Failed to create new process
2025-03-25T10:25:37.963236 # # [349] clone3() with flags says: -22 expected -22
2025-03-25T10:25:37.964153 # ok 19 exit signal (SIGCHLD) in flags
2025-03-25T10:25:37.965406 # # Totals: pass:19 fail:0 xfail:0 xpass:0 skip:0 error:0
2025-03-25T10:25:37.972739 ok 1 selftests: clone3: clone3
2025-03-25T10:25:38.003815 # timeout set to 45
2025-03-25T10:25:38.003898 # selftests: clone3: clone3_clear_sighand
2025-03-25T10:25:38.135269 # TAP version 13
2025-03-25T10:25:38.135348 # 1..1
2025-03-25T10:25:38.135774 # # clone3() syscall supported
2025-03-25T10:25:38.136715 # ok 1 Cleared signal handlers for child process
2025-03-25T10:25:38.137777 # # Totals: pass:1 fail:0 xfail:0 xpass:0 skip:0 error:0
2025-03-25T10:25:38.145907 ok 2 selftests: clone3: clone3_clear_sighand
2025-03-25T10:25:38.178551 # timeout set to 45
2025-03-25T10:25:38.178629 # selftests: clone3: clone3_set_tid
2025-03-25T10:25:38.319203 # TAP version 13
2025-03-25T10:25:38.319468 # 1..29
2025-03-25T10:25:38.319895 # # clone3() syscall supported
2025-03-25T10:25:38.320457 # # /proc/sys/kernel/pid_max 4194304
2025-03-25T10:25:38.321706 # # [394] Trying clone3() with CLONE_SET_TID to 0 and 0x0
2025-03-25T10:25:38.322708 # # Invalid argument - Failed to create new process
2025-03-25T10:25:38.324150 # # [394] clone3() with CLONE_SET_TID 0 says: -22 - expected -22
2025-03-25T10:25:38.325238 # ok 1 invalid size, 0 TID with 33 TIDs and flags 0x0
2025-03-25T10:25:38.326459 # # [394] Trying clone3() with CLONE_SET_TID to 0 and 0x0
2025-03-25T10:25:38.327577 # # Invalid argument - Failed to create new process
2025-03-25T10:25:38.328828 # # [394] clone3() with CLONE_SET_TID 0 says: -22 - expected -22
2025-03-25T10:25:38.329893 # ok 2 invalid size, 0 TID with 64 TIDs and flags 0x0
2025-03-25T10:25:38.331308 # # [394] Trying clone3() with CLONE_SET_TID to 0 and 0x0
2025-03-25T10:25:38.332409 # # Invalid argument - Failed to create new process
2025-03-25T10:25:38.333711 # # [394] clone3() with CLONE_SET_TID 0 says: -22 - expected -22
2025-03-25T10:25:38.334824 # ok 3 invalid size, 0 TID with 65 TIDs and flags 0x0
2025-03-25T10:25:38.335918 # # [394] Trying clone3() with CLONE_SET_TID to 0 and 0x0
2025-03-25T10:25:38.336987 # # Invalid argument - Failed to create new process
2025-03-25T10:25:38.338387 # # [394] clone3() with CLONE_SET_TID 0 says: -22 - expected -22
2025-03-25T10:25:38.339673 # ok 4 invalid size, 0 TID with 1344 TIDs and flags 0x0
2025-03-25T10:25:38.340787 # # [394] Trying clone3() with CLONE_SET_TID to 0 and 0x0
2025-03-25T10:25:38.341717 # # Invalid argument - Failed to create new process
2025-03-25T10:25:38.343081 # # [394] clone3() with CLONE_SET_TID 0 says: -22 - expected -22
2025-03-25T10:25:38.344223 # ok 5 invalid size, 0 TID with 31 TIDs and flags 0x0
2025-03-25T10:25:38.345307 # # [394] Trying clone3() with CLONE_SET_TID to -1 and 0x0
2025-03-25T10:25:38.346548 # # Invalid argument - Failed to create new process
2025-03-25T10:25:38.347828 # # [394] clone3() with CLONE_SET_TID -1 says: -22 - expected -22
2025-03-25T10:25:38.349080 # ok 6 invalid size, TID all 1s with 33 TIDs and flags 0x0
2025-03-25T10:25:38.350298 # # [394] Trying clone3() with CLONE_SET_TID to -1 and 0x0
2025-03-25T10:25:38.351362 # # Invalid argument - Failed to create new process
2025-03-25T10:25:38.352783 # # [394] clone3() with CLONE_SET_TID -1 says: -22 - expected -22
2025-03-25T10:25:38.353920 # ok 7 invalid size, TID all 1s with 64 TIDs and flags 0x0
2025-03-25T10:25:38.355167 # # [394] Trying clone3() with CLONE_SET_TID to -1 and 0x0
2025-03-25T10:25:38.356247 # # Invalid argument - Failed to create new process
2025-03-25T10:25:38.357681 # # [394] clone3() with CLONE_SET_TID -1 says: -22 - expected -22
2025-03-25T10:25:38.358911 # ok 8 invalid size, TID all 1s with 65 TIDs and flags 0x0
2025-03-25T10:25:38.360152 # # [394] Trying clone3() with CLONE_SET_TID to -1 and 0x0
2025-03-25T10:25:38.361076 # # Invalid argument - Failed to create new process
2025-03-25T10:25:38.362557 # # [394] clone3() with CLONE_SET_TID -1 says: -22 - expected -22
2025-03-25T10:25:38.363693 # ok 9 invalid size, TID all 1s with 1344 TIDs and flags 0x0
2025-03-25T10:25:38.364947 # # [394] Trying clone3() with CLONE_SET_TID to -1 and 0x0
2025-03-25T10:25:38.366049 # # Invalid argument - Failed to create new process
2025-03-25T10:25:38.367308 # # [394] clone3() with CLONE_SET_TID -1 says: -22 - expected -22
2025-03-25T10:25:38.368578 # ok 10 invalid size, TID all 1s with 31 TIDs and flags 0x0
2025-03-25T10:25:38.369838 # # [394] Trying clone3() with CLONE_SET_TID to 0 and 0x0
2025-03-25T10:25:38.370927 # # Invalid argument - Failed to create new process
2025-03-25T10:25:38.372180 # # [394] clone3() with CLONE_SET_TID 0 says: -22 - expected -22
2025-03-25T10:25:38.373285 # ok 11 valid size, 0 TID with 1 TIDs and flags 0x0
2025-03-25T10:25:38.374566 # # [394] Trying clone3() with CLONE_SET_TID to -1 and 0x0
2025-03-25T10:25:38.375661 # # Invalid argument - Failed to create new process
2025-03-25T10:25:38.376956 # # [394] clone3() with CLONE_SET_TID -1 says: -22 - expected -22
2025-03-25T10:25:38.378234 # ok 12 valid size, -1 TID with 1 TIDs and flags 0x0
2025-03-25T10:25:38.379352 # # [394] Trying clone3() with CLONE_SET_TID to -1 and 0x0
2025-03-25T10:25:38.380458 # # Invalid argument - Failed to create new process
2025-03-25T10:25:38.381749 # # [394] clone3() with CLONE_SET_TID -1 says: -22 - expected -22
2025-03-25T10:25:38.382845 # ok 13 2 TIDs, -1 and 0 with 2 TIDs and flags 0x0
2025-03-25T10:25:38.384265 # # [394] Trying clone3() with CLONE_SET_TID to -1 and 0x20000000
2025-03-25T10:25:38.385196 # # Invalid argument - Failed to create new process
2025-03-25T10:25:38.386624 # # [394] clone3() with CLONE_SET_TID -1 says: -22 - expected -22
2025-03-25T10:25:38.387760 # ok 14 valid size, -1 TID with 1 TIDs and flags 0x20000000
2025-03-25T10:25:38.389049 # # [394] Trying clone3() with CLONE_SET_TID to 1 and 0x0
2025-03-25T10:25:38.389953 # # File exists - Failed to create new process
2025-03-25T10:25:38.391392 # # [394] clone3() with CLONE_SET_TID 1 says: -17 - expected -17
2025-03-25T10:25:38.392345 # ok 15 duplicate PID 1 with 1 TIDs and flags 0x0
2025-03-25T10:25:38.393615 # # [394] Trying clone3() with CLONE_SET_TID to 1 and 0x20000000
2025-03-25T10:25:38.394704 # # I am the parent (394). My child's pid is 395
2025-03-25T10:25:38.395643 # # I am the child, my PID is 1 (expected 1)
2025-03-25T10:25:38.396925 # # [394] clone3() with CLONE_SET_TID 1 says: 0 - expected 0
2025-03-25T10:25:38.398180 # ok 16 duplicate PID 1 with 1 TIDs and flags 0x20000000
2025-03-25T10:25:38.399456 # # [394] Trying clone3() with CLONE_SET_TID to 4194304 and 0x0
2025-03-25T10:25:38.400376 # # Invalid argument - Failed to create new process
2025-03-25T10:25:38.401947 # # [394] clone3() with CLONE_SET_TID 4194304 says: -22 - expected -22
2025-03-25T10:25:38.403040 # ok 17 set TID to maximum with 1 TIDs and flags 0x0
2025-03-25T10:25:38.404475 # # [394] Trying clone3() with CLONE_SET_TID to 4194304 and 0x20000000
2025-03-25T10:25:38.405571 # # Invalid argument - Failed to create new process
2025-03-25T10:25:38.407090 # # [394] clone3() with CLONE_SET_TID 4194304 says: -22 - expected -22
2025-03-25T10:25:38.408352 # ok 18 set TID to maximum with 1 TIDs and flags 0x20000000
2025-03-25T10:25:38.408752 # # Child has PID 396
2025-03-25T10:25:38.409829 # # [394] Trying clone3() with CLONE_SET_TID to 396 and 0x0
2025-03-25T10:25:38.411005 # # I am the parent (394). My child's pid is 396
2025-03-25T10:25:38.411937 # # I am the child, my PID is 396 (expected 396)
2025-03-25T10:25:38.413216 # # [394] clone3() with CLONE_SET_TID 396 says: 0 - expected 0
2025-03-25T10:25:38.414457 # ok 19 reallocate child TID with 1 TIDs and flags 0x0
2025-03-25T10:25:38.415722 # # [394] Trying clone3() with CLONE_SET_TID to 396 and 0x20000000
2025-03-25T10:25:38.416820 # # Invalid argument - Failed to create new process
2025-03-25T10:25:38.418118 # # [394] clone3() with CLONE_SET_TID 396 says: -22 - expected -22
2025-03-25T10:25:38.419394 # ok 20 duplicate child TID with 1 TIDs and flags 0x20000000
2025-03-25T10:25:38.420674 # # [394] Trying clone3() with CLONE_SET_TID to 1 and 0x20000000
2025-03-25T10:25:38.421594 # # I am the child, my PID is 1 (expected 1)
2025-03-25T10:25:38.422650 # # I am the parent (394). My child's pid is 396
2025-03-25T10:25:38.423890 # # [394] clone3() with CLONE_SET_TID 1 says: 0 - expected 0
2025-03-25T10:25:38.425134 # ok 21 create PID 1 in new NS with 2 TIDs and flags 0x20000000
2025-03-25T10:25:38.425699 # # unshare PID namespace
2025-03-25T10:25:38.427099 # # [394] Trying clone3() with CLONE_SET_TID to 396 and 0x0
2025-03-25T10:25:38.428019 # # Invalid argument - Failed to create new process
2025-03-25T10:25:38.429437 # # [394] clone3() with CLONE_SET_TID 396 says: -22 - expected -22
2025-03-25T10:25:38.430515 # ok 22 duplicate PID 1 with 1 TIDs and flags 0x0
2025-03-25T10:25:38.431761 # # [1] Trying clone3() with CLONE_SET_TID to 43 and 0x0
2025-03-25T10:25:38.432699 # # Invalid argument - Failed to create new process
2025-03-25T10:25:38.433962 # # [1] clone3() with CLONE_SET_TID 43 says: -22 - expected -22
2025-03-25T10:25:38.435663 # ok 23 check leak on invalid TID -1 with 2 TIDs and flags 0x0
2025-03-25T10:25:38.436768 # # [1] Trying clone3() with CLONE_SET_TID to 43 and 0x0
2025-03-25T10:25:38.437680 # # I am the parent (1). My child's pid is 43
2025-03-25T10:25:38.438583 # # I am the child, my PID is 43 (expected 43)
2025-03-25T10:25:38.439833 # # [1] clone3() with CLONE_SET_TID 43 says: 0 - expected 0
2025-03-25T10:25:38.441242 # ok 24 check leak on invalid specific TID with 2 TIDs and flags 0x0
2025-03-25T10:25:38.442118 # # Child in PID namespace has PID 1
2025-03-25T10:25:38.443180 # # [1] Trying clone3() with CLONE_SET_TID to 2 and 0x0
2025-03-25T10:25:38.444076 # # I am the parent (1). My child's pid is 2
2025-03-25T10:25:38.444973 # # I am the child, my PID is 2 (expected 2)
2025-03-25T10:25:38.446213 # # [1] clone3() with CLONE_SET_TID 2 says: 0 - expected 0
2025-03-25T10:25:38.447444 # ok 25 create PID 2 in child NS with 1 TIDs and flags 0x0
2025-03-25T10:25:38.448701 # # [1] Trying clone3() with CLONE_SET_TID to 1 and 0x20000000
2025-03-25T10:25:38.449610 # # Invalid argument - Failed to create new process
2025-03-25T10:25:38.451057 # # [1] clone3() with CLONE_SET_TID 1 says: -22 - expected -22
2025-03-25T10:25:38.452668 # ok 26 fail due to invalid TID at level 1 with 3 TIDs and flags 0x20000000
2025-03-25T10:25:38.453801 # # [1] Trying clone3() with CLONE_SET_TID to 1 and 0x20000000
2025-03-25T10:25:38.455064 # # Invalid argument - Failed to create new process
2025-03-25T10:25:38.456296 # # [1] clone3() with CLONE_SET_TID 1 says: -22 - expected -22
2025-03-25T10:25:38.457698 # ok 27 fail due to too few active PID NSs with 4 TIDs and flags 0x20000000
2025-03-25T10:25:38.458969 # # [1] Trying clone3() with CLONE_SET_TID to 1 and 0x20000000
2025-03-25T10:25:38.460045 # # I am the parent (1). My child's pid is 42
2025-03-25T10:25:38.460952 # # I am the child, my PID is 1 (expected 1)
2025-03-25T10:25:38.461512 # # [1] Child is ready and waiting
2025-03-25T10:25:38.462410 # # [394] Child is ready and waiting
2025-03-25T10:25:38.463663 # # [1] clone3() with CLONE_SET_TID 1 says: 0 - expected 0
2025-03-25T10:25:38.464945 # ok 28 verify that we have 3 PID NSs with 3 TIDs and flags 0x20000000
2025-03-25T10:25:38.465514 # # Expecting PIDs 396, 42, 1
2025-03-25T10:25:38.466422 # # Have PIDs in namespaces: 396, 42, 1
2025-03-25T10:25:38.467320 # ok 29 PIDs in all namespaces as expected
2025-03-25T10:25:38.468383 # # Totals: pass:29 fail:0 xfail:0 xpass:0 skip:0 error:0
2025-03-25T10:25:38.475571 ok 3 selftests: clone3: clone3_set_tid
2025-03-25T10:25:38.507141 # timeout set to 45
2025-03-25T10:25:38.507219 # selftests: clone3: clone3_cap_checkpoint_restore
2025-03-25T10:25:38.649728 # TAP version 13
2025-03-25T10:25:38.649815 # 1..1
2025-03-25T10:25:38.650470 # # Starting 1 tests from 1 test cases.
2025-03-25T10:25:38.651575 # # RUN global.clone3_cap_checkpoint_restore ...
2025-03-25T10:25:38.652315 # # clone3() syscall supported
2025-03-25T10:25:38.654347 # # clone3_cap_checkpoint_restore.c:151:clone3_cap_checkpoint_restore:Child has PID 418
2025-03-25T10:25:38.654773 # cap_set_proc: Operation not permitted
2025-03-25T10:25:38.657064 # # clone3_cap_checkpoint_restore.c:160:clone3_cap_checkpoint_restore:Expected set_capability() (-1) == 0 (0)
2025-03-25T10:25:38.659304 # # clone3_cap_checkpoint_restore.c:161:clone3_cap_checkpoint_restore:Could not set CAP_CHECKPOINT_RESTORE
2025-03-25T10:25:38.660594 # # clone3_cap_checkpoint_restore: Test terminated by assertion
2025-03-25T10:25:38.661674 # # FAIL global.clone3_cap_checkpoint_restore
2025-03-25T10:25:38.662741 # not ok 1 global.clone3_cap_checkpoint_restore
2025-03-25T10:25:38.663304 # # FAILED: 0 / 1 tests passed.
2025-03-25T10:25:38.664386 # # Totals: pass:0 fail:1 xfail:0 xpass:0 skip:0 error:0
2025-03-25T10:25:38.673925 not ok 4 selftests: clone3: clone3_cap_checkpoint_restore # exit=1
2025-03-25T10:25:39.566695
2025-03-25T10:25:39.567058 WARNING: Optional imports not found, TAP 13 output will be
2025-03-25T10:25:39.567130 ignored. To parse yaml, see requirements in docs:
2025-03-25T10:25:39.567235 https://tappy.readthedocs.io/en/latest/consumers.html#tap-version-13
2025-03-25T10:25:39.573731 Traceback (most recent call last):
2025-03-25T10:25:39.585307 File [35m"/lava-1/0/tests/0_kselftest-clone3/automated/linux/kselftest/./parse-output.py"[0m, line [35m93[0m, in [35m<module>[0m
2025-03-25T10:25:39.585382 results = parse_nested_tap(sys.stdin.read())
2025-03-25T10:25:39.585870 File [35m"/lava-1/0/tests/0_kselftest-clone3/automated/linux/kselftest/./parse-output.py"[0m, line [35m51[0m, in [35mparse_nested_tap[0m
2025-03-25T10:25:39.585933 "children": [31mparse_nested_tap[0m[1;31m(output)[0m,
2025-03-25T10:25:39.586187 [31m~~~~~~~~~~~~~~~~[0m[1;31m^^^^^^^^[0m
2025-03-25T10:25:39.586801 File [35m"/lava-1/0/tests/0_kselftest-clone3/automated/linux/kselftest/./parse-output.py"[0m, line [35m59[0m, in [35mparse_nested_tap[0m
2025-03-25T10:25:39.586871 [31mr[0m[1;31m["logs"][0m += f"{uncomment(l.text)}\n"
2025-03-25T10:25:39.586942 [31m~[0m[1;31m^^^^^^^^[0m
2025-03-25T10:25:39.587199 [1;35mKeyError[0m: [35m'logs'[0m
2025-03-25T10:25:39.654201 + ../../utils/send-to-lava.sh ./output/result.txt
2025-03-25T10:25:39.684626 WARNING: no log file found for breakpoints:breakpoint_test_arm64 at ./output/breakpoints:breakpoint_test_arm64.log
2025-03-25T10:25:39.699700 <8>[ 24.450435] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=breakpoints:breakpoint_test_arm64 RESULT=skip>
2025-03-25T10:25:39.712228 WARNING: no log file found for breakpoints:step_after_suspend_test at ./output/breakpoints:step_after_suspend_test.log
2025-03-25T10:25:39.726184 <8>[ 24.476638] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=breakpoints:step_after_suspend_test RESULT=skip>
2025-03-25T10:25:39.737888 WARNING: no log file found for kvm:get-reg-list at ./output/kvm:get-reg-list.log
2025-03-25T10:25:39.751708 <8>[ 24.502462] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=kvm:get-reg-list RESULT=skip>
2025-03-25T10:25:39.764145 WARNING: no log file found for kvm:kvm_create_max_vcpus at ./output/kvm:kvm_create_max_vcpus.log
2025-03-25T10:25:39.778313 <8>[ 24.528863] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=kvm:kvm_create_max_vcpus RESULT=skip>
2025-03-25T10:25:39.789720 WARNING: no log file found for mqueue:mq_open_tests at ./output/mqueue:mq_open_tests.log
2025-03-25T10:25:39.803272 <8>[ 24.554060] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=mqueue:mq_open_tests RESULT=skip>
2025-03-25T10:25:39.814850 WARNING: no log file found for mqueue:mq_perf_tests at ./output/mqueue:mq_perf_tests.log
2025-03-25T10:25:39.828164 <8>[ 24.579010] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=mqueue:mq_perf_tests RESULT=skip>
2025-03-25T10:25:39.838957 WARNING: no log file found for net:fib_nexthops.sh at ./output/net:fib_nexthops.sh.log
2025-03-25T10:25:39.852563 <8>[ 24.603375] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=net:fib_nexthops.sh RESULT=skip>
2025-03-25T10:25:39.863505 WARNING: no log file found for net:msg_zerocopy.sh at ./output/net:msg_zerocopy.sh.log
2025-03-25T10:25:39.877393 <8>[ 24.628173] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=net:msg_zerocopy.sh RESULT=skip>
2025-03-25T10:25:39.888492 WARNING: no log file found for net:rtnetlink.sh at ./output/net:rtnetlink.sh.log
2025-03-25T10:25:39.902074 <8>[ 24.652676] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=net:rtnetlink.sh RESULT=skip>
2025-03-25T10:25:39.913121 WARNING: no log file found for net:run_afpackettests at ./output/net:run_afpackettests.log
2025-03-25T10:25:39.926668 <8>[ 24.677468] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=net:run_afpackettests RESULT=skip>
2025-03-25T10:25:39.937525 WARNING: no log file found for net:tls at ./output/net:tls.log
2025-03-25T10:25:39.951069 <8>[ 24.701909] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=net:tls RESULT=skip>
2025-03-25T10:25:39.963506 WARNING: no log file found for net:udpgro.sh at ./output/net:udpgro.sh.log
2025-03-25T10:25:39.977601 <8>[ 24.728182] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=net:udpgro.sh RESULT=skip>
2025-03-25T10:25:39.988490 WARNING: no log file found for net:xfrm_policy.sh at ./output/net:xfrm_policy.sh.log
2025-03-25T10:25:40.003005 <8>[ 24.753789] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=net:xfrm_policy.sh RESULT=skip>
2025-03-25T10:25:40.014477 WARNING: no log file found for pidfd:pidfd_wait at ./output/pidfd:pidfd_wait.log
2025-03-25T10:25:40.028363 <8>[ 24.779155] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=pidfd:pidfd_wait RESULT=skip>
2025-03-25T10:25:40.039878 WARNING: no log file found for proc:proc-pid-vm at ./output/proc:proc-pid-vm.log
2025-03-25T10:25:40.053526 <8>[ 24.804325] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=proc:proc-pid-vm RESULT=skip>
2025-03-25T10:25:40.064203 WARNING: no log file found for ptrace:vmaccess at ./output/ptrace:vmaccess.log
2025-03-25T10:25:40.078593 <8>[ 24.828917] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=ptrace:vmaccess RESULT=skip>
2025-03-25T10:25:40.089453 WARNING: no log file found for rseq:run_param_test.sh at ./output/rseq:run_param_test.sh.log
2025-03-25T10:25:40.103238 <8>[ 24.853999] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=rseq:run_param_test.sh RESULT=skip>
2025-03-25T10:25:40.115942 WARNING: no log file found for sync:sync_test at ./output/sync:sync_test.log
2025-03-25T10:25:40.129884 <8>[ 24.880692] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=sync:sync_test RESULT=skip>
2025-03-25T10:25:40.142000 WARNING: no log file found for zram:zram.sh at ./output/zram:zram.sh.log
2025-03-25T10:25:40.156140 <8>[ 24.906954] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=zram:zram.sh RESULT=skip>
2025-03-25T10:25:40.167762 WARNING: no log file found for shardfile-clone3 at ./output/shardfile-clone3.log
2025-03-25T10:25:40.180841 <8>[ 24.931639] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=shardfile-clone3 RESULT=pass>
2025-03-25T10:25:40.298343 + set +x
2025-03-25T10:25:40.298844 <8>[ 25.049708] <LAVA_SIGNAL_ENDRUN 0_kselftest-clone3 1_1.1.3.1>
2025-03-25T10:25:40.301566 <LAVA_TEST_RUNNER EXIT>
2025-03-25T10:25:41.405237 [?2004hroot@runner-ykxhnyexq-project-40964107-concurrent-0:~# poweroff