2025-04-07T09:24:15.674414 Booting Linux on physical CPU 0x0000000000 [0x000f0510]
2025-04-07T09:24:15.674684 Linux version 6.4.16 (anders@monster) (aarch64-linux-gcc.br_real (Buildroot 2021.11-12449-g1bef613319) 14.2.0, GNU ld (GNU Binutils) 2.42) #1 SMP Mon Apr 7 11:12:06 CEST 2025
2025-04-07T09:24:15.674774 random: crng init done
2025-04-07T09:24:15.674847 Machine model: linux,dummy-virt
2025-04-07T09:24:15.674902 efi: UEFI not found.
2025-04-07T09:24:15.674967 earlycon: pl11 at MMIO 0x0000000009000000 (options '')
2025-04-07T09:24:15.675034 printk: bootconsole [pl11] enabled
2025-04-07T09:24:15.678736 Zone ranges:
2025-04-07T09:24:15.679170 DMA [mem 0x0000000040000000-0x00000000ffffffff]
2025-04-07T09:24:15.679230 DMA32 empty
2025-04-07T09:24:15.679288 Normal [mem 0x0000000100000000-0x000000013fffffff]
2025-04-07T09:24:15.679351 Movable zone start for each node
2025-04-07T09:24:15.679435 Early memory node ranges
2025-04-07T09:24:15.679613 node 0: [mem 0x0000000040000000-0x000000013fffffff]
2025-04-07T09:24:15.679995 Initmem setup node 0 [mem 0x0000000040000000-0x000000013fffffff]
2025-04-07T09:24:15.705247 psci: probing for conduit method from DT.
2025-04-07T09:24:15.705346 psci: PSCIv1.1 detected in firmware.
2025-04-07T09:24:15.705451 psci: Using standard PSCI v0.2 function IDs
2025-04-07T09:24:15.705723 psci: Trusted OS migration not required
2025-04-07T09:24:15.705829 psci: SMC Calling Convention v1.0
2025-04-07T09:24:15.707690 percpu: Embedded 18 pages/cpu s35112 r8192 d30424 u73728
2025-04-07T09:24:15.708230 pcpu-alloc: s35112 r8192 d30424 u73728 alloc=18*4096
2025-04-07T09:24:15.708333 pcpu-alloc: [0] 0 [0] 1
2025-04-07T09:24:15.709566 Detected PIPT I-cache on CPU0
2025-04-07T09:24:15.713341 CPU features: detected: Address authentication (IMP DEF algorithm)
2025-04-07T09:24:15.713879 CPU features: detected: GIC system register CPU interface
2025-04-07T09:24:15.713989 CPU features: detected: Virtualization Host Extensions
2025-04-07T09:24:15.714218 CPU features: detected: Hardware dirty bit management
2025-04-07T09:24:15.714321 CPU features: detected: Memory Tagging Extension
2025-04-07T09:24:15.714456 CPU features: detected: Asymmetric MTE Tag Check Fault
2025-04-07T09:24:15.714701 CPU features: detected: Spectre-v4
2025-04-07T09:24:15.716959 alternatives: applying boot alternatives
2025-04-07T09:24:15.719644 Kernel command line: console=ttyAMA0,115200 rootwait root=/dev/vda debug verbose console_msg_format=syslog systemd.log_level=warning earlycon
2025-04-07T09:24:15.721636 <5>Unknown kernel command line parameters "verbose", will be passed to user space.
2025-04-07T09:24:15.725620 <6>Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
2025-04-07T09:24:15.726648 <6>Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
2025-04-07T09:24:15.727293 <6>Built 1 zonelists, mobility grouping on. Total pages: 1032192
2025-04-07T09:24:15.727647 <6>mem auto-init: stack:all(zero), heap alloc:off, heap free:off
2025-04-07T09:24:15.727921 <6>software IO TLB: area num 2.
2025-04-07T09:24:15.776906 <6>software IO TLB: mapped [mem 0x00000000fbfff000-0x00000000fffff000] (64MB)
2025-04-07T09:24:15.791806 <6>Memory: 4034392K/4194304K available (7744K kernel code, 876K rwdata, 1860K rodata, 1408K init, 438K bss, 159912K reserved, 0K cma-reserved)
2025-04-07T09:24:15.795580 <6>SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
2025-04-07T09:24:15.800895 <6>rcu: Hierarchical RCU implementation.
2025-04-07T09:24:15.800983 <6>rcu: RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=2.
2025-04-07T09:24:15.801283 <6>rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
2025-04-07T09:24:15.801368 <6>rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
2025-04-07T09:24:15.802467 <6>NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
2025-04-07T09:24:15.806618 <6>GICv3: GIC: Using split EOI/Deactivate mode
2025-04-07T09:24:15.806702 <6>GICv3: 256 SPIs implemented
2025-04-07T09:24:15.806770 <6>GICv3: 0 Extended SPIs implemented
2025-04-07T09:24:15.808044 <6>Root IRQ handler: gic_handle_irq
2025-04-07T09:24:15.808168 <6>GICv3: GICv3 features: 16 PPIs
2025-04-07T09:24:15.808727 <6>GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000
2025-04-07T09:24:15.812079 <6>ITS [mem 0x08080000-0x0809ffff]
2025-04-07T09:24:15.812723 <6>ITS@0x0000000008080000: allocated 8192 Devices @100040000 (indirect, esz 8, psz 64K, shr 1)
2025-04-07T09:24:15.813007 <6>ITS@0x0000000008080000: allocated 8192 Interrupt Collections @100050000 (flat, esz 8, psz 64K, shr 1)
2025-04-07T09:24:15.813654 <6>GICv3: using LPI property table @0x0000000100060000
2025-04-07T09:24:15.814287 <6>GICv3: CPU0: using allocated LPI pending table @0x0000000100070000
2025-04-07T09:24:15.816031 <6>rcu: srcu_init: Setting srcu_struct sizes based on contention.
2025-04-07T09:24:15.819838 <6>arch_timer: cp15 timer(s) running at 1000.00MHz (phys).
2025-04-07T09:24:15.820419 <6>clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
2025-04-07T09:24:15.820882 <6>sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns
2025-04-07T09:24:15.833311 <6>Console: colour dummy device 80x25
2025-04-07T09:24:15.835170 <6>Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)
2025-04-07T09:24:15.835333 <6>pid_max: default: 32768 minimum: 301
2025-04-07T09:24:15.838383 <6>Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
2025-04-07T09:24:15.838587 <6>Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
2025-04-07T09:24:15.860440 <4>cacheinfo: Unable to detect cache hierarchy for CPU 0
2025-04-07T09:24:15.867655 <6>rcu: Hierarchical SRCU implementation.
2025-04-07T09:24:15.867719 <6>rcu: Max phase no-delay instances is 1000.
2025-04-07T09:24:15.870516 <6>Platform MSI: its@8080000 domain created
2025-04-07T09:24:15.871043 <6>PCI/MSI: /intc@8000000/its@8080000 domain created
2025-04-07T09:24:15.871132 <6>EFI services will not be available.
2025-04-07T09:24:15.872572 <6>smp: Bringing up secondary CPUs ...
2025-04-07T09:24:15.885739 <6>Detected PIPT I-cache on CPU1
2025-04-07T09:24:15.885826 <6>GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000
2025-04-07T09:24:15.885897 <6>GICv3: CPU1: using allocated LPI pending table @0x0000000100080000
2025-04-07T09:24:15.885983 <6>CPU1: Booted secondary processor 0x0000000001 [0x000f0510]
2025-04-07T09:24:15.886079 <6>smp: Brought up 1 node, 2 CPUs
2025-04-07T09:24:15.886221 <6>SMP: Total of 2 processors activated.
2025-04-07T09:24:15.886894 <6>CPU features: detected: Branch Target Identification
2025-04-07T09:24:15.886969 <6>CPU features: detected: 32-bit EL0 Support
2025-04-07T09:24:15.887090 <6>CPU features: detected: ARMv8.4 Translation Table Level
2025-04-07T09:24:15.887353 <6>CPU features: detected: Instruction cache invalidation not required for I/D coherence
2025-04-07T09:24:15.887697 <6>CPU features: detected: Data cache clean to the PoU not required for I/D coherence
2025-04-07T09:24:15.887953 <6>CPU features: detected: Common not Private translations
2025-04-07T09:24:15.888244 <6>CPU features: detected: CRC32 instructions
2025-04-07T09:24:15.888294 <6>CPU features: detected: Data independent timing control (DIT)
2025-04-07T09:24:15.888402 <6>CPU features: detected: E0PD
2025-04-07T09:24:15.888683 <6>CPU features: detected: Enhanced Counter Virtualization
2025-04-07T09:24:15.888955 <6>CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)
2025-04-07T09:24:15.889004 <6>CPU features: detected: Enhanced Privileged Access Never
2025-04-07T09:24:15.889268 <6>CPU features: detected: Generic authentication (IMP DEF algorithm)
2025-04-07T09:24:15.889433 <6>CPU features: detected: RCpc load-acquire (LDAPR)
2025-04-07T09:24:15.889718 <6>CPU features: detected: LSE atomic instructions
2025-04-07T09:24:15.889775 <6>CPU features: detected: Privileged Access Never
2025-04-07T09:24:15.889981 <6>CPU features: detected: RAS Extension Support
2025-04-07T09:24:15.890282 <6>CPU features: detected: Random Number Generator
2025-04-07T09:24:15.890549 <6>CPU features: detected: Speculation barrier (SB)
2025-04-07T09:24:15.890706 <6>CPU features: detected: Stage-2 Force Write-Back
2025-04-07T09:24:15.890961 <6>CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality
2025-04-07T09:24:15.891144 <6>CPU features: detected: TLB range maintenance instructions
2025-04-07T09:24:15.891267 <6>CPU features: detected: WFx with timeout
2025-04-07T09:24:15.891425 <6>CPU features: detected: Scalable Matrix Extension
2025-04-07T09:24:15.891502 <6>CPU features: detected: FA64
2025-04-07T09:24:15.891675 <6>CPU features: detected: Speculative Store Bypassing Safe (SSBS)
2025-04-07T09:24:15.891824 <6>CPU features: detected: Scalable Vector Extension
2025-04-07T09:24:15.902021 <6>SVE: maximum available vector length 256 bytes per vector
2025-04-07T09:24:15.902332 <6>SVE: default vector length 64 bytes per vector
2025-04-07T09:24:15.903763 <6>SME: minimum available vector length 16 bytes per vector
2025-04-07T09:24:15.903975 <6>SME: maximum available vector length 256 bytes per vector
2025-04-07T09:24:15.904156 <6>SME: default vector length 32 bytes per vector
2025-04-07T09:24:15.904453 <6>CPU: All CPU(s) started at EL2
2025-04-07T09:24:15.904615 <6>alternatives: applying system-wide alternatives
2025-04-07T09:24:15.940255 <6>devtmpfs: initialized
2025-04-07T09:24:15.951042 <6>clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
2025-04-07T09:24:15.951608 <6>futex hash table entries: 512 (order: 3, 32768 bytes, linear)
2025-04-07T09:24:15.953453 <6>DMI not present or invalid.
2025-04-07T09:24:15.956986 <6>NET: Registered PF_NETLINK/PF_ROUTE protocol family
2025-04-07T09:24:15.960689 <6>DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations
2025-04-07T09:24:15.961305 <6>DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
2025-04-07T09:24:15.961558 <6>DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
2025-04-07T09:24:15.965999 <6>thermal_sys: Registered thermal governor 'step_wise'
2025-04-07T09:24:15.966066 <6>cpuidle: using governor menu
2025-04-07T09:24:15.967287 <6>hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
2025-04-07T09:24:15.967886 <6>ASID allocator initialised with 65536 entries
2025-04-07T09:24:15.967944 <6>Serial: AMBA PL011 UART driver
2025-04-07T09:24:15.991725 <6>9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 15, base_baud = 0) is a PL011 rev1
2025-04-07T09:24:15.993063 <6>printk: console [ttyAMA0] enabled
2025-04-07T09:24:15.993107 <6>printk: console [ttyAMA0] enabled
2025-04-07T09:24:15.993210 <6>printk: bootconsole [pl11] disabled
2025-04-07T09:24:15.993292 <6>printk: bootconsole [pl11] disabled
2025-04-07T09:24:16.005828 <6>ACPI: Interpreter disabled.
2025-04-07T09:24:16.006483 <6>iommu: Default domain type: Translated
2025-04-07T09:24:16.006561 <6>iommu: DMA domain TLB invalidation policy: strict mode
2025-04-07T09:24:16.007716 <5>SCSI subsystem initialized
2025-04-07T09:24:16.008411 <7>libata version 3.00 loaded.
2025-04-07T09:24:16.008714 <6>pps_core: LinuxPPS API ver. 1 registered
2025-04-07T09:24:16.008897 <6>pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
2025-04-07T09:24:16.009045 <6>PTP clock support registered
2025-04-07T09:24:16.016213 <6>vgaarb: loaded
2025-04-07T09:24:16.017124 <6>clocksource: Switched to clocksource arch_sys_counter
2025-04-07T09:24:16.018377 <6>pnp: PnP ACPI: disabled
2025-04-07T09:24:16.039406 <6>NET: Registered PF_INET protocol family
2025-04-07T09:24:16.040405 <6>IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)
2025-04-07T09:24:16.045674 <6>tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)
2025-04-07T09:24:16.045877 <6>Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
2025-04-07T09:24:16.046120 <6>TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)
2025-04-07T09:24:16.046633 <6>TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)
2025-04-07T09:24:16.047401 <6>TCP: Hash tables configured (established 32768 bind 32768)
2025-04-07T09:24:16.048318 <6>UDP hash table entries: 2048 (order: 4, 65536 bytes, linear)
2025-04-07T09:24:16.048813 <6>UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear)
2025-04-07T09:24:16.049637 <6>NET: Registered PF_UNIX/PF_LOCAL protocol family
2025-04-07T09:24:16.049962 <6>PCI: CLS 0 bytes, default 64
2025-04-07T09:24:16.057856 <6>workingset: timestamp_bits=46 max_order=20 bucket_order=0
2025-04-07T09:24:16.059119 <6>fuse: init (API version 7.38)
2025-04-07T09:24:16.060652 <6>Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
2025-04-07T09:24:16.060905 <6>io scheduler mq-deadline registered
2025-04-07T09:24:16.061001 <6>io scheduler kyber registered
2025-04-07T09:24:16.063091 <6>pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:
2025-04-07T09:24:16.063787 <6>pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000
2025-04-07T09:24:16.064222 <6>pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000
2025-04-07T09:24:16.064479 <6>pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000
2025-04-07T09:24:16.065104 <4>pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits
2025-04-07T09:24:16.065797 <6>pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]
2025-04-07T09:24:16.066909 <6>pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00
2025-04-07T09:24:16.067176 <6>pci_bus 0000:00: root bus resource [bus 00-ff]
2025-04-07T09:24:16.067311 <6>pci_bus 0000:00: root bus resource [io 0x0000-0xffff]
2025-04-07T09:24:16.067472 <6>pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]
2025-04-07T09:24:16.067657 <6>pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]
2025-04-07T09:24:16.070161 <6>pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000
2025-04-07T09:24:16.072596 <6>pci 0000:00:01.0: [1af4:1001] type 00 class 0x010000
2025-04-07T09:24:16.072893 <6>pci 0000:00:01.0: reg 0x10: [io 0x0000-0x007f]
2025-04-07T09:24:16.072987 <6>pci 0000:00:01.0: reg 0x14: [mem 0x00000000-0x00000fff]
2025-04-07T09:24:16.073272 <6>pci 0000:00:01.0: reg 0x20: [mem 0x00000000-0x00003fff 64bit pref]
2025-04-07T09:24:16.075517 <6>pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref]
2025-04-07T09:24:16.075809 <6>pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff]
2025-04-07T09:24:16.075938 <6>pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x107f]
2025-04-07T09:24:16.082410 <6>virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)
2025-04-07T09:24:16.184606 <6>virtio_blk virtio0: 2/0/0 default/read/poll queues
2025-04-07T09:24:16.194786 <5>virtio_blk virtio0: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)
2025-04-07T09:24:16.210051 <6>rtc-pl031 9010000.pl031: registered as rtc0
2025-04-07T09:24:16.210823 <6>rtc-pl031 9010000.pl031: setting system clock to 2025-04-07T09:24:16 UTC (1744017856)
2025-04-07T09:24:16.216512 <6>hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 counters available
2025-04-07T09:24:16.217623 <6>NET: Registered PF_INET6 protocol family
2025-04-07T09:24:16.222153 <6>Segment Routing with IPv6
2025-04-07T09:24:16.222232 <6>In-situ OAM (IOAM) with IPv6
2025-04-07T09:24:16.222579 <6>sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver
2025-04-07T09:24:16.224412 <6>NET: Registered PF_PACKET protocol family
2025-04-07T09:24:16.224467 <6>NET: Registered PF_KEY protocol family
2025-04-07T09:24:16.225142 <6>NET: Registered PF_VSOCK protocol family
2025-04-07T09:24:16.233703 <6>registered taskstats version 1
2025-04-07T09:24:16.246719 <6>clk: Disabling unused clocks
2025-04-07T09:24:16.282659 <6>EXT4-fs (vda): orphan cleanup on readonly fs
2025-04-07T09:24:16.283415 <6>EXT4-fs (vda): mounted filesystem 2fcbc1ed-dd01-42d4-a9c7-5be91a955875 ro with ordered data mode. Quota mode: disabled.
2025-04-07T09:24:16.283731 <6>VFS: Mounted root (ext4 filesystem) readonly on device 254:0.
2025-04-07T09:24:16.285030 <6>devtmpfs: mounted
2025-04-07T09:24:16.305282 <6>Freeing unused kernel memory: 1408K
2025-04-07T09:24:16.314245 <6>Run /sbin/init as init process
2025-04-07T09:24:16.314332 <7> with arguments:
2025-04-07T09:24:16.314396 <7> /sbin/init
2025-04-07T09:24:16.314457 <7> verbose
2025-04-07T09:24:16.314522 <7> with environment:
2025-04-07T09:24:16.314580 <7> HOME=/
2025-04-07T09:24:16.314628 <7> TERM=linux
2025-04-07T09:24:16.408354 <6>EXT4-fs (vda): re-mounted 2fcbc1ed-dd01-42d4-a9c7-5be91a955875 r/w. Quota mode: disabled.
2025-04-07T09:24:16.637262 Saving 256 bits of creditable seed for next boot
2025-04-07T09:24:16.724972 Starting syslogd: OK
2025-04-07T09:24:16.761083 Starting klogd: OK
2025-04-07T09:24:16.830425 Running sysctl: OK
2025-04-07T09:24:16.984234 Starting network: OK
2025-04-07T09:24:17.016972 Starting crond: OK
2025-04-07T09:24:17.132719
2025-04-07T09:24:17.133703 Welcome to TuxTest
2025-04-07T09:24:17.235623
tuxtest login: root
2025-04-07T09:24:17.343296 root@tuxtest:~#
2025-04-07T09:24:17.446015 root@tuxtest:~# #
2025-04-07T09:24:17.548397 root@tuxtest:~# export SHELL=/bin/sh
2025-04-07T09:24:17.650554 root@tuxtest:~# . /lava-1/environment
2025-04-07T09:24:17.753514 root@tuxtest:~# /lava-1/bin/lava-test-runner /lava-1/0
2025-04-07T09:24:17.851069 + export TESTRUN_ID=0_ltp-smoke
2025-04-07T09:24:17.851227 + TESTRUN_ID=0_ltp-smoke
2025-04-07T09:24:17.851526 + cd /lava-1/0/tests/0_ltp-smoke
2025-04-07T09:24:17.854839 ++ cat uuid
2025-04-07T09:24:17.860320 + UUID=1_1.1.3.1
2025-04-07T09:24:17.860592 + set +x
2025-04-07T09:24:17.862687 <8><LAVA_SIGNAL_STARTRUN 0_ltp-smoke 1_1.1.3.1>
2025-04-07T09:24:17.863247 + cd ./automated/linux/ltp/
2025-04-07T09:24:17.868621 + ./ltp.sh -T smoketest -s true -v '' -M 5 -R root -r '' -b '' -d /scratch -g '' -e production -i /opt/ltp/ -S /tuxtest/skipfiles/arm64/ltp-smoke -p '' -u '' -t false -n 1 -c 1
2025-04-07T09:24:17.878583 + . ../../lib/sh-test-lib
2025-04-07T09:24:17.880120 ++ LANG=C
2025-04-07T09:24:17.880337 ++ export LANG
2025-04-07T09:24:17.891548 ++ export PATH=/lava-1/0/../bin:/bin:/sbin:/usr/bin:/usr/sbin:/sbin:/usr/sbin:/usr/local/sbin
2025-04-07T09:24:17.891966 ++ PATH=/lava-1/0/../bin:/bin:/sbin:/usr/bin:/usr/sbin:/sbin:/usr/sbin:/usr/local/sbin
2025-04-07T09:24:17.896629 ++ kernel_config=
2025-04-07T09:24:17.900336 ++ pwd
2025-04-07T09:24:17.902520 + OUTPUT=/lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output
2025-04-07T09:24:17.903000 + RESULT_FILE=/lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output/result.txt
2025-04-07T09:24:17.906198 ++ readlink -f ./ltp.sh
2025-04-07T09:24:17.913227 + SCRIPT=/lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/ltp.sh
2025-04-07T09:24:17.915949 ++ dirname /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/ltp.sh
2025-04-07T09:24:17.921565 + SCRIPTPATH=/lava-1/0/tests/0_ltp-smoke/automated/linux/ltp
2025-04-07T09:24:17.922486 + echo 'Script path is: /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp'
2025-04-07T09:24:17.922856 Script path is: /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp
2025-04-07T09:24:17.922910 + TST_CMDFILES=
2025-04-07T09:24:17.923151 + SKIPFILE=
2025-04-07T09:24:17.923262 + SKIPFILE_YAML=
2025-04-07T09:24:17.923331 + BOARD=
2025-04-07T09:24:17.923379 + BRANCH=
2025-04-07T09:24:17.923429 + ENVIRONMENT=
2025-04-07T09:24:17.923672 + LTP_VERSION=20180926
2025-04-07T09:24:17.923721 + TEST_PROGRAM=ltp
2025-04-07T09:24:17.923778 + TEST_GIT_URL=
2025-04-07T09:24:17.926377 ++ pwd
2025-04-07T09:24:17.928171 + TEST_DIR=/lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/ltp
2025-04-07T09:24:17.928616 + BUILD_FROM_TAR=false
2025-04-07T09:24:17.928682 + SHARD_NUMBER=1
2025-04-07T09:24:17.928970 + SHARD_INDEX=1
2025-04-07T09:24:17.929033 + RUNNER=
2025-04-07T09:24:17.929082 + LTP_TMPDIR=/ltp-tmp
2025-04-07T09:24:17.929152 + LTP_INSTALL_PATH=/opt/ltp
2025-04-07T09:24:17.931087 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-07T09:24:17.932168 + case "$arg" in
2025-04-07T09:24:17.932253 + TST_CMDFILES=smoketest
2025-04-07T09:24:17.940052 ++ echo smoketest
2025-04-07T09:24:17.941621 ++ sed 's,\/,_,'
2025-04-07T09:24:17.950296 + LOG_FILE=smoketest
2025-04-07T09:24:17.950601 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-07T09:24:17.950671 + case "$arg" in
2025-04-07T09:24:17.950908 + SKIP_INSTALL=true
2025-04-07T09:24:17.951190 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-07T09:24:17.951234 + case "$arg" in
2025-04-07T09:24:17.951443 + LTP_VERSION=
2025-04-07T09:24:17.951698 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-07T09:24:17.951742 + case "$arg" in
2025-04-07T09:24:17.951793 + export LTP_TIMEOUT_MUL=5
2025-04-07T09:24:17.952030 + LTP_TIMEOUT_MUL=5
2025-04-07T09:24:17.952080 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-07T09:24:17.952289 + case "$arg" in
2025-04-07T09:24:17.952338 + export PASSWD=root
2025-04-07T09:24:17.952558 + PASSWD=root
2025-04-07T09:24:17.952608 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-07T09:24:17.952816 + case "$arg" in
2025-04-07T09:24:17.953027 + export RUNNER=
2025-04-07T09:24:17.953068 + RUNNER=
2025-04-07T09:24:17.953326 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-07T09:24:17.953368 + case "$arg" in
2025-04-07T09:24:17.953411 + export BOARD=
2025-04-07T09:24:17.953456 + BOARD=
2025-04-07T09:24:17.953663 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-07T09:24:17.953879 + case "$arg" in
2025-04-07T09:24:17.953923 + export LTP_TMPDIR=/scratch
2025-04-07T09:24:17.953966 + LTP_TMPDIR=/scratch
2025-04-07T09:24:17.954173 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-07T09:24:17.954223 + case "$arg" in
2025-04-07T09:24:17.954431 + export BRANCH=
2025-04-07T09:24:17.954473 + BRANCH=
2025-04-07T09:24:17.954578 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-07T09:24:17.954790 + case "$arg" in
2025-04-07T09:24:17.954838 + export ENVIRONMENT=production
2025-04-07T09:24:17.955060 + ENVIRONMENT=production
2025-04-07T09:24:17.955108 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-07T09:24:17.955155 + case "$arg" in
2025-04-07T09:24:17.955361 + export LTP_INSTALL_PATH=/opt/ltp/
2025-04-07T09:24:17.955412 + LTP_INSTALL_PATH=/opt/ltp/
2025-04-07T09:24:17.955619 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-07T09:24:17.955670 + case "$arg" in
2025-04-07T09:24:17.956584 + '[' -z /tuxtest/skipfiles/arm64/ltp-smoke ']'
2025-04-07T09:24:17.956976 + '[' /tuxtest/skipfiles/arm64/ltp-smoke = yaml ']'
2025-04-07T09:24:17.957612 + '[' / == / ']'
2025-04-07T09:24:17.957868 + SKIPFILE='-S /tuxtest/skipfiles/arm64/ltp-smoke'
2025-04-07T09:24:17.957917 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-07T09:24:17.958125 + case "$arg" in
2025-04-07T09:24:17.958702 + [[ '' != '' ]]
2025-04-07T09:24:17.959006 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-07T09:24:17.959049 + case "$arg" in
2025-04-07T09:24:17.959094 + [[ '' != '' ]]
2025-04-07T09:24:17.959376 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-07T09:24:17.959417 + case "$arg" in
2025-04-07T09:24:17.959462 + BUILD_FROM_TAR=false
2025-04-07T09:24:17.959763 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-07T09:24:17.959806 + case "$arg" in
2025-04-07T09:24:17.959849 + SHARD_NUMBER=1
2025-04-07T09:24:17.960131 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-07T09:24:17.960174 + case "$arg" in
2025-04-07T09:24:17.960217 + SHARD_INDEX=1
2025-04-07T09:24:17.960502 + getopts M:T:S:b:d:g:e:i:s:v:R:r:u:p:t:c:n: arg
2025-04-07T09:24:17.961108 + TEST_TARFILE=https://github.com/linux-test-project/ltp/releases/download//ltp-full-.tar.xz
2025-04-07T09:24:17.961499 + '[' -n '' ']'
2025-04-07T09:24:17.964189 + check_root
2025-04-07T09:24:17.966981 ++ id -ru
2025-04-07T09:24:17.972329 + '[' 0 -eq 0 ']'
2025-04-07T09:24:17.972405 + return 0
2025-04-07T09:24:17.972980 + create_out_dir /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output
2025-04-07T09:24:17.973433 + '[' -z /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output ']'
2025-04-07T09:24:17.973531 + local OUTPUT=/lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output
2025-04-07T09:24:17.974338 + '[' -d /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output ']'
2025-04-07T09:24:17.974748 + mkdir -p /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output
2025-04-07T09:24:17.981781 + '[' -d /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output ']'
2025-04-07T09:24:17.982469 + info_msg 'About to run ltp test...'
2025-04-07T09:24:17.982574 + local 'msg=About to run ltp test...'
2025-04-07T09:24:17.982814 + '[' -z 'About to run ltp test...' ']'
2025-04-07T09:24:17.983102 + printf 'INFO: %s\n' 'About to run ltp test...'
2025-04-07T09:24:17.983320 INFO: About to run ltp test...
2025-04-07T09:24:17.983770 + info_msg 'Output directory: /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output'
2025-04-07T09:24:17.983888 + local 'msg=Output directory: /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output'
2025-04-07T09:24:17.984321 + '[' -z 'Output directory: /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output' ']'
2025-04-07T09:24:17.984672 + printf 'INFO: %s\n' 'Output directory: /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output'
2025-04-07T09:24:17.984916 INFO: Output directory: /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output
2025-04-07T09:24:17.985131 + '[' true = true ']'
2025-04-07T09:24:17.985346 + info_msg 'ltp installation skipped altogether'
2025-04-07T09:24:17.985561 + local 'msg=ltp installation skipped altogether'
2025-04-07T09:24:17.985875 + '[' -z 'ltp installation skipped altogether' ']'
2025-04-07T09:24:17.986100 + printf 'INFO: %s\n' 'ltp installation skipped altogether'
2025-04-07T09:24:17.986142 INFO: ltp installation skipped altogether
2025-04-07T09:24:17.986562 + '[' '!' -d /opt/ltp/ ']'
2025-04-07T09:24:17.987304 + info_msg 'Running prep_system'
2025-04-07T09:24:17.987539 + local 'msg=Running prep_system'
2025-04-07T09:24:17.987589 + '[' -z 'Running prep_system' ']'
2025-04-07T09:24:17.987802 + printf 'INFO: %s\n' 'Running prep_system'
2025-04-07T09:24:17.987851 INFO: Running prep_system
2025-04-07T09:24:17.988061 + prep_system
2025-04-07T09:24:17.988124 + systemctl is-active systemd-timesyncd
2025-04-07T09:24:17.993387 + '[' -f /proc/sys/kernel/unprivileged_userns_clone ']'
2025-04-07T09:24:17.993969 + info_msg 'Kernel has no support of unprivileged_userns_clone'
2025-04-07T09:24:17.994238 + local 'msg=Kernel has no support of unprivileged_userns_clone'
2025-04-07T09:24:17.994662 + '[' -z 'Kernel has no support of unprivileged_userns_clone' ']'
2025-04-07T09:24:17.994738 + printf 'INFO: %s\n' 'Kernel has no support of unprivileged_userns_clone'
2025-04-07T09:24:17.994885 INFO: Kernel has no support of unprivileged_userns_clone
2025-04-07T09:24:17.995313 + info_msg 'Running run_ltp'
2025-04-07T09:24:17.995371 + local 'msg=Running run_ltp'
2025-04-07T09:24:17.995460 + '[' -z 'Running run_ltp' ']'
2025-04-07T09:24:17.995674 + printf 'INFO: %s\n' 'Running run_ltp'
2025-04-07T09:24:17.995758 INFO: Running run_ltp
2025-04-07T09:24:17.995980 + run_ltp
2025-04-07T09:24:17.996211 + cd /opt/ltp/
2025-04-07T09:24:17.996607 + mkdir -m 777 -p /scratch
2025-04-07T09:24:18.005193 + for file in ${TST_CMDFILES//,/ }
2025-04-07T09:24:18.005290 + cat runtest/smoketest
2025-04-07T09:24:18.015629 + sed -i 's/#.*$//;/^$/d' alltests
2025-04-07T09:24:18.030406 + split --verbose --numeric-suffixes=1 -n l/1/1 alltests
2025-04-07T09:24:18.039842 + echo '============== Tests to run ==============='
2025-04-07T09:24:18.040165 ============== Tests to run ===============
2025-04-07T09:24:18.040243 + cat runtest/shardfile
2025-04-07T09:24:18.045245 access01 access01
2025-04-07T09:24:18.045315 chdir01 chdir01
2025-04-07T09:24:18.045372 fork01 fork01
2025-04-07T09:24:18.045428 time01 time01
2025-04-07T09:24:18.045496 wait02 wait02
2025-04-07T09:24:18.045549 write01 write01
2025-04-07T09:24:18.045599 symlink01 symlink01
2025-04-07T09:24:18.045648 stat04 stat04
2025-04-07T09:24:18.045695 splice02 splice02 -s 20
2025-04-07T09:24:18.045743 df01_sh df01.sh
2025-04-07T09:24:18.045813 shell_test01 echo "SUCCESS" | shell_pipe01.sh
2025-04-07T09:24:18.045867 ping602 ping02.sh -6
2025-04-07T09:24:18.045917 macsec02 macsec02.sh
2025-04-07T09:24:18.046899 + echo '===========End Tests to run ==============='
2025-04-07T09:24:18.047000 ===========End Tests to run ===============
2025-04-07T09:24:18.047217 + '[' -n '' ']'
2025-04-07T09:24:18.048529 + 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/arm64/ltp-smoke' 'tee /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output/LTP_smoketest.out'
2025-04-07T09:24:18.049118 + '[' 2 -ne 2 ']'
2025-04-07T09:24:18.050133 + 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/arm64/ltp-smoke'
2025-04-07T09:24:18.050469 + local 'cmd2=tee /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output/LTP_smoketest.out'
2025-04-07T09:24:18.050515 + exec
2025-04-07T09:24:18.050728 + local ret_val
2025-04-07T09:24:18.057459 ++ 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/arm64/ltp-smoke'
2025-04-07T09:24:18.057742 ++ eval 'tee /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output/LTP_smoketest.out'
2025-04-07T09:24:18.058931 +++ ./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/arm64/ltp-smoke
2025-04-07T09:24:18.059182 +++ tee /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output/LTP_smoketest.out
2025-04-07T09:24:18.094736 -------------------------------------------
2025-04-07T09:24:18.094848 INFO: runltp script is deprecated, try kirk
2025-04-07T09:24:18.095103 https://github.com/linux-test-project/kirk
2025-04-07T09:24:18.095219 -------------------------------------------
2025-04-07T09:24:18.140409 INFO: creating /opt/ltp/output directory
2025-04-07T09:24:18.265039 Checking for required user/group ids
2025-04-07T09:24:18.265569
2025-04-07T09:24:18.344217 'root' user id and group found.
2025-04-07T09:24:18.345242 'nobody' user id and group found.
2025-04-07T09:24:18.345643 'bin' user id and group found.
2025-04-07T09:24:18.346104 'daemon' user id and group found.
2025-04-07T09:24:18.346201 Users group found.
2025-04-07T09:24:18.346697 Sys group found.
2025-04-07T09:24:18.435127 Required users/groups exist.
2025-04-07T09:24:18.438517 no big block device was specified on commandline.
2025-04-07T09:24:18.438863 Tests which require a big block device are disabled.
2025-04-07T09:24:18.438947 You can specify it with option -z
2025-04-07T09:24:18.446118 INFO: Test start time: Mon Apr 7 09:24:18 UTC 2025
2025-04-07T09:24:18.447956 COMMAND: /opt/ltp/bin/ltp-pan -q -e -S -a 117 -n 117 -p -f /scratch/ltp-ZfhPvJ9DWR/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-04-07T09:24:18.457613 LOG File: /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output/LTP_smoketest.log
2025-04-07T09:24:18.467741 FAILED COMMAND File: /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output/LTP_smoketest.failed
2025-04-07T09:24:18.475860 TCONF COMMAND File: /opt/ltp/output/LTP_RUN_ON-LTP_smoketest.log.tconf
2025-04-07T09:24:18.477155 Running tests.......
2025-04-07T09:24:18.517551 tst_tmpdir.c:316: TINFO: Using /scratch/ltp-ZfhPvJ9DWR/LTP_accg7tCKa as tmpdir (ext2/ext3/ext4 filesystem)
2025-04-07T09:24:18.519061 tst_test.c:1900: TINFO: LTP version: 20250130
2025-04-07T09:24:18.519332 tst_test.c:1904: TINFO: Tested kernel: 6.4.16 #1 SMP Mon Apr 7 11:12:06 CEST 2025 aarch64
2025-04-07T09:24:18.519832 tst_kconfig.c:88: TINFO: Parsing kernel config '/proc/config.gz'
2025-04-07T09:24:18.551876 tst_test.c:1722: TINFO: Overall timeout per run is 0h 02m 35s
2025-04-07T09:24:18.563806 access01.c:245: TPASS: access(accessfile_rwx, F_OK) as root passed
2025-04-07T09:24:18.565921 access01.c:245: TPASS: access(accessfile_rwx, F_OK) as nobody passed
2025-04-07T09:24:18.567605 access01.c:245: TPASS: access(accessfile_rwx, X_OK) as root passed
2025-04-07T09:24:18.569369 access01.c:245: TPASS: access(accessfile_rwx, X_OK) as nobody passed
2025-04-07T09:24:18.570585 access01.c:245: TPASS: access(accessfile_rwx, W_OK) as root passed
2025-04-07T09:24:18.572326 access01.c:245: TPASS: access(accessfile_rwx, W_OK) as nobody passed
2025-04-07T09:24:18.573323 access01.c:245: TPASS: access(accessfile_rwx, R_OK) as root passed
2025-04-07T09:24:18.575084 access01.c:245: TPASS: access(accessfile_rwx, R_OK) as nobody passed
2025-04-07T09:24:18.576006 access01.c:245: TPASS: access(accessfile_rwx, R_OK|W_OK) as root passed
2025-04-07T09:24:18.577778 access01.c:245: TPASS: access(accessfile_rwx, R_OK|W_OK) as nobody passed
2025-04-07T09:24:18.578796 access01.c:245: TPASS: access(accessfile_rwx, R_OK|X_OK) as root passed
2025-04-07T09:24:18.580481 access01.c:245: TPASS: access(accessfile_rwx, R_OK|X_OK) as nobody passed
2025-04-07T09:24:18.581531 access01.c:245: TPASS: access(accessfile_rwx, W_OK|X_OK) as root passed
2025-04-07T09:24:18.583294 access01.c:245: TPASS: access(accessfile_rwx, W_OK|X_OK) as nobody passed
2025-04-07T09:24:18.584352 access01.c:245: TPASS: access(accessfile_rwx, R_OK|W_OK|X_OK) as root passed
2025-04-07T09:24:18.586002 access01.c:245: TPASS: access(accessfile_rwx, R_OK|W_OK|X_OK) as nobody passed
2025-04-07T09:24:18.586978 access01.c:245: TPASS: access(accessfile_x, X_OK) as root passed
2025-04-07T09:24:18.588662 access01.c:245: TPASS: access(accessfile_x, X_OK) as nobody passed
2025-04-07T09:24:18.589685 access01.c:245: TPASS: access(accessfile_w, W_OK) as root passed
2025-04-07T09:24:18.591393 access01.c:245: TPASS: access(accessfile_w, W_OK) as nobody passed
2025-04-07T09:24:18.592326 access01.c:245: TPASS: access(accessfile_r, R_OK) as root passed
2025-04-07T09:24:18.594183 access01.c:245: TPASS: access(accessfile_r, R_OK) as nobody passed
2025-04-07T09:24:18.595319 access01.c:242: TPASS: access(accessfile_r, X_OK) as root : EACCES (13)
2025-04-07T09:24:18.597156 access01.c:242: TPASS: access(accessfile_r, X_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.599485 access01.c:242: TPASS: access(accessfile_r, W_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.601784 access01.c:242: TPASS: access(accessfile_w, R_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.602820 access01.c:242: TPASS: access(accessfile_w, X_OK) as root : EACCES (13)
2025-04-07T09:24:18.604672 access01.c:242: TPASS: access(accessfile_w, X_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.607324 access01.c:242: TPASS: access(accessfile_x, R_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.609605 access01.c:242: TPASS: access(accessfile_x, W_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.610618 access01.c:242: TPASS: access(accessfile_r, W_OK|X_OK) as root : EACCES (13)
2025-04-07T09:24:18.612535 access01.c:242: TPASS: access(accessfile_r, W_OK|X_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.614048 access01.c:242: TPASS: access(accessfile_r, R_OK|X_OK) as root : EACCES (13)
2025-04-07T09:24:18.615811 access01.c:242: TPASS: access(accessfile_r, R_OK|X_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.618112 access01.c:242: TPASS: access(accessfile_r, R_OK|W_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.619292 access01.c:242: TPASS: access(accessfile_r, R_OK|W_OK|X_OK) as root : EACCES (13)
2025-04-07T09:24:18.621268 access01.c:242: TPASS: access(accessfile_r, R_OK|W_OK|X_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.622268 access01.c:242: TPASS: access(accessfile_w, W_OK|X_OK) as root : EACCES (13)
2025-04-07T09:24:18.624154 access01.c:242: TPASS: access(accessfile_w, W_OK|X_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.625481 access01.c:242: TPASS: access(accessfile_w, R_OK|X_OK) as root : EACCES (13)
2025-04-07T09:24:18.627385 access01.c:242: TPASS: access(accessfile_w, R_OK|X_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.629781 access01.c:242: TPASS: access(accessfile_w, R_OK|W_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.630972 access01.c:242: TPASS: access(accessfile_w, R_OK|W_OK|X_OK) as root : EACCES (13)
2025-04-07T09:24:18.632915 access01.c:242: TPASS: access(accessfile_w, R_OK|W_OK|X_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.635525 access01.c:242: TPASS: access(accessfile_x, W_OK|X_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.638995 access01.c:242: TPASS: access(accessfile_x, R_OK|X_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.641847 access01.c:242: TPASS: access(accessfile_x, R_OK|W_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.644530 access01.c:242: TPASS: access(accessfile_x, R_OK|W_OK|X_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.645571 access01.c:245: TPASS: access(accessfile_r, W_OK) as root passed
2025-04-07T09:24:18.646198 access01.c:245: TPASS: access(accessfile_r, R_OK|W_OK) as root passed
2025-04-07T09:24:18.646786 access01.c:245: TPASS: access(accessfile_w, R_OK) as root passed
2025-04-07T09:24:18.647332 access01.c:245: TPASS: access(accessfile_w, R_OK|W_OK) as root passed
2025-04-07T09:24:18.647901 access01.c:245: TPASS: access(accessfile_x, R_OK) as root passed
2025-04-07T09:24:18.648444 access01.c:245: TPASS: access(accessfile_x, W_OK) as root passed
2025-04-07T09:24:18.649099 access01.c:245: TPASS: access(accessfile_x, R_OK|W_OK) as root passed
2025-04-07T09:24:18.649675 access01.c:245: TPASS: access(accessdir_r/accessfile_r, F_OK) as root passed
2025-04-07T09:24:18.650264 access01.c:245: TPASS: access(accessdir_r/accessfile_r, R_OK) as root passed
2025-04-07T09:24:18.650832 access01.c:245: TPASS: access(accessdir_r/accessfile_r, W_OK) as root passed
2025-04-07T09:24:18.651406 access01.c:245: TPASS: access(accessdir_r/accessfile_w, F_OK) as root passed
2025-04-07T09:24:18.651966 access01.c:245: TPASS: access(accessdir_r/accessfile_w, R_OK) as root passed
2025-04-07T09:24:18.652519 access01.c:245: TPASS: access(accessdir_r/accessfile_w, W_OK) as root passed
2025-04-07T09:24:18.653196 access01.c:245: TPASS: access(accessdir_r/accessfile_x, F_OK) as root passed
2025-04-07T09:24:18.653691 access01.c:245: TPASS: access(accessdir_r/accessfile_x, R_OK) as root passed
2025-04-07T09:24:18.654321 access01.c:245: TPASS: access(accessdir_r/accessfile_x, W_OK) as root passed
2025-04-07T09:24:18.654969 access01.c:245: TPASS: access(accessdir_r/accessfile_x, X_OK) as root passed
2025-04-07T09:24:18.655624 access01.c:245: TPASS: access(accessdir_w/accessfile_r, F_OK) as root passed
2025-04-07T09:24:18.656258 access01.c:245: TPASS: access(accessdir_w/accessfile_r, R_OK) as root passed
2025-04-07T09:24:18.657226 access01.c:245: TPASS: access(accessdir_w/accessfile_r, W_OK) as root passed
2025-04-07T09:24:18.657723 access01.c:245: TPASS: access(accessdir_w/accessfile_w, F_OK) as root passed
2025-04-07T09:24:18.658449 access01.c:245: TPASS: access(accessdir_w/accessfile_w, R_OK) as root passed
2025-04-07T09:24:18.659155 access01.c:245: TPASS: access(accessdir_w/accessfile_w, W_OK) as root passed
2025-04-07T09:24:18.660139 access01.c:245: TPASS: access(accessdir_w/accessfile_x, F_OK) as root passed
2025-04-07T09:24:18.660441 access01.c:245: TPASS: access(accessdir_w/accessfile_x, R_OK) as root passed
2025-04-07T09:24:18.660671 access01.c:245: TPASS: access(accessdir_w/accessfile_x, W_OK) as root passed
2025-04-07T09:24:18.661064 access01.c:245: TPASS: access(accessdir_w/accessfile_x, X_OK) as root passed
2025-04-07T09:24:18.661284 access01.c:245: TPASS: access(accessdir_x/accessfile_r, F_OK) as root passed
2025-04-07T09:24:18.662090 access01.c:245: TPASS: access(accessdir_x/accessfile_r, F_OK) as nobody passed
2025-04-07T09:24:18.663190 access01.c:245: TPASS: access(accessdir_x/accessfile_r, R_OK) as root passed
2025-04-07T09:24:18.664532 access01.c:245: TPASS: access(accessdir_x/accessfile_r, R_OK) as nobody passed
2025-04-07T09:24:18.665752 access01.c:245: TPASS: access(accessdir_x/accessfile_r, W_OK) as root passed
2025-04-07T09:24:18.665993 access01.c:245: TPASS: access(accessdir_x/accessfile_w, F_OK) as root passed
2025-04-07T09:24:18.667176 access01.c:245: TPASS: access(accessdir_x/accessfile_w, F_OK) as nobody passed
2025-04-07T09:24:18.668254 access01.c:245: TPASS: access(accessdir_x/accessfile_w, R_OK) as root passed
2025-04-07T09:24:18.668495 access01.c:245: TPASS: access(accessdir_x/accessfile_w, W_OK) as root passed
2025-04-07T09:24:18.669872 access01.c:245: TPASS: access(accessdir_x/accessfile_w, W_OK) as nobody passed
2025-04-07T09:24:18.671100 access01.c:245: TPASS: access(accessdir_x/accessfile_x, F_OK) as root passed
2025-04-07T09:24:18.672450 access01.c:245: TPASS: access(accessdir_x/accessfile_x, F_OK) as nobody passed
2025-04-07T09:24:18.673713 access01.c:245: TPASS: access(accessdir_x/accessfile_x, R_OK) as root passed
2025-04-07T09:24:18.674026 access01.c:245: TPASS: access(accessdir_x/accessfile_x, W_OK) as root passed
2025-04-07T09:24:18.674342 access01.c:245: TPASS: access(accessdir_x/accessfile_x, X_OK) as root passed
2025-04-07T09:24:18.675316 access01.c:245: TPASS: access(accessdir_x/accessfile_x, X_OK) as nobody passed
2025-04-07T09:24:18.677383 access01.c:245: TPASS: access(accessdir_rw/accessfile_r, F_OK) as root passed
2025-04-07T09:24:18.677684 access01.c:245: TPASS: access(accessdir_rw/accessfile_r, R_OK) as root passed
2025-04-07T09:24:18.677990 access01.c:245: TPASS: access(accessdir_rw/accessfile_r, W_OK) as root passed
2025-04-07T09:24:18.678262 access01.c:245: TPASS: access(accessdir_rw/accessfile_w, F_OK) as root passed
2025-04-07T09:24:18.678333 access01.c:245: TPASS: access(accessdir_rw/accessfile_w, R_OK) as root passed
2025-04-07T09:24:18.678583 access01.c:245: TPASS: access(accessdir_rw/accessfile_w, W_OK) as root passed
2025-04-07T09:24:18.678850 access01.c:245: TPASS: access(accessdir_rw/accessfile_x, F_OK) as root passed
2025-04-07T09:24:18.679290 access01.c:245: TPASS: access(accessdir_rw/accessfile_x, R_OK) as root passed
2025-04-07T09:24:18.679359 access01.c:245: TPASS: access(accessdir_rw/accessfile_x, W_OK) as root passed
2025-04-07T09:24:18.679630 access01.c:245: TPASS: access(accessdir_rw/accessfile_x, X_OK) as root passed
2025-04-07T09:24:18.679870 access01.c:245: TPASS: access(accessdir_rx/accessfile_r, F_OK) as root passed
2025-04-07T09:24:18.680118 access01.c:245: TPASS: access(accessdir_rx/accessfile_r, F_OK) as nobody passed
2025-04-07T09:24:18.680940 access01.c:245: TPASS: access(accessdir_rx/accessfile_r, R_OK) as root passed
2025-04-07T09:24:18.682039 access01.c:245: TPASS: access(accessdir_rx/accessfile_r, R_OK) as nobody passed
2025-04-07T09:24:18.683592 access01.c:245: TPASS: access(accessdir_rx/accessfile_r, W_OK) as root passed
2025-04-07T09:24:18.683938 access01.c:245: TPASS: access(accessdir_rx/accessfile_w, F_OK) as root passed
2025-04-07T09:24:18.685081 access01.c:245: TPASS: access(accessdir_rx/accessfile_w, F_OK) as nobody passed
2025-04-07T09:24:18.686372 access01.c:245: TPASS: access(accessdir_rx/accessfile_w, R_OK) as root passed
2025-04-07T09:24:18.686700 access01.c:245: TPASS: access(accessdir_rx/accessfile_w, W_OK) as root passed
2025-04-07T09:24:18.687813 access01.c:245: TPASS: access(accessdir_rx/accessfile_w, W_OK) as nobody passed
2025-04-07T09:24:18.688901 access01.c:245: TPASS: access(accessdir_rx/accessfile_x, F_OK) as root passed
2025-04-07T09:24:18.690452 access01.c:245: TPASS: access(accessdir_rx/accessfile_x, F_OK) as nobody passed
2025-04-07T09:24:18.692084 access01.c:245: TPASS: access(accessdir_rx/accessfile_x, R_OK) as root passed
2025-04-07T09:24:18.692146 access01.c:245: TPASS: access(accessdir_rx/accessfile_x, W_OK) as root passed
2025-04-07T09:24:18.692549 access01.c:245: TPASS: access(accessdir_rx/accessfile_x, X_OK) as root passed
2025-04-07T09:24:18.693776 access01.c:245: TPASS: access(accessdir_rx/accessfile_x, X_OK) as nobody passed
2025-04-07T09:24:18.695075 access01.c:245: TPASS: access(accessdir_wx/accessfile_r, F_OK) as root passed
2025-04-07T09:24:18.696142 access01.c:245: TPASS: access(accessdir_wx/accessfile_r, F_OK) as nobody passed
2025-04-07T09:24:18.697498 access01.c:245: TPASS: access(accessdir_wx/accessfile_r, R_OK) as root passed
2025-04-07T09:24:18.698546 access01.c:245: TPASS: access(accessdir_wx/accessfile_r, R_OK) as nobody passed
2025-04-07T09:24:18.699614 access01.c:245: TPASS: access(accessdir_wx/accessfile_r, W_OK) as root passed
2025-04-07T09:24:18.700049 access01.c:245: TPASS: access(accessdir_wx/accessfile_w, F_OK) as root passed
2025-04-07T09:24:18.701207 access01.c:245: TPASS: access(accessdir_wx/accessfile_w, F_OK) as nobody passed
2025-04-07T09:24:18.702263 access01.c:245: TPASS: access(accessdir_wx/accessfile_w, R_OK) as root passed
2025-04-07T09:24:18.702677 access01.c:245: TPASS: access(accessdir_wx/accessfile_w, W_OK) as root passed
2025-04-07T09:24:18.703664 access01.c:245: TPASS: access(accessdir_wx/accessfile_w, W_OK) as nobody passed
2025-04-07T09:24:18.704855 access01.c:245: TPASS: access(accessdir_wx/accessfile_x, F_OK) as root passed
2025-04-07T09:24:18.705967 access01.c:245: TPASS: access(accessdir_wx/accessfile_x, F_OK) as nobody passed
2025-04-07T09:24:18.707667 access01.c:245: TPASS: access(accessdir_wx/accessfile_x, R_OK) as root passed
2025-04-07T09:24:18.708023 access01.c:245: TPASS: access(accessdir_wx/accessfile_x, W_OK) as root passed
2025-04-07T09:24:18.708096 access01.c:245: TPASS: access(accessdir_wx/accessfile_x, X_OK) as root passed
2025-04-07T09:24:18.709355 access01.c:245: TPASS: access(accessdir_wx/accessfile_x, X_OK) as nobody passed
2025-04-07T09:24:18.711631 access01.c:242: TPASS: access(accessdir_r/accessfile_r, F_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.714637 access01.c:242: TPASS: access(accessdir_r/accessfile_r, R_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.717350 access01.c:242: TPASS: access(accessdir_r/accessfile_r, W_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.719010 access01.c:242: TPASS: access(accessdir_r/accessfile_r, X_OK) as root : EACCES (13)
2025-04-07T09:24:18.720321 access01.c:242: TPASS: access(accessdir_r/accessfile_r, X_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.722524 access01.c:242: TPASS: access(accessdir_r/accessfile_w, F_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.725409 access01.c:242: TPASS: access(accessdir_r/accessfile_w, R_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.728241 access01.c:242: TPASS: access(accessdir_r/accessfile_w, W_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.730042 access01.c:242: TPASS: access(accessdir_r/accessfile_w, X_OK) as root : EACCES (13)
2025-04-07T09:24:18.731267 access01.c:242: TPASS: access(accessdir_r/accessfile_w, X_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.734237 access01.c:242: TPASS: access(accessdir_r/accessfile_x, F_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.737323 access01.c:242: TPASS: access(accessdir_r/accessfile_x, R_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.740246 access01.c:242: TPASS: access(accessdir_r/accessfile_x, W_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.743410 access01.c:242: TPASS: access(accessdir_r/accessfile_x, X_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.746642 access01.c:242: TPASS: access(accessdir_w/accessfile_r, F_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.749622 access01.c:242: TPASS: access(accessdir_w/accessfile_r, R_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.752607 access01.c:242: TPASS: access(accessdir_w/accessfile_r, W_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.754316 access01.c:242: TPASS: access(accessdir_w/accessfile_r, X_OK) as root : EACCES (13)
2025-04-07T09:24:18.755572 access01.c:242: TPASS: access(accessdir_w/accessfile_r, X_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.757735 access01.c:242: TPASS: access(accessdir_w/accessfile_w, F_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.760616 access01.c:242: TPASS: access(accessdir_w/accessfile_w, R_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.763189 access01.c:242: TPASS: access(accessdir_w/accessfile_w, W_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.764868 access01.c:242: TPASS: access(accessdir_w/accessfile_w, X_OK) as root : EACCES (13)
2025-04-07T09:24:18.766186 access01.c:242: TPASS: access(accessdir_w/accessfile_w, X_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.770215 access01.c:242: TPASS: access(accessdir_w/accessfile_x, F_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.773294 access01.c:242: TPASS: access(accessdir_w/accessfile_x, R_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.775675 access01.c:242: TPASS: access(accessdir_w/accessfile_x, W_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.778392 access01.c:242: TPASS: access(accessdir_w/accessfile_x, X_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.780622 access01.c:242: TPASS: access(accessdir_x/accessfile_r, W_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.781870 access01.c:242: TPASS: access(accessdir_x/accessfile_r, X_OK) as root : EACCES (13)
2025-04-07T09:24:18.783509 access01.c:242: TPASS: access(accessdir_x/accessfile_r, X_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.785977 access01.c:242: TPASS: access(accessdir_x/accessfile_w, R_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.787135 access01.c:242: TPASS: access(accessdir_x/accessfile_w, X_OK) as root : EACCES (13)
2025-04-07T09:24:18.788773 access01.c:242: TPASS: access(accessdir_x/accessfile_w, X_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.791042 access01.c:242: TPASS: access(accessdir_x/accessfile_x, R_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.793580 access01.c:242: TPASS: access(accessdir_x/accessfile_x, W_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.795875 access01.c:242: TPASS: access(accessdir_rw/accessfile_r, F_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.798284 access01.c:242: TPASS: access(accessdir_rw/accessfile_r, R_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.800510 access01.c:242: TPASS: access(accessdir_rw/accessfile_r, W_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.801812 access01.c:242: TPASS: access(accessdir_rw/accessfile_r, X_OK) as root : EACCES (13)
2025-04-07T09:24:18.803540 access01.c:242: TPASS: access(accessdir_rw/accessfile_r, X_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.805953 access01.c:242: TPASS: access(accessdir_rw/accessfile_w, F_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.808120 access01.c:242: TPASS: access(accessdir_rw/accessfile_w, R_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.810617 access01.c:242: TPASS: access(accessdir_rw/accessfile_w, W_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.811733 access01.c:242: TPASS: access(accessdir_rw/accessfile_w, X_OK) as root : EACCES (13)
2025-04-07T09:24:18.813539 access01.c:242: TPASS: access(accessdir_rw/accessfile_w, X_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.815847 access01.c:242: TPASS: access(accessdir_rw/accessfile_x, F_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.818302 access01.c:242: TPASS: access(accessdir_rw/accessfile_x, R_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.820591 access01.c:242: TPASS: access(accessdir_rw/accessfile_x, W_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.823133 access01.c:242: TPASS: access(accessdir_rw/accessfile_x, X_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.825611 access01.c:242: TPASS: access(accessdir_rx/accessfile_r, W_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.826809 access01.c:242: TPASS: access(accessdir_rx/accessfile_r, X_OK) as root : EACCES (13)
2025-04-07T09:24:18.828609 access01.c:242: TPASS: access(accessdir_rx/accessfile_r, X_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.831211 access01.c:242: TPASS: access(accessdir_rx/accessfile_w, R_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.832375 access01.c:242: TPASS: access(accessdir_rx/accessfile_w, X_OK) as root : EACCES (13)
2025-04-07T09:24:18.834251 access01.c:242: TPASS: access(accessdir_rx/accessfile_w, X_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.836589 access01.c:242: TPASS: access(accessdir_rx/accessfile_x, R_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.839183 access01.c:242: TPASS: access(accessdir_rx/accessfile_x, W_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.841731 access01.c:242: TPASS: access(accessdir_wx/accessfile_r, W_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.842658 access01.c:242: TPASS: access(accessdir_wx/accessfile_r, X_OK) as root : EACCES (13)
2025-04-07T09:24:18.844441 access01.c:242: TPASS: access(accessdir_wx/accessfile_r, X_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.846948 access01.c:242: TPASS: access(accessdir_wx/accessfile_w, R_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.848089 access01.c:242: TPASS: access(accessdir_wx/accessfile_w, X_OK) as root : EACCES (13)
2025-04-07T09:24:18.849902 access01.c:242: TPASS: access(accessdir_wx/accessfile_w, X_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.852148 access01.c:242: TPASS: access(accessdir_wx/accessfile_x, R_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.855044 access01.c:242: TPASS: access(accessdir_wx/accessfile_x, W_OK) as nobody : EACCES (13)
2025-04-07T09:24:18.861001
2025-04-07T09:24:18.861268 Summary:
2025-04-07T09:24:18.861343 passed 199
2025-04-07T09:24:18.861441 failed 0
2025-04-07T09:24:18.861547 broken 0
2025-04-07T09:24:18.861639 skipped 0
2025-04-07T09:24:18.861723 warnings 0
2025-04-07T09:24:18.891859 tst_tmpdir.c:316: TINFO: Using /scratch/ltp-ZfhPvJ9DWR/LTP_forNnV9bP as tmpdir (ext2/ext3/ext4 filesystem)
2025-04-07T09:24:18.892985 tst_test.c:1900: TINFO: LTP version: 20250130
2025-04-07T09:24:18.893527 tst_test.c:1904: TINFO: Tested kernel: 6.4.16 #1 SMP Mon Apr 7 11:12:06 CEST 2025 aarch64
2025-04-07T09:24:18.894173 tst_kconfig.c:88: TINFO: Parsing kernel config '/proc/config.gz'
2025-04-07T09:24:18.919837 tst_test.c:1722: TINFO: Overall timeout per run is 0h 02m 30s
2025-04-07T09:24:18.927531 fork01.c:47: TPASS: correct child status returned 42
2025-04-07T09:24:18.928049 fork01.c:50: TPASS: child_pid == pid (279)
2025-04-07T09:24:18.931580
2025-04-07T09:24:18.931834 Summary:
2025-04-07T09:24:18.931898 passed 2
2025-04-07T09:24:18.931956 failed 0
2025-04-07T09:24:18.932016 broken 0
2025-04-07T09:24:18.932079 skipped 0
2025-04-07T09:24:18.932136 warnings 0
2025-04-07T09:24:18.944067 tst_test.c:1900: TINFO: LTP version: 20250130
2025-04-07T09:24:18.944524 tst_test.c:1904: TINFO: Tested kernel: 6.4.16 #1 SMP Mon Apr 7 11:12:06 CEST 2025 aarch64
2025-04-07T09:24:18.945465 tst_kconfig.c:88: TINFO: Parsing kernel config '/proc/config.gz'
2025-04-07T09:24:18.970062 tst_test.c:1722: TINFO: Overall timeout per run is 0h 02m 30s
2025-04-07T09:24:18.974382 time01.c:36: TPASS: time() returned value 1744017859
2025-04-07T09:24:18.974876 time01.c:38: TPASS: time() returned value 1744017859, stored value 1744017859 are same
2025-04-07T09:24:18.976750
2025-04-07T09:24:18.976986 Summary:
2025-04-07T09:24:18.977244 passed 2
2025-04-07T09:24:18.977501 failed 0
2025-04-07T09:24:18.977746 broken 0
2025-04-07T09:24:18.978009 skipped 0
2025-04-07T09:24:18.978225 warnings 0
2025-04-07T09:24:18.991091 tst_test.c:1900: TINFO: LTP version: 20250130
2025-04-07T09:24:18.991693 tst_test.c:1904: TINFO: Tested kernel: 6.4.16 #1 SMP Mon Apr 7 11:12:06 CEST 2025 aarch64
2025-04-07T09:24:18.992363 tst_kconfig.c:88: TINFO: Parsing kernel config '/proc/config.gz'
2025-04-07T09:24:19.018090 tst_test.c:1722: TINFO: Overall timeout per run is 0h 02m 30s
2025-04-07T09:24:19.023532 wait02.c:41: TPASS: wait() succeeded
2025-04-07T09:24:19.026099
2025-04-07T09:24:19.026351 Summary:
2025-04-07T09:24:19.026416 passed 1
2025-04-07T09:24:19.026479 failed 0
2025-04-07T09:24:19.026542 broken 0
2025-04-07T09:24:19.026610 skipped 0
2025-04-07T09:24:19.026679 warnings 0
2025-04-07T09:24:19.038469 tst_tmpdir.c:316: TINFO: Using /scratch/ltp-ZfhPvJ9DWR/LTP_wricHv70W as tmpdir (ext2/ext3/ext4 filesystem)
2025-04-07T09:24:19.039537 tst_test.c:1900: TINFO: LTP version: 20250130
2025-04-07T09:24:19.040081 tst_test.c:1904: TINFO: Tested kernel: 6.4.16 #1 SMP Mon Apr 7 11:12:06 CEST 2025 aarch64
2025-04-07T09:24:19.040926 tst_kconfig.c:88: TINFO: Parsing kernel config '/proc/config.gz'
2025-04-07T09:24:19.065817 tst_test.c:1722: TINFO: Overall timeout per run is 0h 02m 30s
2025-04-07T09:24:19.534745 write01.c:40: TPASS: write() passed
2025-04-07T09:24:19.536343
2025-04-07T09:24:19.536587 Summary:
2025-04-07T09:24:19.536819 passed 1
2025-04-07T09:24:19.537182 failed 0
2025-04-07T09:24:19.537495 broken 0
2025-04-07T09:24:19.537809 skipped 0
2025-04-07T09:24:19.537942 warnings 0
2025-04-07T09:24:19.604426 symlink01 0 TINFO : Using /scratch/ltp-ZfhPvJ9DWR/LTP_symEh4oge as tmpdir (ext2/ext3/ext4 filesystem)
2025-04-07T09:24:19.604558 symlink01 1 TPASS : Creation of symbolic link file to no object file is ok
2025-04-07T09:24:19.604893 symlink01 2 TPASS : Creation of symbolic link file to no object file is ok
2025-04-07T09:24:19.605208 symlink01 3 TPASS : Creation of symbolic link file and object file via symbolic link is ok
2025-04-07T09:24:19.605309 symlink01 4 TPASS : Creating an existing symbolic link file error is caught
2025-04-07T09:24:19.605623 symlink01 5 TPASS : Creating a symbolic link which exceeds maximum pathname error is caught
2025-04-07T09:24:19.618230 tst_buffers.c:57: TINFO: Test is using guarded buffers
2025-04-07T09:24:19.620588 tst_tmpdir.c:316: TINFO: Using /scratch/ltp-ZfhPvJ9DWR/LTP_staE0YsXy as tmpdir (ext2/ext3/ext4 filesystem)
2025-04-07T09:24:19.626292 tst_device.c:124: TINFO: non-existant loopback device 0
2025-04-07T09:24:19.626655 tst_device.c:124: TINFO: non-existant loopback device 1
2025-04-07T09:24:19.627125 tst_device.c:124: TINFO: non-existant loopback device 2
2025-04-07T09:24:19.627461 tst_device.c:124: TINFO: non-existant loopback device 3
2025-04-07T09:24:19.627952 tst_device.c:124: TINFO: non-existant loopback device 4
2025-04-07T09:24:19.628239 tst_device.c:124: TINFO: non-existant loopback device 5
2025-04-07T09:24:19.628869 tst_device.c:124: TINFO: non-existant loopback device 6
2025-04-07T09:24:19.629324 tst_device.c:124: TINFO: non-existant loopback device 7
2025-04-07T09:24:19.629568 tst_device.c:124: TINFO: non-existant loopback device 8
2025-04-07T09:24:19.630013 tst_device.c:124: TINFO: non-existant loopback device 9
2025-04-07T09:24:19.630367 tst_device.c:124: TINFO: non-existant loopback device 10
2025-04-07T09:24:19.630807 tst_device.c:124: TINFO: non-existant loopback device 11
2025-04-07T09:24:19.631247 tst_device.c:124: TINFO: non-existant loopback device 12
2025-04-07T09:24:19.631741 tst_device.c:124: TINFO: non-existant loopback device 13
2025-04-07T09:24:19.632128 tst_device.c:124: TINFO: non-existant loopback device 14
2025-04-07T09:24:19.632514 tst_device.c:124: TINFO: non-existant loopback device 15
2025-04-07T09:24:19.632911 tst_device.c:124: TINFO: non-existant loopback device 16
2025-04-07T09:24:19.633328 tst_device.c:124: TINFO: non-existant loopback device 17
2025-04-07T09:24:19.633718 tst_device.c:124: TINFO: non-existant loopback device 18
2025-04-07T09:24:19.634188 tst_device.c:124: TINFO: non-existant loopback device 19
2025-04-07T09:24:19.644190 tst_device.c:154: TINFO: No free devices found
2025-04-07T09:24:19.644631 tst_device.c:367: TBROK: Failed to acquire device
2025-04-07T09:24:19.645240
2025-04-07T09:24:19.645468 Summary:
2025-04-07T09:24:19.645531 passed 0
2025-04-07T09:24:19.645789 failed 0
2025-04-07T09:24:19.646019 broken 1
2025-04-07T09:24:19.646415 skipped 0
2025-04-07T09:24:19.646644 warnings 0
2025-04-07T09:24:19.662178 tst_tmpdir.c:316: TINFO: Using /scratch/ltp-ZfhPvJ9DWR/LTP_splqTh5ms as tmpdir (ext2/ext3/ext4 filesystem)
2025-04-07T09:24:19.663381 tst_test.c:1900: TINFO: LTP version: 20250130
2025-04-07T09:24:19.663902 tst_test.c:1904: TINFO: Tested kernel: 6.4.16 #1 SMP Mon Apr 7 11:12:06 CEST 2025 aarch64
2025-04-07T09:24:19.664537 tst_kconfig.c:88: TINFO: Parsing kernel config '/proc/config.gz'
2025-04-07T09:24:19.689622 tst_test.c:1722: TINFO: Overall timeout per run is 0h 02m 30s
2025-04-07T09:24:19.693351 splice02.c:135: TINFO: writting 20 bytes
2025-04-07T09:24:19.695903 splice02.c:87: TINFO: checking file content
2025-04-07T09:24:19.696507 splice02.c:111: TPASS: splice() system call passed
2025-04-07T09:24:19.700896
2025-04-07T09:24:19.701161 Summary:
2025-04-07T09:24:19.701254 passed 1
2025-04-07T09:24:19.701333 failed 0
2025-04-07T09:24:19.701405 broken 0
2025-04-07T09:24:19.701477 skipped 0
2025-04-07T09:24:19.701525 warnings 0
2025-04-07T09:24:19.783081 shell_pipe01 1 TINFO: Running: shell_pipe01.sh
2025-04-07T09:24:19.792340 shell_pipe01 1 TINFO: Tested kernel: Linux tuxtest 6.4.16 #1 SMP Mon Apr 7 11:12:06 CEST 2025 aarch64 GNU/Linux
2025-04-07T09:24:19.842591 shell_pipe01 1 TINFO: timeout per run is 0h 25m 0s
2025-04-07T09:24:19.874456 shell_pipe01 1 TINFO: expecting SUCCESS string passed from stdin
2025-04-07T09:24:19.889299 shell_pipe01 1 TPASS: [ SUCCESS = SUCCESS ] passed as expected
2025-04-07T09:24:19.906512
2025-04-07T09:24:19.906817 Summary:
2025-04-07T09:24:19.906906 passed 1
2025-04-07T09:24:19.906999 failed 0
2025-04-07T09:24:19.907083 broken 0
2025-04-07T09:24:19.907154 skipped 0
2025-04-07T09:24:19.907239 warnings 0
2025-04-07T09:24:20.010573 macsec02 1 TINFO: Running: macsec02.sh
2025-04-07T09:24:20.021179 macsec02 1 TINFO: Tested kernel: Linux tuxtest 6.4.16 #1 SMP Mon Apr 7 11:12:06 CEST 2025 aarch64 GNU/Linux
2025-04-07T09:24:20.181166 macsec02 1 TCONF: veth driver not available
2025-04-07T09:24:20.185986
2025-04-07T09:24:20.186090 Summary:
2025-04-07T09:24:20.186366 passed 0
2025-04-07T09:24:20.186445 failed 0
2025-04-07T09:24:20.186521 broken 0
2025-04-07T09:24:20.186592 skipped 1
2025-04-07T09:24:20.186662 warnings 0
2025-04-07T09:24:20.195435 INFO: ltp-pan reported some tests FAIL
2025-04-07T09:24:20.195523 LTP Version: 20250130
2025-04-07T09:24:20.202357 INFO: Test end time: Mon Apr 7 09:24:20 UTC 2025
2025-04-07T09:24:20.209501
2025-04-07T09:24:20.209769 ###############################################################
2025-04-07T09:24:20.209845
2025-04-07T09:24:20.209936 Done executing testcases.
2025-04-07T09:24:20.210005 LTP Version: 20250130
2025-04-07T09:24:20.210271 ###############################################################
2025-04-07T09:24:20.210322
2025-04-07T09:24:20.211098 -------------------------------------------
2025-04-07T09:24:20.211392 INFO: runltp script is deprecated, try kirk
2025-04-07T09:24:20.211628 https://github.com/linux-test-project/kirk
2025-04-07T09:24:20.211733 -------------------------------------------
2025-04-07T09:24:20.224459 ++ echo 1
2025-04-07T09:24:20.230174 + ret_val=1
2025-04-07T09:24:20.230461 + exec
2025-04-07T09:24:20.230527 + return 1
2025-04-07T09:24:20.231308 + parse_ltp_output /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output/LTP_smoketest.log
2025-04-07T09:24:20.234253 + grep -E 'PASS|FAIL|CONF' /lava-1/0/tests/0_ltp-smoke/automated/linux/ltp/output/LTP_smoketest.log
2025-04-07T09:24:20.236372 + sed 's/PASS/pass/; s/FAIL/fail/; s/CONF/skip/'
2025-04-07T09:24:20.242893 + awk '{print $1" "$2}'
2025-04-07T09:24:20.251162 + rm -rf /scratch
2025-04-07T09:24:20.258129 + rm -rf alltests
2025-04-07T09:24:20.266472 + ../../utils/send-to-lava.sh ./output/result.txt
2025-04-07T09:24:20.296077 WARNING: no log file found for access01 at ./output/access01.log
2025-04-07T09:24:20.315999 <8><LAVA_SIGNAL_TESTCASE TEST_CASE_ID=access01 RESULT=pass>
2025-04-07T09:24:20.329075 WARNING: no log file found for chdir01 at ./output/chdir01.log
2025-04-07T09:24:20.347018 <8><LAVA_SIGNAL_TESTCASE TEST_CASE_ID=chdir01 RESULT=skip>
2025-04-07T09:24:20.357862 WARNING: no log file found for fork01 at ./output/fork01.log
2025-04-07T09:24:20.376188 <8><LAVA_SIGNAL_TESTCASE TEST_CASE_ID=fork01 RESULT=pass>
2025-04-07T09:24:20.387553 WARNING: no log file found for time01 at ./output/time01.log
2025-04-07T09:24:20.406192 <8><LAVA_SIGNAL_TESTCASE TEST_CASE_ID=time01 RESULT=pass>
2025-04-07T09:24:20.417866 WARNING: no log file found for wait02 at ./output/wait02.log
2025-04-07T09:24:20.435616 <8><LAVA_SIGNAL_TESTCASE TEST_CASE_ID=wait02 RESULT=pass>
2025-04-07T09:24:20.448369 WARNING: no log file found for write01 at ./output/write01.log
2025-04-07T09:24:20.466758 <8><LAVA_SIGNAL_TESTCASE TEST_CASE_ID=write01 RESULT=pass>
2025-04-07T09:24:20.477781 WARNING: no log file found for symlink01 at ./output/symlink01.log
2025-04-07T09:24:20.497148 <8><LAVA_SIGNAL_TESTCASE TEST_CASE_ID=symlink01 RESULT=pass>
2025-04-07T09:24:20.508093 WARNING: no log file found for stat04 at ./output/stat04.log
2025-04-07T09:24:20.526823 <8><LAVA_SIGNAL_TESTCASE TEST_CASE_ID=stat04 RESULT=fail>
2025-04-07T09:24:20.538368 WARNING: no log file found for splice02 at ./output/splice02.log
2025-04-07T09:24:20.556113 <8><LAVA_SIGNAL_TESTCASE TEST_CASE_ID=splice02 RESULT=pass>
2025-04-07T09:24:20.566793 WARNING: no log file found for df01_sh at ./output/df01_sh.log
2025-04-07T09:24:20.585190 <8><LAVA_SIGNAL_TESTCASE TEST_CASE_ID=df01_sh RESULT=skip>
2025-04-07T09:24:20.596216 WARNING: no log file found for shell_test01 at ./output/shell_test01.log
2025-04-07T09:24:20.614849 <8><LAVA_SIGNAL_TESTCASE TEST_CASE_ID=shell_test01 RESULT=pass>
2025-04-07T09:24:20.628308 WARNING: no log file found for ping602 at ./output/ping602.log
2025-04-07T09:24:20.646553 <8><LAVA_SIGNAL_TESTCASE TEST_CASE_ID=ping602 RESULT=skip>
2025-04-07T09:24:20.657719 WARNING: no log file found for macsec02 at ./output/macsec02.log
2025-04-07T09:24:20.675616 <8><LAVA_SIGNAL_TESTCASE TEST_CASE_ID=macsec02 RESULT=skip>
2025-04-07T09:24:20.679254 + set +x
2025-04-07T09:24:20.679521 <8><LAVA_SIGNAL_ENDRUN 0_ltp-smoke 1_1.1.3.1>
2025-04-07T09:24:20.684013 <LAVA_TEST_RUNNER EXIT>
2025-04-07T09:24:21.787571 root@tuxtest:~# poweroff