2025-05-09T08:56:57.186331
2025-05-09T08:56:57.186710 OpenSBI v1.5
2025-05-09T08:56:57.186809 ____ _____ ____ _____
2025-05-09T08:56:57.186885 / __ \ / ____| _ \_ _|
2025-05-09T08:56:57.186952 | | | |_ __ ___ _ __ | (___ | |_) || |
2025-05-09T08:56:57.187027 | | | | '_ \ / _ \ '_ \ \___ \| _ < | |
2025-05-09T08:56:57.187090 | |__| | |_) | __/ | | |____) | |_) || |_
2025-05-09T08:56:57.187350 \____/| .__/ \___|_| |_|_____/|____/_____|
2025-05-09T08:56:57.187405 | |
2025-05-09T08:56:57.187464 |_|
2025-05-09T08:56:57.187523
2025-05-09T08:56:57.196870 Platform Name : riscv-virtio,qemu
2025-05-09T08:56:57.196971 Platform Features : medeleg
2025-05-09T08:56:57.197038 Platform HART Count : 2
2025-05-09T08:56:57.197109 Platform IPI Device : aclint-mswi
2025-05-09T08:56:57.197264 Platform Timer Device : aclint-mtimer @ 10000000Hz
2025-05-09T08:56:57.197389 Platform Console Device : uart8250
2025-05-09T08:56:57.197517 Platform HSM Device : ---
2025-05-09T08:56:57.197641 Platform PMU Device : ---
2025-05-09T08:56:57.197886 Platform Reboot Device : syscon-reboot
2025-05-09T08:56:57.197962 Platform Shutdown Device : syscon-poweroff
2025-05-09T08:56:57.198097 Platform Suspend Device : ---
2025-05-09T08:56:57.198183 Platform CPPC Device : ---
2025-05-09T08:56:57.198272 Firmware Base : 0x80000000
2025-05-09T08:56:57.198363 Firmware Size : 337 KB
2025-05-09T08:56:57.198463 Firmware RW Offset : 0x40000
2025-05-09T08:56:57.198540 Firmware RW Size : 81 KB
2025-05-09T08:56:57.198635 Firmware Heap Offset : 0x4b000
2025-05-09T08:56:57.198923 Firmware Heap Size : 37 KB (total), 2 KB (reserved), 11 KB (used), 23 KB (free)
2025-05-09T08:56:57.199116 Firmware Scratch Size : 4096 B (total), 416 B (used), 3680 B (free)
2025-05-09T08:56:57.199216 Runtime SBI Version : 2.0
2025-05-09T08:56:57.199271
2025-05-09T08:56:57.199341 Domain0 Name : root
2025-05-09T08:56:57.199408 Domain0 Boot HART : 0
2025-05-09T08:56:57.199647 Domain0 HARTs : 0*,1*
2025-05-09T08:56:57.199964 Domain0 Region00 : 0x0000000000100000-0x0000000000100fff M: (I,R,W) S/U: (R,W)
2025-05-09T08:56:57.200121 Domain0 Region01 : 0x0000000010000000-0x0000000010000fff M: (I,R,W) S/U: (R,W)
2025-05-09T08:56:57.200465 Domain0 Region02 : 0x0000000002000000-0x000000000200ffff M: (I,R,W) S/U: ()
2025-05-09T08:56:57.200533 Domain0 Region03 : 0x0000000080040000-0x000000008005ffff M: (R,W) S/U: ()
2025-05-09T08:56:57.200863 Domain0 Region04 : 0x0000000080000000-0x000000008003ffff M: (R,X) S/U: ()
2025-05-09T08:56:57.200940 Domain0 Region05 : 0x000000000c400000-0x000000000c5fffff M: (I,R,W) S/U: (R,W)
2025-05-09T08:56:57.201159 Domain0 Region06 : 0x000000000c000000-0x000000000c3fffff M: (I,R,W) S/U: (R,W)
2025-05-09T08:56:57.201504 Domain0 Region07 : 0x0000000000000000-0xffffffffffffffff M: () S/U: (R,W,X)
2025-05-09T08:56:57.201556 Domain0 Next Address : 0x0000000080200000
2025-05-09T08:56:57.201643 Domain0 Next Arg1 : 0x00000000bfe00000
2025-05-09T08:56:57.201872 Domain0 Next Mode : S-mode
2025-05-09T08:56:57.201914 Domain0 SysReset : yes
2025-05-09T08:56:57.201959 Domain0 SysSuspend : yes
2025-05-09T08:56:57.201996
2025-05-09T08:56:57.202081 Boot HART ID : 0
2025-05-09T08:56:57.202169 Boot HART Domain : root
2025-05-09T08:56:57.202411 Boot HART Priv Version : v1.12
2025-05-09T08:56:57.202532 Boot HART Base ISA : rv64imafdch
2025-05-09T08:56:57.202849 Boot HART ISA Extensions : sstc,zicntr,zihpm,zicboz,zicbom,sdtrig,svadu
2025-05-09T08:56:57.202941 Boot HART PMP Count : 16
2025-05-09T08:56:57.203040 Boot HART PMP Granularity : 2 bits
2025-05-09T08:56:57.203124 Boot HART PMP Address Bits: 54
2025-05-09T08:56:57.203254 Boot HART MHPM Info : 16 (0x0007fff8)
2025-05-09T08:56:57.203372 Boot HART Debug Triggers : 2 triggers
2025-05-09T08:56:57.203512 Boot HART MIDELEG : 0x0000000000001666
2025-05-09T08:56:57.203627 Boot HART MEDELEG : 0x0000000000f0b509
2025-05-09T08:56:57.219428 [ 0.000000] Linux version 6.4.16 (anders@monster) (riscv64-linux-gcc.br_real (Buildroot 2021.11-12449-g1bef613319) 14.2.0, GNU ld (GNU Binutils) 2.42) #1 SMP Tue Apr 8 14:28:42 CEST 2025
2025-05-09T08:56:57.219482 [ 0.000000] random: crng init done
2025-05-09T08:56:57.219525 [ 0.000000] Machine model: riscv-virtio,qemu
2025-05-09T08:56:57.219565 [ 0.000000] earlycon: ns16550a0 at MMIO 0x0000000010000000 (options '')
2025-05-09T08:56:57.219603 [ 0.000000] printk: bootconsole [ns16550a0] enabled
2025-05-09T08:56:57.219639 [ 0.000000] efi: UEFI not found.
2025-05-09T08:56:57.220357 [ 0.000000] OF: reserved mem: 0x0000000080000000..0x000000008003ffff (256 KiB) nomap non-reusable mmode_resv1@80000000
2025-05-09T08:56:57.220623 [ 0.000000] OF: reserved mem: 0x0000000080040000..0x000000008005ffff (128 KiB) nomap non-reusable mmode_resv0@80040000
2025-05-09T08:56:57.266737 [ 0.000000] Zone ranges:
2025-05-09T08:56:57.267150 [ 0.000000] DMA32 [mem 0x0000000080000000-0x00000000ffffffff]
2025-05-09T08:56:57.267324 [ 0.000000] Normal [mem 0x0000000100000000-0x000000017fffffff]
2025-05-09T08:56:57.267435 [ 0.000000] Movable zone start for each node
2025-05-09T08:56:57.267592 [ 0.000000] Early memory node ranges
2025-05-09T08:56:57.267859 [ 0.000000] node 0: [mem 0x0000000080000000-0x000000008005ffff]
2025-05-09T08:56:57.268166 [ 0.000000] node 0: [mem 0x0000000080060000-0x000000017fffffff]
2025-05-09T08:56:57.268494 [ 0.000000] Initmem setup node 0 [mem 0x0000000080000000-0x000000017fffffff]
2025-05-09T08:56:57.296955 [ 0.000000] SBI specification v2.0 detected
2025-05-09T08:56:57.297148 [ 0.000000] SBI implementation ID=0x1 Version=0x10005
2025-05-09T08:56:57.297240 [ 0.000000] SBI TIME extension detected
2025-05-09T08:56:57.297320 [ 0.000000] SBI IPI extension detected
2025-05-09T08:56:57.297395 [ 0.000000] SBI RFENCE extension detected
2025-05-09T08:56:57.297541 [ 0.000000] SBI SRST extension detected
2025-05-09T08:56:57.297799 [ 0.000000] SBI HSM extension detected
2025-05-09T08:56:57.299223 [ 0.000000] riscv: base ISA extensions acdfhim
2025-05-09T08:56:57.299313 [ 0.000000] riscv: ELF capabilities acdfim
2025-05-09T08:56:57.301911 [ 0.000000] percpu: Embedded 19 pages/cpu s40056 r8192 d29576 u77824
2025-05-09T08:56:57.302723 [ 0.000000] pcpu-alloc: s40056 r8192 d29576 u77824 alloc=19*4096
2025-05-09T08:56:57.302801 [ 0.000000] pcpu-alloc: [0] 0 [0] 1
2025-05-09T08:56:57.304148 [ 0.000000] Kernel command line: console=ttyS0,115200 rootwait root=/dev/vda debug verbose console_msg_format=syslog systemd.log_level=warning earlycon
2025-05-09T08:56:57.305095 <5>[ 0.000000] Unknown kernel command line parameters "verbose", will be passed to user space.
2025-05-09T08:56:57.306622 <6>[ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
2025-05-09T08:56:57.307383 <6>[ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
2025-05-09T08:56:57.307923 <6>[ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1032192
2025-05-09T08:56:57.308350 <6>[ 0.000000] mem auto-init: stack:all(zero), heap alloc:off, heap free:off
2025-05-09T08:56:57.308627 <6>[ 0.000000] software IO TLB: area num 2.
2025-05-09T08:56:57.336139 <6>[ 0.000000] software IO TLB: mapped [mem 0x00000000fbfff000-0x00000000fffff000] (64MB)
2025-05-09T08:56:57.362650 <5>[ 0.000000] Virtual kernel memory layout:
2025-05-09T08:56:57.362812 <5>[ 0.000000] fixmap : 0xff1bfffffea00000 - 0xff1bffffff000000 (6144 kB)
2025-05-09T08:56:57.362982 <5>[ 0.000000] pci io : 0xff1bffffff000000 - 0xff1c000000000000 ( 16 MB)
2025-05-09T08:56:57.363236 <5>[ 0.000000] vmemmap : 0xff1c000000000000 - 0xff20000000000000 (1024 TB)
2025-05-09T08:56:57.363443 <5>[ 0.000000] vmalloc : 0xff20000000000000 - 0xff60000000000000 (16384 TB)
2025-05-09T08:56:57.363668 <5>[ 0.000000] modules : 0xffffffff01576000 - 0xffffffff80000000 (2026 MB)
2025-05-09T08:56:57.363898 <5>[ 0.000000] lowmem : 0xff60000000000000 - 0xff60000100000000 (4096 MB)
2025-05-09T08:56:57.364135 <5>[ 0.000000] kernel : 0xffffffff80000000 - 0xffffffffffffffff (2047 MB)
2025-05-09T08:56:57.364602 <6>[ 0.000000] Memory: 4016656K/4194304K available (8714K kernel code, 4961K rwdata, 4096K rodata, 2195K init, 476K bss, 177648K reserved, 0K cma-reserved)
2025-05-09T08:56:57.368331 <6>[ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
2025-05-09T08:56:57.373598 <6>[ 0.000000] rcu: Hierarchical RCU implementation.
2025-05-09T08:56:57.373693 <6>[ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=64 to nr_cpu_ids=2.
2025-05-09T08:56:57.373890 <6>[ 0.000000] rcu: RCU debug extended QS entry/exit.
2025-05-09T08:56:57.374088 <6>[ 0.000000] Tracing variant of Tasks RCU enabled.
2025-05-09T08:56:57.374438 <6>[ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
2025-05-09T08:56:57.374655 <6>[ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
2025-05-09T08:56:57.375588 <6>[ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
2025-05-09T08:56:57.377335 <6>[ 0.000000] riscv-intc: 64 local interrupts mapped
2025-05-09T08:56:57.382350 <6>[ 0.000000] plic: plic@c000000: mapped 95 interrupts with 2 handlers for 4 contexts.
2025-05-09T08:56:57.383877 <6>[ 0.000000] riscv: providing IPIs using SBI IPI extension
2025-05-09T08:56:57.384149 <6>[ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.
2025-05-09T08:56:57.385481 <6>[ 0.000000] riscv-timer: riscv_timer_init_dt: Registering clocksource cpuid [0] hartid [0]
2025-05-09T08:56:57.385951 <6>[ 0.000000] clocksource: riscv_clocksource: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns
2025-05-09T08:56:57.386449 <6>[ 0.000046] sched_clock: 64 bits at 10MHz, resolution 100ns, wraps every 4398046511100ns
2025-05-09T08:56:57.386704 <6>[ 0.000340] riscv-timer: Timer interrupt in S-mode is available via sstc extension
2025-05-09T08:56:57.391477 <6>[ 0.005007] Console: colour dummy device 80x25
2025-05-09T08:56:57.394631 <6>[ 0.008146] Calibrating delay loop (skipped), value calculated using timer frequency.. 20.00 BogoMIPS (lpj=40000)
2025-05-09T08:56:57.394838 <6>[ 0.008540] pid_max: default: 32768 minimum: 301
2025-05-09T08:56:57.395978 <6>[ 0.009540] LSM: initializing lsm=capability,integrity
2025-05-09T08:56:57.397841 <6>[ 0.011414] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
2025-05-09T08:56:57.398041 <6>[ 0.011656] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
2025-05-09T08:56:57.423397 <6>[ 0.036948] cblist_init_generic: Setting adjustable number of callback queues.
2025-05-09T08:56:57.423515 <6>[ 0.037172] cblist_init_generic: Setting shift to 1 and lim to 1.
2025-05-09T08:56:57.424282 <6>[ 0.037599] riscv: ELF compat mode supported
2025-05-09T08:56:57.424370 <6>[ 0.037856] ASID allocator using 16 bits (65536 entries)
2025-05-09T08:56:57.425265 <6>[ 0.038880] rcu: Hierarchical SRCU implementation.
2025-05-09T08:56:57.425391 <6>[ 0.039066] rcu: Max phase no-delay instances is 1000.
2025-05-09T08:56:57.427018 <6>[ 0.040630] EFI services will not be available.
2025-05-09T08:56:57.428465 <6>[ 0.042092] smp: Bringing up secondary CPUs ...
2025-05-09T08:56:57.434808 <6>[ 0.048379] smp: Brought up 1 node, 2 CPUs
2025-05-09T08:56:57.446068 <6>[ 0.059674] devtmpfs: initialized
2025-05-09T08:56:57.451775 <6>[ 0.065335] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
2025-05-09T08:56:57.452097 <6>[ 0.065747] futex hash table entries: 512 (order: 3, 32768 bytes, linear)
2025-05-09T08:56:57.454037 <6>[ 0.067616] pinctrl core: initialized pinctrl subsystem
2025-05-09T08:56:57.458836 <6>[ 0.072419] NET: Registered PF_NETLINK/PF_ROUTE protocol family
2025-05-09T08:56:57.461873 <6>[ 0.075340] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations
2025-05-09T08:56:57.462503 <6>[ 0.076082] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
2025-05-09T08:56:57.462819 <6>[ 0.076488] audit: initializing netlink subsys (disabled)
2025-05-09T08:56:57.465932 <6>[ 0.079513] cpuidle: using governor menu
2025-05-09T08:56:57.466368 <5>[ 0.079928] audit: type=2000 audit(0.072:1): state=initialized audit_enabled=0 res=1
2025-05-09T08:56:57.477659 <6>[ 0.091256] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
2025-05-09T08:56:57.477806 <6>[ 0.091468] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page
2025-05-09T08:56:57.482195 <6>[ 0.095765] iommu: Default domain type: Translated
2025-05-09T08:56:57.482285 <6>[ 0.095935] iommu: DMA domain TLB invalidation policy: strict mode
2025-05-09T08:56:57.484127 <5>[ 0.097737] SCSI subsystem initialized
2025-05-09T08:56:57.484928 <7>[ 0.098491] libata version 3.00 loaded.
2025-05-09T08:56:57.485717 <6>[ 0.099302] usbcore: registered new interface driver usbfs
2025-05-09T08:56:57.486047 <6>[ 0.099693] usbcore: registered new interface driver hub
2025-05-09T08:56:57.486325 <6>[ 0.099974] usbcore: registered new device driver usb
2025-05-09T08:56:57.495918 <6>[ 0.109472] vgaarb: loaded
2025-05-09T08:56:57.499120 <6>[ 0.112681] clocksource: Switched to clocksource riscv_clocksource
2025-05-09T08:56:57.524089 <6>[ 0.137606] NET: Registered PF_INET protocol family
2025-05-09T08:56:57.525168 <6>[ 0.138780] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)
2025-05-09T08:56:57.531305 <6>[ 0.144885] tcp_listen_portaddr_hash hash table entries: 2048 (order: 4, 65536 bytes, linear)
2025-05-09T08:56:57.531626 <6>[ 0.145241] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
2025-05-09T08:56:57.531871 <6>[ 0.145497] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)
2025-05-09T08:56:57.532478 <6>[ 0.146070] TCP bind hash table entries: 32768 (order: 9, 2097152 bytes, linear)
2025-05-09T08:56:57.534959 <6>[ 0.148541] TCP: Hash tables configured (established 32768 bind 32768)
2025-05-09T08:56:57.536049 <6>[ 0.149659] UDP hash table entries: 2048 (order: 5, 196608 bytes, linear)
2025-05-09T08:56:57.536601 <6>[ 0.150204] UDP-Lite hash table entries: 2048 (order: 5, 196608 bytes, linear)
2025-05-09T08:56:57.537840 <6>[ 0.151457] NET: Registered PF_UNIX/PF_LOCAL protocol family
2025-05-09T08:56:57.540280 <6>[ 0.153872] RPC: Registered named UNIX socket transport module.
2025-05-09T08:56:57.540426 <6>[ 0.154112] RPC: Registered udp transport module.
2025-05-09T08:56:57.540593 <6>[ 0.154277] RPC: Registered tcp transport module.
2025-05-09T08:56:57.540793 <6>[ 0.154435] RPC: Registered tcp NFSv4.1 backchannel transport module.
2025-05-09T08:56:57.541063 <6>[ 0.154751] PCI: CLS 0 bytes, default 64
2025-05-09T08:56:57.543669 <6>[ 0.157242] workingset: timestamp_bits=46 max_order=20 bucket_order=0
2025-05-09T08:56:57.546288 <5>[ 0.159871] NFS: Registering the id_resolver key type
2025-05-09T08:56:57.547116 <5>[ 0.160739] Key type id_resolver registered
2025-05-09T08:56:57.547174 <5>[ 0.160889] Key type id_legacy registered
2025-05-09T08:56:57.547580 <6>[ 0.161216] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
2025-05-09T08:56:57.547853 <6>[ 0.161481] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering...
2025-05-09T08:56:57.548612 <6>[ 0.162189] 9p: Installing v9fs 9p2000 file system support
2025-05-09T08:56:57.549901 <6>[ 0.163522] NET: Registered PF_ALG protocol family
2025-05-09T08:56:57.550361 <6>[ 0.163987] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 246)
2025-05-09T08:56:57.550627 <6>[ 0.164279] io scheduler mq-deadline registered
2025-05-09T08:56:57.550918 <6>[ 0.164519] io scheduler kyber registered
2025-05-09T08:56:57.551060 <6>[ 0.164769] io scheduler bfq registered
2025-05-09T08:56:57.554452 <6>[ 0.167985] pci-host-generic 30000000.pci: host bridge /soc/pci@30000000 ranges:
2025-05-09T08:56:57.555223 <6>[ 0.168786] pci-host-generic 30000000.pci: IO 0x0003000000..0x000300ffff -> 0x0000000000
2025-05-09T08:56:57.555822 <6>[ 0.169389] pci-host-generic 30000000.pci: MEM 0x0040000000..0x007fffffff -> 0x0040000000
2025-05-09T08:56:57.556126 <6>[ 0.169708] pci-host-generic 30000000.pci: MEM 0x0400000000..0x07ffffffff -> 0x0400000000
2025-05-09T08:56:57.556771 <4>[ 0.170357] pci-host-generic 30000000.pci: Memory resource size exceeds max for 32 bits
2025-05-09T08:56:57.557497 <6>[ 0.170891] pci-host-generic 30000000.pci: ECAM at [mem 0x30000000-0x3fffffff] for [bus 00-ff]
2025-05-09T08:56:57.558491 <6>[ 0.172111] pci-host-generic 30000000.pci: PCI host bridge to bus 0000:00
2025-05-09T08:56:57.558888 <6>[ 0.172553] pci_bus 0000:00: root bus resource [bus 00-ff]
2025-05-09T08:56:57.559157 <6>[ 0.172786] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]
2025-05-09T08:56:57.559373 <6>[ 0.173008] pci_bus 0000:00: root bus resource [mem 0x40000000-0x7fffffff]
2025-05-09T08:56:57.559588 <6>[ 0.173218] pci_bus 0000:00: root bus resource [mem 0x400000000-0x7ffffffff]
2025-05-09T08:56:57.560669 <6>[ 0.174290] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000
2025-05-09T08:56:57.563296 <6>[ 0.176884] pci 0000:00:01.0: [1af4:1001] type 00 class 0x010000
2025-05-09T08:56:57.563604 <6>[ 0.177221] pci 0000:00:01.0: reg 0x10: [io 0x0000-0x007f]
2025-05-09T08:56:57.563756 <6>[ 0.177422] pci 0000:00:01.0: reg 0x14: [mem 0x00000000-0x00000fff]
2025-05-09T08:56:57.564094 <6>[ 0.177659] pci 0000:00:01.0: reg 0x20: [mem 0x00000000-0x00003fff 64bit pref]
2025-05-09T08:56:57.565737 <6>[ 0.179313] pci 0000:00:01.0: BAR 4: assigned [mem 0x400000000-0x400003fff 64bit pref]
2025-05-09T08:56:57.566110 <6>[ 0.179751] pci 0000:00:01.0: BAR 1: assigned [mem 0x40000000-0x40000fff]
2025-05-09T08:56:57.566305 <6>[ 0.179973] pci 0000:00:01.0: BAR 0: assigned [io 0x0080-0x00ff]
2025-05-09T08:56:57.571088 <6>[ 0.184697] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)
2025-05-09T08:56:57.669536 <6>[ 0.283118] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
2025-05-09T08:56:57.676381 <6>[ 0.289954] printk: console [ttyS0] disabled
2025-05-09T08:56:57.677729 <6>[ 0.291339] 10000000.serial: ttyS0 at MMIO 0x10000000 (irq = 13, base_baud = 230400) is a 16550A
2025-05-09T08:56:57.679304 <6>[ 0.292772] printk: console [ttyS0] enabled
2025-05-09T08:56:57.679387 <6>[ 0.292772] printk: console [ttyS0] enabled
2025-05-09T08:56:57.679580 <6>[ 0.293265] printk: bootconsole [ns16550a0] disabled
2025-05-09T08:56:57.679712 <6>[ 0.293265] printk: bootconsole [ns16550a0] disabled
2025-05-09T08:56:57.681604 <6>[ 0.295192] SuperH (H)SCI(F) driver initialized
2025-05-09T08:56:57.693295 <6>[ 0.306882] loop: module loaded
2025-05-09T08:56:57.694142 <6>[ 0.307717] virtio_blk virtio0: 2/0/0 default/read/poll queues
2025-05-09T08:56:57.697307 <5>[ 0.310890] virtio_blk virtio0: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)
2025-05-09T08:56:57.711838 <6>[ 0.325419] e1000e: Intel(R) PRO/1000 Network Driver
2025-05-09T08:56:57.711927 <6>[ 0.325590] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
2025-05-09T08:56:57.713811 <6>[ 0.327423] usbcore: registered new interface driver uas
2025-05-09T08:56:57.714103 <6>[ 0.327713] usbcore: registered new interface driver usb-storage
2025-05-09T08:56:57.715207 <6>[ 0.328825] mousedev: PS/2 mouse device common for all mice
2025-05-09T08:56:57.717441 <6>[ 0.331023] goldfish_rtc 101000.rtc: registered as rtc0
2025-05-09T08:56:57.718209 <6>[ 0.331606] goldfish_rtc 101000.rtc: setting system clock to 2025-05-09T08:56:57 UTC (1746781017)
2025-05-09T08:56:57.721006 <3>[ 0.334320] syscon-poweroff poweroff: pm_power_off already claimed for sbi_srst_power_off
2025-05-09T08:56:57.721223 <4>[ 0.334866] syscon-poweroff: probe of poweroff failed with error -16
2025-05-09T08:56:57.722912 <6>[ 0.336484] sdhci: Secure Digital Host Controller Interface driver
2025-05-09T08:56:57.723059 <6>[ 0.336692] sdhci: Copyright(c) Pierre Ossman
2025-05-09T08:56:57.723711 <6>[ 0.337293] sdhci-pltfm: SDHCI platform and OF driver helper
2025-05-09T08:56:57.724578 <6>[ 0.338155] usbcore: registered new interface driver usbhid
2025-05-09T08:56:57.724755 <6>[ 0.338401] usbhid: USB HID core driver
2025-05-09T08:56:57.725461 <6>[ 0.339041] riscv-pmu-sbi: SBI PMU extension is available
2025-05-09T08:56:57.726153 <6>[ 0.339732] riscv-pmu-sbi: 16 firmware and 18 hardware counters
2025-05-09T08:56:57.726497 <6>[ 0.340046] riscv-pmu-sbi: Perf sampling/filtering is not supported as sscof extension is not available
2025-05-09T08:56:57.729782 <6>[ 0.343371] NET: Registered PF_INET6 protocol family
2025-05-09T08:56:57.736069 <6>[ 0.349652] Segment Routing with IPv6
2025-05-09T08:56:57.736213 <6>[ 0.349910] In-situ OAM (IOAM) with IPv6
2025-05-09T08:56:57.736730 <6>[ 0.350332] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver
2025-05-09T08:56:57.739100 <6>[ 0.352686] NET: Registered PF_PACKET protocol family
2025-05-09T08:56:57.740163 <6>[ 0.353754] 9pnet: Installing 9P2000 support
2025-05-09T08:56:57.740438 <5>[ 0.354100] Key type dns_resolver registered
2025-05-09T08:56:57.740991 <7>[ 0.354615] start plist test
2025-05-09T08:56:57.746585 <7>[ 0.360180] end plist test
2025-05-09T08:56:57.767885 <6>[ 0.381431] debug_vm_pgtable: [debug_vm_pgtable ]: Validating architecture page table helpers
2025-05-09T08:56:57.773207 <6>[ 0.386775] clk: Disabling unused clocks
2025-05-09T08:56:57.806155 <6>[ 0.419695] EXT4-fs (vda): orphan cleanup on readonly fs
2025-05-09T08:56:57.807109 <6>[ 0.420552] EXT4-fs (vda): mounted filesystem e975691a-5fdc-4ac2-b569-9a6f784cf67a ro with ordered data mode. Quota mode: disabled.
2025-05-09T08:56:57.807499 <6>[ 0.421135] VFS: Mounted root (ext4 filesystem) readonly on device 254:0.
2025-05-09T08:56:57.808828 <6>[ 0.422440] devtmpfs: mounted
2025-05-09T08:56:57.845449 <6>[ 0.458977] Freeing unused kernel image (initmem) memory: 2192K
2025-05-09T08:56:57.851521 <6>[ 0.465065] Run /sbin/init as init process
2025-05-09T08:56:57.851621 <7>[ 0.465278] with arguments:
2025-05-09T08:56:57.851711 <7>[ 0.465403] /sbin/init
2025-05-09T08:56:57.851785 <7>[ 0.465484] verbose
2025-05-09T08:56:57.851877 <7>[ 0.465557] with environment:
2025-05-09T08:56:57.851957 <7>[ 0.465663] HOME=/
2025-05-09T08:56:57.852049 <7>[ 0.465740] TERM=linux
2025-05-09T08:56:57.961448 <6>[ 0.574892] EXT4-fs (vda): re-mounted e975691a-5fdc-4ac2-b569-9a6f784cf67a r/w. Quota mode: disabled.
2025-05-09T08:56:58.192653 Saving 256 bits of creditable seed for next boot
2025-05-09T08:56:58.264640 Starting syslogd: OK
2025-05-09T08:56:58.319155 Starting klogd: OK
2025-05-09T08:56:58.419998 Running sysctl: OK
2025-05-09T08:56:58.655691 Starting network: OK
2025-05-09T08:56:58.700615 Starting crond: OK
2025-05-09T08:56:58.817152
2025-05-09T08:56:58.818287 Welcome to TuxTest
2025-05-09T08:56:58.920530
tuxtest login: root
2025-05-09T08:56:59.055479 root@tuxtest:~#
2025-05-09T08:56:59.158347 root@tuxtest:~# #
2025-05-09T08:56:59.261290 root@tuxtest:~# export SHELL=/bin/sh
2025-05-09T08:56:59.363943 root@tuxtest:~# . /lava-1/environment
2025-05-09T08:56:59.467620 root@tuxtest:~# /lava-1/bin/lava-test-runner /lava-1/0
2025-05-09T08:56:59.639090 + export TESTRUN_ID=0_ltp-smoke
2025-05-09T08:56:59.639242 + TESTRUN_ID=0_ltp-smoke
2025-05-09T08:56:59.639324 + cd /lava-1/0/tests/0_ltp-smoke
2025-05-09T08:56:59.645000 ++ cat uuid
2025-05-09T08:56:59.654917 + UUID=1_1.1.3.1
2025-05-09T08:56:59.655190 + set +x
2025-05-09T08:56:59.656033 <8>[ 2.269622] <LAVA_SIGNAL_STARTRUN 0_ltp-smoke 1_1.1.3.1>
2025-05-09T08:56:59.656476 + cd ./automated/linux/ltp/
2025-05-09T08:56:59.659157 + ./ltp.sh -T smoketest -s true -v '' -M 5 -R root -r '' -b '' -d /scratch -g '' -e production -i /opt/ltp/ -S /tuxtest/skipfiles/riscv64/ltp-smoke -p '' -u '' -t false -n 1 -c 1
2025-05-09T08:56:59.676813 + . ../../lib/sh-test-lib
2025-05-09T08:56:59.678310 ++ LANG=C
2025-05-09T08:56:59.678531 ++ export LANG
2025-05-09T08:56:59.693071 ++ export PATH=/lava-1/0/../bin:/bin:/sbin:/usr/bin:/usr/sbin:/sbin:/usr/sbin:/usr/local/sbin
2025-05-09T08:56:59.693338 ++ PATH=/lava-1/0/../bin:/bin:/sbin:/usr/bin:/usr/sbin:/sbin:/usr/sbin:/usr/local/sbin
2025-05-09T08:56:59.698691 ++ kernel_config=
2025-05-09T08:56:59.706847 ++ pwd
2025-05-09T08:56:59.710188 + OUTPUT=/lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output
2025-05-09T08:56:59.711064 + RESULT_FILE=/lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output/result.txt
2025-05-09T08:56:59.717658 ++ readlink -f ./ltp.sh
2025-05-09T08:56:59.730222 + SCRIPT=/lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/ltp.sh
2025-05-09T08:56:59.737558 ++ dirname /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/ltp.sh
2025-05-09T08:56:59.747665 + SCRIPTPATH=/lava-1/0/tests/0_ltp-smoke/automated/linux/ltp
2025-05-09T08:56:59.748554 + echo 'Script path is: /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp'
2025-05-09T08:56:59.749039 Script path is: /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp
2025-05-09T08:56:59.749250 + TST_CMDFILES=
2025-05-09T08:56:59.749462 + SKIPFILE=
2025-05-09T08:56:59.749672 + SKIPFILE_YAML=
2025-05-09T08:56:59.749719 + BOARD=
2025-05-09T08:56:59.749927 + BRANCH=
2025-05-09T08:56:59.749976 + ENVIRONMENT=
2025-05-09T08:56:59.750192 + LTP_VERSION=20180926
2025-05-09T08:56:59.750409 + TEST_PROGRAM=ltp
2025-05-09T08:56:59.750451 + TEST_GIT_URL=
2025-05-09T08:56:59.756493 ++ pwd
2025-05-09T08:56:59.759305 + TEST_DIR=/lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/ltp
2025-05-09T08:56:59.759974 + BUILD_FROM_TAR=false
2025-05-09T08:56:59.760046 + SHARD_NUMBER=1
2025-05-09T08:56:59.760281 + SHARD_INDEX=1
2025-05-09T08:56:59.760526 + RUNNER=
2025-05-09T08:56:59.760597 + LTP_TMPDIR=/ltp-tmp
2025-05-09T08:56:59.760878 + LTP_INSTALL_PATH=/opt/ltp
2025-05-09T08:56:59.763248 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-05-09T08:56:59.764385 + case "$arg" in
2025-05-09T08:56:59.764456 + TST_CMDFILES=smoketest
2025-05-09T08:56:59.775177 ++ echo smoketest
2025-05-09T08:56:59.776184 ++ sed 's,\/,_,'
2025-05-09T08:56:59.789471 + LOG_FILE=smoketest
2025-05-09T08:56:59.790269 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-05-09T08:56:59.790679 + case "$arg" in
2025-05-09T08:56:59.791126 + SKIP_INSTALL=true
2025-05-09T08:56:59.791403 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-05-09T08:56:59.791447 + case "$arg" in
2025-05-09T08:56:59.791661 + LTP_VERSION=
2025-05-09T08:56:59.792088 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-05-09T08:56:59.792133 + case "$arg" in
2025-05-09T08:56:59.792382 + export LTP_TIMEOUT_MUL=5
2025-05-09T08:56:59.792449 + LTP_TIMEOUT_MUL=5
2025-05-09T08:56:59.792673 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-05-09T08:56:59.792897 + case "$arg" in
2025-05-09T08:56:59.793154 + export PASSWD=root
2025-05-09T08:56:59.793199 + PASSWD=root
2025-05-09T08:56:59.793438 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-05-09T08:56:59.793489 + case "$arg" in
2025-05-09T08:56:59.793698 + export RUNNER=
2025-05-09T08:56:59.793748 + RUNNER=
2025-05-09T08:56:59.793959 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-05-09T08:56:59.794181 + case "$arg" in
2025-05-09T08:56:59.794245 + export BOARD=
2025-05-09T08:56:59.794472 + BOARD=
2025-05-09T08:56:59.794863 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-05-09T08:56:59.795112 + case "$arg" in
2025-05-09T08:56:59.795332 + export LTP_TMPDIR=/scratch
2025-05-09T08:56:59.795375 + LTP_TMPDIR=/scratch
2025-05-09T08:56:59.795663 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-05-09T08:56:59.795708 + case "$arg" in
2025-05-09T08:56:59.795947 + export BRANCH=
2025-05-09T08:56:59.795989 + BRANCH=
2025-05-09T08:56:59.796360 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-05-09T08:56:59.796405 + case "$arg" in
2025-05-09T08:56:59.796612 + export ENVIRONMENT=production
2025-05-09T08:56:59.796842 + ENVIRONMENT=production
2025-05-09T08:56:59.797088 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-05-09T08:56:59.797132 + case "$arg" in
2025-05-09T08:56:59.797339 + export LTP_INSTALL_PATH=/opt/ltp/
2025-05-09T08:56:59.797580 + LTP_INSTALL_PATH=/opt/ltp/
2025-05-09T08:56:59.797645 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-05-09T08:56:59.797857 + case "$arg" in
2025-05-09T08:56:59.798816 + '[' -z /tuxtest/skipfiles/riscv64/ltp-smoke ']'
2025-05-09T08:56:59.800348 + '[' /tuxtest/skipfiles/riscv64/ltp-smoke = yaml ']'
2025-05-09T08:56:59.801800 + '[' / == / ']'
2025-05-09T08:56:59.802224 + SKIPFILE='-S /tuxtest/skipfiles/riscv64/ltp-smoke'
2025-05-09T08:56:59.802660 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-05-09T08:56:59.803202 + case "$arg" in
2025-05-09T08:56:59.804144 + [[ '' != '' ]]
2025-05-09T08:56:59.804577 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-05-09T08:56:59.804800 + case "$arg" in
2025-05-09T08:56:59.804851 + [[ '' != '' ]]
2025-05-09T08:56:59.805269 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-05-09T08:56:59.805322 + case "$arg" in
2025-05-09T08:56:59.805539 + BUILD_FROM_TAR=false
2025-05-09T08:56:59.805955 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-05-09T08:56:59.806020 + case "$arg" in
2025-05-09T08:56:59.806234 + SHARD_NUMBER=1
2025-05-09T08:56:59.806459 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-05-09T08:56:59.806849 + case "$arg" in
2025-05-09T08:56:59.807240 + SHARD_INDEX=1
2025-05-09T08:56:59.807463 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-05-09T08:56:59.808980 + TEST_TARFILE=https://github.com/linux-test-project/ltp/releases/download//ltp-full-.tar.xz
2025-05-09T08:56:59.809448 + '[' -n '' ']'
2025-05-09T08:56:59.815456 + check_root
2025-05-09T08:56:59.822041 ++ id -ru
2025-05-09T08:56:59.832904 + '[' 0 -eq 0 ']'
2025-05-09T08:56:59.833186 + return 0
2025-05-09T08:56:59.833936 + create_out_dir /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output
2025-05-09T08:56:59.834671 + '[' -z /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output ']'
2025-05-09T08:56:59.835184 + local OUTPUT=/lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output
2025-05-09T08:56:59.836037 + '[' -d /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output ']'
2025-05-09T08:56:59.836447 + mkdir -p /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output
2025-05-09T08:56:59.849501 + '[' -d /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output ']'
2025-05-09T08:56:59.850635 + info_msg 'About to run ltp test...'
2025-05-09T08:56:59.851109 + local 'msg=About to run ltp test...'
2025-05-09T08:56:59.851342 + '[' -z 'About to run ltp test...' ']'
2025-05-09T08:56:59.851799 + printf 'INFO: %s\n' 'About to run ltp test...'
2025-05-09T08:56:59.852075 INFO: About to run ltp test...
2025-05-09T08:56:59.852521 + info_msg 'Output directory: /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output'
2025-05-09T08:56:59.852989 + local 'msg=Output directory: /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output'
2025-05-09T08:56:59.853348 + '[' -z 'Output directory: /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output' ']'
2025-05-09T08:56:59.853749 + printf 'INFO: %s\n' 'Output directory: /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output'
2025-05-09T08:56:59.853993 INFO: Output directory: /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output
2025-05-09T08:56:59.854224 + '[' true = true ']'
2025-05-09T08:56:59.854469 + info_msg 'ltp installation skipped altogether'
2025-05-09T08:56:59.854921 + local 'msg=ltp installation skipped altogether'
2025-05-09T08:56:59.855181 + '[' -z 'ltp installation skipped altogether' ']'
2025-05-09T08:56:59.855438 + printf 'INFO: %s\n' 'ltp installation skipped altogether'
2025-05-09T08:56:59.855689 INFO: ltp installation skipped altogether
2025-05-09T08:56:59.856168 + '[' '!' -d /opt/ltp/ ']'
2025-05-09T08:56:59.856946 + info_msg 'Running prep_system'
2025-05-09T08:56:59.857199 + local 'msg=Running prep_system'
2025-05-09T08:56:59.857461 + '[' -z 'Running prep_system' ']'
2025-05-09T08:56:59.857685 + printf 'INFO: %s\n' 'Running prep_system'
2025-05-09T08:56:59.857730 INFO: Running prep_system
2025-05-09T08:56:59.857948 + prep_system
2025-05-09T08:56:59.858213 + systemctl is-active systemd-timesyncd
2025-05-09T08:56:59.867755 + '[' -f /proc/sys/kernel/unprivileged_userns_clone ']'
2025-05-09T08:56:59.868313 + info_msg 'Kernel has no support of unprivileged_userns_clone'
2025-05-09T08:56:59.868879 + local 'msg=Kernel has no support of unprivileged_userns_clone'
2025-05-09T08:56:59.869313 + '[' -z 'Kernel has no support of unprivileged_userns_clone' ']'
2025-05-09T08:56:59.869626 + printf 'INFO: %s\n' 'Kernel has no support of unprivileged_userns_clone'
2025-05-09T08:56:59.869690 INFO: Kernel has no support of unprivileged_userns_clone
2025-05-09T08:56:59.870246 + info_msg 'Running run_ltp'
2025-05-09T08:56:59.870524 + local 'msg=Running run_ltp'
2025-05-09T08:56:59.870755 + '[' -z 'Running run_ltp' ']'
2025-05-09T08:56:59.871050 + printf 'INFO: %s\n' 'Running run_ltp'
2025-05-09T08:56:59.871095 INFO: Running run_ltp
2025-05-09T08:56:59.871150 + run_ltp
2025-05-09T08:56:59.871707 + cd /opt/ltp/
2025-05-09T08:56:59.872620 + mkdir -m 777 -p /scratch
2025-05-09T08:56:59.887664 + for file in ${TST_CMDFILES//,/ }
2025-05-09T08:56:59.887995 + cat runtest/smoketest
2025-05-09T08:56:59.905174 + sed -i 's/#.*$//;/^$/d' alltests
2025-05-09T08:56:59.925060 + split --verbose --numeric-suffixes=1 -n l/1/1 alltests
2025-05-09T08:56:59.943624 + echo '============== Tests to run ==============='
2025-05-09T08:56:59.943802 ============== Tests to run ===============
2025-05-09T08:56:59.944243 + cat runtest/shardfile
2025-05-09T08:56:59.955993 access01 access01
2025-05-09T08:56:59.956181 chdir01 chdir01
2025-05-09T08:56:59.956356 fork01 fork01
2025-05-09T08:56:59.956432 time01 time01
2025-05-09T08:56:59.956491 wait02 wait02
2025-05-09T08:56:59.956542 write01 write01
2025-05-09T08:56:59.956614 symlink01 symlink01
2025-05-09T08:56:59.956672 stat04 stat04
2025-05-09T08:56:59.956725 splice02 splice02 -s 20
2025-05-09T08:56:59.956776 df01_sh df01.sh
2025-05-09T08:56:59.956826 shell_test01 echo "SUCCESS" | shell_pipe01.sh
2025-05-09T08:56:59.956875 ping602 ping02.sh -6
2025-05-09T08:56:59.956922 macsec02 macsec02.sh
2025-05-09T08:56:59.958297 + echo '===========End Tests to run ==============='
2025-05-09T08:56:59.958707 ===========End Tests to run ===============
2025-05-09T08:56:59.959153 + '[' -n '' ']'
2025-05-09T08:56:59.961189 + pipe0_status './runltp -p -q -f shardfile -l /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output/LTP_smoketest.log -C /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output/LTP_smoketest.failed -d /scratch -S /tuxtest/skipfiles/riscv64/ltp-smoke' 'tee /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output/LTP_smoketest.out'
2025-05-09T08:56:59.961765 + '[' 2 -ne 2 ']'
2025-05-09T08:56:59.963309 + local 'cmd1=./runltp -p -q -f shardfile -l /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output/LTP_smoketest.log -C /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output/LTP_smoketest.failed -d /scratch -S /tuxtest/skipfiles/riscv64/ltp-smoke'
2025-05-09T08:56:59.963825 + local 'cmd2=tee /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output/LTP_smoketest.out'
2025-05-09T08:56:59.963872 + exec
2025-05-09T08:56:59.964500 + local ret_val
2025-05-09T08:56:59.977526 ++ eval './runltp -p -q -f shardfile -l /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output/LTP_smoketest.log -C /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output/LTP_smoketest.failed -d /scratch -S /tuxtest/skipfiles/riscv64/ltp-smoke'
2025-05-09T08:56:59.977845 ++ eval 'tee /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output/LTP_smoketest.out'
2025-05-09T08:56:59.978793 +++ tee /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output/LTP_smoketest.out
2025-05-09T08:56:59.980035 +++ ./runltp -p -q -f shardfile -l /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output/LTP_smoketest.log -C /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output/LTP_smoketest.failed -d /scratch -S /tuxtest/skipfiles/riscv64/ltp-smoke
2025-05-09T08:57:00.042295 -------------------------------------------
2025-05-09T08:57:00.042722 INFO: runltp script is deprecated, try kirk
2025-05-09T08:57:00.042991 https://github.com/linux-test-project/kirk
2025-05-09T08:57:00.043066 -------------------------------------------
2025-05-09T08:57:00.135778 INFO: creating /opt/ltp/output directory
2025-05-09T08:57:00.366560 Checking for required user/group ids
2025-05-09T08:57:00.366983
2025-05-09T08:57:00.530980 'root' user id and group found.
2025-05-09T08:57:00.532007 'nobody' user id and group found.
2025-05-09T08:57:00.532707 'bin' user id and group found.
2025-05-09T08:57:00.533442 'daemon' user id and group found.
2025-05-09T08:57:00.533979 Users group found.
2025-05-09T08:57:00.534514 Sys group found.
2025-05-09T08:57:00.704841 Required users/groups exist.
2025-05-09T08:57:00.708153 no big block device was specified on commandline.
2025-05-09T08:57:00.708299 Tests which require a big block device are disabled.
2025-05-09T08:57:00.708369 You can specify it with option -z
2025-05-09T08:57:00.731821 INFO: Test start time: Fri May 9 08:57:00 UTC 2025
2025-05-09T08:57:00.734067 COMMAND: /opt/ltp/bin/ltp-pan -q -e -S -a 123 -n 123 -p -f /scratch/ltp-kN0npLsylu/alltests -l /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output/LTP_smoketest.log -C /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output/LTP_smoketest.failed -T /opt/ltp/output/LTP_RUN_ON-LTP_smoketest.log.tconf
2025-05-09T08:57:00.750313 LOG File: /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output/LTP_smoketest.log
2025-05-09T08:57:00.767296 FAILED COMMAND File: /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output/LTP_smoketest.failed
2025-05-09T08:57:00.784263 TCONF COMMAND File: /opt/ltp/output/LTP_RUN_ON-LTP_smoketest.log.tconf
2025-05-09T08:57:00.787239 Running tests.......
2025-05-09T08:57:00.843994 tst_tmpdir.c:316: TINFO: Using /scratch/ltp-kN0npLsylu/LTP_accFLLS6V as tmpdir (ext2/ext3/ext4 filesystem)
2025-05-09T08:57:00.844953 tst_test.c:1900: TINFO: LTP version: 20250130
2025-05-09T08:57:00.845333 tst_test.c:1904: TINFO: Tested kernel: 6.4.16 #1 SMP Tue Apr 8 14:28:42 CEST 2025 riscv64
2025-05-09T08:57:00.846036 tst_kconfig.c:88: TINFO: Parsing kernel config '/proc/config.gz'
2025-05-09T08:57:00.893889 tst_kconfig.c:676: TINFO: CONFIG_DEBUG_SPINLOCK kernel option detected which might slow the execution
2025-05-09T08:57:00.894355 tst_test.c:1722: TINFO: Overall timeout per run is 0h 10m 20s
2025-05-09T08:57:00.908044 access01.c:245: TPASS: access(accessfile_rwx, F_OK) as root passed
2025-05-09T08:57:00.912007 access01.c:245: TPASS: access(accessfile_rwx, F_OK) as nobody passed
2025-05-09T08:57:00.914876 access01.c:245: TPASS: access(accessfile_rwx, X_OK) as root passed
2025-05-09T08:57:00.918522 access01.c:245: TPASS: access(accessfile_rwx, X_OK) as nobody passed
2025-05-09T08:57:00.920267 access01.c:245: TPASS: access(accessfile_rwx, W_OK) as root passed
2025-05-09T08:57:00.923503 access01.c:245: TPASS: access(accessfile_rwx, W_OK) as nobody passed
2025-05-09T08:57:00.925125 access01.c:245: TPASS: access(accessfile_rwx, R_OK) as root passed
2025-05-09T08:57:00.928623 access01.c:245: TPASS: access(accessfile_rwx, R_OK) as nobody passed
2025-05-09T08:57:00.930138 access01.c:245: TPASS: access(accessfile_rwx, R_OK|W_OK) as root passed
2025-05-09T08:57:00.933812 access01.c:245: TPASS: access(accessfile_rwx, R_OK|W_OK) as nobody passed
2025-05-09T08:57:00.935715 access01.c:245: TPASS: access(accessfile_rwx, R_OK|X_OK) as root passed
2025-05-09T08:57:00.939403 access01.c:245: TPASS: access(accessfile_rwx, R_OK|X_OK) as nobody passed
2025-05-09T08:57:00.940835 access01.c:245: TPASS: access(accessfile_rwx, W_OK|X_OK) as root passed
2025-05-09T08:57:00.944219 access01.c:245: TPASS: access(accessfile_rwx, W_OK|X_OK) as nobody passed
2025-05-09T08:57:00.945665 access01.c:245: TPASS: access(accessfile_rwx, R_OK|W_OK|X_OK) as root passed
2025-05-09T08:57:00.949154 access01.c:245: TPASS: access(accessfile_rwx, R_OK|W_OK|X_OK) as nobody passed
2025-05-09T08:57:00.950461 access01.c:245: TPASS: access(accessfile_x, X_OK) as root passed
2025-05-09T08:57:00.954108 access01.c:245: TPASS: access(accessfile_x, X_OK) as nobody passed
2025-05-09T08:57:00.955614 access01.c:245: TPASS: access(accessfile_w, W_OK) as root passed
2025-05-09T08:57:00.959345 access01.c:245: TPASS: access(accessfile_w, W_OK) as nobody passed
2025-05-09T08:57:00.960895 access01.c:245: TPASS: access(accessfile_r, R_OK) as root passed
2025-05-09T08:57:00.964422 access01.c:245: TPASS: access(accessfile_r, R_OK) as nobody passed
2025-05-09T08:57:00.966299 access01.c:242: TPASS: access(accessfile_r, X_OK) as root : EACCES (13)
2025-05-09T08:57:00.969893 access01.c:242: TPASS: access(accessfile_r, X_OK) as nobody : EACCES (13)
2025-05-09T08:57:00.975270 access01.c:242: TPASS: access(accessfile_r, W_OK) as nobody : EACCES (13)
2025-05-09T08:57:00.980355 access01.c:242: TPASS: access(accessfile_w, R_OK) as nobody : EACCES (13)
2025-05-09T08:57:00.982114 access01.c:242: TPASS: access(accessfile_w, X_OK) as root : EACCES (13)
2025-05-09T08:57:00.985744 access01.c:242: TPASS: access(accessfile_w, X_OK) as nobody : EACCES (13)
2025-05-09T08:57:00.990787 access01.c:242: TPASS: access(accessfile_x, R_OK) as nobody : EACCES (13)
2025-05-09T08:57:00.995786 access01.c:242: TPASS: access(accessfile_x, W_OK) as nobody : EACCES (13)
2025-05-09T08:57:00.997642 access01.c:242: TPASS: access(accessfile_r, W_OK|X_OK) as root : EACCES (13)
2025-05-09T08:57:01.001527 access01.c:242: TPASS: access(accessfile_r, W_OK|X_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.003241 access01.c:242: TPASS: access(accessfile_r, R_OK|X_OK) as root : EACCES (13)
2025-05-09T08:57:01.006618 access01.c:242: TPASS: access(accessfile_r, R_OK|X_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.011691 access01.c:242: TPASS: access(accessfile_r, R_OK|W_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.013196 access01.c:242: TPASS: access(accessfile_r, R_OK|W_OK|X_OK) as root : EACCES (13)
2025-05-09T08:57:01.016859 access01.c:242: TPASS: access(accessfile_r, R_OK|W_OK|X_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.018504 access01.c:242: TPASS: access(accessfile_w, W_OK|X_OK) as root : EACCES (13)
2025-05-09T08:57:01.021756 access01.c:242: TPASS: access(accessfile_w, W_OK|X_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.023534 access01.c:242: TPASS: access(accessfile_w, R_OK|X_OK) as root : EACCES (13)
2025-05-09T08:57:01.027005 access01.c:242: TPASS: access(accessfile_w, R_OK|X_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.032190 access01.c:242: TPASS: access(accessfile_w, R_OK|W_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.034024 access01.c:242: TPASS: access(accessfile_w, R_OK|W_OK|X_OK) as root : EACCES (13)
2025-05-09T08:57:01.037405 access01.c:242: TPASS: access(accessfile_w, R_OK|W_OK|X_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.041915 access01.c:242: TPASS: access(accessfile_x, W_OK|X_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.046763 access01.c:242: TPASS: access(accessfile_x, R_OK|X_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.051444 access01.c:242: TPASS: access(accessfile_x, R_OK|W_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.056471 access01.c:242: TPASS: access(accessfile_x, R_OK|W_OK|X_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.058292 access01.c:245: TPASS: access(accessfile_r, W_OK) as root passed
2025-05-09T08:57:01.058798 access01.c:245: TPASS: access(accessfile_r, R_OK|W_OK) as root passed
2025-05-09T08:57:01.058918 access01.c:245: TPASS: access(accessfile_w, R_OK) as root passed
2025-05-09T08:57:01.059198 access01.c:245: TPASS: access(accessfile_w, R_OK|W_OK) as root passed
2025-05-09T08:57:01.059316 access01.c:245: TPASS: access(accessfile_x, R_OK) as root passed
2025-05-09T08:57:01.059489 access01.c:245: TPASS: access(accessfile_x, W_OK) as root passed
2025-05-09T08:57:01.059864 access01.c:245: TPASS: access(accessfile_x, R_OK|W_OK) as root passed
2025-05-09T08:57:01.060125 access01.c:245: TPASS: access(accessdir_r/accessfile_r, F_OK) as root passed
2025-05-09T08:57:01.060437 access01.c:245: TPASS: access(accessdir_r/accessfile_r, R_OK) as root passed
2025-05-09T08:57:01.060486 access01.c:245: TPASS: access(accessdir_r/accessfile_r, W_OK) as root passed
2025-05-09T08:57:01.060897 access01.c:245: TPASS: access(accessdir_r/accessfile_w, F_OK) as root passed
2025-05-09T08:57:01.061181 access01.c:245: TPASS: access(accessdir_r/accessfile_w, R_OK) as root passed
2025-05-09T08:57:01.061283 access01.c:245: TPASS: access(accessdir_r/accessfile_w, W_OK) as root passed
2025-05-09T08:57:01.061540 access01.c:245: TPASS: access(accessdir_r/accessfile_x, F_OK) as root passed
2025-05-09T08:57:01.061670 access01.c:245: TPASS: access(accessdir_r/accessfile_x, R_OK) as root passed
2025-05-09T08:57:01.062195 access01.c:245: TPASS: access(accessdir_r/accessfile_x, W_OK) as root passed
2025-05-09T08:57:01.062269 access01.c:245: TPASS: access(accessdir_r/accessfile_x, X_OK) as root passed
2025-05-09T08:57:01.062456 access01.c:245: TPASS: access(accessdir_w/accessfile_r, F_OK) as root passed
2025-05-09T08:57:01.062731 access01.c:245: TPASS: access(accessdir_w/accessfile_r, R_OK) as root passed
2025-05-09T08:57:01.062885 access01.c:245: TPASS: access(accessdir_w/accessfile_r, W_OK) as root passed
2025-05-09T08:57:01.063421 access01.c:245: TPASS: access(accessdir_w/accessfile_w, F_OK) as root passed
2025-05-09T08:57:01.063612 access01.c:245: TPASS: access(accessdir_w/accessfile_w, R_OK) as root passed
2025-05-09T08:57:01.063905 access01.c:245: TPASS: access(accessdir_w/accessfile_w, W_OK) as root passed
2025-05-09T08:57:01.064002 access01.c:245: TPASS: access(accessdir_w/accessfile_x, F_OK) as root passed
2025-05-09T08:57:01.064168 access01.c:245: TPASS: access(accessdir_w/accessfile_x, R_OK) as root passed
2025-05-09T08:57:01.064509 access01.c:245: TPASS: access(accessdir_w/accessfile_x, W_OK) as root passed
2025-05-09T08:57:01.064776 access01.c:245: TPASS: access(accessdir_w/accessfile_x, X_OK) as root passed
2025-05-09T08:57:01.064942 access01.c:245: TPASS: access(accessdir_x/accessfile_r, F_OK) as root passed
2025-05-09T08:57:01.068266 access01.c:245: TPASS: access(accessdir_x/accessfile_r, F_OK) as nobody passed
2025-05-09T08:57:01.070143 access01.c:245: TPASS: access(accessdir_x/accessfile_r, R_OK) as root passed
2025-05-09T08:57:01.073600 access01.c:245: TPASS: access(accessdir_x/accessfile_r, R_OK) as nobody passed
2025-05-09T08:57:01.075488 access01.c:245: TPASS: access(accessdir_x/accessfile_r, W_OK) as root passed
2025-05-09T08:57:01.075749 access01.c:245: TPASS: access(accessdir_x/accessfile_w, F_OK) as root passed
2025-05-09T08:57:01.079035 access01.c:245: TPASS: access(accessdir_x/accessfile_w, F_OK) as nobody passed
2025-05-09T08:57:01.081017 access01.c:245: TPASS: access(accessdir_x/accessfile_w, R_OK) as root passed
2025-05-09T08:57:01.081397 access01.c:245: TPASS: access(accessdir_x/accessfile_w, W_OK) as root passed
2025-05-09T08:57:01.084763 access01.c:245: TPASS: access(accessdir_x/accessfile_w, W_OK) as nobody passed
2025-05-09T08:57:01.086743 access01.c:245: TPASS: access(accessdir_x/accessfile_x, F_OK) as root passed
2025-05-09T08:57:01.089805 access01.c:245: TPASS: access(accessdir_x/accessfile_x, F_OK) as nobody passed
2025-05-09T08:57:01.091479 access01.c:245: TPASS: access(accessdir_x/accessfile_x, R_OK) as root passed
2025-05-09T08:57:01.091700 access01.c:245: TPASS: access(accessdir_x/accessfile_x, W_OK) as root passed
2025-05-09T08:57:01.092014 access01.c:245: TPASS: access(accessdir_x/accessfile_x, X_OK) as root passed
2025-05-09T08:57:01.095704 access01.c:245: TPASS: access(accessdir_x/accessfile_x, X_OK) as nobody passed
2025-05-09T08:57:01.098035 access01.c:245: TPASS: access(accessdir_rw/accessfile_r, F_OK) as root passed
2025-05-09T08:57:01.098334 access01.c:245: TPASS: access(accessdir_rw/accessfile_r, R_OK) as root passed
2025-05-09T08:57:01.099052 access01.c:245: TPASS: access(accessdir_rw/accessfile_r, W_OK) as root passed
2025-05-09T08:57:01.099317 access01.c:245: TPASS: access(accessdir_rw/accessfile_w, F_OK) as root passed
2025-05-09T08:57:01.099568 access01.c:245: TPASS: access(accessdir_rw/accessfile_w, R_OK) as root passed
2025-05-09T08:57:01.099851 access01.c:245: TPASS: access(accessdir_rw/accessfile_w, W_OK) as root passed
2025-05-09T08:57:01.100383 access01.c:245: TPASS: access(accessdir_rw/accessfile_x, F_OK) as root passed
2025-05-09T08:57:01.100639 access01.c:245: TPASS: access(accessdir_rw/accessfile_x, R_OK) as root passed
2025-05-09T08:57:01.101038 access01.c:245: TPASS: access(accessdir_rw/accessfile_x, W_OK) as root passed
2025-05-09T08:57:01.101476 access01.c:245: TPASS: access(accessdir_rw/accessfile_x, X_OK) as root passed
2025-05-09T08:57:01.101795 access01.c:245: TPASS: access(accessdir_rx/accessfile_r, F_OK) as root passed
2025-05-09T08:57:01.105329 access01.c:245: TPASS: access(accessdir_rx/accessfile_r, F_OK) as nobody passed
2025-05-09T08:57:01.107591 access01.c:245: TPASS: access(accessdir_rx/accessfile_r, R_OK) as root passed
2025-05-09T08:57:01.110915 access01.c:245: TPASS: access(accessdir_rx/accessfile_r, R_OK) as nobody passed
2025-05-09T08:57:01.113394 access01.c:245: TPASS: access(accessdir_rx/accessfile_r, W_OK) as root passed
2025-05-09T08:57:01.113684 access01.c:245: TPASS: access(accessdir_rx/accessfile_w, F_OK) as root passed
2025-05-09T08:57:01.116936 access01.c:245: TPASS: access(accessdir_rx/accessfile_w, F_OK) as nobody passed
2025-05-09T08:57:01.119179 access01.c:245: TPASS: access(accessdir_rx/accessfile_w, R_OK) as root passed
2025-05-09T08:57:01.119569 access01.c:245: TPASS: access(accessdir_rx/accessfile_w, W_OK) as root passed
2025-05-09T08:57:01.122825 access01.c:245: TPASS: access(accessdir_rx/accessfile_w, W_OK) as nobody passed
2025-05-09T08:57:01.125120 access01.c:245: TPASS: access(accessdir_rx/accessfile_x, F_OK) as root passed
2025-05-09T08:57:01.129020 access01.c:245: TPASS: access(accessdir_rx/accessfile_x, F_OK) as nobody passed
2025-05-09T08:57:01.131480 access01.c:245: TPASS: access(accessdir_rx/accessfile_x, R_OK) as root passed
2025-05-09T08:57:01.131771 access01.c:245: TPASS: access(accessdir_rx/accessfile_x, W_OK) as root passed
2025-05-09T08:57:01.132266 access01.c:245: TPASS: access(accessdir_rx/accessfile_x, X_OK) as root passed
2025-05-09T08:57:01.135787 access01.c:245: TPASS: access(accessdir_rx/accessfile_x, X_OK) as nobody passed
2025-05-09T08:57:01.137648 access01.c:245: TPASS: access(accessdir_wx/accessfile_r, F_OK) as root passed
2025-05-09T08:57:01.141124 access01.c:245: TPASS: access(accessdir_wx/accessfile_r, F_OK) as nobody passed
2025-05-09T08:57:01.142926 access01.c:245: TPASS: access(accessdir_wx/accessfile_r, R_OK) as root passed
2025-05-09T08:57:01.146244 access01.c:245: TPASS: access(accessdir_wx/accessfile_r, R_OK) as nobody passed
2025-05-09T08:57:01.148143 access01.c:245: TPASS: access(accessdir_wx/accessfile_r, W_OK) as root passed
2025-05-09T08:57:01.148459 access01.c:245: TPASS: access(accessdir_wx/accessfile_w, F_OK) as root passed
2025-05-09T08:57:01.151997 access01.c:245: TPASS: access(accessdir_wx/accessfile_w, F_OK) as nobody passed
2025-05-09T08:57:01.154100 access01.c:245: TPASS: access(accessdir_wx/accessfile_w, R_OK) as root passed
2025-05-09T08:57:01.154717 access01.c:245: TPASS: access(accessdir_wx/accessfile_w, W_OK) as root passed
2025-05-09T08:57:01.158345 access01.c:245: TPASS: access(accessdir_wx/accessfile_w, W_OK) as nobody passed
2025-05-09T08:57:01.160513 access01.c:245: TPASS: access(accessdir_wx/accessfile_x, F_OK) as root passed
2025-05-09T08:57:01.163929 access01.c:245: TPASS: access(accessdir_wx/accessfile_x, F_OK) as nobody passed
2025-05-09T08:57:01.165632 access01.c:245: TPASS: access(accessdir_wx/accessfile_x, R_OK) as root passed
2025-05-09T08:57:01.165848 access01.c:245: TPASS: access(accessdir_wx/accessfile_x, W_OK) as root passed
2025-05-09T08:57:01.166219 access01.c:245: TPASS: access(accessdir_wx/accessfile_x, X_OK) as root passed
2025-05-09T08:57:01.169678 access01.c:245: TPASS: access(accessdir_wx/accessfile_x, X_OK) as nobody passed
2025-05-09T08:57:01.174633 access01.c:242: TPASS: access(accessdir_r/accessfile_r, F_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.179607 access01.c:242: TPASS: access(accessdir_r/accessfile_r, R_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.184257 access01.c:242: TPASS: access(accessdir_r/accessfile_r, W_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.186215 access01.c:242: TPASS: access(accessdir_r/accessfile_r, X_OK) as root : EACCES (13)
2025-05-09T08:57:01.190988 access01.c:242: TPASS: access(accessdir_r/accessfile_r, X_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.196132 access01.c:242: TPASS: access(accessdir_r/accessfile_w, F_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.200945 access01.c:242: TPASS: access(accessdir_r/accessfile_w, R_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.206119 access01.c:242: TPASS: access(accessdir_r/accessfile_w, W_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.208081 access01.c:242: TPASS: access(accessdir_r/accessfile_w, X_OK) as root : EACCES (13)
2025-05-09T08:57:01.211411 access01.c:242: TPASS: access(accessdir_r/accessfile_w, X_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.216161 access01.c:242: TPASS: access(accessdir_r/accessfile_x, F_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.220882 access01.c:242: TPASS: access(accessdir_r/accessfile_x, R_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.225809 access01.c:242: TPASS: access(accessdir_r/accessfile_x, W_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.230629 access01.c:242: TPASS: access(accessdir_r/accessfile_x, X_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.235349 access01.c:242: TPASS: access(accessdir_w/accessfile_r, F_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.239789 access01.c:242: TPASS: access(accessdir_w/accessfile_r, R_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.244630 access01.c:242: TPASS: access(accessdir_w/accessfile_r, W_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.246357 access01.c:242: TPASS: access(accessdir_w/accessfile_r, X_OK) as root : EACCES (13)
2025-05-09T08:57:01.249727 access01.c:242: TPASS: access(accessdir_w/accessfile_r, X_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.254283 access01.c:242: TPASS: access(accessdir_w/accessfile_w, F_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.259898 access01.c:242: TPASS: access(accessdir_w/accessfile_w, R_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.265124 access01.c:242: TPASS: access(accessdir_w/accessfile_w, W_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.267101 access01.c:242: TPASS: access(accessdir_w/accessfile_w, X_OK) as root : EACCES (13)
2025-05-09T08:57:01.270328 access01.c:242: TPASS: access(accessdir_w/accessfile_w, X_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.275222 access01.c:242: TPASS: access(accessdir_w/accessfile_x, F_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.280139 access01.c:242: TPASS: access(accessdir_w/accessfile_x, R_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.284663 access01.c:242: TPASS: access(accessdir_w/accessfile_x, W_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.289233 access01.c:242: TPASS: access(accessdir_w/accessfile_x, X_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.293882 access01.c:242: TPASS: access(accessdir_x/accessfile_r, W_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.295777 access01.c:242: TPASS: access(accessdir_x/accessfile_r, X_OK) as root : EACCES (13)
2025-05-09T08:57:01.299299 access01.c:242: TPASS: access(accessdir_x/accessfile_r, X_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.303777 access01.c:242: TPASS: access(accessdir_x/accessfile_w, R_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.305294 access01.c:242: TPASS: access(accessdir_x/accessfile_w, X_OK) as root : EACCES (13)
2025-05-09T08:57:01.308753 access01.c:242: TPASS: access(accessdir_x/accessfile_w, X_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.313263 access01.c:242: TPASS: access(accessdir_x/accessfile_x, R_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.317749 access01.c:242: TPASS: access(accessdir_x/accessfile_x, W_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.321942 access01.c:242: TPASS: access(accessdir_rw/accessfile_r, F_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.326708 access01.c:242: TPASS: access(accessdir_rw/accessfile_r, R_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.331400 access01.c:242: TPASS: access(accessdir_rw/accessfile_r, W_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.333043 access01.c:242: TPASS: access(accessdir_rw/accessfile_r, X_OK) as root : EACCES (13)
2025-05-09T08:57:01.336471 access01.c:242: TPASS: access(accessdir_rw/accessfile_r, X_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.341170 access01.c:242: TPASS: access(accessdir_rw/accessfile_w, F_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.345767 access01.c:242: TPASS: access(accessdir_rw/accessfile_w, R_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.350366 access01.c:242: TPASS: access(accessdir_rw/accessfile_w, W_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.352228 access01.c:242: TPASS: access(accessdir_rw/accessfile_w, X_OK) as root : EACCES (13)
2025-05-09T08:57:01.356377 access01.c:242: TPASS: access(accessdir_rw/accessfile_w, X_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.360693 access01.c:242: TPASS: access(accessdir_rw/accessfile_x, F_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.365684 access01.c:242: TPASS: access(accessdir_rw/accessfile_x, R_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.371048 access01.c:242: TPASS: access(accessdir_rw/accessfile_x, W_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.376529 access01.c:242: TPASS: access(accessdir_rw/accessfile_x, X_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.381830 access01.c:242: TPASS: access(accessdir_rx/accessfile_r, W_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.383515 access01.c:242: TPASS: access(accessdir_rx/accessfile_r, X_OK) as root : EACCES (13)
2025-05-09T08:57:01.386331 access01.c:242: TPASS: access(accessdir_rx/accessfile_r, X_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.391687 access01.c:242: TPASS: access(accessdir_rx/accessfile_w, R_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.393711 access01.c:242: TPASS: access(accessdir_rx/accessfile_w, X_OK) as root : EACCES (13)
2025-05-09T08:57:01.396749 access01.c:242: TPASS: access(accessdir_rx/accessfile_w, X_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.402233 access01.c:242: TPASS: access(accessdir_rx/accessfile_x, R_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.406945 access01.c:242: TPASS: access(accessdir_rx/accessfile_x, W_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.411946 access01.c:242: TPASS: access(accessdir_wx/accessfile_r, W_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.414059 access01.c:242: TPASS: access(accessdir_wx/accessfile_r, X_OK) as root : EACCES (13)
2025-05-09T08:57:01.417430 access01.c:242: TPASS: access(accessdir_wx/accessfile_r, X_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.421748 access01.c:242: TPASS: access(accessdir_wx/accessfile_w, R_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.423962 access01.c:242: TPASS: access(accessdir_wx/accessfile_w, X_OK) as root : EACCES (13)
2025-05-09T08:57:01.427683 access01.c:242: TPASS: access(accessdir_wx/accessfile_w, X_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.432893 access01.c:242: TPASS: access(accessdir_wx/accessfile_x, R_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.438158 access01.c:242: TPASS: access(accessdir_wx/accessfile_x, W_OK) as nobody : EACCES (13)
2025-05-09T08:57:01.442758
2025-05-09T08:57:01.443042 Summary:
2025-05-09T08:57:01.443125 passed 199
2025-05-09T08:57:01.443205 failed 0
2025-05-09T08:57:01.443264 broken 0
2025-05-09T08:57:01.443314 skipped 0
2025-05-09T08:57:01.443362 warnings 0
2025-05-09T08:57:01.488948 tst_tmpdir.c:316: TINFO: Using /scratch/ltp-kN0npLsylu/LTP_for3h0vxl as tmpdir (ext2/ext3/ext4 filesystem)
2025-05-09T08:57:01.489671 tst_test.c:1900: TINFO: LTP version: 20250130
2025-05-09T08:57:01.490028 tst_test.c:1904: TINFO: Tested kernel: 6.4.16 #1 SMP Tue Apr 8 14:28:42 CEST 2025 riscv64
2025-05-09T08:57:01.490885 tst_kconfig.c:88: TINFO: Parsing kernel config '/proc/config.gz'
2025-05-09T08:57:01.533033 tst_kconfig.c:676: TINFO: CONFIG_DEBUG_SPINLOCK kernel option detected which might slow the execution
2025-05-09T08:57:01.533204 tst_test.c:1722: TINFO: Overall timeout per run is 0h 10m 00s
2025-05-09T08:57:01.543366 fork01.c:47: TPASS: correct child status returned 42
2025-05-09T08:57:01.544101 fork01.c:50: TPASS: child_pid == pid (284)
2025-05-09T08:57:01.546771
2025-05-09T08:57:01.547030 Summary:
2025-05-09T08:57:01.547096 passed 2
2025-05-09T08:57:01.547154 failed 0
2025-05-09T08:57:01.547205 broken 0
2025-05-09T08:57:01.547265 skipped 0
2025-05-09T08:57:01.547319 warnings 0
2025-05-09T08:57:01.566169 tst_test.c:1900: TINFO: LTP version: 20250130
2025-05-09T08:57:01.566801 tst_test.c:1904: TINFO: Tested kernel: 6.4.16 #1 SMP Tue Apr 8 14:28:42 CEST 2025 riscv64
2025-05-09T08:57:01.567176 tst_kconfig.c:88: TINFO: Parsing kernel config '/proc/config.gz'
2025-05-09T08:57:01.611426 tst_kconfig.c:676: TINFO: CONFIG_DEBUG_SPINLOCK kernel option detected which might slow the execution
2025-05-09T08:57:01.611604 tst_test.c:1722: TINFO: Overall timeout per run is 0h 10m 00s
2025-05-09T08:57:01.616439 time01.c:36: TPASS: time() returned value 1746781021
2025-05-09T08:57:01.617203 time01.c:38: TPASS: time() returned value 1746781021, stored value 1746781021 are same
2025-05-09T08:57:01.619474
2025-05-09T08:57:01.619715 Summary:
2025-05-09T08:57:01.619782 passed 2
2025-05-09T08:57:01.619853 failed 0
2025-05-09T08:57:01.619912 broken 0
2025-05-09T08:57:01.619966 skipped 0
2025-05-09T08:57:01.620031 warnings 0
2025-05-09T08:57:01.638454 tst_test.c:1900: TINFO: LTP version: 20250130
2025-05-09T08:57:01.638960 tst_test.c:1904: TINFO: Tested kernel: 6.4.16 #1 SMP Tue Apr 8 14:28:42 CEST 2025 riscv64
2025-05-09T08:57:01.639415 tst_kconfig.c:88: TINFO: Parsing kernel config '/proc/config.gz'
2025-05-09T08:57:01.681370 tst_kconfig.c:676: TINFO: CONFIG_DEBUG_SPINLOCK kernel option detected which might slow the execution
2025-05-09T08:57:01.681991 tst_test.c:1722: TINFO: Overall timeout per run is 0h 10m 00s
2025-05-09T08:57:01.690631 wait02.c:41: TPASS: wait() succeeded
2025-05-09T08:57:01.692556
2025-05-09T08:57:01.692820 Summary:
2025-05-09T08:57:01.692902 passed 1
2025-05-09T08:57:01.693000 failed 0
2025-05-09T08:57:01.693260 broken 0
2025-05-09T08:57:01.693326 skipped 0
2025-05-09T08:57:01.693393 warnings 0
2025-05-09T08:57:01.712266 tst_tmpdir.c:316: TINFO: Using /scratch/ltp-kN0npLsylu/LTP_wriVLu0qh as tmpdir (ext2/ext3/ext4 filesystem)
2025-05-09T08:57:01.712762 tst_test.c:1900: TINFO: LTP version: 20250130
2025-05-09T08:57:01.713080 tst_test.c:1904: TINFO: Tested kernel: 6.4.16 #1 SMP Tue Apr 8 14:28:42 CEST 2025 riscv64
2025-05-09T08:57:01.713525 tst_kconfig.c:88: TINFO: Parsing kernel config '/proc/config.gz'
2025-05-09T08:57:01.755383 tst_kconfig.c:676: TINFO: CONFIG_DEBUG_SPINLOCK kernel option detected which might slow the execution
2025-05-09T08:57:01.755541 tst_test.c:1722: TINFO: Overall timeout per run is 0h 10m 00s
2025-05-09T08:57:02.159474 write01.c:40: TPASS: write() passed
2025-05-09T08:57:02.161926
2025-05-09T08:57:02.162212 Summary:
2025-05-09T08:57:02.162275 passed 1
2025-05-09T08:57:02.162330 failed 0
2025-05-09T08:57:02.162377 broken 0
2025-05-09T08:57:02.162416 skipped 0
2025-05-09T08:57:02.162464 warnings 0
2025-05-09T08:57:02.248079 symlink01 0 TINFO : Using /scratch/ltp-kN0npLsylu/LTP_symjj0DNC as tmpdir (ext2/ext3/ext4 filesystem)
2025-05-09T08:57:02.248260 symlink01 1 TPASS : Creation of symbolic link file to no object file is ok
2025-05-09T08:57:02.248665 symlink01 2 TPASS : Creation of symbolic link file to no object file is ok
2025-05-09T08:57:02.249167 symlink01 3 TPASS : Creation of symbolic link file and object file via symbolic link is ok
2025-05-09T08:57:02.249239 symlink01 4 TPASS : Creating an existing symbolic link file error is caught
2025-05-09T08:57:02.249661 symlink01 5 TPASS : Creating a symbolic link which exceeds maximum pathname error is caught
2025-05-09T08:57:02.268112 tst_buffers.c:57: TINFO: Test is using guarded buffers
2025-05-09T08:57:02.270501 tst_tmpdir.c:316: TINFO: Using /scratch/ltp-kN0npLsylu/LTP_staDmxzQ4 as tmpdir (ext2/ext3/ext4 filesystem)
2025-05-09T08:57:02.281117 tst_device.c:306: TWARN: Failed to create test_dev.img: ENOSPC (28)
2025-05-09T08:57:02.281249 tst_device.c:367: TBROK: Failed to acquire device
2025-05-09T08:57:02.281329
2025-05-09T08:57:02.281431 Summary:
2025-05-09T08:57:02.281584 passed 0
2025-05-09T08:57:02.281674 failed 0
2025-05-09T08:57:02.281741 broken 1
2025-05-09T08:57:02.281856 skipped 0
2025-05-09T08:57:02.281920 warnings 1
2025-05-09T08:57:02.303794 tst_tmpdir.c:316: TINFO: Using /scratch/ltp-kN0npLsylu/LTP_splQ3yUOk as tmpdir (ext2/ext3/ext4 filesystem)
2025-05-09T08:57:02.304699 tst_test.c:1900: TINFO: LTP version: 20250130
2025-05-09T08:57:02.305194 tst_test.c:1904: TINFO: Tested kernel: 6.4.16 #1 SMP Tue Apr 8 14:28:42 CEST 2025 riscv64
2025-05-09T08:57:02.305329 tst_kconfig.c:88: TINFO: Parsing kernel config '/proc/config.gz'
2025-05-09T08:57:02.350686 tst_kconfig.c:676: TINFO: CONFIG_DEBUG_SPINLOCK kernel option detected which might slow the execution
2025-05-09T08:57:02.351373 tst_test.c:1722: TINFO: Overall timeout per run is 0h 10m 00s
2025-05-09T08:57:02.356376 splice02.c:135: TINFO: writting 20 bytes
2025-05-09T08:57:02.360583 splice02.c:87: TINFO: checking file content
2025-05-09T08:57:02.361022 splice02.c:111: TPASS: splice() system call passed
2025-05-09T08:57:02.364838
2025-05-09T08:57:02.365096 Summary:
2025-05-09T08:57:02.365165 passed 1
2025-05-09T08:57:02.365227 failed 0
2025-05-09T08:57:02.365317 broken 0
2025-05-09T08:57:02.365388 skipped 0
2025-05-09T08:57:02.365432 warnings 0
2025-05-09T08:57:02.518166 shell_pipe01 1 TINFO: Running: shell_pipe01.sh
2025-05-09T08:57:02.536894 shell_pipe01 1 TINFO: Tested kernel: Linux tuxtest 6.4.16 #1 SMP Tue Apr 8 14:28:42 CEST 2025 riscv64 GNU/Linux
2025-05-09T08:57:02.619497 shell_pipe01 1 TINFO: timeout per run is 0h 25m 0s
2025-05-09T08:57:02.676315 shell_pipe01 1 TINFO: expecting SUCCESS string passed from stdin
2025-05-09T08:57:02.699944 shell_pipe01 1 TPASS: [ SUCCESS = SUCCESS ] passed as expected
2025-05-09T08:57:02.729121
2025-05-09T08:57:02.729435 Summary:
2025-05-09T08:57:02.729518 passed 1
2025-05-09T08:57:02.729581 failed 0
2025-05-09T08:57:02.729638 broken 0
2025-05-09T08:57:02.729687 skipped 0
2025-05-09T08:57:02.729731 warnings 0
2025-05-09T08:57:02.895485 macsec02 1 TINFO: Running: macsec02.sh
2025-05-09T08:57:02.913398 macsec02 1 TINFO: Tested kernel: Linux tuxtest 6.4.16 #1 SMP Tue Apr 8 14:28:42 CEST 2025 riscv64 GNU/Linux
2025-05-09T08:57:03.553064 macsec02 1 TINFO: initialize 'lhost' 'ltp_ns_veth2' interface
2025-05-09T08:57:03.569363 cat: /proc/sys/net/ipv6/conf/ltp_ns_veth2/disable_ipv6: No such file or directory
2025-05-09T08:57:03.571305 /opt/ltp/testcases/bin/tst_net.sh: line 142: [: =: unary operator expected
2025-05-09T08:57:03.616725 ip: SIOCGIFFLAGS: No such device
2025-05-09T08:57:03.672896 macsec02 1 TINFO: initialize 'rhost' 'ltp_ns_veth1' interface
2025-05-09T08:57:04.336388 macsec02 1 TINFO: add remote addr 10.0.0.1/24
2025-05-09T08:57:04.551775 macsec02 1 TINFO: add remote addr fd00:1:1:1::1/64
2025-05-09T08:57:04.645070 ip: either "local" is duplicate, or "nodad" is garbage
2025-05-09T08:57:04.667583 # tst_net_iface_prefix.c:133: TINFO: prefix and interface not found for '10.0.0.2'.
2025-05-09T08:57:04.667701
2025-05-09T08:57:04.813813 cat: /proc/sys/net/ipv6/conf/ltp_ns_veth2/disable_ipv6: No such file or directory
2025-05-09T08:57:04.815985 /opt/ltp/testcases/bin/tst_net.sh: line 142: [: =: unary operator expected
2025-05-09T08:57:04.929323 # tst_net_iface_prefix.c:133: TINFO: prefix and interface not found for 'fd00:1:1:1::2'.
2025-05-09T08:57:04.929489
2025-05-09T08:57:05.043888 macsec02 1 TINFO: Network config (local -- remote):
2025-05-09T08:57:05.045129 macsec02 1 TINFO: ltp_ns_veth2 -- ltp_ns_veth1
2025-05-09T08:57:05.046601 macsec02 1 TINFO: 10.0.0.2/24 -- 10.0.0.1/24
2025-05-09T08:57:05.048092 macsec02 1 TINFO: fd00:1:1:1::2/64 -- fd00:1:1:1::1/64
2025-05-09T08:57:05.110039 cat: /sys/class/net/ltp_ns_veth2/mtu: No such file or directory
2025-05-09T08:57:05.153126 cat: /sys/class/net/ltp_ns_veth2/address: No such file or directory
2025-05-09T08:57:05.275709 macsec02 1 TINFO: ping6 binary/symlink is missing, using workaround. Please, report missing ping6 to your distribution.
2025-05-09T08:57:05.474979 macsec02 1 TCONF: macsec driver not available
2025-05-09T08:57:05.491089
2025-05-09T08:57:05.491446 Summary:
2025-05-09T08:57:05.491529 passed 0
2025-05-09T08:57:05.491596 failed 0
2025-05-09T08:57:05.491655 broken 0
2025-05-09T08:57:05.491707 skipped 1
2025-05-09T08:57:05.491759 warnings 0
2025-05-09T08:57:05.499044 INFO: ltp-pan reported some tests FAIL
2025-05-09T08:57:05.499938 LTP Version: 20250130
2025-05-09T08:57:05.516350 INFO: Test end time: Fri May 9 08:57:05 UTC 2025
2025-05-09T08:57:05.528544
2025-05-09T08:57:05.528897 ###############################################################
2025-05-09T08:57:05.529061
2025-05-09T08:57:05.529125 Done executing testcases.
2025-05-09T08:57:05.529182 LTP Version: 20250130
2025-05-09T08:57:05.529298 ###############################################################
2025-05-09T08:57:05.529455
2025-05-09T08:57:05.531746 -------------------------------------------
2025-05-09T08:57:05.531883 INFO: runltp script is deprecated, try kirk
2025-05-09T08:57:05.532053 https://github.com/linux-test-project/kirk
2025-05-09T08:57:05.532332 -------------------------------------------
2025-05-09T08:57:05.551944 ++ echo 1
2025-05-09T08:57:05.560471 + ret_val=1
2025-05-09T08:57:05.560578 + exec
2025-05-09T08:57:05.560857 + return 1
2025-05-09T08:57:05.561783 + parse_ltp_output /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output/LTP_smoketest.log
2025-05-09T08:57:05.568250 + grep -E 'PASS|FAIL|CONF' /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output/LTP_smoketest.log
2025-05-09T08:57:05.571781 + sed 's/PASS/pass/; s/FAIL/fail/; s/CONF/skip/'
2025-05-09T08:57:05.579480 + awk '{print $1" "$2}'
2025-05-09T08:57:05.591671 + rm -rf /scratch
2025-05-09T08:57:05.606357 + rm -rf alltests
2025-05-09T08:57:05.623317 + ../../utils/send-to-lava.sh ./output/result.txt
2025-05-09T08:57:05.713822 <8>[ 8.327396] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=access01 RESULT=pass>
2025-05-09T08:57:05.766071 <8>[ 8.379644] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=chdir01 RESULT=skip>
2025-05-09T08:57:05.817874 <8>[ 8.431450] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fork01 RESULT=pass>
2025-05-09T08:57:05.869604 <8>[ 8.483136] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=time01 RESULT=pass>
2025-05-09T08:57:05.924367 <8>[ 8.537933] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=wait02 RESULT=pass>
2025-05-09T08:57:05.975638 <8>[ 8.589215] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=write01 RESULT=pass>
2025-05-09T08:57:06.028091 <8>[ 8.641639] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=symlink01 RESULT=pass>
2025-05-09T08:57:06.080636 <8>[ 8.694180] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=stat04 RESULT=fail>
2025-05-09T08:57:06.131631 <8>[ 8.745207] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=splice02 RESULT=pass>
2025-05-09T08:57:06.182772 <8>[ 8.796322] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=df01_sh RESULT=skip>
2025-05-09T08:57:06.237261 <8>[ 8.850797] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=shell_test01 RESULT=pass>
2025-05-09T08:57:06.289710 <8>[ 8.903254] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=ping602 RESULT=skip>
2025-05-09T08:57:06.345331 <8>[ 8.958863] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=macsec02 RESULT=skip>
2025-05-09T08:57:06.349079 + set +x
2025-05-09T08:57:06.349567 <8>[ 8.963183] <LAVA_SIGNAL_ENDRUN 0_ltp-smoke 1_1.1.3.1>
2025-05-09T08:57:06.354490 <LAVA_TEST_RUNNER EXIT>
2025-05-09T08:57:07.457415 root@tuxtest:~# poweroff