HomeDefectsLIN1025-2762
Not to be fixed

LIN1025-2762 : [s32g] optee xtest caught calltrace at optee_smc_do_call_with_arg+0x190/0x2b0

Created: Jul 17, 2025    Updated: Jan 25, 2026
Resolved Date: Jan 25, 2026
Found In Version: 10.25.33.1
Severity: Standard
Applicable for: Wind River Linux LTS 25
Component/s: BSP

Description

[  498.873347] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks:
[  498.873373] rcu: 	6-...!: (0 ticks this GP) idle=cc14/1/0x4000000000000000 softirq=0/0 fqs=8 rcuc=6483 jiffies(starved)
[  498.873389] rcu: 	(detected by 2, t=6502 jiffies, g=67753, q=5600 ncpus=8)
[  498.873400] Sending NMI from CPU 2 to CPUs 6:
[  498.873433] NMI backtrace for cpu 6
[  498.873447] CPU: 6 UID: 0 PID: 1522 Comm: xtest Tainted: G        W  O       6.12.38-rt6-yocto-preempt-rt #1
[  498.873459] Tainted: [W]=WARN, [O]=OOT_MODULE
[  498.873462] Hardware name: NXP S32G3 Reference Design Board (S32G-VNP-RDB3) (DT)
[  498.873468] pstate: 80000005 (Nzcv daif -PAN -UAO -TCO -DIT -SSBS BTYPE=--)
[  498.873475] pc : __arm_smccc_smc+0x8/0x30
[  498.873494] lr : optee_smccc_smc+0x24/0x40
[  498.873508] sp : ffff80008639bb10
[  498.873512] x29: ffff80008639bb20 x28: ffff00081ba14140 x27: 0000000000000000
[  498.873525] x26: 0000000000000000 x25: ffff000806e970a0 x24: ffff000806b92378
[  498.873537] x23: 0000000000000000 x22: ffff000806b92000 x21: ffff80008639bb70
[  498.873548] x20: ffff0008178fc3e0 x19: 0000000006e970a0 x18: 0000000000000000
[  498.873559] x17: 0000000000000000 x16: 0000000000000000 x15: 0000ffffdfbb71a8
[  498.873571] x14: 0000000000000000 x13: 0000000000000000 x12: 0000000000000000
[  498.873582] x11: 0000000000000000 x10: 0000000000000000 x9 : ffff800080fc5f08
[  498.873592] x8 : ffff80008639bb70 x7 : 0000000000000000 x6 : 0000000000000000
[  498.873604] x5 : 0000000000000000 x4 : 0000000000000000 x3 : 0000000000000000
[  498.873615] x2 : 0000000000000000 x1 : 0000000000000000 x0 : 00000000ffff0004
[  498.873629] Call trace:
[  498.873633]  __arm_smccc_smc+0x8/0x30
[  498.873644]  optee_smc_do_call_with_arg+0x190/0x2b0
[  498.873651]  optee_invoke_func+0x138/0x220
[  498.873661]  tee_ioctl_invoke+0x300/0x380
[  498.873672]  tee_ioctl+0x3b8/0x588
[  498.873680]  __arm64_sys_ioctl+0xb4/0x100
[  498.873693]  invoke_syscall+0x5c/0x128
[  498.873704]  el0_svc_common.constprop.0+0x48/0xf8
[  498.873715]  do_el0_svc+0x24/0x40
[  498.873724]  el0_svc+0x48/0x148
[  498.873737]  el0t_64_sync_handler+0x120/0x130
[  498.873748]  el0t_64_sync+0x190/0x198
[  498.874422] rcu: rcu_preempt kthread timer wakeup didn't happen for 6482 jiffies! g67753 f0x2 RCU_GP_WAIT_FQS(5) ->state=0x402
[  498.874432] rcu: 	Possible timer handling issue on cpu=6 timer-softirq=4131
[  498.874436] rcu: rcu_preempt kthread starved for 6483 jiffies! g67753 f0x2 RCU_GP_WAIT_FQS(5) ->state=0x0 ->cpu=4
[  498.874443] rcu: 	Unless rcu_preempt kthread gets sufficient CPU time, OOM is now expected behavior.
[  498.874447] rcu: RCU grace-period kthread stack dump:
[  498.874451] task:rcu_preempt     state:R  running task     stack:13216 pid:20    tgid:20    ppid:2      flags:0x00000008
[  498.874474] Call trace:
[  498.874477]  __switch_to+0xf4/0x168
[  498.874489]  0xffff800083a8bcd0
[  524.897347] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks:
[  524.897371] rcu: 	4-...!: (0 ticks this GP) idle=23fc/1/0x4000000000000000 softirq=0/0 fqs=0 rcuc=6504 jiffies(starved)
[  524.897386] rcu: 	(detected by 1, t=6502 jiffies, g=67761, q=6256 ncpus=8)
[  524.897395] Sending NMI from CPU 1 to CPUs 4:
[  524.897425] NMI backtrace for cpu 4
[  524.897439] CPU: 4 UID: 0 PID: 1522 Comm: xtest Tainted: G        W  O       6.12.38-rt6-yocto-preempt-rt #1
[  524.897452] Tainted: [W]=WARN, [O]=OOT_MODULE
[  524.897455] Hardware name: NXP S32G3 Reference Design Board (S32G-VNP-RDB3) (DT)
[  524.897460] pstate: 80000005 (Nzcv daif -PAN -UAO -TCO -DIT -SSBS BTYPE=--)
[  524.897468] pc : __arm_smccc_smc+0x8/0x30
[  524.897487] lr : optee_smccc_smc+0x24/0x40
[  524.897501] sp : ffff80008639bb10
[  524.897504] x29: ffff80008639bb20 x28: ffff00081ba14140 x27: 0000000000000000
[  524.897519] x26: 0000000000000000 x25: ffff000806e970a0 x24: ffff000806b92378
[  524.897531] x23: 0000000000000000 x22: ffff000806b92000 x21: ffff80008639bb70
[  524.897543] x20: ffff0008178fc3e0 x19: 0000000006e970a0 x18: 0000000000000000
[  524.897553] x17: 0000000000000000 x16: 0000000000000000 x15: 0000ffffdfbb71a8
[  524.897565] x14: 0000000000000000 x13: 0000000000000000 x12: 0000000000000000
[  524.897577] x11: 0000000000000000 x10: 0000000000000000 x9 : ffff800080fc5f08
[  524.897590] x8 : ffff80008639bb70 x7 : 0000000000000000 x6 : 0000000000000000
[  524.897598] x5 : 0000000000000000 x4 : 0000000000000000 x3 : 0000000000000000
[  524.897610] x2 : 0000000000000000 x1 : 0000000000000000 x0 : 00000000ffff0004
[  524.897624] Call trace:
[  524.897627]  __arm_smccc_smc+0x8/0x30
[  524.897636]  optee_smc_do_call_with_arg+0x190/0x2b0
[  524.897644]  optee_invoke_func+0x138/0x220
[  524.897655]  tee_ioctl_invoke+0x300/0x380
[  524.897666]  tee_ioctl+0x3b8/0x588
[  524.897675]  __arm64_sys_ioctl+0xb4/0x100
[  524.897688]  invoke_syscall+0x5c/0x128
[  524.897698]  el0_svc_common.constprop.0+0x48/0xf8
[  524.897709]  do_el0_svc+0x24/0x40
[  524.897719]  el0_svc+0x48/0x148
[  524.897733]  el0t_64_sync_handler+0x120/0x130
[  524.897744]  el0t_64_sync+0x190/0x198
[  524.898412] rcu: rcu_preempt kthread timer wakeup didn't happen for 6501 jiffies! g67761 f0x2 RCU_GP_WAIT_FQS(5) ->state=0x402
[  524.898422] rcu: 	Possible timer handling issue on cpu=4 timer-softirq=9028
[  524.898427] rcu: rcu_preempt kthread starved for 6502 jiffies! g67761 f0x2 RCU_GP_WAIT_FQS(5) ->state=0x0 ->cpu=6
[  524.898434] rcu: 	Unless rcu_preempt kthread gets sufficient CPU time, OOM is now expected behavior.
[  524.898438] rcu: RCU grace-period kthread stack dump:
[  524.898441] task:rcu_preempt     state:R  running task     stack:13216 pid:20    tgid:20    ppid:2      flags:0x00000008
[  524.898464] Call trace:
[  524.898467]  __switch_to+0xf4/0x168
[  524.898479]  0xffff800083a8bcd0
[  560.193347] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks:
[  560.193368] rcu: 	6-...!: (0 ticks this GP) idle=97a4/1/0x4000000000000000 softirq=0/0 fqs=4 rcuc=6496 jiffies(starved)
[  560.193381] rcu: 	(detected by 5, t=6502 jiffies, g=67813, q=37135 ncpus=8)
[  560.193390] Sending NMI from CPU 5 to CPUs 6:
[  560.193421] NMI backtrace for cpu 6
[  560.193431] CPU: 6 UID: 0 PID: 1522 Comm: xtest Tainted: G        W  O       6.12.38-rt6-yocto-preempt-rt #1
[  560.193443] Tainted: [W]=WARN, [O]=OOT_MODULE
[  560.193446] Hardware name: NXP S32G3 Reference Design Board (S32G-VNP-RDB3) (DT)
[  560.193452] pstate: 80000005 (Nzcv daif -PAN -UAO -TCO -DIT -SSBS BTYPE=--)
[  560.193462] pc : __arm_smccc_smc+0x8/0x30
[  560.193480] lr : optee_smccc_smc+0x24/0x40
[  560.193494] sp : ffff80008639bb10
[  560.193497] x29: ffff80008639bb20 x28: ffff00081ba14140 x27: 0000000000000000
[  560.193511] x26: 0000000000000000 x25: ffff000806e970a0 x24: ffff000806b92378
[  560.193521] x23: 0000000000000000 x22: ffff000806b92000 x21: ffff80008639bb70
[  560.193534] x20: ffff0008178fc3e0 x19: 0000000006e970a0 x18: 0000000000000000
[  560.193545] x17: 0000000000000000 x16: 0000000000000000 x15: 0000ffffdfbb71a8
[  560.193557] x14: 0000000000000000 x13: 0000000000000000 x12: 0000000000000000
[  560.193569] x11: 0000000000000000 x10: 0000000000000000 x9 : ffff800080fc5f08
[  560.193579] x8 : ffff80008639bb70 x7 : 0000000000000000 x6 : 0000000000000000
[  560.193590] x5 : 0000000000000000 x4 : 0000000000000000 x3 : 0000000000000000
[  560.193601] x2 : 0000000000000000 x1 : 0000000000000000 x0 : 00000000ffff0004
[  560.193613] Call trace:
[  560.193617]  __arm_smccc_smc+0x8/0x30
[  560.193626]  optee_smc_do_call_with_arg+0x190/0x2b0
[  560.193634]  optee_invoke_func+0x138/0x220
[  560.193645]  tee_ioctl_invoke+0x300/0x380
[  560.193656]  tee_ioctl+0x3b8/0x588
[  560.193665]  __arm64_sys_ioctl+0xb4/0x100
[  560.193678]  invoke_syscall+0x5c/0x128
[  560.193690]  el0_svc_common.constprop.0+0x48/0xf8
[  560.193701]  do_el0_svc+0x24/0x40
[  560.193711]  el0_svc+0x48/0x148
[  560.193726]  el0t_64_sync_handler+0x120/0x130
[  560.193736]  el0t_64_sync+0x190/0x198
[  560.194409] rcu: rcu_preempt kthread timer wakeup didn't happen for 6495 jiffies! g67813 f0x2 RCU_GP_WAIT_FQS(5) ->state=0x402
[  560.194419] rcu: 	Possible timer handling issue on cpu=6 timer-softirq=4152
[  560.194423] rcu: rcu_preempt kthread starved for 6496 jiffies! g67813 f0x2 RCU_GP_WAIT_FQS(5) ->state=0x0 ->cpu=5
[  560.194430] rcu: 	Unless rcu_preempt kthread gets sufficient CPU time, OOM is now expected behavior.
[  560.194434] rcu: RCU grace-period kthread stack dump:
[  560.194437] task:rcu_preempt     state:R  running task     stack:13216 pid:20    tgid:20    ppid:2      flags:0x00000008
[  560.194460] Call trace:
[  560.194463]  __switch_to+0xf4/0x168
[  560.194473]  __schedule+0x31c/0x7b8
[  560.194481]  schedule+0x50/0x130
[  560.194488]  schedule_timeout+0xc4/0x160
[  560.194498]  rcu_gp_fqs_loop+0x160/0x540
[  560.194509]  rcu_gp_kthread+0x1cc/0x240
[  560.194519]  kthread+0x104/0x120
[  560.194530]  ret_from_fork+0x10/0x20
[  560.194538] rcu: Stack dump where RCU GP kthread last ran:
[  560.194543] CPU: 5 UID: 0 PID: 0 Comm: swapper/5 Tainted: G        W  O       6.12.38-rt6-yocto-preempt-rt #1
[  560.194553] Tainted: [W]=WARN, [O]=OOT_MODULE
[  560.194556] Hardware name: NXP S32G3 Reference Design Board (S32G-VNP-RDB3) (DT)
[  560.194560] pstate: 80000005 (Nzcv daif -PAN -UAO -TCO -DIT -SSBS BTYPE=--)
[  560.194567] pc : default_idle_call+0x88/0x158
[  560.194574] lr : default_idle_call+0x84/0x158
[  560.194581] sp : ffff800083ae3dc0
[  560.194584] x29: ffff800083ae3dc0 x28: 0000000000000000 x27: 0000000000000000
[  560.194594] x26: 0000000000000000 x25: 0000000000000000 x24: 0000000000000005
[  560.194603] x23: ffff800081eae620 x22: ffff000801500040 x21: ffff000801500040
[  560.194614] x20: ffff80008011fb3c x19: ffff80008011fb3c x18: 0000000000000001
[  560.194623] x17: 0000000000000fff x16: 00000000000003d4 x15: 0000000000000001
[  560.194632] x14: 00000000000003ff x13: 00000000000000d4 x12: 0000000000000000
[  560.194642] x11: 0000000000000001 x10: 0000000000001920 x9 : ffff80008011fa6c
[  560.194651] x8 : ffff800083ae3cd0 x7 : ffff800083ae4000 x6 : ffff800083ae0000
[  560.194663] x5 : ffff80008210d840 x4 : 00000000ffffffff x3 : ffff80008210ee30
[  560.194673] x2 : ffff8007f9450000 x1 : ffff800081eb0000 x0 : 0000000000000000
[  560.194683] Call trace:
[  560.194685]  default_idle_call+0x88/0x158
[  560.194693]  cpuidle_idle_call+0x134/0x190
[  560.194702]  do_idle+0xd4/0x110
[  560.194709]  cpu_startup_entry+0x3c/0x58
[  560.194716]  secondary_start_kernel+0xd8/0x100
[  560.194726]  __secondary_switched+0xb8/0xc0

