2025-04-16T07:42:01.165925 [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x000f0510]
2025-04-16T07:42:01.166391 [ 0.000000] Linux version 6.14.0 (tuxmake@tuxmake) (Debian clang version 21.0.0 (++20250401110258+749535ba2808-1~exp1~20250401230337.1361), Debian LLD 21.0.0) #1 SMP PREEMPT @1743678930
2025-04-16T07:42:01.166503 [ 0.000000] KASLR enabled
2025-04-16T07:42:01.166594 [ 0.000000] random: crng init done
2025-04-16T07:42:01.166668 [ 0.000000] Machine model: linux,dummy-virt
2025-04-16T07:42:01.166739 [ 0.000000] efi: UEFI not found.
2025-04-16T07:42:01.166908 [ 0.000000] earlycon: pl11 at MMIO 0x0000000009000000 (options '')
2025-04-16T07:42:01.167048 [ 0.000000] printk: legacy bootconsole [pl11] enabled
2025-04-16T07:42:01.168416 [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT
2025-04-16T07:42:01.171126 [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000013fffffff]
2025-04-16T07:42:01.171897 [ 0.000000] NODE_DATA(0) allocated [mem 0x13f5fc000-0x13f5fe77f]
2025-04-16T07:42:01.174376 [ 0.000000] Zone ranges:
2025-04-16T07:42:01.174782 [ 0.000000] DMA [mem 0x0000000040000000-0x00000000ffffffff]
2025-04-16T07:42:01.174888 [ 0.000000] DMA32 empty
2025-04-16T07:42:01.175067 [ 0.000000] Normal [mem 0x0000000100000000-0x000000013fffffff]
2025-04-16T07:42:01.175191 [ 0.000000] Movable zone start for each node
2025-04-16T07:42:01.175312 [ 0.000000] Early memory node ranges
2025-04-16T07:42:01.175496 [ 0.000000] node 0: [mem 0x0000000040000000-0x000000013fffffff]
2025-04-16T07:42:01.176003 [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000013fffffff]
2025-04-16T07:42:01.201972 [ 0.000000] cma: Reserved 32 MiB at 0x0000000000000000
2025-04-16T07:42:01.202887 [ 0.000000] psci: probing for conduit method from DT.
2025-04-16T07:42:01.203154 [ 0.000000] psci: PSCIv1.1 detected in firmware.
2025-04-16T07:42:01.203281 [ 0.000000] psci: Using standard PSCI v0.2 function IDs
2025-04-16T07:42:01.203478 [ 0.000000] psci: Trusted OS migration not required
2025-04-16T07:42:01.203607 [ 0.000000] psci: SMC Calling Convention v1.0
2025-04-16T07:42:01.205928 [ 0.000000] percpu: Embedded 34 pages/cpu s101464 r8192 d29608 u139264
2025-04-16T07:42:01.206359 [ 0.000000] pcpu-alloc: s101464 r8192 d29608 u139264 alloc=34*4096
2025-04-16T07:42:01.206624 [ 0.000000] pcpu-alloc: [0] 0 [0] 1
2025-04-16T07:42:01.207741 [ 0.000000] Detected PIPT I-cache on CPU0
2025-04-16T07:42:01.209136 [ 0.000000] CPU features: detected: Branch Target Identification
2025-04-16T07:42:01.209333 [ 0.000000] CPU features: detected: Address authentication (IMP DEF algorithm)
2025-04-16T07:42:01.209556 [ 0.000000] CPU features: detected: GIC system register CPU interface
2025-04-16T07:42:01.209731 [ 0.000000] CPU features: detected: HCRX_EL2 register
2025-04-16T07:42:01.209941 [ 0.000000] CPU features: detected: 52-bit Virtual Addressing (LPA2)
2025-04-16T07:42:01.210114 [ 0.000000] CPU features: detected: Virtualization Host Extensions
2025-04-16T07:42:01.210307 [ 0.000000] CPU features: detected: Memory Tagging Extension
2025-04-16T07:42:01.210475 [ 0.000000] CPU features: detected: Asymmetric MTE Tag Check Fault
2025-04-16T07:42:01.210722 [ 0.000000] CPU features: detected: Spectre-v4
2025-04-16T07:42:01.213898 [ 0.000000] alternatives: applying boot alternatives
2025-04-16T07:42:01.216919 [ 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-04-16T07:42:01.218950 <5>[ 0.000000] Unknown kernel command line parameters "verbose", will be passed to user space.
2025-04-16T07:42:01.220886 <6>[ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes
2025-04-16T07:42:01.223100 <6>[ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
2025-04-16T07:42:01.224280 <6>[ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
2025-04-16T07:42:01.224562 <6>[ 0.000000] software IO TLB: area num 2.
2025-04-16T07:42:01.275353 <6>[ 0.000000] software IO TLB: mapped [mem 0x00000000fa000000-0x00000000fe000000] (64MB)
2025-04-16T07:42:01.276715 <6>[ 0.000000] Fallback order for Node 0: 0
2025-04-16T07:42:01.276814 <6>[ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1048576
2025-04-16T07:42:01.276912 <6>[ 0.000000] Policy zone: Normal
2025-04-16T07:42:01.277673 <6>[ 0.000000] mem auto-init: stack:all(zero), heap alloc:off, heap free:off
2025-04-16T07:42:01.301095 <6>[ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
2025-04-16T07:42:01.642401 <6>[ 0.000000] ftrace: allocating 71913 entries in 282 pages
2025-04-16T07:42:01.642486 <6>[ 0.000000] ftrace: allocated 282 pages with 4 groups
2025-04-16T07:42:01.649871 <6>[ 0.000000] rcu: Preemptible hierarchical RCU implementation.
2025-04-16T07:42:01.650013 <6>[ 0.000000] rcu: RCU event tracing is enabled.
2025-04-16T07:42:01.650096 <6>[ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2.
2025-04-16T07:42:01.650295 <6>[ 0.000000] Trampoline variant of Tasks RCU enabled.
2025-04-16T07:42:01.650426 <6>[ 0.000000] Rude variant of Tasks RCU enabled.
2025-04-16T07:42:01.650560 <6>[ 0.000000] Tracing variant of Tasks RCU enabled.
2025-04-16T07:42:01.650852 <6>[ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
2025-04-16T07:42:01.651068 <6>[ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
2025-04-16T07:42:01.652370 <6>[ 0.000000] RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.
2025-04-16T07:42:01.652639 <6>[ 0.000000] RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.
2025-04-16T07:42:01.652874 <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-04-16T07:42:01.678409 <6>[ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
2025-04-16T07:42:01.683956 <6>[ 0.000000] GICv3: GIC: Using split EOI/Deactivate mode
2025-04-16T07:42:01.684125 <6>[ 0.000000] GICv3: 256 SPIs implemented
2025-04-16T07:42:01.684261 <6>[ 0.000000] GICv3: 0 Extended SPIs implemented
2025-04-16T07:42:01.685820 <6>[ 0.000000] Root IRQ handler: gic_handle_irq
2025-04-16T07:42:01.685918 <6>[ 0.000000] GICv3: GICv3 features: 16 PPIs
2025-04-16T07:42:01.686074 <6>[ 0.000000] GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0
2025-04-16T07:42:01.686720 <6>[ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000
2025-04-16T07:42:01.691492 <6>[ 0.000000] ITS [mem 0x08080000-0x0809ffff]
2025-04-16T07:42:01.692258 <6>[ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @100210000 (indirect, esz 8, psz 64K, shr 1)
2025-04-16T07:42:01.692562 <6>[ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @100220000 (flat, esz 8, psz 64K, shr 1)
2025-04-16T07:42:01.693268 <6>[ 0.000000] GICv3: using LPI property table @0x0000000100230000
2025-04-16T07:42:01.694027 <6>[ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000100240000
2025-04-16T07:42:01.695935 <6>[ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.
2025-04-16T07:42:01.702689 <6>[ 0.000000] arch_timer: cp15 timer(s) running at 1000.00MHz (phys).
2025-04-16T07:42:01.703095 <6>[ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
2025-04-16T07:42:01.703653 <6>[ 0.000043] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns
2025-04-16T07:42:01.707021 <6>[ 0.003196] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)
2025-04-16T07:42:01.720858 <6>[ 0.015537] Console: colour dummy device 80x25
2025-04-16T07:42:01.724567 <6>[ 0.020381] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)
2025-04-16T07:42:01.724878 <6>[ 0.021340] pid_max: default: 32768 minimum: 301
2025-04-16T07:42:01.727303 <6>[ 0.023632] LSM: initializing lsm=capability
2025-04-16T07:42:01.730775 <6>[ 0.027192] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
2025-04-16T07:42:01.731079 <6>[ 0.027561] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
2025-04-16T07:42:01.761060 <4>[ 0.057461] cacheinfo: Unable to detect cache hierarchy for CPU 0
2025-04-16T07:42:01.778053 <6>[ 0.074436] rcu: Hierarchical SRCU implementation.
2025-04-16T07:42:01.778153 <6>[ 0.074643] rcu: Max phase no-delay instances is 1000.
2025-04-16T07:42:01.781047 <6>[ 0.077443] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level
2025-04-16T07:42:01.788382 <6>[ 0.084780] fsl-mc MSI: its@8080000 domain created
2025-04-16T07:42:01.791508 <6>[ 0.087933] EFI services will not be available.
2025-04-16T07:42:01.795238 <6>[ 0.091652] smp: Bringing up secondary CPUs ...
2025-04-16T07:42:01.818771 <6>[ 0.107482] Detected PIPT I-cache on CPU1
2025-04-16T07:42:01.818898 <6>[ 0.108821] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000
2025-04-16T07:42:01.819080 <6>[ 0.109487] GICv3: CPU1: using allocated LPI pending table @0x0000000100250000
2025-04-16T07:42:01.819284 <6>[ 0.111128] CPU1: Booted secondary processor 0x0000000001 [0x000f0510]
2025-04-16T07:42:01.819605 <6>[ 0.115145] smp: Brought up 1 node, 2 CPUs
2025-04-16T07:42:01.819715 <6>[ 0.116251] SMP: Total of 2 processors activated.
2025-04-16T07:42:01.819886 <6>[ 0.116454] CPU: All CPU(s) started at EL2
2025-04-16T07:42:01.820209 <6>[ 0.116724] CPU features: detected: 32-bit EL0 Support
2025-04-16T07:42:01.820417 <6>[ 0.116955] CPU features: detected: 32-bit EL1 Support
2025-04-16T07:42:01.820626 <6>[ 0.117144] CPU features: detected: ARMv8.4 Translation Table Level
2025-04-16T07:42:01.820956 <6>[ 0.117364] CPU features: detected: Instruction cache invalidation not required for I/D coherence
2025-04-16T07:42:01.821271 <6>[ 0.117691] CPU features: detected: Data cache clean to the PoU not required for I/D coherence
2025-04-16T07:42:01.821532 <6>[ 0.118019] CPU features: detected: Common not Private translations
2025-04-16T07:42:01.821728 <6>[ 0.118258] CPU features: detected: CRC32 instructions
2025-04-16T07:42:01.821965 <6>[ 0.118452] CPU features: detected: Data independent timing control (DIT)
2025-04-16T07:42:01.822314 <6>[ 0.118689] CPU features: detected: E0PD
2025-04-16T07:42:01.822364 <6>[ 0.118845] CPU features: detected: Enhanced Counter Virtualization
2025-04-16T07:42:01.822588 <6>[ 0.119062] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)
2025-04-16T07:42:01.822812 <6>[ 0.119312] CPU features: detected: Enhanced Privileged Access Never
2025-04-16T07:42:01.823020 <6>[ 0.119535] CPU features: detected: Enhanced Virtualization Traps
2025-04-16T07:42:01.823209 <6>[ 0.119744] CPU features: detected: Fine Grained Traps
2025-04-16T07:42:01.823524 <6>[ 0.119977] CPU features: detected: Generic authentication (IMP DEF algorithm)
2025-04-16T07:42:01.824080 <6>[ 0.120541] CPU features: detected: RCpc load-acquire (LDAPR)
2025-04-16T07:42:01.824337 <6>[ 0.120805] CPU features: detected: 52-bit Virtual Addressing for KVM (LPA2)
2025-04-16T07:42:01.824548 <6>[ 0.121062] CPU features: detected: LSE atomic instructions
2025-04-16T07:42:01.824804 <6>[ 0.121273] CPU features: detected: Memory Copy and Memory Set instructions
2025-04-16T07:42:01.825019 <6>[ 0.121529] CPU features: detected: Privileged Access Never
2025-04-16T07:42:01.825272 <6>[ 0.121772] CPU features: detected: PMUv3
2025-04-16T07:42:01.825416 <6>[ 0.121944] CPU features: detected: RAS Extension Support
2025-04-16T07:42:01.825622 <6>[ 0.122139] CPU features: detected: Random Number Generator
2025-04-16T07:42:01.825835 <6>[ 0.122346] CPU features: detected: Speculation barrier (SB)
2025-04-16T07:42:01.826041 <6>[ 0.122561] CPU features: detected: Stage-2 Force Write-Back
2025-04-16T07:42:01.826381 <6>[ 0.122766] CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality
2025-04-16T07:42:01.826599 <6>[ 0.123074] CPU features: detected: TLB range maintenance instructions
2025-04-16T07:42:01.826793 <6>[ 0.123325] CPU features: detected: WFx with timeout
2025-04-16T07:42:01.827114 <6>[ 0.123578] CPU features: detected: Speculative Store Bypassing Safe (SSBS)
2025-04-16T07:42:01.827334 <6>[ 0.123839] CPU features: detected: Scalable Vector Extension
2025-04-16T07:42:01.838268 <6>[ 0.132420] alternatives: applying system-wide alternatives
2025-04-16T07:42:01.848410 <6>[ 0.144416] CPU features: detected: Hardware dirty bit management on CPU0-1
2025-04-16T07:42:01.848729 <6>[ 0.145236] SVE: maximum available vector length 256 bytes per vector
2025-04-16T07:42:01.848925 <6>[ 0.145458] SVE: default vector length 64 bytes per vector
2025-04-16T07:42:01.860900 <6>[ 0.157209] Memory: 3955692K/4194304K available (22976K kernel code, 6952K rwdata, 14412K rodata, 3584K init, 801K bss, 199832K reserved, 32768K cma-reserved)
2025-04-16T07:42:01.885700 <6>[ 0.182057] devtmpfs: initialized
2025-04-16T07:42:01.926732 <6>[ 0.223056] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
2025-04-16T07:42:01.927256 <6>[ 0.223706] posixtimers hash table entries: 1024 (order: 2, 16384 bytes, linear)
2025-04-16T07:42:01.927593 <6>[ 0.224074] futex hash table entries: 512 (order: 3, 32768 bytes, linear)
2025-04-16T07:42:01.930484 <6>[ 0.226875] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL
2025-04-16T07:42:01.930817 <6>[ 0.227139] 0 pages in range for non-PLT usage
2025-04-16T07:42:01.933985 <6>[ 0.227227] 512032 pages in range for PLT usage
2025-04-16T07:42:01.934054 <6>[ 0.230408] pinctrl core: initialized pinctrl subsystem
2025-04-16T07:42:01.949182 <6>[ 0.245577] DMI not present or invalid.
2025-04-16T07:42:01.965312 <6>[ 0.261686] NET: Registered PF_NETLINK/PF_ROUTE protocol family
2025-04-16T07:42:01.977991 <6>[ 0.274314] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations
2025-04-16T07:42:01.979035 <6>[ 0.275408] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
2025-04-16T07:42:01.980886 <6>[ 0.277337] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
2025-04-16T07:42:01.981424 <6>[ 0.277843] audit: initializing netlink subsys (disabled)
2025-04-16T07:42:01.983590 <5>[ 0.279982] audit: type=2000 audit(0.256:1): state=initialized audit_enabled=0 res=1
2025-04-16T07:42:01.990109 <6>[ 0.286436] thermal_sys: Registered thermal governor 'step_wise'
2025-04-16T07:42:01.990941 <6>[ 0.286506] thermal_sys: Registered thermal governor 'power_allocator'
2025-04-16T07:42:01.991040 <6>[ 0.287353] cpuidle: using governor menu
2025-04-16T07:42:01.992948 <6>[ 0.289401] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
2025-04-16T07:42:01.993906 <6>[ 0.290326] ASID allocator initialised with 65536 entries
2025-04-16T07:42:02.008673 <6>[ 0.305079] Serial: AMBA PL011 UART driver
2025-04-16T07:42:02.215641 <6>[ 0.512017] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 15, base_baud = 0) is a PL011 rev1
2025-04-16T07:42:02.217711 <6>[ 0.513680] printk: console [ttyAMA0] enabled
2025-04-16T07:42:02.217919 <6>[ 0.513680] printk: console [ttyAMA0] enabled
2025-04-16T07:42:02.218301 <6>[ 0.514712] printk: legacy bootconsole [pl11] disabled
2025-04-16T07:42:02.218490 <6>[ 0.514712] printk: legacy bootconsole [pl11] disabled
2025-04-16T07:42:02.253220 <6>[ 0.549295] HugeTLB: allocation took 0ms with hugepage_allocation_threads=1
2025-04-16T07:42:02.253454 <6>[ 0.549591] HugeTLB: allocation took 0ms with hugepage_allocation_threads=1
2025-04-16T07:42:02.253804 <6>[ 0.549908] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
2025-04-16T07:42:02.253898 <6>[ 0.549930] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page
2025-04-16T07:42:02.254125 <6>[ 0.549967] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages
2025-04-16T07:42:02.254415 <6>[ 0.549981] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page
2025-04-16T07:42:02.255189 <6>[ 0.550016] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
2025-04-16T07:42:02.255250 <6>[ 0.550036] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page
2025-04-16T07:42:02.255606 <6>[ 0.550058] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages
2025-04-16T07:42:02.255668 <6>[ 0.550070] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page
2025-04-16T07:42:02.287765 <6>[ 0.584051] cryptd: max_cpu_qlen set to 1000
2025-04-16T07:42:02.312762 <6>[ 0.609108] ACPI: Interpreter disabled.
2025-04-16T07:42:02.348794 <6>[ 0.645102] iommu: Default domain type: Translated
2025-04-16T07:42:02.349137 <6>[ 0.645588] iommu: DMA domain TLB invalidation policy: strict mode
2025-04-16T07:42:02.354226 <5>[ 0.650454] SCSI subsystem initialized
2025-04-16T07:42:02.356878 <7>[ 0.653242] libata version 3.00 loaded.
2025-04-16T07:42:02.359206 <6>[ 0.655585] usbcore: registered new interface driver usbfs
2025-04-16T07:42:02.359677 <6>[ 0.656145] usbcore: registered new interface driver hub
2025-04-16T07:42:02.360208 <6>[ 0.656613] usbcore: registered new device driver usb
2025-04-16T07:42:02.368028 <6>[ 0.664394] mc: Linux media interface: v0.10
2025-04-16T07:42:02.368474 <6>[ 0.664905] videodev: Linux video capture interface: v2.00
2025-04-16T07:42:02.369079 <6>[ 0.665492] pps_core: LinuxPPS API ver. 1 registered
2025-04-16T07:42:02.369402 <6>[ 0.665769] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
2025-04-16T07:42:02.369721 <6>[ 0.666234] PTP clock support registered
2025-04-16T07:42:02.371168 <6>[ 0.667562] EDAC MC: Ver: 3.0.0
2025-04-16T07:42:02.378093 <6>[ 0.674403] scmi_core: SCMI protocol bus registered
2025-04-16T07:42:02.392349 <6>[ 0.688704] FPGA manager framework
2025-04-16T07:42:02.393554 <6>[ 0.689930] Advanced Linux Sound Architecture Driver Initialized.
2025-04-16T07:42:02.404988 <6>[ 0.701335] vgaarb: loaded
2025-04-16T07:42:02.408445 <6>[ 0.704749] clocksource: Switched to clocksource arch_sys_counter
2025-04-16T07:42:03.190259 <5>[ 1.486506] VFS: Disk quotas dquot_6.6.0
2025-04-16T07:42:03.190737 <6>[ 1.486857] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
2025-04-16T07:42:03.193257 <6>[ 1.489603] pnp: PnP ACPI: disabled
2025-04-16T07:42:03.241096 <6>[ 1.537355] NET: Registered PF_INET protocol family
2025-04-16T07:42:03.242543 <6>[ 1.538749] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)
2025-04-16T07:42:03.247303 <6>[ 1.543443] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)
2025-04-16T07:42:03.247686 <6>[ 1.543612] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
2025-04-16T07:42:03.248152 <6>[ 1.543758] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)
2025-04-16T07:42:03.248596 <6>[ 1.544282] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)
2025-04-16T07:42:03.248921 <6>[ 1.545264] TCP: Hash tables configured (established 32768 bind 32768)
2025-04-16T07:42:03.251463 <6>[ 1.547664] MPTCP token hash table entries: 4096 (order: 4, 98304 bytes, linear)
2025-04-16T07:42:03.252039 <6>[ 1.548201] UDP hash table entries: 2048 (order: 5, 131072 bytes, linear)
2025-04-16T07:42:03.252663 <6>[ 1.548880] UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear)
2025-04-16T07:42:03.253878 <6>[ 1.550171] NET: Registered PF_UNIX/PF_LOCAL protocol family
2025-04-16T07:42:03.258159 <6>[ 1.554367] RPC: Registered named UNIX socket transport module.
2025-04-16T07:42:03.258405 <6>[ 1.554512] RPC: Registered udp transport module.
2025-04-16T07:42:03.258642 <6>[ 1.554573] RPC: Registered tcp transport module.
2025-04-16T07:42:03.259243 <6>[ 1.554609] RPC: Registered tcp-with-tls transport module.
2025-04-16T07:42:03.259391 <6>[ 1.554642] RPC: Registered tcp NFSv4.1 backchannel transport module.
2025-04-16T07:42:03.259523 <6>[ 1.554821] PCI: CLS 0 bytes, default 64
2025-04-16T07:42:03.286091 <6>[ 1.582342] kvm [1]: nv: 566 coarse grained trap handlers
2025-04-16T07:42:03.288800 <6>[ 1.585082] kvm [1]: nv: 669 fine grained trap handlers
2025-04-16T07:42:03.291535 <6>[ 1.587843] kvm [1]: IPA Size Limit: 52 bits
2025-04-16T07:42:03.292230 <6>[ 1.588482] kvm [1]: GICv3: no GICV resource entry
2025-04-16T07:42:03.292542 <6>[ 1.588955] kvm [1]: disabling GICv2 emulation
2025-04-16T07:42:03.293210 <6>[ 1.589490] kvm [1]: GIC system register CPU interface enabled
2025-04-16T07:42:03.293773 <6>[ 1.590257] kvm [1]: vgic interrupt IRQ9
2025-04-16T07:42:03.294585 <6>[ 1.590952] kvm [1]: VHE mode initialized successfully
2025-04-16T07:42:03.303547 <5>[ 1.599840] Initialise system trusted keyrings
2025-04-16T07:42:03.305422 <6>[ 1.601729] workingset: timestamp_bits=42 max_order=20 bucket_order=0
2025-04-16T07:42:03.308718 <6>[ 1.604964] squashfs: version 4.0 (2009/01/31) Phillip Lougher
2025-04-16T07:42:03.311408 <5>[ 1.607732] NFS: Registering the id_resolver key type
2025-04-16T07:42:03.311585 <5>[ 1.608006] Key type id_resolver registered
2025-04-16T07:42:03.311770 <5>[ 1.608050] Key type id_legacy registered
2025-04-16T07:42:03.312132 <6>[ 1.608313] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
2025-04-16T07:42:03.312521 <6>[ 1.608388] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering...
2025-04-16T07:42:03.313060 <6>[ 1.609430] 9p: Installing v9fs 9p2000 file system support
2025-04-16T07:42:03.348373 <6>[ 1.644625] NET: Registered PF_ALG protocol family
2025-04-16T07:42:03.348535 <5>[ 1.644869] Key type asymmetric registered
2025-04-16T07:42:03.348757 <5>[ 1.644963] Asymmetric key parser 'x509' registered
2025-04-16T07:42:03.348990 <6>[ 1.645248] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 244)
2025-04-16T07:42:03.349136 <6>[ 1.645349] io scheduler mq-deadline registered
2025-04-16T07:42:03.349289 <6>[ 1.645443] io scheduler kyber registered
2025-04-16T07:42:03.461531 <6>[ 1.757779] pl061_gpio 9030000.pl061: PL061 GPIO chip registered
2025-04-16T07:42:03.478735 <6>[ 1.774944] ledtrig-cpu: registered to indicate activity on CPUs
2025-04-16T07:42:03.486631 <6>[ 1.782709] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:
2025-04-16T07:42:03.487459 <6>[ 1.783474] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000
2025-04-16T07:42:03.487976 <6>[ 1.784106] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000
2025-04-16T07:42:03.488469 <6>[ 1.784247] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000
2025-04-16T07:42:03.488911 <4>[ 1.784927] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits
2025-04-16T07:42:03.489664 <6>[ 1.785548] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]
2025-04-16T07:42:03.490796 <6>[ 1.787105] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00
2025-04-16T07:42:03.491160 <6>[ 1.787446] pci_bus 0000:00: root bus resource [bus 00-ff]
2025-04-16T07:42:03.491719 <6>[ 1.787506] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]
2025-04-16T07:42:03.491825 <6>[ 1.787867] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]
2025-04-16T07:42:03.492425 <6>[ 1.787889] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]
2025-04-16T07:42:03.493040 <6>[ 1.789191] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint
2025-04-16T07:42:03.497586 <6>[ 1.793612] pci 0000:00:01.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint
2025-04-16T07:42:03.498227 <6>[ 1.794537] pci 0000:00:01.0: BAR 0 [io 0x0000-0x007f]
2025-04-16T07:42:03.498614 <6>[ 1.794627] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]
2025-04-16T07:42:03.498668 <6>[ 1.794722] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
2025-04-16T07:42:03.503249 <6>[ 1.799283] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned
2025-04-16T07:42:03.503625 <6>[ 1.799765] pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff]: assigned
2025-04-16T07:42:03.503752 <6>[ 1.799839] pci 0000:00:01.0: BAR 0 [io 0x1000-0x107f]: assigned
2025-04-16T07:42:03.504277 <6>[ 1.800125] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]
2025-04-16T07:42:03.504378 <6>[ 1.800156] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]
2025-04-16T07:42:03.504598 <6>[ 1.800175] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]
2025-04-16T07:42:03.787850 <6>[ 2.083590] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)
2025-04-16T07:42:03.836997 <6>[ 2.133270] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
2025-04-16T07:42:03.868649 <6>[ 2.164892] msm_serial: driver initialized
2025-04-16T07:42:03.871948 <6>[ 2.168228] SuperH (H)SCI(F) driver initialized
2025-04-16T07:42:03.873627 <6>[ 2.169902] STM32 USART driver initialized
2025-04-16T07:42:03.929842 <6>[ 2.226132] loop: module loaded
2025-04-16T07:42:03.930760 <6>[ 2.227025] virtio_blk virtio0: 2/0/0 default/read/poll queues
2025-04-16T07:42:03.940150 <5>[ 2.236157] virtio_blk virtio0: [vda] 5388544 512-byte logical blocks (2.76 GB/2.57 GiB)
2025-04-16T07:42:03.959080 <6>[ 2.255353] megasas: 07.727.03.00-rc1
2025-04-16T07:42:03.973729 <5>[ 2.269502] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]
2025-04-16T07:42:03.975465 <6>[ 2.270915] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
2025-04-16T07:42:03.975837 <6>[ 2.271315] Intel/Sharp Extended Query Table at 0x0031
2025-04-16T07:42:03.975890 <6>[ 2.272132] Using buffer write method
2025-04-16T07:42:03.976153 <7>[ 2.272405] erase region 0: offset=0x0,size=0x40000,blocks=256
2025-04-16T07:42:03.977373 <5>[ 2.272774] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]
2025-04-16T07:42:03.977666 <6>[ 2.273295] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
2025-04-16T07:42:03.977980 <6>[ 2.273334] Intel/Sharp Extended Query Table at 0x0031
2025-04-16T07:42:03.978034 <6>[ 2.273798] Using buffer write method
2025-04-16T07:42:03.978340 <7>[ 2.273821] erase region 0: offset=0x0,size=0x40000,blocks=256
2025-04-16T07:42:03.978440 <5>[ 2.273887] Concatenating MTD devices:
2025-04-16T07:42:03.978568 <5>[ 2.273914] (0): "0.flash"
2025-04-16T07:42:03.978676 <5>[ 2.273954] (1): "0.flash"
2025-04-16T07:42:03.978798 <5>[ 2.273973] into device "0.flash"
2025-04-16T07:42:04.044386 <6>[ 2.340714] thunder_xcv, ver 1.0
2025-04-16T07:42:04.044729 <6>[ 2.341173] thunder_bgx, ver 1.0
2025-04-16T07:42:04.045100 <6>[ 2.341568] nicpf, ver 1.0
2025-04-16T07:42:04.056484 <6>[ 2.352701] hns3: Hisilicon Ethernet Network Driver for Hip08 Family - version
2025-04-16T07:42:04.056761 <6>[ 2.352758] hns3: Copyright (c) 2017 Huawei Corporation.
2025-04-16T07:42:04.056942 <6>[ 2.353148] hclge is initializing
2025-04-16T07:42:04.057143 <6>[ 2.353310] e1000: Intel(R) PRO/1000 Network Driver
2025-04-16T07:42:04.057342 <6>[ 2.353345] e1000: Copyright (c) 1999-2006 Intel Corporation.
2025-04-16T07:42:04.057571 <6>[ 2.353547] e1000e: Intel(R) PRO/1000 Network Driver
2025-04-16T07:42:04.057816 <6>[ 2.353571] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
2025-04-16T07:42:04.057999 <6>[ 2.353760] igb: Intel(R) Gigabit Ethernet Network Driver
2025-04-16T07:42:04.058182 <6>[ 2.353791] igb: Copyright (c) 2007-2014 Intel Corporation.
2025-04-16T07:42:04.058419 <6>[ 2.354001] igbvf: Intel(R) Gigabit Virtual Function Network Driver
2025-04-16T07:42:04.058619 <6>[ 2.354052] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.
2025-04-16T07:42:04.060693 <6>[ 2.357031] sky2: driver version 1.30
2025-04-16T07:42:04.075169 <6>[ 2.371475] VFIO - User Level meta-driver version: 0.3
2025-04-16T07:42:04.103222 <6>[ 2.399480] usbcore: registered new interface driver usb-storage
2025-04-16T07:42:04.133166 <6>[ 2.429440] rtc-pl031 9010000.pl031: registered as rtc0
2025-04-16T07:42:04.134207 <6>[ 2.429996] rtc-pl031 9010000.pl031: setting system clock to 2025-04-16T07:42:04 UTC (1744789324)
2025-04-16T07:42:04.140130 <6>[ 2.436331] i2c_dev: i2c /dev entries driver
2025-04-16T07:42:04.212008 <6>[ 2.508066] sdhci: Secure Digital Host Controller Interface driver
2025-04-16T07:42:04.212250 <6>[ 2.508114] sdhci: Copyright(c) Pierre Ossman
2025-04-16T07:42:04.218009 <6>[ 2.514324] Synopsys Designware Multimedia Card Interface Driver
2025-04-16T07:42:04.226957 <6>[ 2.523253] sdhci-pltfm: SDHCI platform and OF driver helper
2025-04-16T07:42:04.268785 <6>[ 2.565096] usbcore: registered new interface driver usbhid
2025-04-16T07:42:04.268880 <6>[ 2.565159] usbhid: USB HID core driver
2025-04-16T07:42:04.297170 <6>[ 2.593426] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available
2025-04-16T07:42:04.305779 <6>[ 2.602042] cs_system_cfg: CoreSight Configuration manager initialised
2025-04-16T07:42:04.342194 <6>[ 2.638477] NET: Registered PF_INET6 protocol family
2025-04-16T07:42:04.348982 <6>[ 2.645324] Segment Routing with IPv6
2025-04-16T07:42:04.349096 <6>[ 2.645581] In-situ OAM (IOAM) with IPv6
2025-04-16T07:42:04.349862 <6>[ 2.646230] NET: Registered PF_PACKET protocol family
2025-04-16T07:42:04.351504 <6>[ 2.647864] 9pnet: Installing 9P2000 support
2025-04-16T07:42:04.352087 <5>[ 2.648319] Key type dns_resolver registered
2025-04-16T07:42:04.430903 <6>[ 2.727195] registered taskstats version 1
2025-04-16T07:42:04.432285 <5>[ 2.728646] Loading compiled-in X.509 certificates
2025-04-16T07:42:04.493489 <6>[ 2.789795] Demotion targets for Node 0: null
2025-04-16T07:42:04.504875 <6>[ 2.801159] input: gpio-keys as /devices/platform/gpio-keys/input/input0
2025-04-16T07:42:04.512061 <6>[ 2.808215] clk: Disabling unused clocks
2025-04-16T07:42:04.512774 <6>[ 2.808950] PM: genpd: Disabling unused power domains
2025-04-16T07:42:04.513410 <6>[ 2.809737] ALSA device list:
2025-04-16T07:42:04.513476 <6>[ 2.809852] No soundcards found.
2025-04-16T07:42:04.547599 <6>[ 2.843699] EXT4-fs (vda): mounted filesystem 2ea66019-2eda-4da4-821a-b9ba5736bba0 r/w with ordered data mode. Quota mode: none.
2025-04-16T07:42:04.548006 <6>[ 2.844097] VFS: Mounted root (ext4 filesystem) on device 254:0.
2025-04-16T07:42:04.549287 <6>[ 2.845648] devtmpfs: mounted
2025-04-16T07:42:04.903274 <6>[ 3.199271] Freeing unused kernel memory: 3584K
2025-04-16T07:42:04.904293 <6>[ 3.200480] Run /sbin/init as init process
2025-04-16T07:42:04.904372 <7>[ 3.200706] with arguments:
2025-04-16T07:42:04.904434 <7>[ 3.200766] /sbin/init
2025-04-16T07:42:04.904524 <7>[ 3.200814] verbose
2025-04-16T07:42:04.904649 <7>[ 3.200835] with environment:
2025-04-16T07:42:04.904750 <7>[ 3.200859] HOME=/
2025-04-16T07:42:04.904860 <7>[ 3.200887] TERM=linux
2025-04-16T07:42:05.373465 [!p]104[?7h
2025-04-16T07:42:05.373854 [0;1;39mWelcome to [0m[1mDebian GNU/Linux trixie/sid[0m[0;1;39m![0m
2025-04-16T07:42:05.373926
2025-04-16T07:42:07.459705 [[0;32m OK [0m] Created slice [0;1;39msystem-getty.slice[0m - Slice /system/getty.
2025-04-16T07:42:07.470085 [[0;32m OK [0m] Created slice [0;1;39msystem-modprobe.slice[0m - Slice /system/modprobe.
2025-04-16T07:42:07.479754 [[0;32m OK [0m] Created slice [0;1;39msystem-serial\x2dget…slice[0m - Slice /system/serial-getty.
2025-04-16T07:42:07.490349 [[0;32m OK [0m] Created slice [0;1;39msystem-xfs_scrub.sli…[0mxfs_scrub background service slice.
2025-04-16T07:42:07.499092 [[0;32m OK [0m] Created slice [0;1;39muser.slice[0m - User and Session Slice.
2025-04-16T07:42:07.502513 [[0;32m OK [0m] Started [0;1;39msystemd-ask-password-conso…[0mequests to Console Directory Watch.
2025-04-16T07:42:07.504921 [[0;32m OK [0m] Started [0;1;39msystemd-ask-password-wall.…[0md Requests to Wall Directory Watch.
2025-04-16T07:42:07.507612 Expecting device [0;1;39mdev-ttyAMA0.device[0m - /dev/ttyAMA0...
2025-04-16T07:42:07.509172 [[0;32m OK [0m] Reached target [0;1;39mpaths.target[0m - Path Units.
2025-04-16T07:42:07.510401 [[0;32m OK [0m] Reached target [0;1;39mremote-fs.target[0m - Remote File Systems.
2025-04-16T07:42:07.511572 [[0;32m OK [0m] Reached target [0;1;39mslices.target[0m - Slice Units.
2025-04-16T07:42:07.512845 [[0;32m OK [0m] Reached target [0;1;39mswap.target[0m - Swaps.
2025-04-16T07:42:07.526601 [[0;32m OK [0m] Listening on [0;1;39msystemd-creds.socket[0m - Credential Encryption/Decryption.
2025-04-16T07:42:07.529968 [[0;32m OK [0m] Listening on [0;1;39msystemd-initctl.socke…[0m- initctl Compatibility Named Pipe.
2025-04-16T07:42:07.533599 [[0;32m OK [0m] Listening on [0;1;39msystemd-journald-dev-…socket[0m - Journal Socket (/dev/log).
2025-04-16T07:42:07.536926 [[0;32m OK [0m] Listening on [0;1;39msystemd-journald.socket[0m - Journal Sockets.
2025-04-16T07:42:07.540502 [[0;32m OK [0m] Listening on [0;1;39msystemd-udevd-control.socket[0m - udev Control Socket.
2025-04-16T07:42:07.542976 [[0;32m OK [0m] Listening on [0;1;39msystemd-udevd-kernel.socket[0m - udev Kernel Socket.
2025-04-16T07:42:07.575576 Mounting [0;1;39mdev-hugepages.mount[0m - Huge Pages File System...
2025-04-16T07:42:07.599055 Mounting [0;1;39mdev-mqueue.mount[0m - POSIX Message Queue File System...
2025-04-16T07:42:07.627015 Mounting [0;1;39mrun-lock.mount[0m - Legacy Locks Directory /run/lock...
2025-04-16T07:42:07.659372 Mounting [0;1;39msys-kernel-debug.mount[0m - Kernel Debug File System...
2025-04-16T07:42:07.715940 Mounting [0;1;39msys-kernel-tracing.mount[0m - Kernel Trace File System...
2025-04-16T07:42:07.771755 Mounting [0;1;39mtmp.mount[0m - Temporary Directory /tmp...
2025-04-16T07:42:07.835661 Starting [0;1;39mkmod-static-nodes.service[0m…eate List of Static Device Nodes...
2025-04-16T07:42:07.897880 Starting [0;1;39mmodprobe@configfs.service[0m - Load Kernel Module configfs...
2025-04-16T07:42:07.976089 Starting [0;1;39mmodprobe@drm.service[0m - Load Kernel Module drm...
2025-04-16T07:42:08.035458 Starting [0;1;39mmodprobe@efi_pstore.servi…[0m - Load Kernel Module efi_pstore...
2025-04-16T07:42:08.075191 Starting [0;1;39mmodprobe@fuse.service[0m - Load Kernel Module fuse...
2025-04-16T07:42:08.114109 Starting [0;1;39msystemd-journald.service[0m - Journal Service...
2025-04-16T07:42:08.184386 Starting [0;1;39msystemd-modules-load.service[0m - Load Kernel Modules...
2025-04-16T07:42:08.216874 Starting [0;1;39msystemd-remount-fs.servic…[0munt Root and Kernel File Systems...
2025-04-16T07:42:08.245457 Starting [0;1;39msystemd-udev-load-credent…[0mLoad udev Rules from Credentials...
2025-04-16T07:42:08.269650 Starting [0;1;39msystemd-udev-trigger.service[0m - Coldplug All udev Devices...
2025-04-16T07:42:08.330665 [[0;32m OK [0m] Mounted [0;1;39mdev-hugepages.mount[0m - Huge Pages File System.
2025-04-16T07:42:08.335030 [[0;32m OK [0m] Mounted [0;1;39mdev-mqueue.mount[0m - POSIX Message Queue File System.
2025-04-16T07:42:08.339026 [[0;32m OK [0m] Mounted [0;1;39mrun-lock.mount[0m - Legacy Locks Directory /run/lock.
2025-04-16T07:42:08.343166 [[0;32m OK [0m] Mounted [0;1;39msys-kernel-debug.mount[0m - Kernel Debug File System.
2025-04-16T07:42:08.353427 [[0;32m OK [0m] Mounted [0;1;39msys-kernel-tracing.mount[0m - Kernel Trace File System.
2025-04-16T07:42:08.357778 [[0;32m OK [0m] Mounted [0;1;39mtmp.mount[0m - Temporary Directory /tmp.
2025-04-16T07:42:08.373729 [[0;32m OK [0m] Finished [0;1;39mkmod-static-nodes.service[0m…Create List of Static Device Nodes.
2025-04-16T07:42:08.431628 Starting [0;1;39msystemd-tmpfiles-setup-de…[0m Device Nodes in /dev gracefully...
2025-04-16T07:42:08.917730 [[0;32m OK [0m] Finished [0;1;39msystemd-remount-fs.servic…[0mmount Root and Kernel File Systems.
2025-04-16T07:42:08.933925 [[0;32m OK [0m] Finished [0;1;39msystemd-modules-load.service[0m - Load Kernel Modules.
2025-04-16T07:42:08.983337 Starting [0;1;39msystemd-random-seed.service[0m - Load/Save OS Random Seed...
2025-04-16T07:42:09.108106 Starting [0;1;39msystemd-sysctl.service[0m - Apply Kernel Variables...
2025-04-16T07:42:09.259132 [[0;32m OK [0m] Finished [0;1;39msystemd-udev-load-credent…[0m- Load udev Rules from Credentials.
2025-04-16T07:42:09.381212 [[0;32m OK [0m] Finished [0;1;39msystemd-random-seed.service[0m - Load/Save OS Random Seed.
2025-04-16T07:42:09.413614 [[0;32m OK [0m] Finished [0;1;39mmodprobe@efi_pstore.service[0m - Load Kernel Module efi_pstore.
2025-04-16T07:42:09.484283 [[0;32m OK [0m] Finished [0;1;39msystemd-tmpfiles-setup-de…[0mic Device Nodes in /dev gracefully.
2025-04-16T07:42:09.514619 [[0;32m OK [0m] Finished [0;1;39mmodprobe@configfs.service[0m - Load Kernel Module configfs.
2025-04-16T07:42:09.538201 Mounting [0;1;39msys-kernel-config.mount[0m - Kernel Configuration File System...
2025-04-16T07:42:09.589454 Starting [0;1;39msystemd-sysusers.service[0m - Create System Users...
2025-04-16T07:42:09.723206 [[0;32m OK [0m] Mounted [0;1;39msys-kernel-config.mount[0m - Kernel Configuration File System.
2025-04-16T07:42:09.818220 [[0;32m OK [0m] Finished [0;1;39msystemd-sysctl.service[0m - Apply Kernel Variables.
2025-04-16T07:42:09.890141 <6>[ 8.184932] fuse: init (API version 7.43)
2025-04-16T07:42:09.940921 [[0;32m OK [0m] Finished [0;1;39mmodprobe@drm.service[0m - Load Kernel Module drm.
2025-04-16T07:42:09.973420 [[0;32m OK [0m] Finished [0;1;39mmodprobe@fuse.service[0m - Load Kernel Module fuse.
2025-04-16T07:42:10.007393 Mounting [0;1;39msys-fs-fuse-connections.mount[0m - FUSE Control File System...
2025-04-16T07:42:10.046858 [[0;32m OK [0m] Finished [0;1;39msystemd-sysusers.service[0m - Create System Users.
2025-04-16T07:42:10.097567 Starting [0;1;39msystemd-tmpfiles-setup-de…[0meate Static Device Nodes in /dev...
2025-04-16T07:42:10.200400 [[0;32m OK [0m] Mounted [0;1;39msys-fs-fuse-connections.mount[0m - FUSE Control File System.
2025-04-16T07:42:10.416499 [[0;32m OK [0m] Started [0;1;39msystemd-journald.service[0m - Journal Service.
2025-04-16T07:42:10.449068 Starting [0;1;39msystemd-journal-flush.ser…[0msh Journal to Persistent Storage...
2025-04-16T07:42:10.790495 [[0;32m OK [0m] Finished [0;1;39msystemd-tmpfiles-setup-de…[0mCreate Static Device Nodes in /dev.
2025-04-16T07:42:10.991780 [[0;32m OK [0m] Reached target [0;1;39mlocal-fs-pre.target[0m…Preparation for Local File Systems.
2025-04-16T07:42:10.996844 [[0;32m OK [0m] Reached target [0;1;39mlocal-fs.target[0m - Local File Systems.
2025-04-16T07:42:11.020141 [[0;32m OK [0m] Listening on [0;1;39msystemd-sysext.socket[0m… System Extension Image Management.
2025-04-16T07:42:11.065191 Starting [0;1;39msystemd-udevd.service[0m - R…ager for Device Events and Files...
2025-04-16T07:42:11.322623 [[0;32m OK [0m] Finished [0;1;39msystemd-journal-flush.ser…[0mlush Journal to Persistent Storage.
2025-04-16T07:42:11.368385 Starting [0;1;39msystemd-tmpfiles-setup.se…[0mate System Files and Directories...
2025-04-16T07:42:12.012812 [[0;32m OK [0m] Started [0;1;39msystemd-udevd.service[0m - Ru…anager for Device Events and Files.
2025-04-16T07:42:12.262066 [[0;32m OK [0m] Finished [0;1;39msystemd-tmpfiles-setup.se…[0mreate System Files and Directories.
2025-04-16T07:42:12.303509 Starting [0;1;39mldconfig.service[0m - Rebuild Dynamic Linker Cache...
2025-04-16T07:42:12.337131 Starting [0;1;39msystemd-journal-catalog-u…ervice[0m - Rebuild Journal Catalog...
2025-04-16T07:42:13.143418 [[0;32m OK [0m] Finished [0;1;39msystemd-journal-catalog-u….service[0m - Rebuild Journal Catalog.
2025-04-16T07:42:13.465880 [[0;32m OK [0m] Finished [0;1;39mldconfig.service[0m - Rebuild Dynamic Linker Cache.
2025-04-16T07:42:13.499410 Starting [0;1;39msystemd-update-done.service[0m - Update is Completed...
2025-04-16T07:42:13.701193 [[0;32m OK [0m] Finished [0;1;39msystemd-update-done.service[0m - Update is Completed.
2025-04-16T07:42:15.954392 [[0m[0;31m* [0m] (1 of 2) Job dev-ttyAMA0.device/start running (8s / 13min 30s)
2025-04-16T07:42:16.323341 M
[K[[0;1;31m*[0m[0;31m* [0m] (1 of 2) Job dev-ttyAMA0.device/start running (8s / 13min 30s)
2025-04-16T07:42:16.907026 M
[K[[0;31m*[0;1;31m*[0m[0;31m* [0m] (1 of 2) Job dev-ttyAMA0.device/start running (9s / 13min 30s)
2025-04-16T07:42:16.921685 M
[K[[0;32m OK [0m] Finished [0;1;39msystemd-udev-trigger.service[0m - Coldplug All udev Devices.
2025-04-16T07:42:17.009159 [K[[0;32m OK [0m] Reached target [0;1;39msysinit.target[0m - System Initialization.
2025-04-16T07:42:17.015155 [[0;32m OK [0m] Started [0;1;39mapt-daily.timer[0m - Daily apt download activities.
2025-04-16T07:42:17.018059 [[0;32m OK [0m] Started [0;1;39mapt-daily-upgrade.timer[0m - …y apt upgrade and clean activities.
2025-04-16T07:42:17.020597 [[0;32m OK [0m] Started [0;1;39mdpkg-db-backup.timer[0m - Daily dpkg database backup timer.
2025-04-16T07:42:17.023697 [[0;32m OK [0m] Started [0;1;39me2scrub_all.timer[0m - Period…Metadata Check for All Filesystems.
2025-04-16T07:42:17.027014 [[0;32m OK [0m] Started [0;1;39mfstrim.timer[0m - Discard unused filesystem blocks once a week.
2025-04-16T07:42:17.029414 [[0;32m OK [0m] Started [0;1;39mlogrotate.timer[0m - Daily rotation of log files.
2025-04-16T07:42:17.031305 [[0;32m OK [0m] Started [0;1;39msystemd-tmpfiles-clean.tim…[0my Cleanup of Temporary Directories.
2025-04-16T07:42:17.034826 [[0;32m OK [0m] Started [0;1;39mxfs_scrub_all.timer[0m - Peri…Metadata Check for All Filesystems.
2025-04-16T07:42:17.036137 [[0;32m OK [0m] Reached target [0;1;39mtimers.target[0m - Timer Units.
2025-04-16T07:42:17.039164 [[0;32m OK [0m] Listening on [0;1;39mdbus.socket[0m - D-Bus System Message Bus Socket.
2025-04-16T07:42:17.041902 [[0;32m OK [0m] Listening on [0;1;39msystemd-hostnamed.socket[0m - Hostname Service Socket.
2025-04-16T07:42:17.043016 [[0;32m OK [0m] Reached target [0;1;39msockets.target[0m - Socket Units.
2025-04-16T07:42:17.045021 [[0;32m OK [0m] Reached target [0;1;39mbasic.target[0m - Basic System.
2025-04-16T07:42:17.076272 [[0;32m OK [0m] Started [0;1;39mcron.service[0m - Regular background program processing daemon.
2025-04-16T07:42:17.105848 Starting [0;1;39mdbus.service[0m - D-Bus System Message Bus...
2025-04-16T07:42:17.149524 Starting [0;1;39me2scrub_reap.service[0m - Re…ne ext4 Metadata Check Snapshots...
2025-04-16T07:42:17.239258 Starting [0;1;39msystemd-logind.service[0m - User Login Management...
2025-04-16T07:42:17.268660 Starting [0;1;39msystemd-user-sessions.service[0m - Permit User Sessions...
2025-04-16T07:42:17.685677 [[0;32m OK [0m] Started [0;1;39mdbus.service[0m - D-Bus System Message Bus.
2025-04-16T07:42:17.913885 [[0;32m OK [0m] Finished [0;1;39msystemd-user-sessions.service[0m - Permit User Sessions.
2025-04-16T07:42:18.037628 [[0;32m OK [0m] Started [0;1;39mgetty@tty1.service[0m - Getty on tty1.
2025-04-16T07:42:18.098349 [[0;32m OK [0m] Found device [0;1;39mdev-ttyAMA0.device[0m - /dev/ttyAMA0.
2025-04-16T07:42:18.295529 [[0;32m OK [0m] Started [0;1;39mserial-getty@ttyAMA0.service[0m - Serial Getty on ttyAMA0.
2025-04-16T07:42:18.298246 [[0;32m OK [0m] Reached target [0;1;39mgetty.target[0m - Login Prompts.
2025-04-16T07:42:19.446475 [[0;32m OK [0m] Started [0;1;39msystemd-logind.service[0m - User Login Management.
2025-04-16T07:42:19.574058 [[0;32m OK [0m] Finished [0;1;39me2scrub_reap.service[0m - Re…line ext4 Metadata Check Snapshots.
2025-04-16T07:42:19.660813 [[0;32m OK [0m] Reached target [0;1;39mmulti-user.target[0m - Multi-User System.
2025-04-16T07:42:19.667976 [[0;32m OK [0m] Reached target [0;1;39mgraphical.target[0m - Graphical Interface.
2025-04-16T07:42:21.569088 [!p]104[?7h[6n[32766;32766H[6n[!p]104[?7h[6n[32766;32766H[6n
2025-04-16T07:42:21.569499 Debian GNU/Linux trixie/sid runner-xxurkrix-project-40964107-concurrent-0 ttyAMA0
2025-04-16T07:42:21.569576
2025-04-16T07:42:21.673179 runner-xxurkrix-project-40964107-concurrent-0 login: root
2025-04-16T07:42:22.088167 Linux runner-xxurkrix-project-40964107-concurrent-0 6.14.0 #1 SMP PREEMPT @1743678930 aarch64
2025-04-16T07:42:22.090199
2025-04-16T07:42:22.090656 The programs included with the Debian GNU/Linux system are free software;
2025-04-16T07:42:22.091013 the exact distribution terms for each program are described in the
2025-04-16T07:42:22.091103 individual files in /usr/share/doc/*/copyright.
2025-04-16T07:42:22.091179
2025-04-16T07:42:22.091645 Debian GNU/Linux comes with ABSOLUTELY NO WARRANTY, to the extent
2025-04-16T07:42:22.091702 permitted by applicable law.
2025-04-16T07:42:25.122387 [?2004hroot@runner-xxurkrix-project-40964107-concurrent-0:~#
2025-04-16T07:42:25.226927 [?2004l
[?2004hroot@runner-xxurkrix-project-40964107-concurrent-0:~# #
2025-04-16T07:42:25.331175 [?2004l
[?2004hroot@runner-xxurkrix-project-40964107-concurrent-0:~# export SHELL=/bin/sh
2025-04-16T07:42:25.435099 [?2004l
[?2004hroot@runner-xxurkrix-project-40964107-concurrent-0:~# . /lava-1/environment
2025-04-16T07:42:25.541210 [?2004l
[?2004hroot@runner-xxurkrix-project-40964107-concurrent-0:~# /lava-1/bin/lava-test-runne
er /lava-1/0
2025-04-16T07:42:25.758628 [?2004l
+ export TESTRUN_ID=0_ltp-syscalls
2025-04-16T07:42:25.759180 + cd /lava-1/0/tests/0_ltp-syscalls
2025-04-16T07:42:25.765366 + cat uuid
2025-04-16T07:42:25.777224 + UUID=1_1.1.3.1
2025-04-16T07:42:25.777671 + set +x
2025-04-16T07:42:25.778711 <8>[ 24.075079] <LAVA_SIGNAL_STARTRUN 0_ltp-syscalls 1_1.1.3.1>
2025-04-16T07:42:25.779489 + cd ./automated/linux/ltp/
2025-04-16T07:42:25.789449 + ./ltp.sh -T syscalls -s true -v -M 5 -R root -r kirk -b -d /scratch -g -e production -i /opt/ltp/ -S skipfile-lkft.yaml -p -u -t false -n 25 -c 4
2025-04-16T07:42:25.807305 + . ../../lib/sh-test-lib
2025-04-16T07:42:25.810213 ++ LANG=C
2025-04-16T07:42:25.810638 ++ export LANG
2025-04-16T07:42:25.827970 ++ export PATH=/lava-1/0/../bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/sbin:/usr/sbin:/usr/local/sbin
2025-04-16T07:42:25.828495 ++ PATH=/lava-1/0/../bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/sbin:/usr/sbin:/usr/local/sbin
2025-04-16T07:42:25.835303 ++ kernel_config=
2025-04-16T07:42:25.844554 ++ pwd
2025-04-16T07:42:25.849483 + OUTPUT=/lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/output
2025-04-16T07:42:25.850562 + RESULT_FILE=/lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/output/result.txt
2025-04-16T07:42:25.858103 ++ readlink -f ./ltp.sh
2025-04-16T07:42:25.871628 + SCRIPT=/lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/ltp.sh
2025-04-16T07:42:25.880306 ++ dirname /lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/ltp.sh
2025-04-16T07:42:25.895311 + SCRIPTPATH=/lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp
2025-04-16T07:42:25.896442 + echo 'Script path is: /lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp'
2025-04-16T07:42:25.897018 Script path is: /lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp
2025-04-16T07:42:25.897404 + TST_CMDFILES=
2025-04-16T07:42:25.897628 + SKIPFILE=
2025-04-16T07:42:25.897860 + SKIPFILE_YAML=
2025-04-16T07:42:25.898090 + BOARD=
2025-04-16T07:42:25.898153 + BRANCH=
2025-04-16T07:42:25.898381 + ENVIRONMENT=
2025-04-16T07:42:25.898767 + LTP_VERSION=20180926
2025-04-16T07:42:25.898987 + TEST_PROGRAM=ltp
2025-04-16T07:42:25.899207 + TEST_GIT_URL=
2025-04-16T07:42:25.905983 ++ pwd
2025-04-16T07:42:25.910834 + TEST_DIR=/lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/ltp
2025-04-16T07:42:25.911568 + BUILD_FROM_TAR=false
2025-04-16T07:42:25.911788 + SHARD_NUMBER=1
2025-04-16T07:42:25.912202 + SHARD_INDEX=1
2025-04-16T07:42:25.912430 + RUNNER=
2025-04-16T07:42:25.912660 + LTP_TMPDIR=/ltp-tmp
2025-04-16T07:42:25.912899 + LTP_INSTALL_PATH=/opt/ltp
2025-04-16T07:42:25.915553 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-16T07:42:25.916242 + case "$arg" in
2025-04-16T07:42:25.916483 + TST_CMDFILES=syscalls
2025-04-16T07:42:25.930999 ++ echo syscalls
2025-04-16T07:42:25.936134 ++ sed 's,\/,_,'
2025-04-16T07:42:25.968761 + LOG_FILE=syscalls
2025-04-16T07:42:25.969323 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-16T07:42:25.969748 + case "$arg" in
2025-04-16T07:42:25.970149 + SKIP_INSTALL=true
2025-04-16T07:42:25.970467 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-16T07:42:25.970694 + case "$arg" in
2025-04-16T07:42:25.970913 + LTP_VERSION=
2025-04-16T07:42:25.971364 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-16T07:42:25.971590 + case "$arg" in
2025-04-16T07:42:25.971981 + export LTP_TIMEOUT_MUL=5
2025-04-16T07:42:25.972199 + LTP_TIMEOUT_MUL=5
2025-04-16T07:42:25.972654 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-16T07:42:25.972918 + case "$arg" in
2025-04-16T07:42:25.973153 + export PASSWD=root
2025-04-16T07:42:25.973384 + PASSWD=root
2025-04-16T07:42:25.973693 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-16T07:42:25.973918 + case "$arg" in
2025-04-16T07:42:25.974138 + export RUNNER=kirk
2025-04-16T07:42:25.974376 + RUNNER=kirk
2025-04-16T07:42:25.974675 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-16T07:42:25.974895 + case "$arg" in
2025-04-16T07:42:25.975110 + export BOARD=
2025-04-16T07:42:25.975332 + BOARD=
2025-04-16T07:42:25.975547 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-16T07:42:25.975764 + case "$arg" in
2025-04-16T07:42:25.976211 + export LTP_TMPDIR=/scratch
2025-04-16T07:42:25.976459 + LTP_TMPDIR=/scratch
2025-04-16T07:42:25.976754 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-16T07:42:25.976975 + case "$arg" in
2025-04-16T07:42:25.977207 + export BRANCH=
2025-04-16T07:42:25.977257 + BRANCH=
2025-04-16T07:42:25.977715 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-16T07:42:25.977815 + case "$arg" in
2025-04-16T07:42:25.978096 + export ENVIRONMENT=production
2025-04-16T07:42:25.978364 + ENVIRONMENT=production
2025-04-16T07:42:25.978624 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-16T07:42:25.979022 + case "$arg" in
2025-04-16T07:42:25.979345 + export LTP_INSTALL_PATH=/opt/ltp/
2025-04-16T07:42:25.979607 + LTP_INSTALL_PATH=/opt/ltp/
2025-04-16T07:42:25.980214 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-16T07:42:25.980442 + case "$arg" in
2025-04-16T07:42:25.981409 + '[' -z skipfile-lkft.yaml ']'
2025-04-16T07:42:25.981890 + '[' yaml = yaml ']'
2025-04-16T07:42:25.982449 + SKIPFILE_YAML=/lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/skipfile-lkft.yaml
2025-04-16T07:42:25.982845 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-16T07:42:25.983102 + case "$arg" in
2025-04-16T07:42:25.983815 + [[ '' != '' ]]
2025-04-16T07:42:25.984472 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-16T07:42:25.984722 + case "$arg" in
2025-04-16T07:42:25.984990 + [[ '' != '' ]]
2025-04-16T07:42:25.985309 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-16T07:42:25.985542 + case "$arg" in
2025-04-16T07:42:25.985782 + BUILD_FROM_TAR=false
2025-04-16T07:42:25.986009 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-16T07:42:25.986237 + case "$arg" in
2025-04-16T07:42:25.986468 + SHARD_NUMBER=25
2025-04-16T07:42:25.986906 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-16T07:42:25.987138 + case "$arg" in
2025-04-16T07:42:25.987384 + SHARD_INDEX=4
2025-04-16T07:42:25.987688 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-16T07:42:25.988872 + TEST_TARFILE=https://github.com/linux-test-project/ltp/releases/download//ltp-full-.tar.xz
2025-04-16T07:42:25.989485 + '[' -n /lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/skipfile-lkft.yaml ']'
2025-04-16T07:42:25.989965 + export SKIPFILE_PATH=/lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/generated_skipfile
2025-04-16T07:42:25.990342 + SKIPFILE_PATH=/lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/generated_skipfile
2025-04-16T07:42:25.990600 + generate_skipfile
2025-04-16T07:42:25.991390 + info_msg 'Generating a skipfile based on /lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/skipfile-lkft.yaml'
2025-04-16T07:42:25.992412 + local 'msg=Generating a skipfile based on /lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/skipfile-lkft.yaml'
2025-04-16T07:42:25.993570 + '[' -z 'Generating a skipfile based on /lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/skipfile-lkft.yaml' ']'
2025-04-16T07:42:25.994156 + printf 'INFO: %s\n' 'Generating a skipfile based on /lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/skipfile-lkft.yaml'
2025-04-16T07:42:25.995132 INFO: Generating a skipfile based on /lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/skipfile-lkft.yaml
2025-04-16T07:42:25.995777 + detect_abi
2025-04-16T07:42:26.003313 ++ uname -m
2025-04-16T07:42:26.015878 + abi=aarch64
2025-04-16T07:42:26.016905 + case "${abi}" in
2025-04-16T07:42:26.017147 + abi=arm64
2025-04-16T07:42:26.018039 + local SKIPGEN_ARGS=
2025-04-16T07:42:26.018289 + test -n ''
2025-04-16T07:42:26.018698 + test -n ''
2025-04-16T07:42:26.018831 + test -n production
2025-04-16T07:42:26.019287 + SKIPGEN_ARGS=' --environment production'
2025-04-16T07:42:26.020011 + ../../bin/arm64/skipgen --environment production /lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/skipfile-lkft.yaml
2025-04-16T07:42:26.221938 + res=0
2025-04-16T07:42:26.222516 + test 0 -eq 0
2025-04-16T07:42:26.223027 + info_msg 'Using the following generated skipfile contents (until EOF):'
2025-04-16T07:42:26.223586 + local 'msg=Using the following generated skipfile contents (until EOF):'
2025-04-16T07:42:26.224242 + '[' -z 'Using the following generated skipfile contents (until EOF):' ']'
2025-04-16T07:42:26.224866 + printf 'INFO: %s\n' 'Using the following generated skipfile contents (until EOF):'
2025-04-16T07:42:26.224990 INFO: Using the following generated skipfile contents (until EOF):
2025-04-16T07:42:26.225502 + cat /lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/generated_skipfile
2025-04-16T07:42:26.242475 bind06
2025-04-16T07:42:26.242559 cve-2018-18559
2025-04-16T07:42:26.242637 dio10
2025-04-16T07:42:26.242720 dio12
2025-04-16T07:42:26.242824 dio13
2025-04-16T07:42:26.242939 dio14
2025-04-16T07:42:26.243034 dio15
2025-04-16T07:42:26.243094 dio16
2025-04-16T07:42:26.243154 dio17
2025-04-16T07:42:26.243214 dio18
2025-04-16T07:42:26.243286 dio19
2025-04-16T07:42:26.243347 dio20
2025-04-16T07:42:26.243406 dio21
2025-04-16T07:42:26.243466 dio22
2025-04-16T07:42:26.243525 dio23
2025-04-16T07:42:26.243597 dio24
2025-04-16T07:42:26.243657 dio25
2025-04-16T07:42:26.243716 dio26
2025-04-16T07:42:26.243776 dio27
2025-04-16T07:42:26.243835 dio28
2025-04-16T07:42:26.243906 dio29
2025-04-16T07:42:26.243965 dio30
2025-04-16T07:42:26.244022 fanotify07
2025-04-16T07:42:26.244092 fanotify08
2025-04-16T07:42:26.244344 fanotify09
2025-04-16T07:42:26.244393 fork13
2025-04-16T07:42:26.244444 ftrace_stress_test.sh
2025-04-16T07:42:26.244518 futex_wake04
2025-04-16T07:42:26.244594 gf01
2025-04-16T07:42:26.244656 gf14
2025-04-16T07:42:26.244722 gf15
2025-04-16T07:42:26.244785 gf18
2025-04-16T07:42:26.244849 hackbench01
2025-04-16T07:42:26.244922 hackbench02
2025-04-16T07:42:26.244987 hugemmap06
2025-04-16T07:42:26.245059 inotify07
2025-04-16T07:42:26.245130 inotify08
2025-04-16T07:42:26.245200 ksm01
2025-04-16T07:42:26.245270 memcg_stress
2025-04-16T07:42:26.245341 msgctl10
2025-04-16T07:42:26.245411 msgctl11
2025-04-16T07:42:26.245483 msgstress03
2025-04-16T07:42:26.245554 msgstress04
2025-04-16T07:42:26.245625 mtest06
2025-04-16T07:42:26.245694 perf_event_open02
2025-04-16T07:42:26.245778 ping01
2025-04-16T07:42:26.245854 ping602
2025-04-16T07:42:26.245927 pth_str01
2025-04-16T07:42:26.245998 pth_str02
2025-04-16T07:42:26.246070 pth_str03
2025-04-16T07:42:26.246139 sendfile09
2025-04-16T07:42:26.246209 sendfile09_64
2025-04-16T07:42:26.246281 setsockopt06
2025-04-16T07:42:26.246356 time-schedule01
2025-04-16T07:42:26.250015 + info_msg EOF
2025-04-16T07:42:26.250796 + local msg=EOF
2025-04-16T07:42:26.251112 + '[' -z EOF ']'
2025-04-16T07:42:26.251377 + printf 'INFO: %s\n' EOF
2025-04-16T07:42:26.251638 INFO: EOF
2025-04-16T07:42:26.252537 + '[' '!' -f /lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/generated_skipfile ']'
2025-04-16T07:42:26.253060 + SKIPFILE='-S /lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/generated_skipfile'
2025-04-16T07:42:26.258805 + check_root
2025-04-16T07:42:26.268491 ++ id -ru
2025-04-16T07:42:26.288718 + '[' 0 -eq 0 ']'
2025-04-16T07:42:26.289395 + return 0
2025-04-16T07:42:26.290407 + create_out_dir /lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/output
2025-04-16T07:42:26.291133 + '[' -z /lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/output ']'
2025-04-16T07:42:26.291792 + local OUTPUT=/lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/output
2025-04-16T07:42:26.292403 + '[' -d /lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/output ']'
2025-04-16T07:42:26.293036 + mkdir -p /lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/output
2025-04-16T07:42:26.317309 + '[' -d /lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/output ']'
2025-04-16T07:42:26.318334 + info_msg 'About to run ltp test...'
2025-04-16T07:42:26.318767 + local 'msg=About to run ltp test...'
2025-04-16T07:42:26.318993 + '[' -z 'About to run ltp test...' ']'
2025-04-16T07:42:26.319431 + printf 'INFO: %s\n' 'About to run ltp test...'
2025-04-16T07:42:26.319656 INFO: About to run ltp test...
2025-04-16T07:42:26.320276 + info_msg 'Output directory: /lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/output'
2025-04-16T07:42:26.320748 + local 'msg=Output directory: /lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/output'
2025-04-16T07:42:26.321222 + '[' -z 'Output directory: /lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/output' ']'
2025-04-16T07:42:26.321665 + printf 'INFO: %s\n' 'Output directory: /lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/output'
2025-04-16T07:42:26.321985 INFO: Output directory: /lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/output
2025-04-16T07:42:26.322417 + '[' true = true ']'
2025-04-16T07:42:26.322743 + info_msg 'ltp installation skipped altogether'
2025-04-16T07:42:26.323064 + local 'msg=ltp installation skipped altogether'
2025-04-16T07:42:26.323287 + '[' -z 'ltp installation skipped altogether' ']'
2025-04-16T07:42:26.323756 + printf 'INFO: %s\n' 'ltp installation skipped altogether'
2025-04-16T07:42:26.324016 INFO: ltp installation skipped altogether
2025-04-16T07:42:26.324657 + '[' '!' -d /opt/ltp/ ']'
2025-04-16T07:42:26.325975 + info_msg 'Running prep_system'
2025-04-16T07:42:26.326372 + local 'msg=Running prep_system'
2025-04-16T07:42:26.326607 + '[' -z 'Running prep_system' ']'
2025-04-16T07:42:26.326856 + printf 'INFO: %s\n' 'Running prep_system'
2025-04-16T07:42:26.327104 INFO: Running prep_system
2025-04-16T07:42:26.327341 + prep_system
2025-04-16T07:42:26.327774 + systemctl is-active systemd-timesyncd
2025-04-16T07:42:26.419372 inactive
2025-04-16T07:42:26.429659 + '[' -f /proc/sys/kernel/unprivileged_userns_clone ']'
2025-04-16T07:42:26.430277 + info_msg 'Kernel has no support of unprivileged_userns_clone'
2025-04-16T07:42:26.430828 + local 'msg=Kernel has no support of unprivileged_userns_clone'
2025-04-16T07:42:26.431309 + '[' -z 'Kernel has no support of unprivileged_userns_clone' ']'
2025-04-16T07:42:26.431828 + printf 'INFO: %s\n' 'Kernel has no support of unprivileged_userns_clone'
2025-04-16T07:42:26.432254 INFO: Kernel has no support of unprivileged_userns_clone
2025-04-16T07:42:26.433006 + info_msg 'Running run_ltp'
2025-04-16T07:42:26.433227 + local 'msg=Running run_ltp'
2025-04-16T07:42:26.433667 + '[' -z 'Running run_ltp' ']'
2025-04-16T07:42:26.433984 + printf 'INFO: %s\n' 'Running run_ltp'
2025-04-16T07:42:26.434061 INFO: Running run_ltp
2025-04-16T07:42:26.434303 + run_ltp
2025-04-16T07:42:26.434958 + cd /opt/ltp/
2025-04-16T07:42:26.435842 + mkdir -m 777 -p /scratch
2025-04-16T07:42:26.462537 + for file in ${TST_CMDFILES//,/ }
2025-04-16T07:42:26.462868 + cat runtest/syscalls
2025-04-16T07:42:26.486676 + sed -i 's/#.*$//;/^$/d' alltests
2025-04-16T07:42:26.526744 + split --verbose --numeric-suffixes=1 -n l/4/25 alltests
2025-04-16T07:42:26.552475 + echo '============== Tests to run ==============='
2025-04-16T07:42:26.552747 ============== Tests to run ===============
2025-04-16T07:42:26.553011 + cat runtest/shardfile
2025-04-16T07:42:26.568619 faccessat02 faccessat02
2025-04-16T07:42:26.568686 faccessat201 faccessat201
2025-04-16T07:42:26.568755 faccessat202 faccessat202
2025-04-16T07:42:26.568822 fallocate01 fallocate01
2025-04-16T07:42:26.569071 fallocate02 fallocate02
2025-04-16T07:42:26.569135 fallocate03 fallocate03
2025-04-16T07:42:26.569200 fallocate04 fallocate04
2025-04-16T07:42:26.569266 fallocate05 fallocate05
2025-04-16T07:42:26.569329 fallocate06 fallocate06
2025-04-16T07:42:26.569591 fsetxattr01 fsetxattr01
2025-04-16T07:42:26.569652 fsetxattr02 fsetxattr02
2025-04-16T07:42:26.569709 posix_fadvise01 posix_fadvise01
2025-04-16T07:42:26.570025 posix_fadvise01_64 posix_fadvise01_64
2025-04-16T07:42:26.570077 posix_fadvise02 posix_fadvise02
2025-04-16T07:42:26.570342 posix_fadvise02_64 posix_fadvise02_64
2025-04-16T07:42:26.570392 posix_fadvise03 posix_fadvise03
2025-04-16T07:42:26.570656 posix_fadvise03_64 posix_fadvise03_64
2025-04-16T07:42:26.570706 posix_fadvise04 posix_fadvise04
2025-04-16T07:42:26.570973 posix_fadvise04_64 posix_fadvise04_64
2025-04-16T07:42:26.571017 fchdir01 fchdir01
2025-04-16T07:42:26.571062 fchdir02 fchdir02
2025-04-16T07:42:26.571107 fchdir03 fchdir03
2025-04-16T07:42:26.571324 fchmod01 fchmod01
2025-04-16T07:42:26.571366 fchmod02 fchmod02
2025-04-16T07:42:26.571410 fchmod03 fchmod03
2025-04-16T07:42:26.571454 fchmod04 fchmod04
2025-04-16T07:42:26.571671 fchmod05 fchmod05
2025-04-16T07:42:26.571713 fchmod06 fchmod06
2025-04-16T07:42:26.571756 fchmodat01 fchmodat01
2025-04-16T07:42:26.571974 fchmodat02 fchmodat02
2025-04-16T07:42:26.572230 fchmodat2_01 fchmodat2_01
2025-04-16T07:42:26.572272 fchmodat2_02 fchmodat2_02
2025-04-16T07:42:26.572316 fchown01 fchown01
2025-04-16T07:42:26.572534 fchown01_16 fchown01_16
2025-04-16T07:42:26.572575 fchown02 fchown02
2025-04-16T07:42:26.572619 fchown02_16 fchown02_16
2025-04-16T07:42:26.572663 fchown03 fchown03
2025-04-16T07:42:26.572908 fchown03_16 fchown03_16
2025-04-16T07:42:26.572950 fchown04 fchown04
2025-04-16T07:42:26.572994 fchown04_16 fchown04_16
2025-04-16T07:42:26.573037 fchown05 fchown05
2025-04-16T07:42:26.573283 fchown05_16 fchown05_16
2025-04-16T07:42:26.573325 fchownat01 fchownat01
2025-04-16T07:42:26.573368 fchownat02 fchownat02
2025-04-16T07:42:26.573586 fcntl01 fcntl01
2025-04-16T07:42:26.573627 fcntl01_64 fcntl01_64
2025-04-16T07:42:26.573669 fcntl02 fcntl02
2025-04-16T07:42:26.573711 fcntl02_64 fcntl02_64
2025-04-16T07:42:26.577351 + echo '===========End Tests to run ==============='
2025-04-16T07:42:26.577631 ===========End Tests to run ===============
2025-04-16T07:42:26.578086 + '[' -n kirk ']'
2025-04-16T07:42:26.578385 + eval kirk --version
2025-04-16T07:42:26.579096 ++ kirk --version
2025-04-16T07:42:28.762911 kirk, 1.4
2025-04-16T07:42:28.875765 + '[' 0 -ne 0 ']'
2025-04-16T07:42:28.877901 + pipe0_status 'kirk --framework ltp --run-suite shardfile -d /scratch --env LTP_COLORIZE_OUTPUT=0 --skip-file /lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/generated_skipfile --json-report /tmp/kirk-report.json' 'tee /lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/output/LTP_syscalls.out'
2025-04-16T07:42:28.878548 + '[' 2 -ne 2 ']'
2025-04-16T07:42:28.879548 + local 'cmd1=kirk --framework ltp --run-suite shardfile -d /scratch --env LTP_COLORIZE_OUTPUT=0 --skip-file /lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/generated_skipfile --json-report /tmp/kirk-report.json'
2025-04-16T07:42:28.880149 + local 'cmd2=tee /lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/output/LTP_syscalls.out'
2025-04-16T07:42:28.880391 + exec
2025-04-16T07:42:28.880877 + local ret_val
2025-04-16T07:42:28.898730 ++ eval 'kirk --framework ltp --run-suite shardfile -d /scratch --env LTP_COLORIZE_OUTPUT=0 --skip-file /lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/generated_skipfile --json-report /tmp/kirk-report.json'
2025-04-16T07:42:28.900805 +++ kirk --framework ltp --run-suite shardfile -d /scratch --env LTP_COLORIZE_OUTPUT=0 --skip-file /lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/generated_skipfile --json-report /tmp/kirk-report.json
2025-04-16T07:42:28.902234 ++ eval 'tee /lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/output/LTP_syscalls.out'
2025-04-16T07:42:28.903284 +++ tee /lava-1/0/tests/0_ltp-syscalls/automated/linux/ltp/output/LTP_syscalls.out
2025-04-16T07:42:30.050531 Host information
2025-04-16T07:42:30.050680
2025-04-16T07:42:30.050949 System: Linux
2025-04-16T07:42:30.051027 Node: runner-xxurkrix-project-40964107-concurrent-0
2025-04-16T07:42:30.051282 Kernel Release: 6.14.0
2025-04-16T07:42:30.051339 Kernel Version: #1 SMP PREEMPT @1743678930
2025-04-16T07:42:30.051617 Machine Architecture: aarch64
2025-04-16T07:42:30.051661 Processor:
2025-04-16T07:42:30.051709
2025-04-16T07:42:30.052122 Temporary directory: /scratch/kirk.root/tmpxcfwpfny
2025-04-16T07:42:30.052172
2025-04-16T07:42:30.058890 Connecting to SUT: host
2025-04-16T07:42:30.380477 Starting suite: shardfile
2025-04-16T07:42:30.460918 faccessat02: <12>[ 28.757164] /usr/local/bin/kirk[263]: starting test faccessat02 (faccessat02)
2025-04-16T07:42:30.666934 [1;32mpass[0m (0.106s)
2025-04-16T07:42:30.699522 faccessat201: <12>[ 28.995700] /usr/local/bin/kirk[263]: starting test faccessat201 (faccessat201)
2025-04-16T07:42:30.891047 [1;32mpass[0m (0.099s)
2025-04-16T07:42:30.922691 fallocate03: <12>[ 29.218895] /usr/local/bin/kirk[263]: starting test fallocate03 (fallocate03)
2025-04-16T07:42:31.108587 [1;32mpass[0m (0.096s)
2025-04-16T07:42:31.141699 posix_fadvise01: <12>[ 29.437928] /usr/local/bin/kirk[263]: starting test posix_fadvise01 (posix_fadvise01)
2025-04-16T07:42:31.330429 [1;32mpass[0m (0.094s)
2025-04-16T07:42:31.359723 posix_fadvise02: <12>[ 29.655867] /usr/local/bin/kirk[263]: starting test posix_fadvise02 (posix_fadvise02)
2025-04-16T07:42:31.545112 [1;32mpass[0m (0.093s)
2025-04-16T07:42:31.579571 posix_fadvise03: <12>[ 29.875661] /usr/local/bin/kirk[263]: starting test posix_fadvise03 (posix_fadvise03)
2025-04-16T07:42:31.764383 [1;32mpass[0m (0.092s)
2025-04-16T07:42:31.795589 posix_fadvise04: <12>[ 30.091674] /usr/local/bin/kirk[263]: starting test posix_fadvise04 (posix_fadvise04)
2025-04-16T07:42:31.972649 [1;32mpass[0m (0.087s)
2025-04-16T07:42:32.006706 fchdir01: <12>[ 30.302760] /usr/local/bin/kirk[263]: starting test fchdir01 (fchdir01)
2025-04-16T07:42:32.186949 [1;32mpass[0m (0.092s)
2025-04-16T07:42:32.223588 fchdir02: <12>[ 30.519648] /usr/local/bin/kirk[263]: starting test fchdir02 (fchdir02)
2025-04-16T07:42:32.400818 [1;32mpass[0m (0.085s)
2025-04-16T07:42:32.436659 fchmod01: <12>[ 30.732760] /usr/local/bin/kirk[263]: starting test fchmod01 (fchmod01)
2025-04-16T07:42:32.624653 [1;32mpass[0m (0.092s)
2025-04-16T07:42:32.658003 fchmodat01: <12>[ 30.954192] /usr/local/bin/kirk[263]: starting test fchmodat01 (fchmodat01)
2025-04-16T07:42:32.847706 [1;32mpass[0m (0.098s)
2025-04-16T07:42:32.879626 fchmodat02: <12>[ 31.175759] /usr/local/bin/kirk[263]: starting test fchmodat02 (fchmodat02)
2025-04-16T07:42:33.072246 [1;32mpass[0m (0.098s)
2025-04-16T07:42:33.101708 fchmodat2_02: <12>[ 31.397993] /usr/local/bin/kirk[263]: starting test fchmodat2_02 (fchmodat2_02)
2025-04-16T07:42:33.275152 [1;32mpass[0m (0.087s)
2025-04-16T07:42:33.307164 fchown01: <12>[ 31.603297] /usr/local/bin/kirk[263]: starting test fchown01 (fchown01)
2025-04-16T07:42:33.480828 [1;32mpass[0m (0.086s)
2025-04-16T07:42:33.511660 fcntl02: <12>[ 31.807637] /usr/local/bin/kirk[263]: starting test fcntl02 (fcntl02)
2025-04-16T07:42:33.685808 [1;32mpass[0m (0.086s)
2025-04-16T07:42:33.715569 faccessat202: <12>[ 32.011698] /usr/local/bin/kirk[263]: starting test faccessat202 (faccessat202)
2025-04-16T07:42:33.908541 [1;32mpass[0m (0.098s)
2025-04-16T07:42:33.937136 fallocate01: <12>[ 32.233429] /usr/local/bin/kirk[263]: starting test fallocate01 (fallocate01)
2025-04-16T07:42:34.061117 [1;32mpass[0m (0.032s)
2025-04-16T07:42:34.093473 fallocate02: <12>[ 32.389642] /usr/local/bin/kirk[263]: starting test fallocate02 (fallocate02)
2025-04-16T07:42:34.224279 [1;32mpass[0m (0.032s)
2025-04-16T07:42:34.255679 fallocate04: <12>[ 32.551843] /usr/local/bin/kirk[263]: starting test fallocate04 (fallocate04)
2025-04-16T07:42:36.867453 <6>[ 35.163253] loop0: detected capacity change from 0 to 614400
2025-04-16T07:42:36.950512 <3>[ 35.245141] /dev/zero: Can't lookup blockdev
2025-04-16T07:42:36.995088 <3>[ 35.291390] /dev/zero: Can't lookup blockdev
2025-04-16T07:42:37.033591 <3>[ 35.329897] /dev/zero: Can't lookup blockdev
2025-04-16T07:42:37.248507 <6>[ 35.544598] raid6: neonx8 gen() 1895 MB/s
2025-04-16T07:42:37.316413 <6>[ 35.612588] raid6: neonx4 gen() 2255 MB/s
2025-04-16T07:42:37.384594 <6>[ 35.680872] raid6: neonx2 gen() 1866 MB/s
2025-04-16T07:42:37.452294 <6>[ 35.748534] raid6: neonx1 gen() 1263 MB/s
2025-04-16T07:42:37.520270 <6>[ 35.816543] raid6: int64x8 gen() 1952 MB/s
2025-04-16T07:42:37.588536 <6>[ 35.884751] raid6: int64x4 gen() 2675 MB/s
2025-04-16T07:42:37.656222 <6>[ 35.952529] raid6: int64x2 gen() 2302 MB/s
2025-04-16T07:42:37.724238 <6>[ 36.020540] raid6: int64x1 gen() 1850 MB/s
2025-04-16T07:42:37.724462 <6>[ 36.020624] raid6: using algorithm int64x4 gen() 2675 MB/s
2025-04-16T07:42:37.792476 <6>[ 36.088553] raid6: .... xor() 1664 MB/s, rmw enabled
2025-04-16T07:42:37.792695 <6>[ 36.088638] raid6: using neon recovery algorithm
2025-04-16T07:42:37.802787 <6>[ 36.099077] xor: measuring software checksum speed
2025-04-16T07:42:37.803491 <6>[ 36.099849] 8regs : 5323 MB/sec
2025-04-16T07:42:37.804577 <6>[ 36.100928] 32regs : 4617 MB/sec
2025-04-16T07:42:37.814500 <6>[ 36.110766] arm64_neon : 373 MB/sec
2025-04-16T07:42:37.814740 <6>[ 36.110973] xor: using function: 8regs (5323 MB/sec)
2025-04-16T07:42:37.969904 <6>[ 36.265979] Btrfs loaded, zoned=no, fsverity=no
2025-04-16T07:42:38.073040 <3>[ 36.369313] /dev/zero: Can't lookup blockdev
2025-04-16T07:42:39.263653 <3>[ 37.559553] operation not supported error, dev loop0, sector 614272 op 0x9:(WRITE_ZEROES) flags 0x10000800 phys_seg 0 prio class 0
2025-04-16T07:42:39.565955 <6>[ 37.862154] EXT4-fs (loop0): mounting ext2 file system using the ext4 subsystem
2025-04-16T07:42:39.576782 <6>[ 37.872446] EXT4-fs (loop0): mounted filesystem 7c3e4765-155f-40f5-9f9c-5e9a9389b84e r/w without journal. Quota mode: none.
2025-04-16T07:42:39.637647 <6>[ 37.933634] EXT4-fs (loop0): unmounting filesystem 7c3e4765-155f-40f5-9f9c-5e9a9389b84e.
2025-04-16T07:42:41.604651 <6>[ 39.900773] EXT4-fs (loop0): mounting ext3 file system using the ext4 subsystem
2025-04-16T07:42:41.641775 <6>[ 39.937680] EXT4-fs (loop0): mounted filesystem 6572f5e3-223c-4ccc-9764-c0ea524d0dae r/w with ordered data mode. Quota mode: none.
2025-04-16T07:42:41.731447 <6>[ 40.027567] EXT4-fs (loop0): unmounting filesystem 6572f5e3-223c-4ccc-9764-c0ea524d0dae.
2025-04-16T07:42:42.235118 <6>[ 40.531233] EXT4-fs (loop0): mounted filesystem 2d8e2beb-a1e5-4fd4-8ef1-818db7f88dfc r/w with ordered data mode. Quota mode: none.
2025-04-16T07:42:42.334816 <6>[ 40.630999] EXT4-fs (loop0): unmounting filesystem 2d8e2beb-a1e5-4fd4-8ef1-818db7f88dfc.
2025-04-16T07:42:42.854979 <6>[ 41.150969] BTRFS: device fsid 624930a2-85b7-4c91-befd-6746ad95cd7b devid 1 transid 8 /dev/loop0 (7:0) scanned by fallocate04 (498)
2025-04-16T07:42:42.861206 <6>[ 41.157270] BTRFS info (device loop0): first mount of filesystem 624930a2-85b7-4c91-befd-6746ad95cd7b
2025-04-16T07:42:42.861954 <6>[ 41.158057] BTRFS info (device loop0): using crc32c (crc32c-arm64) checksum algorithm
2025-04-16T07:42:42.863784 <6>[ 41.160111] BTRFS info (device loop0): using free-space-tree
2025-04-16T07:42:42.929123 <6>[ 41.225372] BTRFS info (device loop0): checking UUID tree
2025-04-16T07:42:43.098701 <6>[ 41.394915] BTRFS info (device loop0): last unmount of filesystem 624930a2-85b7-4c91-befd-6746ad95cd7b
2025-04-16T07:42:43.612423 [1;33mskip[0m (9.231s)
2025-04-16T07:42:43.646765 fallocate05: <12>[ 41.942926] /usr/local/bin/kirk[263]: starting test fallocate05 (fallocate05)
2025-04-16T07:42:46.314723 <6>[ 44.610933] loop0: detected capacity change from 0 to 614400
2025-04-16T07:42:46.408295 <3>[ 44.704042] /dev/zero: Can't lookup blockdev
2025-04-16T07:42:46.447001 <3>[ 44.743332] /dev/zero: Can't lookup blockdev
2025-04-16T07:42:46.485100 <3>[ 44.781381] /dev/zero: Can't lookup blockdev
2025-04-16T07:42:46.671052 <3>[ 44.966887] /dev/zero: Can't lookup blockdev
2025-04-16T07:42:47.883013 <3>[ 46.179131] operation not supported error, dev loop0, sector 614272 op 0x9:(WRITE_ZEROES) flags 0x10000800 phys_seg 0 prio class 0
2025-04-16T07:42:48.197987 <6>[ 46.494049] EXT4-fs (loop0): mounting ext2 file system using the ext4 subsystem
2025-04-16T07:42:48.209005 <6>[ 46.505209] EXT4-fs (loop0): mounted filesystem 4f5e6a51-6113-4ea0-ac51-780741a3d866 r/w without journal. Quota mode: none.
2025-04-16T07:42:48.253487 <6>[ 46.549722] EXT4-fs (loop0): unmounting filesystem 4f5e6a51-6113-4ea0-ac51-780741a3d866.
2025-04-16T07:42:49.506437 <6>[ 47.802671] EXT4-fs (loop0): mounting ext3 file system using the ext4 subsystem
2025-04-16T07:42:49.539269 <6>[ 47.835430] EXT4-fs (loop0): mounted filesystem f0684705-e22a-4f8b-9a42-d22b7e865357 r/w with ordered data mode. Quota mode: none.
2025-04-16T07:42:49.618053 <6>[ 47.914266] EXT4-fs (loop0): unmounting filesystem f0684705-e22a-4f8b-9a42-d22b7e865357.
2025-04-16T07:42:50.065401 <6>[ 48.361405] EXT4-fs (loop0): mounted filesystem c08a8bf7-5f25-4103-b63f-2cf090994e29 r/w with ordered data mode. Quota mode: none.
2025-04-16T07:43:11.457313 <6>[ 69.753510] EXT4-fs (loop0): unmounting filesystem c08a8bf7-5f25-4103-b63f-2cf090994e29.
2025-04-16T07:43:12.844279 <6>[ 71.140237] BTRFS: device fsid 7179d8a3-ff4a-4e04-82ce-e4ee1ff04d55 devid 1 transid 8 /dev/loop0 (7:0) scanned by fallocate05 (562)
2025-04-16T07:43:12.850766 <6>[ 71.147029] BTRFS info (device loop0): first mount of filesystem 7179d8a3-ff4a-4e04-82ce-e4ee1ff04d55
2025-04-16T07:43:12.851024 <6>[ 71.147174] BTRFS info (device loop0): using crc32c (crc32c-arm64) checksum algorithm
2025-04-16T07:43:12.851232 <6>[ 71.147239] BTRFS info (device loop0): using free-space-tree
2025-04-16T07:43:12.894515 <6>[ 71.190807] BTRFS info (device loop0): checking UUID tree
2025-04-16T07:43:26.195260 <6>[ 84.491475] BTRFS info (device loop0): last unmount of filesystem 7179d8a3-ff4a-4e04-82ce-e4ee1ff04d55
2025-04-16T07:43:28.028669 [1;33mskip[0m (44.278s)
2025-04-16T07:43:28.056308 fallocate06: <12>[ 86.352357] /usr/local/bin/kirk[263]: starting test fallocate06 (fallocate06)
2025-04-16T07:43:38.504606 <6>[ 96.800827] loop0: detected capacity change from 0 to 2097152
2025-04-16T07:43:38.591355 <3>[ 96.886226] /dev/zero: Can't lookup blockdev
2025-04-16T07:43:38.634334 <3>[ 96.930567] /dev/zero: Can't lookup blockdev
2025-04-16T07:43:38.671802 <3>[ 96.968076] /dev/zero: Can't lookup blockdev
2025-04-16T07:43:38.868807 <3>[ 97.165069] /dev/zero: Can't lookup blockdev
2025-04-16T07:43:42.469413 <3>[ 100.765433] operation not supported error, dev loop0, sector 2097024 op 0x9:(WRITE_ZEROES) flags 0x10000800 phys_seg 0 prio class 0
2025-04-16T07:43:42.673218 <6>[ 100.969425] EXT4-fs (loop0): mounting ext2 file system using the ext4 subsystem
2025-04-16T07:43:42.683263 <6>[ 100.978944] EXT4-fs (loop0): mounted filesystem e9b778fc-6b49-485d-9dfb-548abaa14d32 r/w without journal. Quota mode: none.
2025-04-16T07:43:42.742935 <6>[ 101.039164] EXT4-fs (loop0): unmounting filesystem e9b778fc-6b49-485d-9dfb-548abaa14d32.
2025-04-16T07:43:44.531539 <6>[ 102.827773] EXT4-fs (loop0): mounting ext3 file system using the ext4 subsystem
2025-04-16T07:43:44.552281 <6>[ 102.848241] EXT4-fs (loop0): mounted filesystem fbdeee1c-81a6-4ce5-9e39-474ac6f5803b r/w with ordered data mode. Quota mode: none.
2025-04-16T07:43:44.642395 <6>[ 102.938619] EXT4-fs (loop0): unmounting filesystem fbdeee1c-81a6-4ce5-9e39-474ac6f5803b.
2025-04-16T07:43:45.380488 <6>[ 103.676633] EXT4-fs (loop0): mounted filesystem d374b983-e747-4563-a03f-bf71a8c775f8 r/w with ordered data mode. Quota mode: none.
2025-04-16T07:44:24.755525 <6>[ 143.050392] EXT4-fs (loop0): unmounting filesystem d374b983-e747-4563-a03f-bf71a8c775f8.
2025-04-16T07:44:28.492284 <6>[ 146.788341] BTRFS: device fsid 2ea3f1a4-2152-4485-ba4f-403c9a3291d2 devid 1 transid 8 /dev/loop0 (7:0) scanned by fallocate06 (628)
2025-04-16T07:44:28.495598 <6>[ 146.791882] BTRFS info (device loop0): first mount of filesystem 2ea3f1a4-2152-4485-ba4f-403c9a3291d2
2025-04-16T07:44:28.498278 <6>[ 146.794367] BTRFS info (device loop0): using crc32c (crc32c-arm64) checksum algorithm
2025-04-16T07:44:28.498740 <6>[ 146.794954] BTRFS info (device loop0): using free-space-tree
2025-04-16T07:44:28.568631 <6>[ 146.864819] BTRFS info (device loop0): checking UUID tree
2025-04-16T07:45:49.838534 <6>[ 228.134636] BTRFS info (device loop0): last unmount of filesystem 2ea3f1a4-2152-4485-ba4f-403c9a3291d2
2025-04-16T07:46:13.382457 [1;33mskip[0m (2m 45s)
2025-04-16T07:46:13.413124 fsetxattr01: <12>[ 251.709330] /usr/local/bin/kirk[263]: starting test fsetxattr01 (fsetxattr01)
2025-04-16T07:46:15.998536 <6>[ 254.294524] loop0: detected capacity change from 0 to 614400
2025-04-16T07:46:16.084278 <3>[ 254.379809] /dev/zero: Can't lookup blockdev
2025-04-16T07:46:16.118691 <3>[ 254.414982] /dev/zero: Can't lookup blockdev
2025-04-16T07:46:16.151287 <3>[ 254.447601] /dev/zero: Can't lookup blockdev
2025-04-16T07:46:16.331134 <3>[ 254.627192] /dev/zero: Can't lookup blockdev
2025-04-16T07:46:17.499111 <3>[ 255.795253] operation not supported error, dev loop0, sector 614272 op 0x9:(WRITE_ZEROES) flags 0x10000800 phys_seg 0 prio class 0
2025-04-16T07:46:17.785455 <6>[ 256.081478] EXT4-fs (loop0): mounting ext2 file system using the ext4 subsystem
2025-04-16T07:46:17.798614 <6>[ 256.094644] EXT4-fs (loop0): mounted filesystem 9d1ce644-9f83-4496-966e-35c8734f9f8c r/w without journal. Quota mode: none.
2025-04-16T07:46:17.871169 <6>[ 256.167305] EXT4-fs (loop0): unmounting filesystem 9d1ce644-9f83-4496-966e-35c8734f9f8c.
2025-04-16T07:46:19.676426 <6>[ 257.972696] EXT4-fs (loop0): mounting ext3 file system using the ext4 subsystem
2025-04-16T07:46:19.703756 <6>[ 257.999903] EXT4-fs (loop0): mounted filesystem 186f3377-c627-48a3-85ed-e6cdbc689c32 r/w with ordered data mode. Quota mode: none.
2025-04-16T07:46:19.745886 <6>[ 258.042172] EXT4-fs (loop0): unmounting filesystem 186f3377-c627-48a3-85ed-e6cdbc689c32.
2025-04-16T07:46:20.148971 <6>[ 258.445150] EXT4-fs (loop0): mounted filesystem 28678975-6a6d-4917-a0c3-7d741136287b r/w with ordered data mode. Quota mode: none.
2025-04-16T07:46:20.202022 <6>[ 258.497822] EXT4-fs (loop0): unmounting filesystem 28678975-6a6d-4917-a0c3-7d741136287b.
2025-04-16T07:46:20.652926 <6>[ 258.949009] BTRFS: device fsid 95c34347-1077-4537-a24f-5acc2367eaaa devid 1 transid 8 /dev/loop0 (7:0) scanned by fsetxattr01 (694)
2025-04-16T07:46:20.659455 <6>[ 258.955683] BTRFS info (device loop0): first mount of filesystem 95c34347-1077-4537-a24f-5acc2367eaaa
2025-04-16T07:46:20.660125 <6>[ 258.956285] BTRFS info (device loop0): using crc32c (crc32c-arm64) checksum algorithm
2025-04-16T07:46:20.662237 <6>[ 258.958465] BTRFS info (device loop0): using free-space-tree
2025-04-16T07:46:20.728261 <6>[ 259.024121] BTRFS info (device loop0): checking UUID tree
2025-04-16T07:46:20.785475 <6>[ 259.081618] BTRFS info (device loop0): last unmount of filesystem 95c34347-1077-4537-a24f-5acc2367eaaa
2025-04-16T07:46:21.368956 [1;32mpass[0m (7.840s)
2025-04-16T07:46:21.399736 fsetxattr02: <12>[ 259.695917] /usr/local/bin/kirk[263]: starting test fsetxattr02 (fsetxattr02)
2025-04-16T07:46:21.526320 [1;33mskip[0m (0.034s)
2025-04-16T07:46:21.555768 posix_fadvise01_64: <12>[ 259.851901] /usr/local/bin/kirk[263]: starting test posix_fadvise01_64 (posix_fadvise01_64)
2025-04-16T07:46:21.740273 [1;32mpass[0m (0.090s)
2025-04-16T07:46:21.777536 posix_fadvise02_64: <12>[ 260.073788] /usr/local/bin/kirk[263]: starting test posix_fadvise02_64 (posix_fadvise02_64)
2025-04-16T07:46:21.956928 [1;32mpass[0m (0.089s)
2025-04-16T07:46:21.987348 posix_fadvise03_64: <12>[ 260.283480] /usr/local/bin/kirk[263]: starting test posix_fadvise03_64 (posix_fadvise03_64)
2025-04-16T07:46:22.170663 [1;32mpass[0m (0.091s)
2025-04-16T07:46:22.199343 posix_fadvise04_64: <12>[ 260.495489] /usr/local/bin/kirk[263]: starting test posix_fadvise04_64 (posix_fadvise04_64)
2025-04-16T07:46:22.380344 [1;32mpass[0m (0.087s)
2025-04-16T07:46:22.408915 fchdir03: <12>[ 260.705151] /usr/local/bin/kirk[263]: starting test fchdir03 (fchdir03)
2025-04-16T07:46:22.588871 [1;32mpass[0m (0.092s)
2025-04-16T07:46:22.623609 fchmod02: <12>[ 260.919823] /usr/local/bin/kirk[263]: starting test fchmod02 (fchmod02)
2025-04-16T07:46:22.811588 [1;32mpass[0m (0.091s)
2025-04-16T07:46:22.841675 fchmod03: <12>[ 261.137923] /usr/local/bin/kirk[263]: starting test fchmod03 (fchmod03)
2025-04-16T07:46:23.028532 [1;32mpass[0m (0.094s)
2025-04-16T07:46:23.059437 fchmod04: <12>[ 261.355638] /usr/local/bin/kirk[263]: starting test fchmod04 (fchmod04)
2025-04-16T07:46:23.252134 [1;32mpass[0m (0.096s)
2025-04-16T07:46:23.285087 fchmod05: <12>[ 261.581386] /usr/local/bin/kirk[263]: starting test fchmod05 (fchmod05)
2025-04-16T07:46:23.471195 [1;32mpass[0m (0.094s)
2025-04-16T07:46:23.502570 fchmod06: <12>[ 261.798769] /usr/local/bin/kirk[263]: starting test fchmod06 (fchmod06)
2025-04-16T07:46:23.735718 [1;32mpass[0m (0.142s)
2025-04-16T07:46:23.766191 fchmodat2_01: <12>[ 262.062338] /usr/local/bin/kirk[263]: starting test fchmodat2_01 (fchmodat2_01)
2025-04-16T07:46:26.386339 <6>[ 264.682563] loop0: detected capacity change from 0 to 614400
2025-04-16T07:46:26.468844 <3>[ 264.764982] /dev/zero: Can't lookup blockdev
2025-04-16T07:46:26.506987 <3>[ 264.803288] /dev/zero: Can't lookup blockdev
2025-04-16T07:46:26.543267 <3>[ 264.839565] /dev/zero: Can't lookup blockdev
2025-04-16T07:46:26.727480 <3>[ 265.023405] /dev/zero: Can't lookup blockdev
2025-04-16T07:46:27.925726 <3>[ 266.221860] operation not supported error, dev loop0, sector 614272 op 0x9:(WRITE_ZEROES) flags 0x10000800 phys_seg 0 prio class 0
2025-04-16T07:46:31.594249 [1;32mpass[0m (7.704s)
2025-04-16T07:46:31.624838 fchown01_16: <12>[ 269.921036] /usr/local/bin/kirk[263]: starting test fchown01_16 (fchown01_16)
2025-04-16T07:46:31.805434 [1;33mskip[0m (0.088s)
2025-04-16T07:46:31.839424 fchown02: <12>[ 270.135481] /usr/local/bin/kirk[263]: starting test fchown02 (fchown02)
2025-04-16T07:46:32.023522 [1;32mpass[0m (0.092s)
2025-04-16T07:46:32.055219 fchown02_16: <12>[ 270.351392] /usr/local/bin/kirk[263]: starting test fchown02_16 (fchown02_16)
2025-04-16T07:46:32.236417 [1;33mskip[0m (0.089s)
2025-04-16T07:46:32.266412 fchown03: <12>[ 270.562535] /usr/local/bin/kirk[263]: starting test fchown03 (fchown03)
2025-04-16T07:46:32.450110 [1;32mpass[0m (0.091s)
2025-04-16T07:46:32.479119 fchown03_16: <12>[ 270.775308] /usr/local/bin/kirk[263]: starting test fchown03_16 (fchown03_16)
2025-04-16T07:46:32.660887 [1;33mskip[0m (0.092s)
2025-04-16T07:46:32.690910 fchown04: <12>[ 270.987078] /usr/local/bin/kirk[263]: starting test fchown04 (fchown04)
2025-04-16T07:46:32.918417 [1;32mpass[0m (0.133s)
2025-04-16T07:46:32.947934 fchown04_16: <12>[ 271.244085] /usr/local/bin/kirk[263]: starting test fchown04_16 (fchown04_16)
2025-04-16T07:46:33.165008 [1;33mskip[0m (0.123s)
2025-04-16T07:46:33.194736 fchown05: <12>[ 271.490940] /usr/local/bin/kirk[263]: starting test fchown05 (fchown05)
2025-04-16T07:46:33.380592 [1;32mpass[0m (0.093s)
2025-04-16T07:46:33.410484 fchown05_16: <12>[ 271.706675] /usr/local/bin/kirk[263]: starting test fchown05_16 (fchown05_16)
2025-04-16T07:46:33.593557 [1;33mskip[0m (0.091s)
2025-04-16T07:46:33.623778 fchownat01: <12>[ 271.919966] /usr/local/bin/kirk[263]: starting test fchownat01 (fchownat01)
2025-04-16T07:46:33.746812 [1;32mpass[0m (0.030s)
2025-04-16T07:46:33.788074 fchownat02: <12>[ 272.084281] /usr/local/bin/kirk[263]: starting test fchownat02 (fchownat02)
2025-04-16T07:46:33.907020 [1;32mpass[0m (0.029s)
2025-04-16T07:46:33.937468 fcntl01: <12>[ 272.233764] /usr/local/bin/kirk[263]: starting test fcntl01 (fcntl01)
2025-04-16T07:46:34.057963 [1;32mpass[0m (0.031s)
2025-04-16T07:46:34.087582 fcntl01_64: <12>[ 272.383773] /usr/local/bin/kirk[263]: starting test fcntl01_64 (fcntl01_64)
2025-04-16T07:46:34.214529 [1;32mpass[0m (0.031s)
2025-04-16T07:46:34.241375 fcntl02_64: <12>[ 272.537619] /usr/local/bin/kirk[263]: starting test fcntl02_64 (fcntl02_64)
2025-04-16T07:46:34.462150 [1;32mpass[0m (0.087s)
2025-04-16T07:46:34.464526
2025-04-16T07:46:34.465062
2025-04-16T07:46:34.465151 Execution time: 4m 4s
2025-04-16T07:46:34.465255
2025-04-16T07:46:34.465371 Suite Name: shardfile
2025-04-16T07:46:34.465496 Total Run: 48
2025-04-16T07:46:34.465607 Total Runtime: 3m 58s
2025-04-16T07:46:34.465696 Passed Tests: 335
2025-04-16T07:46:34.465835 Failed Tests: 0
2025-04-16T07:46:34.465896 Skipped Tests: 16
2025-04-16T07:46:34.465941 Broken Tests: 0
2025-04-16T07:46:34.465980 Warnings: 0
2025-04-16T07:46:34.466024 Kernel Version: Linux 6.14.0 #1 SMP PREEMPT @1743678930
2025-04-16T07:46:34.466072 CPU: unknown
2025-04-16T07:46:34.466327 Machine Architecture: aarch64
2025-04-16T07:46:34.466373 RAM: 3998056 kB
2025-04-16T07:46:34.466419 Swap memory: 0 kB
2025-04-16T07:46:34.466464 Distro: debian
2025-04-16T07:46:34.466682 Distro Version:
2025-04-16T07:46:34.466725
2025-04-16T07:46:34.469262
2025-04-16T07:46:34.469495 Disconnecting from SUT: host
2025-04-16T07:46:34.579756 ++ echo 0
2025-04-16T07:46:34.596853 + ret_val=0
2025-04-16T07:46:34.597137 + exec
2025-04-16T07:46:34.597766 + return 0
2025-04-16T07:46:34.598545 + parse_ltp_json_results /tmp/kirk-report.json
2025-04-16T07:46:34.598948 + local result
2025-04-16T07:46:34.606859 + jq -r '.results| .[]| "\(.test_fqn) \(.test.result)"' /tmp/kirk-report.json
2025-04-16T07:46:34.611197 + sed 's/brok/fail/; s/conf/skip/'
2025-04-16T07:46:34.709416 ++ jq -r '.results| .[]| .test_fqn' /tmp/kirk-report.json
2025-04-16T07:46:34.779332 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:34.787124 ++ jq -r '.results | .[] | select(.test_fqn == "faccessat02") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:34.860610 + result=pass
2025-04-16T07:46:34.861112 + '[' pass = pass ']'
2025-04-16T07:46:34.861397 + continue
2025-04-16T07:46:34.861908 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:34.870164 ++ jq -r '.results | .[] | select(.test_fqn == "faccessat201") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:34.940470 + result=pass
2025-04-16T07:46:34.940757 + '[' pass = pass ']'
2025-04-16T07:46:34.941203 + continue
2025-04-16T07:46:34.941462 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:34.949140 ++ jq -r '.results | .[] | select(.test_fqn == "fallocate03") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:35.019329 + result=pass
2025-04-16T07:46:35.019929 + '[' pass = pass ']'
2025-04-16T07:46:35.020377 + continue
2025-04-16T07:46:35.020809 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:35.031165 ++ jq -r '.results | .[] | select(.test_fqn == "posix_fadvise01") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:35.104696 + result=pass
2025-04-16T07:46:35.105150 + '[' pass = pass ']'
2025-04-16T07:46:35.105226 + continue
2025-04-16T07:46:35.105675 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:35.113727 ++ jq -r '.results | .[] | select(.test_fqn == "posix_fadvise02") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:35.184875 + result=pass
2025-04-16T07:46:35.185220 + '[' pass = pass ']'
2025-04-16T07:46:35.185518 + continue
2025-04-16T07:46:35.186010 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:35.194237 ++ jq -r '.results | .[] | select(.test_fqn == "posix_fadvise03") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:35.264703 + result=pass
2025-04-16T07:46:35.264988 + '[' pass = pass ']'
2025-04-16T07:46:35.265246 + continue
2025-04-16T07:46:35.265775 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:35.273535 ++ jq -r '.results | .[] | select(.test_fqn == "posix_fadvise04") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:35.343141 + result=pass
2025-04-16T07:46:35.343598 + '[' pass = pass ']'
2025-04-16T07:46:35.343860 + continue
2025-04-16T07:46:35.344346 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:35.352276 ++ jq -r '.results | .[] | select(.test_fqn == "fchdir01") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:35.421784 + result=pass
2025-04-16T07:46:35.422342 + '[' pass = pass ']'
2025-04-16T07:46:35.422618 + continue
2025-04-16T07:46:35.422854 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:35.430683 ++ jq -r '.results | .[] | select(.test_fqn == "fchdir02") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:35.501008 + result=pass
2025-04-16T07:46:35.501473 + '[' pass = pass ']'
2025-04-16T07:46:35.501719 + continue
2025-04-16T07:46:35.502228 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:35.509393 ++ jq -r '.results | .[] | select(.test_fqn == "fchmod01") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:35.579060 + result=pass
2025-04-16T07:46:35.579568 + '[' pass = pass ']'
2025-04-16T07:46:35.579825 + continue
2025-04-16T07:46:35.580814 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:35.588455 ++ jq -r '.results | .[] | select(.test_fqn == "fchmodat01") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:35.657798 + result=pass
2025-04-16T07:46:35.658272 + '[' pass = pass ']'
2025-04-16T07:46:35.658558 + continue
2025-04-16T07:46:35.658812 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:35.666426 ++ jq -r '.results | .[] | select(.test_fqn == "fchmodat02") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:35.736385 + result=pass
2025-04-16T07:46:35.736720 + '[' pass = pass ']'
2025-04-16T07:46:35.736971 + continue
2025-04-16T07:46:35.737504 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:35.745048 ++ jq -r '.results | .[] | select(.test_fqn == "fchmodat2_02") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:35.814032 + result=pass
2025-04-16T07:46:35.814540 + '[' pass = pass ']'
2025-04-16T07:46:35.814813 + continue
2025-04-16T07:46:35.815260 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:35.822897 ++ jq -r '.results | .[] | select(.test_fqn == "fchown01") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:35.895163 + result=pass
2025-04-16T07:46:35.895456 + '[' pass = pass ']'
2025-04-16T07:46:35.895884 + continue
2025-04-16T07:46:35.896428 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:35.904158 ++ jq -r '.results | .[] | select(.test_fqn == "fcntl02") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:35.973897 + result=pass
2025-04-16T07:46:35.974368 + '[' pass = pass ']'
2025-04-16T07:46:35.974619 + continue
2025-04-16T07:46:35.975024 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:35.982719 ++ jq -r '.results | .[] | select(.test_fqn == "faccessat202") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:36.052419 + result=pass
2025-04-16T07:46:36.052869 + '[' pass = pass ']'
2025-04-16T07:46:36.053125 + continue
2025-04-16T07:46:36.053498 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:36.060916 ++ jq -r '.results | .[] | select(.test_fqn == "fallocate01") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:36.130001 + result=pass
2025-04-16T07:46:36.130676 + '[' pass = pass ']'
2025-04-16T07:46:36.130946 + continue
2025-04-16T07:46:36.131377 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:36.139345 ++ jq -r '.results | .[] | select(.test_fqn == "fallocate02") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:36.211093 + result=pass
2025-04-16T07:46:36.211636 + '[' pass = pass ']'
2025-04-16T07:46:36.211912 + continue
2025-04-16T07:46:36.212504 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:36.220755 ++ jq -r '.results | .[] | select(.test_fqn == "fallocate04") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:36.292187 + result=pass
2025-04-16T07:46:36.292729 + '[' pass = pass ']'
2025-04-16T07:46:36.292846 + continue
2025-04-16T07:46:36.293325 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:36.302543 ++ jq -r '.results | .[] | select(.test_fqn == "fallocate05") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:36.372660 + result=pass
2025-04-16T07:46:36.373155 + '[' pass = pass ']'
2025-04-16T07:46:36.373418 + continue
2025-04-16T07:46:36.373658 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:36.381408 ++ jq -r '.results | .[] | select(.test_fqn == "fallocate06") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:36.451441 + result=pass
2025-04-16T07:46:36.452117 + '[' pass = pass ']'
2025-04-16T07:46:36.452382 + continue
2025-04-16T07:46:36.452636 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:36.461417 ++ jq -r '.results | .[] | select(.test_fqn == "fsetxattr01") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:36.533190 + result=pass
2025-04-16T07:46:36.533727 + '[' pass = pass ']'
2025-04-16T07:46:36.534056 + continue
2025-04-16T07:46:36.534774 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:36.543381 ++ jq -r '.results | .[] | select(.test_fqn == "fsetxattr02") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:36.615617 + result=conf
2025-04-16T07:46:36.616330 + '[' conf = pass ']'
2025-04-16T07:46:36.616978 + jq -r '.results | .[] | select(.test_fqn == "fsetxattr02") | .test.log' /tmp/kirk-report.json
2025-04-16T07:46:36.695320 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:36.704975 ++ jq -r '.results | .[] | select(.test_fqn == "posix_fadvise01_64") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:36.774632 + result=pass
2025-04-16T07:46:36.775167 + '[' pass = pass ']'
2025-04-16T07:46:36.775400 + continue
2025-04-16T07:46:36.776062 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:36.784625 ++ jq -r '.results | .[] | select(.test_fqn == "posix_fadvise02_64") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:36.855529 + result=pass
2025-04-16T07:46:36.856181 + '[' pass = pass ']'
2025-04-16T07:46:36.856482 + continue
2025-04-16T07:46:36.856768 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:36.864984 ++ jq -r '.results | .[] | select(.test_fqn == "posix_fadvise03_64") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:36.934208 + result=pass
2025-04-16T07:46:36.934739 + '[' pass = pass ']'
2025-04-16T07:46:36.935013 + continue
2025-04-16T07:46:36.935479 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:36.943737 ++ jq -r '.results | .[] | select(.test_fqn == "posix_fadvise04_64") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:37.013450 + result=pass
2025-04-16T07:46:37.014227 + '[' pass = pass ']'
2025-04-16T07:46:37.014530 + continue
2025-04-16T07:46:37.014976 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:37.022437 ++ jq -r '.results | .[] | select(.test_fqn == "fchdir03") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:37.091876 + result=pass
2025-04-16T07:46:37.092724 + '[' pass = pass ']'
2025-04-16T07:46:37.093136 + continue
2025-04-16T07:46:37.093810 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:37.101778 ++ jq -r '.results | .[] | select(.test_fqn == "fchmod02") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:37.173952 + result=pass
2025-04-16T07:46:37.174627 + '[' pass = pass ']'
2025-04-16T07:46:37.174916 + continue
2025-04-16T07:46:37.175519 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:37.183485 ++ jq -r '.results | .[] | select(.test_fqn == "fchmod03") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:37.253426 + result=pass
2025-04-16T07:46:37.254119 + '[' pass = pass ']'
2025-04-16T07:46:37.254399 + continue
2025-04-16T07:46:37.255014 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:37.263205 ++ jq -r '.results | .[] | select(.test_fqn == "fchmod04") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:37.331722 + result=pass
2025-04-16T07:46:37.332425 + '[' pass = pass ']'
2025-04-16T07:46:37.332664 + continue
2025-04-16T07:46:37.333128 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:37.340930 ++ jq -r '.results | .[] | select(.test_fqn == "fchmod05") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:37.409279 + result=pass
2025-04-16T07:46:37.409965 + '[' pass = pass ']'
2025-04-16T07:46:37.410243 + continue
2025-04-16T07:46:37.410852 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:37.418698 ++ jq -r '.results | .[] | select(.test_fqn == "fchmod06") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:37.489138 + result=pass
2025-04-16T07:46:37.489647 + '[' pass = pass ']'
2025-04-16T07:46:37.489886 + continue
2025-04-16T07:46:37.490360 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:37.498075 ++ jq -r '.results | .[] | select(.test_fqn == "fchmodat2_01") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:37.567265 + result=pass
2025-04-16T07:46:37.567745 + '[' pass = pass ']'
2025-04-16T07:46:37.568221 + continue
2025-04-16T07:46:37.568629 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:37.578004 ++ jq -r '.results | .[] | select(.test_fqn == "fchown01_16") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:37.649445 + result=conf
2025-04-16T07:46:37.649997 + '[' conf = pass ']'
2025-04-16T07:46:37.650657 + jq -r '.results | .[] | select(.test_fqn == "fchown01_16") | .test.log' /tmp/kirk-report.json
2025-04-16T07:46:37.726563 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:37.734544 ++ jq -r '.results | .[] | select(.test_fqn == "fchown02") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:37.803842 + result=pass
2025-04-16T07:46:37.804456 + '[' pass = pass ']'
2025-04-16T07:46:37.804743 + continue
2025-04-16T07:46:37.805018 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:37.813118 ++ jq -r '.results | .[] | select(.test_fqn == "fchown02_16") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:37.882130 + result=conf
2025-04-16T07:46:37.882626 + '[' conf = pass ']'
2025-04-16T07:46:37.883178 + jq -r '.results | .[] | select(.test_fqn == "fchown02_16") | .test.log' /tmp/kirk-report.json
2025-04-16T07:46:37.959115 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:37.967369 ++ jq -r '.results | .[] | select(.test_fqn == "fchown03") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:38.036860 + result=pass
2025-04-16T07:46:38.037355 + '[' pass = pass ']'
2025-04-16T07:46:38.037455 + continue
2025-04-16T07:46:38.037981 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:38.045642 ++ jq -r '.results | .[] | select(.test_fqn == "fchown03_16") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:38.114660 + result=conf
2025-04-16T07:46:38.115169 + '[' conf = pass ']'
2025-04-16T07:46:38.115708 + jq -r '.results | .[] | select(.test_fqn == "fchown03_16") | .test.log' /tmp/kirk-report.json
2025-04-16T07:46:38.195068 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:38.203597 ++ jq -r '.results | .[] | select(.test_fqn == "fchown04") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:38.273790 + result=pass
2025-04-16T07:46:38.274103 + '[' pass = pass ']'
2025-04-16T07:46:38.274206 + continue
2025-04-16T07:46:38.274712 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:38.282753 ++ jq -r '.results | .[] | select(.test_fqn == "fchown04_16") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:38.354115 + result=conf
2025-04-16T07:46:38.354796 + '[' conf = pass ']'
2025-04-16T07:46:38.355440 + jq -r '.results | .[] | select(.test_fqn == "fchown04_16") | .test.log' /tmp/kirk-report.json
2025-04-16T07:46:38.433402 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:38.441979 ++ jq -r '.results | .[] | select(.test_fqn == "fchown05") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:38.511012 + result=pass
2025-04-16T07:46:38.511477 + '[' pass = pass ']'
2025-04-16T07:46:38.511740 + continue
2025-04-16T07:46:38.512179 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:38.519619 ++ jq -r '.results | .[] | select(.test_fqn == "fchown05_16") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:38.589601 + result=conf
2025-04-16T07:46:38.590095 + '[' conf = pass ']'
2025-04-16T07:46:38.590816 + jq -r '.results | .[] | select(.test_fqn == "fchown05_16") | .test.log' /tmp/kirk-report.json
2025-04-16T07:46:38.666696 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:38.675473 ++ jq -r '.results | .[] | select(.test_fqn == "fchownat01") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:38.745589 + result=pass
2025-04-16T07:46:38.746082 + '[' pass = pass ']'
2025-04-16T07:46:38.746346 + continue
2025-04-16T07:46:38.746957 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:38.754712 ++ jq -r '.results | .[] | select(.test_fqn == "fchownat02") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:38.824307 + result=pass
2025-04-16T07:46:38.824785 + '[' pass = pass ']'
2025-04-16T07:46:38.825031 + continue
2025-04-16T07:46:38.825462 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:38.833120 ++ jq -r '.results | .[] | select(.test_fqn == "fcntl01") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:38.901954 + result=pass
2025-04-16T07:46:38.902514 + '[' pass = pass ']'
2025-04-16T07:46:38.902794 + continue
2025-04-16T07:46:38.903340 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:38.912688 ++ jq -r '.results | .[] | select(.test_fqn == "fcntl01_64") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:38.985003 + result=pass
2025-04-16T07:46:38.985559 + '[' pass = pass ']'
2025-04-16T07:46:38.985684 + continue
2025-04-16T07:46:38.986231 + for test_fqn in $(jq -r '.results| .[]| .test_fqn' "$1")
2025-04-16T07:46:38.994032 ++ jq -r '.results | .[] | select(.test_fqn == "fcntl02_64") | .test.result' /tmp/kirk-report.json
2025-04-16T07:46:39.063785 + result=pass
2025-04-16T07:46:39.064516 + '[' pass = pass ']'
2025-04-16T07:46:39.064765 + continue
2025-04-16T07:46:39.065591 + rm /tmp/kirk-report.json
2025-04-16T07:46:39.087559 + rm -rf /scratch
2025-04-16T07:46:39.114859 + rm -rf alltests
2025-04-16T07:46:39.137601 + ../../utils/send-to-lava.sh ./output/result.txt
2025-04-16T07:46:39.226146 <8>[ 277.522311] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=faccessat02 RESULT=pass>
2025-04-16T07:46:39.281735 <8>[ 277.577812] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=faccessat201 RESULT=pass>
2025-04-16T07:46:39.335309 <8>[ 277.631503] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fallocate03 RESULT=pass>
2025-04-16T07:46:39.389586 <8>[ 277.685718] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=posix_fadvise01 RESULT=pass>
2025-04-16T07:46:39.445626 <8>[ 277.741948] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=posix_fadvise02 RESULT=pass>
2025-04-16T07:46:39.498940 <8>[ 277.795090] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=posix_fadvise03 RESULT=pass>
2025-04-16T07:46:39.550339 <8>[ 277.846652] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=posix_fadvise04 RESULT=pass>
2025-04-16T07:46:39.604028 <8>[ 277.900039] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fchdir01 RESULT=pass>
2025-04-16T07:46:39.656875 <8>[ 277.953169] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fchdir02 RESULT=pass>
2025-04-16T07:46:39.710324 <8>[ 278.006636] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fchmod01 RESULT=pass>
2025-04-16T07:46:39.767237 <8>[ 278.063529] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fchmodat01 RESULT=pass>
2025-04-16T07:46:39.821390 <8>[ 278.117714] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fchmodat02 RESULT=pass>
2025-04-16T07:46:39.876632 <8>[ 278.172880] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fchmodat2_02 RESULT=pass>
2025-04-16T07:46:39.928728 <8>[ 278.224970] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fchown01 RESULT=pass>
2025-04-16T07:46:39.980181 <8>[ 278.276229] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fcntl02 RESULT=pass>
2025-04-16T07:46:40.032039 <8>[ 278.328140] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=faccessat202 RESULT=pass>
2025-04-16T07:46:40.085166 <8>[ 278.381476] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fallocate01 RESULT=pass>
2025-04-16T07:46:40.136704 <8>[ 278.432910] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fallocate02 RESULT=pass>
2025-04-16T07:46:40.188330 <8>[ 278.484464] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fallocate04 RESULT=pass>
2025-04-16T07:46:40.242356 <8>[ 278.538440] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fallocate05 RESULT=pass>
2025-04-16T07:46:40.294584 <8>[ 278.590906] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fallocate06 RESULT=pass>
2025-04-16T07:46:40.346605 <8>[ 278.642821] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fsetxattr01 RESULT=pass>
2025-04-16T07:46:40.373489 <LAVA_SIGNAL_STARTTC fsetxattr02>
2025-04-16T07:46:40.382051 tst_test.c:1335: TCONF: brd driver not available
2025-04-16T07:46:40.382131
2025-04-16T07:46:40.384753 <LAVA_SIGNAL_ENDTC fsetxattr02>
2025-04-16T07:46:40.416306 <8>[ 278.712117] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fsetxattr02 RESULT=skip>
2025-04-16T07:46:40.477222 <8>[ 278.773445] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=posix_fadvise01_64 RESULT=pass>
2025-04-16T07:46:40.531045 <8>[ 278.827118] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=posix_fadvise02_64 RESULT=pass>
2025-04-16T07:46:40.582536 <8>[ 278.878706] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=posix_fadvise03_64 RESULT=pass>
2025-04-16T07:46:40.634780 <8>[ 278.930903] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=posix_fadvise04_64 RESULT=pass>
2025-04-16T07:46:40.686021 <8>[ 278.982168] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fchdir03 RESULT=pass>
2025-04-16T07:46:40.737263 <8>[ 279.033579] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fchmod02 RESULT=pass>
2025-04-16T07:46:40.790825 <8>[ 279.087007] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fchmod03 RESULT=pass>
2025-04-16T07:46:40.844437 <8>[ 279.140356] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fchmod04 RESULT=pass>
2025-04-16T07:46:40.896498 <8>[ 279.192420] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fchmod05 RESULT=pass>
2025-04-16T07:46:40.948883 <8>[ 279.245116] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fchmod06 RESULT=pass>
2025-04-16T07:46:41.003356 <8>[ 279.299505] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fchmodat2_01 RESULT=pass>
2025-04-16T07:46:41.029420 <LAVA_SIGNAL_STARTTC fchown01_16>
2025-04-16T07:46:41.036836 tst_tmpdir.c:316: TINFO: Using /tmp/LTP_fchQZFLLh as tmpdir (tmpfs filesystem)
2025-04-16T07:46:41.037116 tst_test.c:1900: TINFO: LTP version: 20250130
2025-04-16T07:46:41.037185 tst_test.c:1904: TINFO: Tested kernel: 6.14.0 #1 SMP PREEMPT @1743678930 aarch64
2025-04-16T07:46:41.037499 tst_kconfig.c:88: TINFO: Parsing kernel config '/proc/config.gz'
2025-04-16T07:46:41.037746 tst_kconfig.c:676: TINFO: CONFIG_TRACE_IRQFLAGS kernel option detected which might slow the execution
2025-04-16T07:46:41.037822 tst_test.c:1722: TINFO: Overall timeout per run is 0h 21m 36s
2025-04-16T07:46:41.038365 /all/src/ltp_ltp-20250130/testcases/kernel/syscalls/fchown/../utils/compat_tst_16.h:143: TCONF: 16-bit version of fchown() is not supported on your platform
2025-04-16T07:46:41.038411
2025-04-16T07:46:41.038451 Summary:
2025-04-16T07:46:41.038495 passed 0
2025-04-16T07:46:41.038532 failed 0
2025-04-16T07:46:41.038575 broken 0
2025-04-16T07:46:41.038786 skipped 1
2025-04-16T07:46:41.038830 warnings 0
2025-04-16T07:46:41.038865
2025-04-16T07:46:41.041166 <LAVA_SIGNAL_ENDTC fchown01_16>
2025-04-16T07:46:41.068933 <8>[ 279.365065] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fchown01_16 RESULT=skip>
2025-04-16T07:46:41.121008 <8>[ 279.417330] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fchown02 RESULT=pass>
2025-04-16T07:46:41.148179 <LAVA_SIGNAL_STARTTC fchown02_16>
2025-04-16T07:46:41.156653 tst_tmpdir.c:316: TINFO: Using /tmp/LTP_fchk34Dj8 as tmpdir (tmpfs filesystem)
2025-04-16T07:46:41.156719 tst_test.c:1900: TINFO: LTP version: 20250130
2025-04-16T07:46:41.157010 tst_test.c:1904: TINFO: Tested kernel: 6.14.0 #1 SMP PREEMPT @1743678930 aarch64
2025-04-16T07:46:41.157078 tst_kconfig.c:88: TINFO: Parsing kernel config '/proc/config.gz'
2025-04-16T07:46:41.157479 tst_kconfig.c:676: TINFO: CONFIG_TRACE_IRQFLAGS kernel option detected which might slow the execution
2025-04-16T07:46:41.157547 tst_test.c:1722: TINFO: Overall timeout per run is 0h 21m 36s
2025-04-16T07:46:41.158022 /all/src/ltp_ltp-20250130/testcases/kernel/syscalls/fchown/../utils/compat_tst_16.h:143: TCONF: 16-bit version of fchown() is not supported on your platform
2025-04-16T07:46:41.158070
2025-04-16T07:46:41.158116 Summary:
2025-04-16T07:46:41.158155 passed 0
2025-04-16T07:46:41.158198 failed 0
2025-04-16T07:46:41.158241 broken 0
2025-04-16T07:46:41.158283 skipped 1
2025-04-16T07:46:41.158492 warnings 0
2025-04-16T07:46:41.158545
2025-04-16T07:46:41.160775 <LAVA_SIGNAL_ENDTC fchown02_16>
2025-04-16T07:46:41.188456 <8>[ 279.484412] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fchown02_16 RESULT=skip>
2025-04-16T07:46:41.242628 <8>[ 279.538802] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fchown03 RESULT=pass>
2025-04-16T07:46:41.267816 <LAVA_SIGNAL_STARTTC fchown03_16>
2025-04-16T07:46:41.276503 tst_tmpdir.c:316: TINFO: Using /tmp/LTP_fchV423Kn as tmpdir (tmpfs filesystem)
2025-04-16T07:46:41.276787 tst_test.c:1900: TINFO: LTP version: 20250130
2025-04-16T07:46:41.276871 tst_test.c:1904: TINFO: Tested kernel: 6.14.0 #1 SMP PREEMPT @1743678930 aarch64
2025-04-16T07:46:41.277198 tst_kconfig.c:88: TINFO: Parsing kernel config '/proc/config.gz'
2025-04-16T07:46:41.277464 tst_kconfig.c:676: TINFO: CONFIG_TRACE_IRQFLAGS kernel option detected which might slow the execution
2025-04-16T07:46:41.277526 tst_test.c:1722: TINFO: Overall timeout per run is 0h 21m 36s
2025-04-16T07:46:41.277943 /all/src/ltp_ltp-20250130/testcases/kernel/syscalls/fchown/../utils/compat_tst_16.h:143: TCONF: 16-bit version of fchown() is not supported on your platform
2025-04-16T07:46:41.278016
2025-04-16T07:46:41.278095 Summary:
2025-04-16T07:46:41.278151 passed 0
2025-04-16T07:46:41.278369 failed 0
2025-04-16T07:46:41.278416 broken 0
2025-04-16T07:46:41.278464 skipped 1
2025-04-16T07:46:41.278503 warnings 0
2025-04-16T07:46:41.278550
2025-04-16T07:46:41.281134 <LAVA_SIGNAL_ENDTC fchown03_16>
2025-04-16T07:46:41.310174 <8>[ 279.606445] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fchown03_16 RESULT=skip>
2025-04-16T07:46:41.363243 <8>[ 279.659399] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fchown04 RESULT=pass>
2025-04-16T07:46:41.387766 <LAVA_SIGNAL_STARTTC fchown04_16>
2025-04-16T07:46:41.396181 tst_tmpdir.c:316: TINFO: Using /tmp/LTP_fchIrxeHs as tmpdir (tmpfs filesystem)
2025-04-16T07:46:41.396530 tst_test.c:1076: TINFO: Mounting (null) to /tmp/LTP_fchIrxeHs/mntpoint fstyp=tmpfs flags=21
2025-04-16T07:46:41.396604 tst_test.c:1900: TINFO: LTP version: 20250130
2025-04-16T07:46:41.396894 tst_test.c:1904: TINFO: Tested kernel: 6.14.0 #1 SMP PREEMPT @1743678930 aarch64
2025-04-16T07:46:41.396956 tst_kconfig.c:88: TINFO: Parsing kernel config '/proc/config.gz'
2025-04-16T07:46:41.397328 tst_kconfig.c:676: TINFO: CONFIG_TRACE_IRQFLAGS kernel option detected which might slow the execution
2025-04-16T07:46:41.397382 tst_test.c:1722: TINFO: Overall timeout per run is 0h 21m 36s
2025-04-16T07:46:41.397881 /all/src/ltp_ltp-20250130/testcases/kernel/syscalls/fchown/../utils/compat_tst_16.h:143: TCONF: 16-bit version of fchown() is not supported on your platform
2025-04-16T07:46:41.397928
2025-04-16T07:46:41.397967 Summary:
2025-04-16T07:46:41.398012 passed 0
2025-04-16T07:46:41.398056 failed 0
2025-04-16T07:46:41.398100 broken 0
2025-04-16T07:46:41.398310 skipped 1
2025-04-16T07:46:41.398354 warnings 0
2025-04-16T07:46:41.398390
2025-04-16T07:46:41.400860 <LAVA_SIGNAL_ENDTC fchown04_16>
2025-04-16T07:46:41.429099 <8>[ 279.725271] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fchown04_16 RESULT=skip>
2025-04-16T07:46:41.485265 <8>[ 279.780997] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fchown05 RESULT=pass>
2025-04-16T07:46:41.510448 <LAVA_SIGNAL_STARTTC fchown05_16>
2025-04-16T07:46:41.519062 tst_tmpdir.c:316: TINFO: Using /tmp/LTP_fchpEOsCI as tmpdir (tmpfs filesystem)
2025-04-16T07:46:41.519327 tst_test.c:1900: TINFO: LTP version: 20250130
2025-04-16T07:46:41.519412 tst_test.c:1904: TINFO: Tested kernel: 6.14.0 #1 SMP PREEMPT @1743678930 aarch64
2025-04-16T07:46:41.519723 tst_kconfig.c:88: TINFO: Parsing kernel config '/proc/config.gz'
2025-04-16T07:46:41.519974 tst_kconfig.c:676: TINFO: CONFIG_TRACE_IRQFLAGS kernel option detected which might slow the execution
2025-04-16T07:46:41.520217 tst_test.c:1722: TINFO: Overall timeout per run is 0h 21m 36s
2025-04-16T07:46:41.520651 /all/src/ltp_ltp-20250130/testcases/kernel/syscalls/fchown/../utils/compat_tst_16.h:143: TCONF: 16-bit version of fchown() is not supported on your platform
2025-04-16T07:46:41.520697
2025-04-16T07:46:41.520736 Summary:
2025-04-16T07:46:41.520778 passed 0
2025-04-16T07:46:41.520814 failed 0
2025-04-16T07:46:41.520855 broken 0
2025-04-16T07:46:41.521065 skipped 1
2025-04-16T07:46:41.521112 warnings 0
2025-04-16T07:46:41.521147
2025-04-16T07:46:41.523827 <LAVA_SIGNAL_ENDTC fchown05_16>
2025-04-16T07:46:41.551965 <8>[ 279.847948] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fchown05_16 RESULT=skip>
2025-04-16T07:46:41.605491 <8>[ 279.901628] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fchownat01 RESULT=pass>
2025-04-16T07:46:41.656097 <8>[ 279.952102] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fchownat02 RESULT=pass>
2025-04-16T07:46:41.710633 <8>[ 280.006969] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fcntl01 RESULT=pass>
2025-04-16T07:46:41.763150 <8>[ 280.059278] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fcntl01_64 RESULT=pass>
2025-04-16T07:46:41.814602 <8>[ 280.110900] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fcntl02_64 RESULT=pass>
2025-04-16T07:46:41.820827 + set +x
2025-04-16T07:46:41.821512 <8>[ 280.117863] <LAVA_SIGNAL_ENDRUN 0_ltp-syscalls 1_1.1.3.1>
2025-04-16T07:46:41.827248 <LAVA_TEST_RUNNER EXIT>
2025-04-16T07:46:42.930975 [?2004hroot@runner-xxurkrix-project-40964107-concurrent-0:~# poweroff