Steps to Reproduce

INFO: HTTP shared image: http://pek-lpgtest7408.wrs.com/buildarea1/SharedImage/LTS25/BSP/nxp-s32g_preempt-rt_glibc-std_optee_hse_GIT/20250716_024541

/lpg-build/cdc/fast_prod/WRL10_25/WRL10_25_GIT/wrlinux-10/setup.sh --machines nxp-s32g --templates feature/docker feature/s32g-optee --distros wrlinux --dl-layers=1 --accept-eula=yes
source environment-setup-x86_64-wrlinuxsdk-linux
source oe-init-build-env build
echo 'PREFERRED_PROVIDER_virtual/kernel = "linux-yocto-rt"' >> conf/local.conf


echo 'BB_NUMBER_THREADS ?= "24"' >> conf/local.conf
echo 'PARALLEL_MAKE ?= "-j 24"' >> conf/local.conf
export https_proxy=147.11.252.42:9090
export http_proxy=147.11.252.42:9090
bitbake-layers add-layer /net/pek-lpgtest16.wrs.com/buildarea1/wgao/wassp-linux/testcases/wrlinux/wr-testing/bts-dev

#####To Clone a whole new testcases layer#####
git clone --depth 1 -b master git://lxgit.wrs.com/wrlinux-testing/testcases.git ../layers/testcases/wrlinux/
bitbake-layers add-layer ../layers/testcases/wrlinux/wr-testing/bts-dev
#####End#####

echo '
require templates/feature/bts/template.conf
IMAGE_FSTYPES += " tar.bz2"
echo 'IMAGE_FSTYPES:remove = " live hddimg iso"' >> conf/local.conf
bitbake-layers add-layer /net/pek-lpgtest7408/buildarea1/SharedImage/wrlinux-testing-dl
echo 'SHARED_IMAGE_BASE = "/net/pek-lpgtest7408/buildarea1/SharedImage"
FIRMWARE_DIR_BASE = "${SHARED_IMAGE_BASE}/wr-bsp-images/nxp-s32g/firmwares"
DDR_FW_PATH = "${FIRMWARE_DIR_BASE}/ddr/g3/ddr_fw_ecc_off.bin"
HSE_LOCAL_FIRMWARE_DIR = "${FIRMWARE_DIR_BASE}/hse"
HSE_FW_VERSION_S32G2 = "0.1.0.14"
HSE_FW_VERSION_S32G3 = "0.2.64.0"
HSE_FW_NAME_S32G2 = "rev2.0_s32g2xx_hse_fw_0.1.0_1.0.14_pb240319.bin.pink"
HSE_FW_NAME_S32G3 = "s32g3xx_hse_fw_0.20.0_2.64.0_pb250127.bin.pink"
LLCE_LOCAL_FIRMWARE_DIR = "${FIRMWARE_DIR_BASE}/llce/1.0.9/s32g2"
LLCE_LOCAL_FIRMWARE_DIR_S32G3 = "${FIRMWARE_DIR_BASE}/llce/1.0.9/s32g3"
IPCF_M7_APP_BIN_DIR = "${FIRMWARE_DIR_BASE}/ipcf/4.9"
PFE_LOCAL_FIRMWARE_DIR = "${FIRMWARE_DIR_BASE}/pfe/1.11.0"
CUSTOMER_RECIPES:append = " llce"
CUSTOMER_RECIPES:openembedded-layer += 'ccid pcsc-lite opensc'
BB_NO_NETWORK = '0'
IMAGE_INSTALL:append = " llce ipc-shm pkcs11-hse pkcs11-hse-examples pfe pfe-slave libfci-cli"' >> conf/local.conf
bitbake wrlinux-image-std