← Back to team overview

canonical-ubuntu-qa team mailing list archive

[Bug 2129834] [NEW] fs:read_all_sys in ubuntu_ltp hangs on kernel 6.17 due to rv monitor crash

 

Public bug reported:

Kernel 6.17 is affected by a crash induced by the wrong fix pulled here: https://lkml.org/lkml/2025/9/22/1506. reading enabled_monitors taints the test whcih misses the deadline.
This patch should be included:
https://www.mail-archive.com/linux-trace-kernel@xxxxxxxxxxxxxxx/msg13150.html

Full log:
16600  14:57:21 INFO | START ubuntu_ltp.fs:read_all_sys ubuntu_ltp.fs:read_all_sys timeout=6300 timestamp=1760972241 localtime=Oct 20 14:57:21
16601  14:57:21 DEBUG| Persistent state client._record_indent now set to 2
16602  14:57:21 DEBUG| Persistent state client.unexpected_reboot now set to ('ubuntu_ltp.fs:read_all_sys', 'ubuntu_ltp.fs:read_all_sys')
16603  14:57:21 DEBUG| Waiting for pid 60299 for 6300 seconds
16604  14:57:21 WARNI| System python is too old, crash handling disabled
16605  14:57:21 INFO | Setting LTP_TIMEOUT_MUL=50 for read_all_sys
16606  14:57:21 ERROR| [stderr] -------------------------------------------
16607  14:57:21 ERROR| [stderr] INFO: runltp script is deprecated, try kirk
16608  14:57:21 ERROR| [stderr] https://github.com/linux-test-project/kirk
16609  14:57:21 ERROR| [stderr] -------------------------------------------
16610  14:57:21 DEBUG| [stdout] Checking for required user/group ids
16611  14:57:21 DEBUG| [stdout]
16612  14:57:21 DEBUG| [stdout] 'root' user id and group found.
16613  14:57:21 DEBUG| [stdout] 'nobody' user id and group found.
16614  14:57:21 DEBUG| [stdout] 'bin' user id and group found.
16615  14:57:21 DEBUG| [stdout] 'daemon' user id and group found.
16616  14:57:21 DEBUG| [stdout] Users group found.
16617  14:57:21 DEBUG| [stdout] Sys group found.
16618  14:57:21 DEBUG| [stdout] Required users/groups exist.
16619  14:57:21 DEBUG| [stdout] no big block device was specified on commandline.
16620  14:57:21 DEBUG| [stdout] Tests which require a big block device are disabled.
16621  14:57:21 DEBUG| [stdout] You can specify it with option -z
16622  14:57:21 DEBUG| [stdout] INFO: Test start time: Mon Oct 20 02:57:21 PM UTC 2025
16623  14:57:21 DEBUG| [stdout] COMMAND: /opt/ltp/bin/ltp-pan -q -e -S -a 60304 -n 60304 -f /tmp/ltp-QUoNvysr8i/alltests -l /dev/null -C /dev/null -T /dev/null
16624  14:57:21 DEBUG| [stdout] LOG File: /dev/null
16625  14:57:21 DEBUG| [stdout] FAILED COMMAND File: /dev/null
16626  14:57:21 DEBUG| [stdout] TCONF COMMAND File: /dev/null
16627  14:57:21 DEBUG| [stdout] Running tests.......
16628  14:57:21 DEBUG| [stdout] tst_test.c:1952: TINFO: LTP version: 20230929-1383-g3c1f992e2
16629  14:57:21 DEBUG| [stdout] tst_test.c:1955: TINFO: Tested kernel: 6.17.0-7-generic #7-Ubuntu SMP Sat Oct 18 09:07:31 UTC 2025 s390x
16630  14:57:21 DEBUG| [stdout] tst_kconfig.c:88: TINFO: Parsing kernel config '/lib/modules/6.17.0-7-generic/build/.config'
16631  14:57:21 DEBUG| [stdout] tst_test.c:1773: TINFO: Overall timeout per run is 0h 26m 40s
16632  14:57:21 DEBUG| [stdout] read_all.c:601: TINFO: Worker timeout set to 10% of runtime: 1000ms
16633  14:57:23 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60353 (2): Stuck for 1883896us, restarting it
16634  14:57:23 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60352 (1): Stuck for 1884084us, restarting it
16635  14:57:23 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60354 (3): Stuck for 1885375us, restarting it
16636  14:57:23 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60351 (0): Stuck for 1885608us, restarting it
16637  14:57:23 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60355 (4): Stuck for 1886018us, restarting it
16638  14:57:23 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60355 (4): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
16639  14:57:23 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60356 (5): Stuck for 1886312us, restarting it
16640  14:57:23 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60357 (6): Stuck for 1887080us, restarting it
16641  14:57:24 DEBUG| [stdout] read_all.c:395: TINFO: Worker 60353 (2): Timeout waiting after kill
16642  14:57:24 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60353 (2): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
16643  14:57:24 DEBUG| [stdout] read_all.c:395: TINFO: Worker 60352 (1): Timeout waiting after kill
16644  14:57:24 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60352 (1): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
16645  14:57:24 DEBUG| [stdout] read_all.c:395: TINFO: Worker 60354 (3): Timeout waiting after kill
16646  14:57:24 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60354 (3): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
16647  14:57:24 DEBUG| [stdout] read_all.c:395: TINFO: Worker 60351 (0): Timeout waiting after kill
16648  14:57:24 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60351 (0): Last popped '/sys/kernel/tracing/rv/available_monitors'
16649  14:57:24 DEBUG| [stdout] read_all.c:395: TINFO: Worker 60356 (5): Timeout waiting after kill
16650  14:57:24 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60356 (5): Last popped '/sys/kernel/tracing/rv/available_monitors'
16651  14:57:24 DEBUG| [stdout] read_all.c:395: TINFO: Worker 60357 (6): Timeout waiting after kill
16652  14:57:24 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60357 (6): Last popped '/sys/kernel/tracing/rv/available_monitors'
16653  14:57:25 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60363 (2): Stuck for 1000076us, restarting it
16654  14:57:25 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60366 (0): Stuck for 1000107us, restarting it
16655  14:57:26 DEBUG| [stdout] read_all.c:395: TINFO: Worker 60363 (2): Timeout waiting after kill
16656  14:57:26 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60363 (2): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
16657  14:57:26 DEBUG| [stdout] read_all.c:395: TINFO: Worker 60366 (0): Timeout waiting after kill
16658  14:57:26 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60366 (0): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
16659  14:57:28 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60371 (0): Stuck for 1408969us, restarting it
16660  14:57:28 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60371 (0): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
16661  14:57:28 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60364 (1): Stuck for 3411562us, restarting it
16662  14:57:28 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60364 (1): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
16663  14:57:28 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60370 (2): Stuck for 1413387us, restarting it
16664  14:57:28 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60370 (2): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
16665  14:57:28 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60365 (3): Stuck for 3412587us, restarting it
16666  14:57:28 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60365 (3): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_256_xts'
16667  14:57:28 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60362 (4): Stuck for 4412476us, restarting it
16668  14:57:28 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60367 (5): Stuck for 3412058us, restarting it
16669  14:57:28 DEBUG| [stdout] read_all.c:454: TINFO: Silencing timeout warnings; consider increasing LTP_RUNTIME_MUL or removing -q
16670  14:57:29 DEBUG| [stdout] read_all.c:660: TINFO: opendir(/sys/module/pkey_uv): ENOENT (2)
16671  15:24:01 DEBUG| [stdout] Test timeouted, sending SIGKILL!
16672  15:24:01 DEBUG| [stdout] tst_test.c:1836: TINFO: Killed the leftover descendant processes
16673  15:24:01 DEBUG| [stdout] tst_test.c:1845: TINFO: If you are running on slow machine, try exporting LTP_TIMEOUT_MUL > 1
16674  15:24:01 DEBUG| [stdout] tst_test.c:1847: TBROK: Test killed! (timeout?)
16675  15:24:01 DEBUG| [stdout]
16676  15:24:01 DEBUG| [stdout] Summary:
16677  15:24:01 DEBUG| [stdout] passed 0
16678  15:24:01 DEBUG| [stdout] failed 0
16679  15:24:01 DEBUG| [stdout] broken 1
16680  15:24:01 DEBUG| [stdout] skipped 0
16681  15:24:01 DEBUG| [stdout] warnings 0
16682  15:24:01 DEBUG| [stdout] INFO: ltp-pan reported some tests FAIL
16683  15:24:01 DEBUG| [stdout] LTP Version: 20230929-1383-g3c1f992e2
16684  15:24:01 DEBUG| [stdout] INFO: Test end time: Mon Oct 20 03:24:01 PM UTC 2025
16685  15:24:01 ERROR| [stderr] -------------------------------------------
16686  15:24:01 ERROR| [stderr] INFO: runltp script is deprecated, try kirk
16687  15:24:01 ERROR| [stderr] https://github.com/linux-test-project/kirk
16688  15:24:01 ERROR| [stderr] -------------------------------------------
16689  15:24:01 ERROR| Exception escaping from test:
16690  Traceback (most recent call last):
16691   File "/home/ubuntu/autotest/client/shared/test.py", line 411, in _exec
16692   _call_test_function(self.execute, *p_args, **p_dargs)
16693   ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
16694   File "/home/ubuntu/autotest/client/shared/test.py", line 823, in _call_test_function
16695   return func(*args, **dargs)
16696   File "/home/ubuntu/autotest/client/shared/test.py", line 290, in execute
16697   self._call_run_once(constraints, profile_only,
16698   ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^
16699   postprocess_profiled_run, args, dargs)
16700   ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
16701   File "/home/ubuntu/autotest/client/shared/test.py", line 212, in _call_run_once
16702   self.run_once(*args, **dargs)
16703   ~~~~~~~~~~~~~^^^^^^^^^^^^^^^^
16704   File "/home/ubuntu/autotest/client/tests/ubuntu_ltp/ubuntu_ltp.py", line 138, in run_once
16705   utils.system_output(cmd, verbose=False, retain_output=True)
16706   ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
16707   File "/home/ubuntu/autotest/client/shared/utils.py", line 1265, in system_output
16708   out = run(command, timeout=timeout, ignore_status=ignore_status,
16709   ~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
16710   stdout_tee=TEE_TO_LOGS, stderr_tee=TEE_TO_LOGS,
16711   ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
16712   verbose=verbose, args=args).stdout
16713   ^^^^^^^^^^^^^^^^^^^^^^^^^^^
16714   File "/home/ubuntu/autotest/client/shared/utils.py", line 916, in run
16715   raise error.CmdError(command, bg_job.result,
16716   "Command returned non-zero exit status")
16717  autotest.client.shared.error.CmdError: Command failed, rc=1, Command returned non-zero exit status
16718  * Command:
16719   /opt/ltp/runltp -f /tmp/target -q -C /dev/null -l /dev/null -T /dev/null
16720  Exit status: 1
16721  Duration: 1600.021127462387
16722
16723  stdout:
16724  Checking for required user/group ids
16725
16726  'root' user id and group found.
16727  'nobody' user id and group found.
16728  'bin' user id and group found.
16729  'daemon' user id and group found.
16730  Users group found.
16731  Sys group found.
16732  Required users/groups exist.
16733  no big block device was specified on commandline.
16734  Tests which require a big block device are disabled.
16735  You can specify it with option -z
16736  INFO: Test start time: Mon Oct 20 02:57:21 PM UTC 2025
16737  COMMAND: /opt/ltp/bin/ltp-pan -q -e -S -a 60304 -n 60304 -f /tmp/ltp-QUoNvysr8i/alltests -l /dev/null -C /dev/null -T /dev/null
16738  LOG File: /dev/null
16739  FAILED COMMAND File: /dev/null
16740  TCONF COMMAND File: /dev/null
16741  Running tests.......
16742  tst_test.c:1952: TINFO: LTP version: 20230929-1383-g3c1f992e2
16743  tst_test.c:1955: TINFO: Tested kernel: 6.17.0-7-generic #7-Ubuntu SMP Sat Oct 18 09:07:31 UTC 2025 s390x
16744  tst_kconfig.c:88: TINFO: Parsing kernel config '/lib/modules/6.17.0-7-generic/build/.config'
16745  tst_test.c:1773: TINFO: Overall timeout per run is 0h 26m 40s
16746  read_all.c:601: TINFO: Worker timeout set to 10% of runtime: 1000ms
16747  read_all.c:477: TINFO: Worker 60353 (2): Stuck for 1883896us, restarting it
16748  read_all.c:477: TINFO: Worker 60352 (1): Stuck for 1884084us, restarting it
16749  read_all.c:477: TINFO: Worker 60354 (3): Stuck for 1885375us, restarting it
16750  read_all.c:477: TINFO: Worker 60351 (0): Stuck for 1885608us, restarting it
16751  read_all.c:477: TINFO: Worker 60355 (4): Stuck for 1886018us, restarting it
16752  read_all.c:413: TINFO: Worker 60355 (4): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
16753  read_all.c:477: TINFO: Worker 60356 (5): Stuck for 1886312us, restarting it
16754  read_all.c:477: TINFO: Worker 60357 (6): Stuck for 1887080us, restarting it
16755  read_all.c:395: TINFO: Worker 60353 (2): Timeout waiting after kill
16756  read_all.c:413: TINFO: Worker 60353 (2): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
16757  read_all.c:395: TINFO: Worker 60352 (1): Timeout waiting after kill
16758  read_all.c:413: TINFO: Worker 60352 (1): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
16759  read_all.c:395: TINFO: Worker 60354 (3): Timeout waiting after kill
16760  read_all.c:413: TINFO: Worker 60354 (3): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
16761  read_all.c:395: TINFO: Worker 60351 (0): Timeout waiting after kill
16762  read_all.c:413: TINFO: Worker 60351 (0): Last popped '/sys/kernel/tracing/rv/available_monitors'
16763  read_all.c:395: TINFO: Worker 60356 (5): Timeout waiting after kill
16764  read_all.c:413: TINFO: Worker 60356 (5): Last popped '/sys/kernel/tracing/rv/available_monitors'
16765  read_all.c:395: TINFO: Worker 60357 (6): Timeout waiting after kill
16766  read_all.c:413: TINFO: Worker 60357 (6): Last popped '/sys/kernel/tracing/rv/available_monitors'
16767  read_all.c:477: TINFO: Worker 60363 (2): Stuck for 1000076us, restarting it
16768  read_all.c:477: TINFO: Worker 60366 (0): Stuck for 1000107us, restarting it
16769  read_all.c:395: TINFO: Worker 60363 (2): Timeout waiting after kill
16770  read_all.c:413: TINFO: Worker 60363 (2): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
16771  read_all.c:395: TINFO: Worker 60366 (0): Timeout waiting after kill
16772  read_all.c:413: TINFO: Worker 60366 (0): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
16773  read_all.c:477: TINFO: Worker 60371 (0): Stuck for 1408969us, restarting it
16774  read_all.c:413: TINFO: Worker 60371 (0): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
16775  read_all.c:477: TINFO: Worker 60364 (1): Stuck for 3411562us, restarting it
16776  read_all.c:413: TINFO: Worker 60364 (1): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
16777  read_all.c:477: TINFO: Worker 60370 (2): Stuck for 1413387us, restarting it
16778  read_all.c:413: TINFO: Worker 60370 (2): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
16779  read_all.c:477: TINFO: Worker 60365 (3): Stuck for 3412587us, restarting it
16780  read_all.c:413: TINFO: Worker 60365 (3): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_256_xts'
16781  read_all.c:477: TINFO: Worker 60362 (4): Stuck for 4412476us, restarting it
16782  read_all.c:477: TINFO: Worker 60367 (5): Stuck for 3412058us, restarting it
16783  read_all.c:454: TINFO: Silencing timeout warnings; consider increasing LTP_RUNTIME_MUL or removing -q
16784  read_all.c:660: TINFO: opendir(/sys/module/pkey_uv): ENOENT (2)
16785  Test timeouted, sending SIGKILL!
16786  tst_test.c:1836: TINFO: Killed the leftover descendant processes
16787  tst_test.c:1845: TINFO: If you are running on slow machine, try exporting LTP_TIMEOUT_MUL > 1
16788  tst_test.c:1847: TBROK: Test killed! (timeout?)
16789
16790  Summary:
16791  passed 0
16792  failed 0
16793  broken 1
16794  skipped 0
16795  warnings 0
16796  INFO: ltp-pan reported some tests FAIL
16797  LTP Version: 20230929-1383-g3c1f992e2
16798  INFO: Test end time: Mon Oct 20 03:24:01 PM UTC 2025
16799  stderr:
16800  -------------------------------------------
16801  INFO: runltp script is deprecated, try kirk
16802  https://github.com/linux-test-project/kirk
16803  -------------------------------------------
16804  -------------------------------------------
16805  INFO: runltp script is deprecated, try kirk
16806  https://github.com/linux-test-project/kirk
16807  -------------------------------------------
16808  15:24:01 INFO | Restore timeout multiplier LTP_TIMEOUT_MUL back to default
16809  15:24:01 ERROR| child process failed
16810  15:24:01 DEBUG| Traceback (most recent call last):
16811  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 411, in _exec
16812  15:24:01 DEBUG| _call_test_function(self.execute, *p_args, **p_dargs)
16813  15:24:01 DEBUG| ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
16814  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 823, in _call_test_function
16815  15:24:01 DEBUG| return func(*args, **dargs)
16816  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 290, in execute
16817  15:24:01 DEBUG| self._call_run_once(constraints, profile_only,
16818  15:24:01 DEBUG| ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^
16819  15:24:01 DEBUG| postprocess_profiled_run, args, dargs)
16820  15:24:01 DEBUG| ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
16821  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 212, in _call_run_once
16822  15:24:01 DEBUG| self.run_once(*args, **dargs)
16823  15:24:01 DEBUG| ~~~~~~~~~~~~~^^^^^^^^^^^^^^^^
16824  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/tests/ubuntu_ltp/ubuntu_ltp.py", line 138, in run_once
16825  15:24:01 DEBUG| utils.system_output(cmd, verbose=False, retain_output=True)
16826  15:24:01 DEBUG| ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
16827  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/utils.py", line 1265, in system_output
16828  15:24:01 DEBUG| out = run(command, timeout=timeout, ignore_status=ignore_status,
16829  15:24:01 DEBUG| ~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
16830  15:24:01 DEBUG| stdout_tee=TEE_TO_LOGS, stderr_tee=TEE_TO_LOGS,
16831  15:24:01 DEBUG| ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
16832  15:24:01 DEBUG| verbose=verbose, args=args).stdout
16833  15:24:01 DEBUG| ^^^^^^^^^^^^^^^^^^^^^^^^^^^
16834  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/utils.py", line 916, in run
16835  15:24:01 DEBUG| raise error.CmdError(command, bg_job.result,
16836  15:24:01 DEBUG| "Command returned non-zero exit status")
16837  15:24:01 DEBUG| autotest.client.shared.error.CmdError: Command failed, rc=1, Command returned non-zero exit status
16838  15:24:01 DEBUG| * Command:
16839  15:24:01 DEBUG| /opt/ltp/runltp -f /tmp/target -q -C /dev/null -l /dev/null -T /dev/null
16840  15:24:01 DEBUG| Exit status: 1
16841  15:24:01 DEBUG| Duration: 1600.021127462387
16842  15:24:01 DEBUG|
16843  15:24:01 DEBUG| stdout:
16844  15:24:01 DEBUG| Checking for required user/group ids
16845  15:24:01 DEBUG|
16846  15:24:01 DEBUG| 'root' user id and group found.
16847  15:24:01 DEBUG| 'nobody' user id and group found.
16848  15:24:01 DEBUG| 'bin' user id and group found.
16849  15:24:01 DEBUG| 'daemon' user id and group found.
16850  15:24:01 DEBUG| Users group found.
16851  15:24:01 DEBUG| Sys group found.
16852  15:24:01 DEBUG| Required users/groups exist.
16853  15:24:01 DEBUG| no big block device was specified on commandline.
16854  15:24:01 DEBUG| Tests which require a big block device are disabled.
16855  15:24:01 DEBUG| You can specify it with option -z
16856  15:24:01 DEBUG| INFO: Test start time: Mon Oct 20 02:57:21 PM UTC 2025
16857  15:24:01 DEBUG| COMMAND: /opt/ltp/bin/ltp-pan -q -e -S -a 60304 -n 60304 -f /tmp/ltp-QUoNvysr8i/alltests -l /dev/null -C /dev/null -T /dev/null
16858  15:24:01 DEBUG| LOG File: /dev/null
16859  15:24:01 DEBUG| FAILED COMMAND File: /dev/null
16860  15:24:01 DEBUG| TCONF COMMAND File: /dev/null
16861  15:24:01 DEBUG| Running tests.......
16862  15:24:01 DEBUG| tst_test.c:1952: TINFO: LTP version: 20230929-1383-g3c1f992e2
16863  15:24:01 DEBUG| tst_test.c:1955: TINFO: Tested kernel: 6.17.0-7-generic #7-Ubuntu SMP Sat Oct 18 09:07:31 UTC 2025 s390x
16864  15:24:01 DEBUG| tst_kconfig.c:88: TINFO: Parsing kernel config '/lib/modules/6.17.0-7-generic/build/.config'
16865  15:24:01 DEBUG| tst_test.c:1773: TINFO: Overall timeout per run is 0h 26m 40s
16866  15:24:01 DEBUG| read_all.c:601: TINFO: Worker timeout set to 10% of runtime: 1000ms
16867  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60353 (2): Stuck for 1883896us, restarting it
16868  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60352 (1): Stuck for 1884084us, restarting it
16869  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60354 (3): Stuck for 1885375us, restarting it
16870  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60351 (0): Stuck for 1885608us, restarting it
16871  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60355 (4): Stuck for 1886018us, restarting it
16872  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60355 (4): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
16873  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60356 (5): Stuck for 1886312us, restarting it
16874  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60357 (6): Stuck for 1887080us, restarting it
16875  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60353 (2): Timeout waiting after kill
16876  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60353 (2): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
16877  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60352 (1): Timeout waiting after kill
16878  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60352 (1): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
16879  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60354 (3): Timeout waiting after kill
16880  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60354 (3): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
16881  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60351 (0): Timeout waiting after kill
16882  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60351 (0): Last popped '/sys/kernel/tracing/rv/available_monitors'
16883  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60356 (5): Timeout waiting after kill
16884  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60356 (5): Last popped '/sys/kernel/tracing/rv/available_monitors'
16885  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60357 (6): Timeout waiting after kill
16886  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60357 (6): Last popped '/sys/kernel/tracing/rv/available_monitors'
16887  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60363 (2): Stuck for 1000076us, restarting it
16888  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60366 (0): Stuck for 1000107us, restarting it
16889  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60363 (2): Timeout waiting after kill
16890  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60363 (2): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
16891  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60366 (0): Timeout waiting after kill
16892  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60366 (0): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
16893  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60371 (0): Stuck for 1408969us, restarting it
16894  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60371 (0): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
16895  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60364 (1): Stuck for 3411562us, restarting it
16896  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60364 (1): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
16897  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60370 (2): Stuck for 1413387us, restarting it
16898  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60370 (2): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
16899  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60365 (3): Stuck for 3412587us, restarting it
16900  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60365 (3): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_256_xts'
16901  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60362 (4): Stuck for 4412476us, restarting it
16902  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60367 (5): Stuck for 3412058us, restarting it
16903  15:24:01 DEBUG| read_all.c:454: TINFO: Silencing timeout warnings; consider increasing LTP_RUNTIME_MUL or removing -q
16904  15:24:01 DEBUG| read_all.c:660: TINFO: opendir(/sys/module/pkey_uv): ENOENT (2)
16905  15:24:01 DEBUG| Test timeouted, sending SIGKILL!
16906  15:24:01 DEBUG| tst_test.c:1836: TINFO: Killed the leftover descendant processes
16907  15:24:01 DEBUG| tst_test.c:1845: TINFO: If you are running on slow machine, try exporting LTP_TIMEOUT_MUL > 1
16908  15:24:01 DEBUG| tst_test.c:1847: TBROK: Test killed! (timeout?)
16909  15:24:01 DEBUG|
16910  15:24:01 DEBUG| Summary:
16911  15:24:01 DEBUG| passed 0
16912  15:24:01 DEBUG| failed 0
16913  15:24:01 DEBUG| broken 1
16914  15:24:01 DEBUG| skipped 0
16915  15:24:01 DEBUG| warnings 0
16916  15:24:01 DEBUG| INFO: ltp-pan reported some tests FAIL
16917  15:24:01 DEBUG| LTP Version: 20230929-1383-g3c1f992e2
16918  15:24:01 DEBUG| INFO: Test end time: Mon Oct 20 03:24:01 PM UTC 2025
16919  15:24:01 DEBUG| stderr:
16920  15:24:01 DEBUG| -------------------------------------------
16921  15:24:01 DEBUG| INFO: runltp script is deprecated, try kirk
16922  15:24:01 DEBUG| https://github.com/linux-test-project/kirk
16923  15:24:01 DEBUG| -------------------------------------------
16924  15:24:01 DEBUG| -------------------------------------------
16925  15:24:01 DEBUG| INFO: runltp script is deprecated, try kirk
16926  15:24:01 DEBUG| https://github.com/linux-test-project/kirk
16927  15:24:01 DEBUG| -------------------------------------------
16928  15:24:01 DEBUG|
16929  15:24:01 DEBUG| During handling of the above exception, another exception occurred:
16930  15:24:01 DEBUG|
16931  15:24:01 DEBUG| Traceback (most recent call last):
16932  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 434, in _exec
16933  15:24:01 DEBUG| raise exc_info[0](exc_info[1]).with_traceback(exc_info[2])
16934  15:24:01 DEBUG| ~~~~~~~~~~~^^^^^^^^^^^^^
16935  15:24:01 DEBUG| TypeError: CmdError.__init__() missing 1 required positional argument: 'result_obj'
16936  15:24:01 DEBUG|
16937  15:24:01 DEBUG| During handling of the above exception, another exception occurred:
16938  15:24:01 DEBUG|
16939  15:24:01 DEBUG| Traceback (most recent call last):
16940  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/parallel.py", line 25, in fork_start
16941  15:24:01 DEBUG| l()
16942  15:24:01 DEBUG| ~^^
16943  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/job.py", line 506, in
16944  15:24:01 DEBUG| l = lambda: test.runtest(self, url, tag, args, dargs)
16945  15:24:01 DEBUG| ~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
16946  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/test.py", line 121, in runtest
16947  15:24:01 DEBUG| common_test.runtest(job, url, tag, args, dargs, locals(), globals(),
16948  15:24:01 DEBUG| ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
16949  15:24:01 DEBUG| job.sysinfo.log_before_each_test,
16950  15:24:01 DEBUG| ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
16951  15:24:01 DEBUG| job.sysinfo.log_after_each_test,
16952  15:24:01 DEBUG| ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
16953  15:24:01 DEBUG| job.sysinfo.log_before_each_iteration,
16954  15:24:01 DEBUG| ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
16955  15:24:01 DEBUG| job.sysinfo.log_after_each_iteration)
16956  15:24:01 DEBUG| ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
16957  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 913, in runtest
16958  15:24:01 DEBUG| mytest._exec(args, dargs)
16959  15:24:01 DEBUG| ~~~~~~~~~~~~^^^^^^^^^^^^^
16960  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 455, in _exec
16961  15:24:01 DEBUG| raise error.UnhandledTestError(e)
16962  15:24:01 DEBUG| autotest.client.shared.error.UnhandledTestError: Unhandled TypeError: CmdError.__init__() missing 1 required positional argument: 'result_obj'
16963  15:24:01 DEBUG| Traceback (most recent call last):
16964  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 411, in _exec
16965  15:24:01 DEBUG| _call_test_function(self.execute, *p_args, **p_dargs)
16966  15:24:01 DEBUG| ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
16967  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 823, in _call_test_function
16968  15:24:01 DEBUG| return func(*args, **dargs)
16969  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 290, in execute
16970  15:24:01 DEBUG| self._call_run_once(constraints, profile_only,
16971  15:24:01 DEBUG| ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^
16972  15:24:01 DEBUG| postprocess_profiled_run, args, dargs)
16973  15:24:01 DEBUG| ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
16974  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 212, in _call_run_once
16975  15:24:01 DEBUG| self.run_once(*args, **dargs)
16976  15:24:01 DEBUG| ~~~~~~~~~~~~~^^^^^^^^^^^^^^^^
16977  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/tests/ubuntu_ltp/ubuntu_ltp.py", line 138, in run_once
16978  15:24:01 DEBUG| utils.system_output(cmd, verbose=False, retain_output=True)
16979  15:24:01 DEBUG| ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
16980  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/utils.py", line 1265, in system_output
16981  15:24:01 DEBUG| out = run(command, timeout=timeout, ignore_status=ignore_status,
16982  15:24:01 DEBUG| ~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
16983  15:24:01 DEBUG| stdout_tee=TEE_TO_LOGS, stderr_tee=TEE_TO_LOGS,
16984  15:24:01 DEBUG| ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
16985  15:24:01 DEBUG| verbose=verbose, args=args).stdout
16986  15:24:01 DEBUG| ^^^^^^^^^^^^^^^^^^^^^^^^^^^
16987  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/utils.py", line 916, in run
16988  15:24:01 DEBUG| raise error.CmdError(command, bg_job.result,
16989  15:24:01 DEBUG| "Command returned non-zero exit status")
16990  15:24:01 DEBUG| autotest.client.shared.error.CmdError: Command failed, rc=1, Command returned non-zero exit status
16991  15:24:01 DEBUG| * Command:
16992  15:24:01 DEBUG| /opt/ltp/runltp -f /tmp/target -q -C /dev/null -l /dev/null -T /dev/null
16993  15:24:01 DEBUG| Exit status: 1
16994  15:24:01 DEBUG| Duration: 1600.021127462387
16995  15:24:01 DEBUG|
16996  15:24:01 DEBUG| stdout:
16997  15:24:01 DEBUG| Checking for required user/group ids
16998  15:24:01 DEBUG|
16999  15:24:01 DEBUG| 'root' user id and group found.
17000  15:24:01 DEBUG| 'nobody' user id and group found.
17001  15:24:01 DEBUG| 'bin' user id and group found.
17002  15:24:01 DEBUG| 'daemon' user id and group found.
17003  15:24:01 DEBUG| Users group found.
17004  15:24:01 DEBUG| Sys group found.
17005  15:24:01 DEBUG| Required users/groups exist.
17006  15:24:01 DEBUG| no big block device was specified on commandline.
17007  15:24:01 DEBUG| Tests which require a big block device are disabled.
17008  15:24:01 DEBUG| You can specify it with option -z
17009  15:24:01 DEBUG| INFO: Test start time: Mon Oct 20 02:57:21 PM UTC 2025
17010  15:24:01 DEBUG| COMMAND: /opt/ltp/bin/ltp-pan -q -e -S -a 60304 -n 60304 -f /tmp/ltp-QUoNvysr8i/alltests -l /dev/null -C /dev/null -T /dev/null
17011  15:24:01 DEBUG| LOG File: /dev/null
17012  15:24:01 DEBUG| FAILED COMMAND File: /dev/null
17013  15:24:01 DEBUG| TCONF COMMAND File: /dev/null
17014  15:24:01 DEBUG| Running tests.......
17015  15:24:01 DEBUG| tst_test.c:1952: TINFO: LTP version: 20230929-1383-g3c1f992e2
17016  15:24:01 DEBUG| tst_test.c:1955: TINFO: Tested kernel: 6.17.0-7-generic #7-Ubuntu SMP Sat Oct 18 09:07:31 UTC 2025 s390x
17017  15:24:01 DEBUG| tst_kconfig.c:88: TINFO: Parsing kernel config '/lib/modules/6.17.0-7-generic/build/.config'
17018  15:24:01 DEBUG| tst_test.c:1773: TINFO: Overall timeout per run is 0h 26m 40s
17019  15:24:01 DEBUG| read_all.c:601: TINFO: Worker timeout set to 10% of runtime: 1000ms
17020  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60353 (2): Stuck for 1883896us, restarting it
17021  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60352 (1): Stuck for 1884084us, restarting it
17022  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60354 (3): Stuck for 1885375us, restarting it
17023  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60351 (0): Stuck for 1885608us, restarting it
17024  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60355 (4): Stuck for 1886018us, restarting it
17025  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60355 (4): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
17026  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60356 (5): Stuck for 1886312us, restarting it
17027  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60357 (6): Stuck for 1887080us, restarting it
17028  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60353 (2): Timeout waiting after kill
17029  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60353 (2): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
17030  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60352 (1): Timeout waiting after kill
17031  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60352 (1): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
17032  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60354 (3): Timeout waiting after kill
17033  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60354 (3): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
17034  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60351 (0): Timeout waiting after kill
17035  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60351 (0): Last popped '/sys/kernel/tracing/rv/available_monitors'
17036  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60356 (5): Timeout waiting after kill
17037  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60356 (5): Last popped '/sys/kernel/tracing/rv/available_monitors'
17038  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60357 (6): Timeout waiting after kill
17039  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60357 (6): Last popped '/sys/kernel/tracing/rv/available_monitors'
17040  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60363 (2): Stuck for 1000076us, restarting it
17041  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60366 (0): Stuck for 1000107us, restarting it
17042  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60363 (2): Timeout waiting after kill
17043  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60363 (2): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
17044  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60366 (0): Timeout waiting after kill
17045  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60366 (0): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
17046  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60371 (0): Stuck for 1408969us, restarting it
17047  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60371 (0): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
17048  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60364 (1): Stuck for 3411562us, restarting it
17049  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60364 (1): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
17050  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60370 (2): Stuck for 1413387us, restarting it
17051  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60370 (2): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
17052  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60365 (3): Stuck for 3412587us, restarting it
17053  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60365 (3): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_256_xts'
17054  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60362 (4): Stuck for 4412476us, restarting it
17055  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60367 (5): Stuck for 3412058us, restarting it
17056  15:24:01 DEBUG| read_all.c:454: TINFO: Silencing timeout warnings; consider increasing LTP_RUNTIME_MUL or removing -q
17057  15:24:01 DEBUG| read_all.c:660: TINFO: opendir(/sys/module/pkey_uv): ENOENT (2)
17058  15:24:01 DEBUG| Test timeouted, sending SIGKILL!
17059  15:24:01 DEBUG| tst_test.c:1836: TINFO: Killed the leftover descendant processes
17060  15:24:01 DEBUG| tst_test.c:1845: TINFO: If you are running on slow machine, try exporting LTP_TIMEOUT_MUL > 1
17061  15:24:01 DEBUG| tst_test.c:1847: TBROK: Test killed! (timeout?)
17062  15:24:01 DEBUG|
17063  15:24:01 DEBUG| Summary:
17064  15:24:01 DEBUG| passed 0
17065  15:24:01 DEBUG| failed 0
17066  15:24:01 DEBUG| broken 1
17067  15:24:01 DEBUG| skipped 0
17068  15:24:01 DEBUG| warnings 0
17069  15:24:01 DEBUG| INFO: ltp-pan reported some tests FAIL
17070  15:24:01 DEBUG| LTP Version: 20230929-1383-g3c1f992e2
17071  15:24:01 DEBUG| INFO: Test end time: Mon Oct 20 03:24:01 PM UTC 2025
17072  15:24:01 DEBUG| stderr:
17073  15:24:01 DEBUG| -------------------------------------------
17074  15:24:01 DEBUG| INFO: runltp script is deprecated, try kirk
17075  15:24:01 DEBUG| https://github.com/linux-test-project/kirk
17076  15:24:01 DEBUG| -------------------------------------------
17077  15:24:01 DEBUG| -------------------------------------------
17078  15:24:01 DEBUG| INFO: runltp script is deprecated, try kirk
17079  15:24:01 DEBUG| https://github.com/linux-test-project/kirk
17080  15:24:01 DEBUG| -------------------------------------------
17081  15:24:01 DEBUG|
17082  15:24:01 DEBUG| During handling of the above exception, another exception occurred:
17083  15:24:01 DEBUG|
17084  15:24:01 DEBUG| Traceback (most recent call last):
17085  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 434, in _exec
17086  15:24:01 DEBUG| raise exc_info[0](exc_info[1]).with_traceback(exc_info[2])
17087  15:24:01 DEBUG| ~~~~~~~~~~~^^^^^^^^^^^^^
17088  15:24:01 DEBUG| TypeError: CmdError.__init__() missing 1 required positional argument: 'result_obj'
17089  15:24:01 DEBUG|
17090  15:24:01 INFO | ERROR ubuntu_ltp.fs:read_all_sys ubuntu_ltp.fs:read_all_sys timestamp=1760973841 localtime=Oct 20 15:24:01 Unhandled TypeError: CmdError.__init__() missing 1 required positional argument: 'result_obj'
17091   Traceback (most recent call last):
17092   File "/home/ubuntu/autotest/client/shared/test.py", line 411, in _exec
17093   _call_test_function(self.execute, *p_args, **p_dargs)
17094   ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
17095   File "/home/ubuntu/autotest/client/shared/test.py", line 823, in _call_test_function
17096   return func(*args, **dargs)
17097   File "/home/ubuntu/autotest/client/shared/test.py", line 290, in execute
17098   self._call_run_once(constraints, profile_only,
17099   ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^
17100   postprocess_profiled_run, args, dargs)
17101   ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
17102   File "/home/ubuntu/autotest/client/shared/test.py", line 212, in _call_run_once
17103   self.run_once(*args, **dargs)
17104   ~~~~~~~~~~~~~^^^^^^^^^^^^^^^^
17105   File "/home/ubuntu/autotest/client/tests/ubuntu_ltp/ubuntu_ltp.py", line 138, in run_once
17106   utils.system_output(cmd, verbose=False, retain_output=True)
17107   ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
17108   File "/home/ubuntu/autotest/client/shared/utils.py", line 1265, in system_output
17109   out = run(command, timeout=timeout, ignore_status=ignore_status,
17110   ~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
17111   stdout_tee=TEE_TO_LOGS, stderr_tee=TEE_TO_LOGS,
17112   ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
17113   verbose=verbose, args=args).stdout
17114   ^^^^^^^^^^^^^^^^^^^^^^^^^^^
17115   File "/home/ubuntu/autotest/client/shared/utils.py", line 916, in run
17116   raise error.CmdError(command, bg_job.result,
17117   "Command returned non-zero exit status")
17118   autotest.client.shared.error.CmdError: Command failed, rc=1, Command returned non-zero exit status
17119   * Command:
17120   /opt/ltp/runltp -f /tmp/target -q -C /dev/null -l /dev/null -T /dev/null
17121   Exit status: 1
17122   Duration: 1600.021127462387
17123
17124   stdout:
17125   Checking for required user/group ids
17126
17127   'root' user id and group found.
17128   'nobody' user id and group found.
17129   'bin' user id and group found.
17130   'daemon' user id and group found.
17131   Users group found.
17132   Sys group found.
17133   Required users/groups exist.
17134   no big block device was specified on commandline.
17135   Tests which require a big block device are disabled.
17136   You can specify it with option -z
17137   INFO: Test start time: Mon Oct 20 02:57:21 PM UTC 2025
17138   COMMAND: /opt/ltp/bin/ltp-pan -q -e -S -a 60304 -n 60304 -f /tmp/ltp-QUoNvysr8i/alltests -l /dev/null -C /dev/null -T /dev/null
17139   LOG File: /dev/null
17140   FAILED COMMAND File: /dev/null
17141   TCONF COMMAND File: /dev/null
17142   Running tests.......
17143   tst_test.c:1952: TINFO: LTP version: 20230929-1383-g3c1f992e2
17144   tst_test.c:1955: TINFO: Tested kernel: 6.17.0-7-generic #7-Ubuntu SMP Sat Oct 18 09:07:31 UTC 2025 s390x
17145   tst_kconfig.c:88: TINFO: Parsing kernel config '/lib/modules/6.17.0-7-generic/build/.config'
17146   tst_test.c:1773: TINFO: Overall timeout per run is 0h 26m 40s
17147   read_all.c:601: TINFO: Worker timeout set to 10% of runtime: 1000ms
17148   read_all.c:477: TINFO: Worker 60353 (2): Stuck for 1883896us, restarting it
17149   read_all.c:477: TINFO: Worker 60352 (1): Stuck for 1884084us, restarting it
17150   read_all.c:477: TINFO: Worker 60354 (3): Stuck for 1885375us, restarting it
17151   read_all.c:477: TINFO: Worker 60351 (0): Stuck for 1885608us, restarting it
17152   read_all.c:477: TINFO: Worker 60355 (4): Stuck for 1886018us, restarting it
17153   read_all.c:413: TINFO: Worker 60355 (4): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
17154   read_all.c:477: TINFO: Worker 60356 (5): Stuck for 1886312us, restarting it
17155   read_all.c:477: TINFO: Worker 60357 (6): Stuck for 1887080us, restarting it
17156   read_all.c:395: TINFO: Worker 60353 (2): Timeout waiting after kill
17157   read_all.c:413: TINFO: Worker 60353 (2): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
17158   read_all.c:395: TINFO: Worker 60352 (1): Timeout waiting after kill
17159   read_all.c:413: TINFO: Worker 60352 (1): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
17160   read_all.c:395: TINFO: Worker 60354 (3): Timeout waiting after kill
17161   read_all.c:413: TINFO: Worker 60354 (3): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
17162   read_all.c:395: TINFO: Worker 60351 (0): Timeout waiting after kill
17163   read_all.c:413: TINFO: Worker 60351 (0): Last popped '/sys/kernel/tracing/rv/available_monitors'
17164   read_all.c:395: TINFO: Worker 60356 (5): Timeout waiting after kill
17165   read_all.c:413: TINFO: Worker 60356 (5): Last popped '/sys/kernel/tracing/rv/available_monitors'
17166   read_all.c:395: TINFO: Worker 60357 (6): Timeout waiting after kill
17167   read_all.c:413: TINFO: Worker 60357 (6): Last popped '/sys/kernel/tracing/rv/available_monitors'
17168   read_all.c:477: TINFO: Worker 60363 (2): Stuck for 1000076us, restarting it
17169   read_all.c:477: TINFO: Worker 60366 (0): Stuck for 1000107us, restarting it
17170   read_all.c:395: TINFO: Worker 60363 (2): Timeout waiting after kill
17171   read_all.c:413: TINFO: Worker 60363 (2): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
17172   read_all.c:395: TINFO: Worker 60366 (0): Timeout waiting after kill
17173   read_all.c:413: TINFO: Worker 60366 (0): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
17174   read_all.c:477: TINFO: Worker 60371 (0): Stuck for 1408969us, restarting it
17175   read_all.c:413: TINFO: Worker 60371 (0): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
17176   read_all.c:477: TINFO: Worker 60364 (1): Stuck for 3411562us, restarting it
17177   read_all.c:413: TINFO: Worker 60364 (1): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
17178   read_all.c:477: TINFO: Worker 60370 (2): Stuck for 1413387us, restarting it
17179   read_all.c:413: TINFO: Worker 60370 (2): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
17180   read_all.c:477: TINFO: Worker 60365 (3): Stuck for 3412587us, restarting it
17181   read_all.c:413: TINFO: Worker 60365 (3): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_256_xts'
17182   read_all.c:477: TINFO: Worker 60362 (4): Stuck for 4412476us, restarting it
17183   read_all.c:477: TINFO: Worker 60367 (5): Stuck for 3412058us, restarting it
17184   read_all.c:454: TINFO: Silencing timeout warnings; consider increasing LTP_RUNTIME_MUL or removing -q
17185   read_all.c:660: TINFO: opendir(/sys/module/pkey_uv): ENOENT (2)
17186   Test timeouted, sending SIGKILL!
17187   tst_test.c:1836: TINFO: Killed the leftover descendant processes
17188   tst_test.c:1845: TINFO: If you are running on slow machine, try exporting LTP_TIMEOUT_MUL > 1
17189   tst_test.c:1847: TBROK: Test killed! (timeout?)
17190
17191   Summary:
17192   passed 0
17193   failed 0
17194   broken 1
17195   skipped 0
17196   warnings 0
17197   INFO: ltp-pan reported some tests FAIL
17198   LTP Version: 20230929-1383-g3c1f992e2
17199   INFO: Test end time: Mon Oct 20 03:24:01 PM UTC 2025
17200   stderr:
17201   -------------------------------------------
17202   INFO: runltp script is deprecated, try kirk
17203   https://github.com/linux-test-project/kirk
17204   -------------------------------------------
17205   -------------------------------------------
17206   INFO: runltp script is deprecated, try kirk
17207   https://github.com/linux-test-project/kirk
17208   -------------------------------------------
17209
17210   During handling of the above exception, another exception occurred:
17211
17212   Traceback (most recent call last):
17213   File "/home/ubuntu/autotest/client/shared/test.py", line 434, in _exec
17214   raise exc_info[0](exc_info[1]).with_traceback(exc_info[2])
17215   ~~~~~~~~~~~^^^^^^^^^^^^^
17216   TypeError: CmdError.__init__() missing 1 required positional argument: 'result_obj'
17217

** Affects: ubuntu-kernel-tests
     Importance: Undecided
         Status: New

** Description changed:

- Kernel 6.17 is affected by a crash induce dby the wrong fix pulled here: https://lkml.org/lkml/2025/9/22/1506. reading enabled_monitors taints the test whcih misses the deadline.
+ Kernel 6.17 is affected by a crash induced by the wrong fix pulled here: https://lkml.org/lkml/2025/9/22/1506. reading enabled_monitors taints the test whcih misses the deadline.
  This patch should be included:
  https://www.mail-archive.com/linux-trace-kernel@xxxxxxxxxxxxxxx/msg13150.html
- 
  
  Full log:
  16600  14:57:21 INFO | START ubuntu_ltp.fs:read_all_sys ubuntu_ltp.fs:read_all_sys timeout=6300 timestamp=1760972241 localtime=Oct 20 14:57:21
  16601  14:57:21 DEBUG| Persistent state client._record_indent now set to 2
  16602  14:57:21 DEBUG| Persistent state client.unexpected_reboot now set to ('ubuntu_ltp.fs:read_all_sys', 'ubuntu_ltp.fs:read_all_sys')
  16603  14:57:21 DEBUG| Waiting for pid 60299 for 6300 seconds
  16604  14:57:21 WARNI| System python is too old, crash handling disabled
  16605  14:57:21 INFO | Setting LTP_TIMEOUT_MUL=50 for read_all_sys
  16606  14:57:21 ERROR| [stderr] -------------------------------------------
  16607  14:57:21 ERROR| [stderr] INFO: runltp script is deprecated, try kirk
  16608  14:57:21 ERROR| [stderr] https://github.com/linux-test-project/kirk
  16609  14:57:21 ERROR| [stderr] -------------------------------------------
  16610  14:57:21 DEBUG| [stdout] Checking for required user/group ids
  16611  14:57:21 DEBUG| [stdout]
  16612  14:57:21 DEBUG| [stdout] 'root' user id and group found.
  16613  14:57:21 DEBUG| [stdout] 'nobody' user id and group found.
  16614  14:57:21 DEBUG| [stdout] 'bin' user id and group found.
  16615  14:57:21 DEBUG| [stdout] 'daemon' user id and group found.
  16616  14:57:21 DEBUG| [stdout] Users group found.
  16617  14:57:21 DEBUG| [stdout] Sys group found.
  16618  14:57:21 DEBUG| [stdout] Required users/groups exist.
  16619  14:57:21 DEBUG| [stdout] no big block device was specified on commandline.
  16620  14:57:21 DEBUG| [stdout] Tests which require a big block device are disabled.
  16621  14:57:21 DEBUG| [stdout] You can specify it with option -z
  16622  14:57:21 DEBUG| [stdout] INFO: Test start time: Mon Oct 20 02:57:21 PM UTC 2025
  16623  14:57:21 DEBUG| [stdout] COMMAND: /opt/ltp/bin/ltp-pan -q -e -S -a 60304 -n 60304 -f /tmp/ltp-QUoNvysr8i/alltests -l /dev/null -C /dev/null -T /dev/null
  16624  14:57:21 DEBUG| [stdout] LOG File: /dev/null
  16625  14:57:21 DEBUG| [stdout] FAILED COMMAND File: /dev/null
  16626  14:57:21 DEBUG| [stdout] TCONF COMMAND File: /dev/null
  16627  14:57:21 DEBUG| [stdout] Running tests.......
  16628  14:57:21 DEBUG| [stdout] tst_test.c:1952: TINFO: LTP version: 20230929-1383-g3c1f992e2
  16629  14:57:21 DEBUG| [stdout] tst_test.c:1955: TINFO: Tested kernel: 6.17.0-7-generic #7-Ubuntu SMP Sat Oct 18 09:07:31 UTC 2025 s390x
  16630  14:57:21 DEBUG| [stdout] tst_kconfig.c:88: TINFO: Parsing kernel config '/lib/modules/6.17.0-7-generic/build/.config'
  16631  14:57:21 DEBUG| [stdout] tst_test.c:1773: TINFO: Overall timeout per run is 0h 26m 40s
  16632  14:57:21 DEBUG| [stdout] read_all.c:601: TINFO: Worker timeout set to 10% of runtime: 1000ms
  16633  14:57:23 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60353 (2): Stuck for 1883896us, restarting it
  16634  14:57:23 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60352 (1): Stuck for 1884084us, restarting it
  16635  14:57:23 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60354 (3): Stuck for 1885375us, restarting it
  16636  14:57:23 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60351 (0): Stuck for 1885608us, restarting it
  16637  14:57:23 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60355 (4): Stuck for 1886018us, restarting it
  16638  14:57:23 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60355 (4): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
  16639  14:57:23 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60356 (5): Stuck for 1886312us, restarting it
  16640  14:57:23 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60357 (6): Stuck for 1887080us, restarting it
  16641  14:57:24 DEBUG| [stdout] read_all.c:395: TINFO: Worker 60353 (2): Timeout waiting after kill
  16642  14:57:24 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60353 (2): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
  16643  14:57:24 DEBUG| [stdout] read_all.c:395: TINFO: Worker 60352 (1): Timeout waiting after kill
  16644  14:57:24 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60352 (1): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
  16645  14:57:24 DEBUG| [stdout] read_all.c:395: TINFO: Worker 60354 (3): Timeout waiting after kill
  16646  14:57:24 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60354 (3): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
  16647  14:57:24 DEBUG| [stdout] read_all.c:395: TINFO: Worker 60351 (0): Timeout waiting after kill
  16648  14:57:24 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60351 (0): Last popped '/sys/kernel/tracing/rv/available_monitors'
  16649  14:57:24 DEBUG| [stdout] read_all.c:395: TINFO: Worker 60356 (5): Timeout waiting after kill
  16650  14:57:24 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60356 (5): Last popped '/sys/kernel/tracing/rv/available_monitors'
  16651  14:57:24 DEBUG| [stdout] read_all.c:395: TINFO: Worker 60357 (6): Timeout waiting after kill
  16652  14:57:24 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60357 (6): Last popped '/sys/kernel/tracing/rv/available_monitors'
  16653  14:57:25 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60363 (2): Stuck for 1000076us, restarting it
  16654  14:57:25 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60366 (0): Stuck for 1000107us, restarting it
  16655  14:57:26 DEBUG| [stdout] read_all.c:395: TINFO: Worker 60363 (2): Timeout waiting after kill
  16656  14:57:26 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60363 (2): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
  16657  14:57:26 DEBUG| [stdout] read_all.c:395: TINFO: Worker 60366 (0): Timeout waiting after kill
  16658  14:57:26 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60366 (0): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
  16659  14:57:28 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60371 (0): Stuck for 1408969us, restarting it
  16660  14:57:28 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60371 (0): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
  16661  14:57:28 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60364 (1): Stuck for 3411562us, restarting it
  16662  14:57:28 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60364 (1): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
  16663  14:57:28 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60370 (2): Stuck for 1413387us, restarting it
  16664  14:57:28 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60370 (2): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
  16665  14:57:28 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60365 (3): Stuck for 3412587us, restarting it
  16666  14:57:28 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60365 (3): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_256_xts'
  16667  14:57:28 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60362 (4): Stuck for 4412476us, restarting it
  16668  14:57:28 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60367 (5): Stuck for 3412058us, restarting it
  16669  14:57:28 DEBUG| [stdout] read_all.c:454: TINFO: Silencing timeout warnings; consider increasing LTP_RUNTIME_MUL or removing -q
  16670  14:57:29 DEBUG| [stdout] read_all.c:660: TINFO: opendir(/sys/module/pkey_uv): ENOENT (2)
  16671  15:24:01 DEBUG| [stdout] Test timeouted, sending SIGKILL!
  16672  15:24:01 DEBUG| [stdout] tst_test.c:1836: TINFO: Killed the leftover descendant processes
  16673  15:24:01 DEBUG| [stdout] tst_test.c:1845: TINFO: If you are running on slow machine, try exporting LTP_TIMEOUT_MUL > 1
  16674  15:24:01 DEBUG| [stdout] tst_test.c:1847: TBROK: Test killed! (timeout?)
  16675  15:24:01 DEBUG| [stdout]
  16676  15:24:01 DEBUG| [stdout] Summary:
  16677  15:24:01 DEBUG| [stdout] passed 0
  16678  15:24:01 DEBUG| [stdout] failed 0
  16679  15:24:01 DEBUG| [stdout] broken 1
  16680  15:24:01 DEBUG| [stdout] skipped 0
  16681  15:24:01 DEBUG| [stdout] warnings 0
  16682  15:24:01 DEBUG| [stdout] INFO: ltp-pan reported some tests FAIL
  16683  15:24:01 DEBUG| [stdout] LTP Version: 20230929-1383-g3c1f992e2
  16684  15:24:01 DEBUG| [stdout] INFO: Test end time: Mon Oct 20 03:24:01 PM UTC 2025
  16685  15:24:01 ERROR| [stderr] -------------------------------------------
  16686  15:24:01 ERROR| [stderr] INFO: runltp script is deprecated, try kirk
  16687  15:24:01 ERROR| [stderr] https://github.com/linux-test-project/kirk
  16688  15:24:01 ERROR| [stderr] -------------------------------------------
  16689  15:24:01 ERROR| Exception escaping from test:
  16690  Traceback (most recent call last):
  16691   File "/home/ubuntu/autotest/client/shared/test.py", line 411, in _exec
  16692   _call_test_function(self.execute, *p_args, **p_dargs)
  16693   ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16694   File "/home/ubuntu/autotest/client/shared/test.py", line 823, in _call_test_function
  16695   return func(*args, **dargs)
  16696   File "/home/ubuntu/autotest/client/shared/test.py", line 290, in execute
  16697   self._call_run_once(constraints, profile_only,
  16698   ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16699   postprocess_profiled_run, args, dargs)
  16700   ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16701   File "/home/ubuntu/autotest/client/shared/test.py", line 212, in _call_run_once
  16702   self.run_once(*args, **dargs)
  16703   ~~~~~~~~~~~~~^^^^^^^^^^^^^^^^
  16704   File "/home/ubuntu/autotest/client/tests/ubuntu_ltp/ubuntu_ltp.py", line 138, in run_once
  16705   utils.system_output(cmd, verbose=False, retain_output=True)
  16706   ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16707   File "/home/ubuntu/autotest/client/shared/utils.py", line 1265, in system_output
  16708   out = run(command, timeout=timeout, ignore_status=ignore_status,
  16709   ~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16710   stdout_tee=TEE_TO_LOGS, stderr_tee=TEE_TO_LOGS,
  16711   ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16712   verbose=verbose, args=args).stdout
  16713   ^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16714   File "/home/ubuntu/autotest/client/shared/utils.py", line 916, in run
  16715   raise error.CmdError(command, bg_job.result,
  16716   "Command returned non-zero exit status")
  16717  autotest.client.shared.error.CmdError: Command failed, rc=1, Command returned non-zero exit status
  16718  * Command:
  16719   /opt/ltp/runltp -f /tmp/target -q -C /dev/null -l /dev/null -T /dev/null
  16720  Exit status: 1
  16721  Duration: 1600.021127462387
- 16722  
+ 16722
  16723  stdout:
  16724  Checking for required user/group ids
- 16725  
+ 16725
  16726  'root' user id and group found.
  16727  'nobody' user id and group found.
  16728  'bin' user id and group found.
  16729  'daemon' user id and group found.
  16730  Users group found.
  16731  Sys group found.
  16732  Required users/groups exist.
  16733  no big block device was specified on commandline.
  16734  Tests which require a big block device are disabled.
  16735  You can specify it with option -z
  16736  INFO: Test start time: Mon Oct 20 02:57:21 PM UTC 2025
  16737  COMMAND: /opt/ltp/bin/ltp-pan -q -e -S -a 60304 -n 60304 -f /tmp/ltp-QUoNvysr8i/alltests -l /dev/null -C /dev/null -T /dev/null
  16738  LOG File: /dev/null
  16739  FAILED COMMAND File: /dev/null
  16740  TCONF COMMAND File: /dev/null
  16741  Running tests.......
  16742  tst_test.c:1952: TINFO: LTP version: 20230929-1383-g3c1f992e2
  16743  tst_test.c:1955: TINFO: Tested kernel: 6.17.0-7-generic #7-Ubuntu SMP Sat Oct 18 09:07:31 UTC 2025 s390x
  16744  tst_kconfig.c:88: TINFO: Parsing kernel config '/lib/modules/6.17.0-7-generic/build/.config'
  16745  tst_test.c:1773: TINFO: Overall timeout per run is 0h 26m 40s
  16746  read_all.c:601: TINFO: Worker timeout set to 10% of runtime: 1000ms
  16747  read_all.c:477: TINFO: Worker 60353 (2): Stuck for 1883896us, restarting it
  16748  read_all.c:477: TINFO: Worker 60352 (1): Stuck for 1884084us, restarting it
  16749  read_all.c:477: TINFO: Worker 60354 (3): Stuck for 1885375us, restarting it
  16750  read_all.c:477: TINFO: Worker 60351 (0): Stuck for 1885608us, restarting it
  16751  read_all.c:477: TINFO: Worker 60355 (4): Stuck for 1886018us, restarting it
  16752  read_all.c:413: TINFO: Worker 60355 (4): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
  16753  read_all.c:477: TINFO: Worker 60356 (5): Stuck for 1886312us, restarting it
  16754  read_all.c:477: TINFO: Worker 60357 (6): Stuck for 1887080us, restarting it
  16755  read_all.c:395: TINFO: Worker 60353 (2): Timeout waiting after kill
  16756  read_all.c:413: TINFO: Worker 60353 (2): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
  16757  read_all.c:395: TINFO: Worker 60352 (1): Timeout waiting after kill
  16758  read_all.c:413: TINFO: Worker 60352 (1): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
  16759  read_all.c:395: TINFO: Worker 60354 (3): Timeout waiting after kill
  16760  read_all.c:413: TINFO: Worker 60354 (3): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
  16761  read_all.c:395: TINFO: Worker 60351 (0): Timeout waiting after kill
  16762  read_all.c:413: TINFO: Worker 60351 (0): Last popped '/sys/kernel/tracing/rv/available_monitors'
  16763  read_all.c:395: TINFO: Worker 60356 (5): Timeout waiting after kill
  16764  read_all.c:413: TINFO: Worker 60356 (5): Last popped '/sys/kernel/tracing/rv/available_monitors'
  16765  read_all.c:395: TINFO: Worker 60357 (6): Timeout waiting after kill
  16766  read_all.c:413: TINFO: Worker 60357 (6): Last popped '/sys/kernel/tracing/rv/available_monitors'
  16767  read_all.c:477: TINFO: Worker 60363 (2): Stuck for 1000076us, restarting it
  16768  read_all.c:477: TINFO: Worker 60366 (0): Stuck for 1000107us, restarting it
  16769  read_all.c:395: TINFO: Worker 60363 (2): Timeout waiting after kill
  16770  read_all.c:413: TINFO: Worker 60363 (2): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
  16771  read_all.c:395: TINFO: Worker 60366 (0): Timeout waiting after kill
  16772  read_all.c:413: TINFO: Worker 60366 (0): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
  16773  read_all.c:477: TINFO: Worker 60371 (0): Stuck for 1408969us, restarting it
  16774  read_all.c:413: TINFO: Worker 60371 (0): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
  16775  read_all.c:477: TINFO: Worker 60364 (1): Stuck for 3411562us, restarting it
  16776  read_all.c:413: TINFO: Worker 60364 (1): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
  16777  read_all.c:477: TINFO: Worker 60370 (2): Stuck for 1413387us, restarting it
  16778  read_all.c:413: TINFO: Worker 60370 (2): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
  16779  read_all.c:477: TINFO: Worker 60365 (3): Stuck for 3412587us, restarting it
  16780  read_all.c:413: TINFO: Worker 60365 (3): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_256_xts'
  16781  read_all.c:477: TINFO: Worker 60362 (4): Stuck for 4412476us, restarting it
  16782  read_all.c:477: TINFO: Worker 60367 (5): Stuck for 3412058us, restarting it
  16783  read_all.c:454: TINFO: Silencing timeout warnings; consider increasing LTP_RUNTIME_MUL or removing -q
  16784  read_all.c:660: TINFO: opendir(/sys/module/pkey_uv): ENOENT (2)
  16785  Test timeouted, sending SIGKILL!
  16786  tst_test.c:1836: TINFO: Killed the leftover descendant processes
  16787  tst_test.c:1845: TINFO: If you are running on slow machine, try exporting LTP_TIMEOUT_MUL > 1
  16788  tst_test.c:1847: TBROK: Test killed! (timeout?)
- 16789  
+ 16789
  16790  Summary:
  16791  passed 0
  16792  failed 0
  16793  broken 1
  16794  skipped 0
  16795  warnings 0
  16796  INFO: ltp-pan reported some tests FAIL
  16797  LTP Version: 20230929-1383-g3c1f992e2
  16798  INFO: Test end time: Mon Oct 20 03:24:01 PM UTC 2025
  16799  stderr:
  16800  -------------------------------------------
  16801  INFO: runltp script is deprecated, try kirk
  16802  https://github.com/linux-test-project/kirk
  16803  -------------------------------------------
  16804  -------------------------------------------
  16805  INFO: runltp script is deprecated, try kirk
  16806  https://github.com/linux-test-project/kirk
  16807  -------------------------------------------
  16808  15:24:01 INFO | Restore timeout multiplier LTP_TIMEOUT_MUL back to default
  16809  15:24:01 ERROR| child process failed
  16810  15:24:01 DEBUG| Traceback (most recent call last):
  16811  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 411, in _exec
  16812  15:24:01 DEBUG| _call_test_function(self.execute, *p_args, **p_dargs)
  16813  15:24:01 DEBUG| ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16814  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 823, in _call_test_function
  16815  15:24:01 DEBUG| return func(*args, **dargs)
  16816  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 290, in execute
  16817  15:24:01 DEBUG| self._call_run_once(constraints, profile_only,
  16818  15:24:01 DEBUG| ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16819  15:24:01 DEBUG| postprocess_profiled_run, args, dargs)
  16820  15:24:01 DEBUG| ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16821  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 212, in _call_run_once
  16822  15:24:01 DEBUG| self.run_once(*args, **dargs)
  16823  15:24:01 DEBUG| ~~~~~~~~~~~~~^^^^^^^^^^^^^^^^
  16824  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/tests/ubuntu_ltp/ubuntu_ltp.py", line 138, in run_once
  16825  15:24:01 DEBUG| utils.system_output(cmd, verbose=False, retain_output=True)
  16826  15:24:01 DEBUG| ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16827  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/utils.py", line 1265, in system_output
  16828  15:24:01 DEBUG| out = run(command, timeout=timeout, ignore_status=ignore_status,
  16829  15:24:01 DEBUG| ~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16830  15:24:01 DEBUG| stdout_tee=TEE_TO_LOGS, stderr_tee=TEE_TO_LOGS,
  16831  15:24:01 DEBUG| ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16832  15:24:01 DEBUG| verbose=verbose, args=args).stdout
  16833  15:24:01 DEBUG| ^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16834  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/utils.py", line 916, in run
  16835  15:24:01 DEBUG| raise error.CmdError(command, bg_job.result,
  16836  15:24:01 DEBUG| "Command returned non-zero exit status")
  16837  15:24:01 DEBUG| autotest.client.shared.error.CmdError: Command failed, rc=1, Command returned non-zero exit status
  16838  15:24:01 DEBUG| * Command:
  16839  15:24:01 DEBUG| /opt/ltp/runltp -f /tmp/target -q -C /dev/null -l /dev/null -T /dev/null
  16840  15:24:01 DEBUG| Exit status: 1
  16841  15:24:01 DEBUG| Duration: 1600.021127462387
  16842  15:24:01 DEBUG|
  16843  15:24:01 DEBUG| stdout:
  16844  15:24:01 DEBUG| Checking for required user/group ids
  16845  15:24:01 DEBUG|
  16846  15:24:01 DEBUG| 'root' user id and group found.
  16847  15:24:01 DEBUG| 'nobody' user id and group found.
  16848  15:24:01 DEBUG| 'bin' user id and group found.
  16849  15:24:01 DEBUG| 'daemon' user id and group found.
  16850  15:24:01 DEBUG| Users group found.
  16851  15:24:01 DEBUG| Sys group found.
  16852  15:24:01 DEBUG| Required users/groups exist.
  16853  15:24:01 DEBUG| no big block device was specified on commandline.
  16854  15:24:01 DEBUG| Tests which require a big block device are disabled.
  16855  15:24:01 DEBUG| You can specify it with option -z
  16856  15:24:01 DEBUG| INFO: Test start time: Mon Oct 20 02:57:21 PM UTC 2025
  16857  15:24:01 DEBUG| COMMAND: /opt/ltp/bin/ltp-pan -q -e -S -a 60304 -n 60304 -f /tmp/ltp-QUoNvysr8i/alltests -l /dev/null -C /dev/null -T /dev/null
  16858  15:24:01 DEBUG| LOG File: /dev/null
  16859  15:24:01 DEBUG| FAILED COMMAND File: /dev/null
  16860  15:24:01 DEBUG| TCONF COMMAND File: /dev/null
  16861  15:24:01 DEBUG| Running tests.......
  16862  15:24:01 DEBUG| tst_test.c:1952: TINFO: LTP version: 20230929-1383-g3c1f992e2
  16863  15:24:01 DEBUG| tst_test.c:1955: TINFO: Tested kernel: 6.17.0-7-generic #7-Ubuntu SMP Sat Oct 18 09:07:31 UTC 2025 s390x
  16864  15:24:01 DEBUG| tst_kconfig.c:88: TINFO: Parsing kernel config '/lib/modules/6.17.0-7-generic/build/.config'
  16865  15:24:01 DEBUG| tst_test.c:1773: TINFO: Overall timeout per run is 0h 26m 40s
  16866  15:24:01 DEBUG| read_all.c:601: TINFO: Worker timeout set to 10% of runtime: 1000ms
  16867  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60353 (2): Stuck for 1883896us, restarting it
  16868  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60352 (1): Stuck for 1884084us, restarting it
  16869  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60354 (3): Stuck for 1885375us, restarting it
  16870  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60351 (0): Stuck for 1885608us, restarting it
  16871  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60355 (4): Stuck for 1886018us, restarting it
  16872  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60355 (4): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
  16873  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60356 (5): Stuck for 1886312us, restarting it
  16874  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60357 (6): Stuck for 1887080us, restarting it
  16875  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60353 (2): Timeout waiting after kill
  16876  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60353 (2): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
  16877  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60352 (1): Timeout waiting after kill
  16878  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60352 (1): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
  16879  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60354 (3): Timeout waiting after kill
  16880  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60354 (3): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
  16881  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60351 (0): Timeout waiting after kill
  16882  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60351 (0): Last popped '/sys/kernel/tracing/rv/available_monitors'
  16883  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60356 (5): Timeout waiting after kill
  16884  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60356 (5): Last popped '/sys/kernel/tracing/rv/available_monitors'
  16885  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60357 (6): Timeout waiting after kill
  16886  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60357 (6): Last popped '/sys/kernel/tracing/rv/available_monitors'
  16887  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60363 (2): Stuck for 1000076us, restarting it
  16888  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60366 (0): Stuck for 1000107us, restarting it
  16889  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60363 (2): Timeout waiting after kill
  16890  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60363 (2): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
  16891  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60366 (0): Timeout waiting after kill
  16892  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60366 (0): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
  16893  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60371 (0): Stuck for 1408969us, restarting it
  16894  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60371 (0): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
  16895  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60364 (1): Stuck for 3411562us, restarting it
  16896  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60364 (1): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
  16897  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60370 (2): Stuck for 1413387us, restarting it
  16898  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60370 (2): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
  16899  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60365 (3): Stuck for 3412587us, restarting it
  16900  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60365 (3): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_256_xts'
  16901  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60362 (4): Stuck for 4412476us, restarting it
  16902  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60367 (5): Stuck for 3412058us, restarting it
  16903  15:24:01 DEBUG| read_all.c:454: TINFO: Silencing timeout warnings; consider increasing LTP_RUNTIME_MUL or removing -q
  16904  15:24:01 DEBUG| read_all.c:660: TINFO: opendir(/sys/module/pkey_uv): ENOENT (2)
  16905  15:24:01 DEBUG| Test timeouted, sending SIGKILL!
  16906  15:24:01 DEBUG| tst_test.c:1836: TINFO: Killed the leftover descendant processes
  16907  15:24:01 DEBUG| tst_test.c:1845: TINFO: If you are running on slow machine, try exporting LTP_TIMEOUT_MUL > 1
  16908  15:24:01 DEBUG| tst_test.c:1847: TBROK: Test killed! (timeout?)
  16909  15:24:01 DEBUG|
  16910  15:24:01 DEBUG| Summary:
  16911  15:24:01 DEBUG| passed 0
  16912  15:24:01 DEBUG| failed 0
  16913  15:24:01 DEBUG| broken 1
  16914  15:24:01 DEBUG| skipped 0
  16915  15:24:01 DEBUG| warnings 0
  16916  15:24:01 DEBUG| INFO: ltp-pan reported some tests FAIL
  16917  15:24:01 DEBUG| LTP Version: 20230929-1383-g3c1f992e2
  16918  15:24:01 DEBUG| INFO: Test end time: Mon Oct 20 03:24:01 PM UTC 2025
  16919  15:24:01 DEBUG| stderr:
  16920  15:24:01 DEBUG| -------------------------------------------
  16921  15:24:01 DEBUG| INFO: runltp script is deprecated, try kirk
  16922  15:24:01 DEBUG| https://github.com/linux-test-project/kirk
  16923  15:24:01 DEBUG| -------------------------------------------
  16924  15:24:01 DEBUG| -------------------------------------------
  16925  15:24:01 DEBUG| INFO: runltp script is deprecated, try kirk
  16926  15:24:01 DEBUG| https://github.com/linux-test-project/kirk
  16927  15:24:01 DEBUG| -------------------------------------------
  16928  15:24:01 DEBUG|
  16929  15:24:01 DEBUG| During handling of the above exception, another exception occurred:
  16930  15:24:01 DEBUG|
  16931  15:24:01 DEBUG| Traceback (most recent call last):
  16932  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 434, in _exec
  16933  15:24:01 DEBUG| raise exc_info[0](exc_info[1]).with_traceback(exc_info[2])
  16934  15:24:01 DEBUG| ~~~~~~~~~~~^^^^^^^^^^^^^
  16935  15:24:01 DEBUG| TypeError: CmdError.__init__() missing 1 required positional argument: 'result_obj'
  16936  15:24:01 DEBUG|
  16937  15:24:01 DEBUG| During handling of the above exception, another exception occurred:
  16938  15:24:01 DEBUG|
  16939  15:24:01 DEBUG| Traceback (most recent call last):
  16940  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/parallel.py", line 25, in fork_start
  16941  15:24:01 DEBUG| l()
  16942  15:24:01 DEBUG| ~^^
  16943  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/job.py", line 506, in
  16944  15:24:01 DEBUG| l = lambda: test.runtest(self, url, tag, args, dargs)
  16945  15:24:01 DEBUG| ~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16946  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/test.py", line 121, in runtest
  16947  15:24:01 DEBUG| common_test.runtest(job, url, tag, args, dargs, locals(), globals(),
  16948  15:24:01 DEBUG| ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16949  15:24:01 DEBUG| job.sysinfo.log_before_each_test,
  16950  15:24:01 DEBUG| ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16951  15:24:01 DEBUG| job.sysinfo.log_after_each_test,
  16952  15:24:01 DEBUG| ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16953  15:24:01 DEBUG| job.sysinfo.log_before_each_iteration,
  16954  15:24:01 DEBUG| ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16955  15:24:01 DEBUG| job.sysinfo.log_after_each_iteration)
  16956  15:24:01 DEBUG| ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16957  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 913, in runtest
  16958  15:24:01 DEBUG| mytest._exec(args, dargs)
  16959  15:24:01 DEBUG| ~~~~~~~~~~~~^^^^^^^^^^^^^
  16960  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 455, in _exec
  16961  15:24:01 DEBUG| raise error.UnhandledTestError(e)
  16962  15:24:01 DEBUG| autotest.client.shared.error.UnhandledTestError: Unhandled TypeError: CmdError.__init__() missing 1 required positional argument: 'result_obj'
  16963  15:24:01 DEBUG| Traceback (most recent call last):
  16964  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 411, in _exec
  16965  15:24:01 DEBUG| _call_test_function(self.execute, *p_args, **p_dargs)
  16966  15:24:01 DEBUG| ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16967  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 823, in _call_test_function
  16968  15:24:01 DEBUG| return func(*args, **dargs)
  16969  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 290, in execute
  16970  15:24:01 DEBUG| self._call_run_once(constraints, profile_only,
  16971  15:24:01 DEBUG| ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16972  15:24:01 DEBUG| postprocess_profiled_run, args, dargs)
  16973  15:24:01 DEBUG| ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16974  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 212, in _call_run_once
  16975  15:24:01 DEBUG| self.run_once(*args, **dargs)
  16976  15:24:01 DEBUG| ~~~~~~~~~~~~~^^^^^^^^^^^^^^^^
  16977  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/tests/ubuntu_ltp/ubuntu_ltp.py", line 138, in run_once
  16978  15:24:01 DEBUG| utils.system_output(cmd, verbose=False, retain_output=True)
  16979  15:24:01 DEBUG| ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16980  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/utils.py", line 1265, in system_output
  16981  15:24:01 DEBUG| out = run(command, timeout=timeout, ignore_status=ignore_status,
  16982  15:24:01 DEBUG| ~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16983  15:24:01 DEBUG| stdout_tee=TEE_TO_LOGS, stderr_tee=TEE_TO_LOGS,
  16984  15:24:01 DEBUG| ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16985  15:24:01 DEBUG| verbose=verbose, args=args).stdout
  16986  15:24:01 DEBUG| ^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16987  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/utils.py", line 916, in run
  16988  15:24:01 DEBUG| raise error.CmdError(command, bg_job.result,
  16989  15:24:01 DEBUG| "Command returned non-zero exit status")
  16990  15:24:01 DEBUG| autotest.client.shared.error.CmdError: Command failed, rc=1, Command returned non-zero exit status
  16991  15:24:01 DEBUG| * Command:
  16992  15:24:01 DEBUG| /opt/ltp/runltp -f /tmp/target -q -C /dev/null -l /dev/null -T /dev/null
  16993  15:24:01 DEBUG| Exit status: 1
  16994  15:24:01 DEBUG| Duration: 1600.021127462387
  16995  15:24:01 DEBUG|
  16996  15:24:01 DEBUG| stdout:
  16997  15:24:01 DEBUG| Checking for required user/group ids
  16998  15:24:01 DEBUG|
  16999  15:24:01 DEBUG| 'root' user id and group found.
  17000  15:24:01 DEBUG| 'nobody' user id and group found.
  17001  15:24:01 DEBUG| 'bin' user id and group found.
  17002  15:24:01 DEBUG| 'daemon' user id and group found.
  17003  15:24:01 DEBUG| Users group found.
  17004  15:24:01 DEBUG| Sys group found.
  17005  15:24:01 DEBUG| Required users/groups exist.
  17006  15:24:01 DEBUG| no big block device was specified on commandline.
  17007  15:24:01 DEBUG| Tests which require a big block device are disabled.
  17008  15:24:01 DEBUG| You can specify it with option -z
  17009  15:24:01 DEBUG| INFO: Test start time: Mon Oct 20 02:57:21 PM UTC 2025
  17010  15:24:01 DEBUG| COMMAND: /opt/ltp/bin/ltp-pan -q -e -S -a 60304 -n 60304 -f /tmp/ltp-QUoNvysr8i/alltests -l /dev/null -C /dev/null -T /dev/null
  17011  15:24:01 DEBUG| LOG File: /dev/null
  17012  15:24:01 DEBUG| FAILED COMMAND File: /dev/null
  17013  15:24:01 DEBUG| TCONF COMMAND File: /dev/null
  17014  15:24:01 DEBUG| Running tests.......
  17015  15:24:01 DEBUG| tst_test.c:1952: TINFO: LTP version: 20230929-1383-g3c1f992e2
  17016  15:24:01 DEBUG| tst_test.c:1955: TINFO: Tested kernel: 6.17.0-7-generic #7-Ubuntu SMP Sat Oct 18 09:07:31 UTC 2025 s390x
  17017  15:24:01 DEBUG| tst_kconfig.c:88: TINFO: Parsing kernel config '/lib/modules/6.17.0-7-generic/build/.config'
  17018  15:24:01 DEBUG| tst_test.c:1773: TINFO: Overall timeout per run is 0h 26m 40s
  17019  15:24:01 DEBUG| read_all.c:601: TINFO: Worker timeout set to 10% of runtime: 1000ms
  17020  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60353 (2): Stuck for 1883896us, restarting it
  17021  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60352 (1): Stuck for 1884084us, restarting it
  17022  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60354 (3): Stuck for 1885375us, restarting it
  17023  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60351 (0): Stuck for 1885608us, restarting it
  17024  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60355 (4): Stuck for 1886018us, restarting it
  17025  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60355 (4): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
  17026  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60356 (5): Stuck for 1886312us, restarting it
  17027  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60357 (6): Stuck for 1887080us, restarting it
  17028  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60353 (2): Timeout waiting after kill
  17029  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60353 (2): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
  17030  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60352 (1): Timeout waiting after kill
  17031  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60352 (1): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
  17032  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60354 (3): Timeout waiting after kill
  17033  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60354 (3): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
  17034  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60351 (0): Timeout waiting after kill
  17035  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60351 (0): Last popped '/sys/kernel/tracing/rv/available_monitors'
  17036  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60356 (5): Timeout waiting after kill
  17037  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60356 (5): Last popped '/sys/kernel/tracing/rv/available_monitors'
  17038  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60357 (6): Timeout waiting after kill
  17039  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60357 (6): Last popped '/sys/kernel/tracing/rv/available_monitors'
  17040  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60363 (2): Stuck for 1000076us, restarting it
  17041  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60366 (0): Stuck for 1000107us, restarting it
  17042  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60363 (2): Timeout waiting after kill
  17043  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60363 (2): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
  17044  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60366 (0): Timeout waiting after kill
  17045  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60366 (0): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
  17046  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60371 (0): Stuck for 1408969us, restarting it
  17047  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60371 (0): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
  17048  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60364 (1): Stuck for 3411562us, restarting it
  17049  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60364 (1): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
  17050  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60370 (2): Stuck for 1413387us, restarting it
  17051  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60370 (2): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
  17052  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60365 (3): Stuck for 3412587us, restarting it
  17053  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60365 (3): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_256_xts'
  17054  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60362 (4): Stuck for 4412476us, restarting it
  17055  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60367 (5): Stuck for 3412058us, restarting it
  17056  15:24:01 DEBUG| read_all.c:454: TINFO: Silencing timeout warnings; consider increasing LTP_RUNTIME_MUL or removing -q
  17057  15:24:01 DEBUG| read_all.c:660: TINFO: opendir(/sys/module/pkey_uv): ENOENT (2)
  17058  15:24:01 DEBUG| Test timeouted, sending SIGKILL!
  17059  15:24:01 DEBUG| tst_test.c:1836: TINFO: Killed the leftover descendant processes
  17060  15:24:01 DEBUG| tst_test.c:1845: TINFO: If you are running on slow machine, try exporting LTP_TIMEOUT_MUL > 1
  17061  15:24:01 DEBUG| tst_test.c:1847: TBROK: Test killed! (timeout?)
  17062  15:24:01 DEBUG|
  17063  15:24:01 DEBUG| Summary:
  17064  15:24:01 DEBUG| passed 0
  17065  15:24:01 DEBUG| failed 0
  17066  15:24:01 DEBUG| broken 1
  17067  15:24:01 DEBUG| skipped 0
  17068  15:24:01 DEBUG| warnings 0
  17069  15:24:01 DEBUG| INFO: ltp-pan reported some tests FAIL
  17070  15:24:01 DEBUG| LTP Version: 20230929-1383-g3c1f992e2
  17071  15:24:01 DEBUG| INFO: Test end time: Mon Oct 20 03:24:01 PM UTC 2025
  17072  15:24:01 DEBUG| stderr:
  17073  15:24:01 DEBUG| -------------------------------------------
  17074  15:24:01 DEBUG| INFO: runltp script is deprecated, try kirk
  17075  15:24:01 DEBUG| https://github.com/linux-test-project/kirk
  17076  15:24:01 DEBUG| -------------------------------------------
  17077  15:24:01 DEBUG| -------------------------------------------
  17078  15:24:01 DEBUG| INFO: runltp script is deprecated, try kirk
  17079  15:24:01 DEBUG| https://github.com/linux-test-project/kirk
  17080  15:24:01 DEBUG| -------------------------------------------
  17081  15:24:01 DEBUG|
  17082  15:24:01 DEBUG| During handling of the above exception, another exception occurred:
  17083  15:24:01 DEBUG|
  17084  15:24:01 DEBUG| Traceback (most recent call last):
  17085  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 434, in _exec
  17086  15:24:01 DEBUG| raise exc_info[0](exc_info[1]).with_traceback(exc_info[2])
  17087  15:24:01 DEBUG| ~~~~~~~~~~~^^^^^^^^^^^^^
  17088  15:24:01 DEBUG| TypeError: CmdError.__init__() missing 1 required positional argument: 'result_obj'
  17089  15:24:01 DEBUG|
  17090  15:24:01 INFO | ERROR ubuntu_ltp.fs:read_all_sys ubuntu_ltp.fs:read_all_sys timestamp=1760973841 localtime=Oct 20 15:24:01 Unhandled TypeError: CmdError.__init__() missing 1 required positional argument: 'result_obj'
  17091   Traceback (most recent call last):
  17092   File "/home/ubuntu/autotest/client/shared/test.py", line 411, in _exec
  17093   _call_test_function(self.execute, *p_args, **p_dargs)
  17094   ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  17095   File "/home/ubuntu/autotest/client/shared/test.py", line 823, in _call_test_function
  17096   return func(*args, **dargs)
  17097   File "/home/ubuntu/autotest/client/shared/test.py", line 290, in execute
  17098   self._call_run_once(constraints, profile_only,
  17099   ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^
  17100   postprocess_profiled_run, args, dargs)
  17101   ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  17102   File "/home/ubuntu/autotest/client/shared/test.py", line 212, in _call_run_once
  17103   self.run_once(*args, **dargs)
  17104   ~~~~~~~~~~~~~^^^^^^^^^^^^^^^^
  17105   File "/home/ubuntu/autotest/client/tests/ubuntu_ltp/ubuntu_ltp.py", line 138, in run_once
  17106   utils.system_output(cmd, verbose=False, retain_output=True)
  17107   ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  17108   File "/home/ubuntu/autotest/client/shared/utils.py", line 1265, in system_output
  17109   out = run(command, timeout=timeout, ignore_status=ignore_status,
  17110   ~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  17111   stdout_tee=TEE_TO_LOGS, stderr_tee=TEE_TO_LOGS,
  17112   ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  17113   verbose=verbose, args=args).stdout
  17114   ^^^^^^^^^^^^^^^^^^^^^^^^^^^
  17115   File "/home/ubuntu/autotest/client/shared/utils.py", line 916, in run
  17116   raise error.CmdError(command, bg_job.result,
  17117   "Command returned non-zero exit status")
  17118   autotest.client.shared.error.CmdError: Command failed, rc=1, Command returned non-zero exit status
  17119   * Command:
  17120   /opt/ltp/runltp -f /tmp/target -q -C /dev/null -l /dev/null -T /dev/null
  17121   Exit status: 1
  17122   Duration: 1600.021127462387
- 17123  
+ 17123
  17124   stdout:
  17125   Checking for required user/group ids
- 17126  
+ 17126
  17127   'root' user id and group found.
  17128   'nobody' user id and group found.
  17129   'bin' user id and group found.
  17130   'daemon' user id and group found.
  17131   Users group found.
  17132   Sys group found.
  17133   Required users/groups exist.
  17134   no big block device was specified on commandline.
  17135   Tests which require a big block device are disabled.
  17136   You can specify it with option -z
  17137   INFO: Test start time: Mon Oct 20 02:57:21 PM UTC 2025
  17138   COMMAND: /opt/ltp/bin/ltp-pan -q -e -S -a 60304 -n 60304 -f /tmp/ltp-QUoNvysr8i/alltests -l /dev/null -C /dev/null -T /dev/null
  17139   LOG File: /dev/null
  17140   FAILED COMMAND File: /dev/null
  17141   TCONF COMMAND File: /dev/null
  17142   Running tests.......
  17143   tst_test.c:1952: TINFO: LTP version: 20230929-1383-g3c1f992e2
  17144   tst_test.c:1955: TINFO: Tested kernel: 6.17.0-7-generic #7-Ubuntu SMP Sat Oct 18 09:07:31 UTC 2025 s390x
  17145   tst_kconfig.c:88: TINFO: Parsing kernel config '/lib/modules/6.17.0-7-generic/build/.config'
  17146   tst_test.c:1773: TINFO: Overall timeout per run is 0h 26m 40s
  17147   read_all.c:601: TINFO: Worker timeout set to 10% of runtime: 1000ms
  17148   read_all.c:477: TINFO: Worker 60353 (2): Stuck for 1883896us, restarting it
  17149   read_all.c:477: TINFO: Worker 60352 (1): Stuck for 1884084us, restarting it
  17150   read_all.c:477: TINFO: Worker 60354 (3): Stuck for 1885375us, restarting it
  17151   read_all.c:477: TINFO: Worker 60351 (0): Stuck for 1885608us, restarting it
  17152   read_all.c:477: TINFO: Worker 60355 (4): Stuck for 1886018us, restarting it
  17153   read_all.c:413: TINFO: Worker 60355 (4): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
  17154   read_all.c:477: TINFO: Worker 60356 (5): Stuck for 1886312us, restarting it
  17155   read_all.c:477: TINFO: Worker 60357 (6): Stuck for 1887080us, restarting it
  17156   read_all.c:395: TINFO: Worker 60353 (2): Timeout waiting after kill
  17157   read_all.c:413: TINFO: Worker 60353 (2): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
  17158   read_all.c:395: TINFO: Worker 60352 (1): Timeout waiting after kill
  17159   read_all.c:413: TINFO: Worker 60352 (1): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
  17160   read_all.c:395: TINFO: Worker 60354 (3): Timeout waiting after kill
  17161   read_all.c:413: TINFO: Worker 60354 (3): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
  17162   read_all.c:395: TINFO: Worker 60351 (0): Timeout waiting after kill
  17163   read_all.c:413: TINFO: Worker 60351 (0): Last popped '/sys/kernel/tracing/rv/available_monitors'
  17164   read_all.c:395: TINFO: Worker 60356 (5): Timeout waiting after kill
  17165   read_all.c:413: TINFO: Worker 60356 (5): Last popped '/sys/kernel/tracing/rv/available_monitors'
  17166   read_all.c:395: TINFO: Worker 60357 (6): Timeout waiting after kill
  17167   read_all.c:413: TINFO: Worker 60357 (6): Last popped '/sys/kernel/tracing/rv/available_monitors'
  17168   read_all.c:477: TINFO: Worker 60363 (2): Stuck for 1000076us, restarting it
  17169   read_all.c:477: TINFO: Worker 60366 (0): Stuck for 1000107us, restarting it
  17170   read_all.c:395: TINFO: Worker 60363 (2): Timeout waiting after kill
  17171   read_all.c:413: TINFO: Worker 60363 (2): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
  17172   read_all.c:395: TINFO: Worker 60366 (0): Timeout waiting after kill
  17173   read_all.c:413: TINFO: Worker 60366 (0): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
  17174   read_all.c:477: TINFO: Worker 60371 (0): Stuck for 1408969us, restarting it
  17175   read_all.c:413: TINFO: Worker 60371 (0): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
  17176   read_all.c:477: TINFO: Worker 60364 (1): Stuck for 3411562us, restarting it
  17177   read_all.c:413: TINFO: Worker 60364 (1): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
  17178   read_all.c:477: TINFO: Worker 60370 (2): Stuck for 1413387us, restarting it
  17179   read_all.c:413: TINFO: Worker 60370 (2): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
  17180   read_all.c:477: TINFO: Worker 60365 (3): Stuck for 3412587us, restarting it
  17181   read_all.c:413: TINFO: Worker 60365 (3): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_256_xts'
  17182   read_all.c:477: TINFO: Worker 60362 (4): Stuck for 4412476us, restarting it
  17183   read_all.c:477: TINFO: Worker 60367 (5): Stuck for 3412058us, restarting it
  17184   read_all.c:454: TINFO: Silencing timeout warnings; consider increasing LTP_RUNTIME_MUL or removing -q
  17185   read_all.c:660: TINFO: opendir(/sys/module/pkey_uv): ENOENT (2)
  17186   Test timeouted, sending SIGKILL!
  17187   tst_test.c:1836: TINFO: Killed the leftover descendant processes
  17188   tst_test.c:1845: TINFO: If you are running on slow machine, try exporting LTP_TIMEOUT_MUL > 1
  17189   tst_test.c:1847: TBROK: Test killed! (timeout?)
- 17190  
+ 17190
  17191   Summary:
  17192   passed 0
  17193   failed 0
  17194   broken 1
  17195   skipped 0
  17196   warnings 0
  17197   INFO: ltp-pan reported some tests FAIL
  17198   LTP Version: 20230929-1383-g3c1f992e2
  17199   INFO: Test end time: Mon Oct 20 03:24:01 PM UTC 2025
  17200   stderr:
  17201   -------------------------------------------
  17202   INFO: runltp script is deprecated, try kirk
  17203   https://github.com/linux-test-project/kirk
  17204   -------------------------------------------
  17205   -------------------------------------------
  17206   INFO: runltp script is deprecated, try kirk
  17207   https://github.com/linux-test-project/kirk
  17208   -------------------------------------------
- 17209  
+ 17209
  17210   During handling of the above exception, another exception occurred:
- 17211  
+ 17211
  17212   Traceback (most recent call last):
  17213   File "/home/ubuntu/autotest/client/shared/test.py", line 434, in _exec
  17214   raise exc_info[0](exc_info[1]).with_traceback(exc_info[2])
  17215   ~~~~~~~~~~~^^^^^^^^^^^^^
  17216   TypeError: CmdError.__init__() missing 1 required positional argument: 'result_obj'
  17217

-- 
You received this bug notification because you are a member of Canonical
Platform QA Team, which is subscribed to ubuntu-kernel-tests.
https://bugs.launchpad.net/bugs/2129834

Title:
  fs:read_all_sys in ubuntu_ltp hangs on kernel 6.17 due to rv monitor
  crash

Status in ubuntu-kernel-tests:
  New

Bug description:
  Kernel 6.17 is affected by a crash induced by the wrong fix pulled here: https://lkml.org/lkml/2025/9/22/1506. reading enabled_monitors taints the test whcih misses the deadline.
  This patch should be included:
  https://www.mail-archive.com/linux-trace-kernel@xxxxxxxxxxxxxxx/msg13150.html

  Full log:
  16600  14:57:21 INFO | START ubuntu_ltp.fs:read_all_sys ubuntu_ltp.fs:read_all_sys timeout=6300 timestamp=1760972241 localtime=Oct 20 14:57:21
  16601  14:57:21 DEBUG| Persistent state client._record_indent now set to 2
  16602  14:57:21 DEBUG| Persistent state client.unexpected_reboot now set to ('ubuntu_ltp.fs:read_all_sys', 'ubuntu_ltp.fs:read_all_sys')
  16603  14:57:21 DEBUG| Waiting for pid 60299 for 6300 seconds
  16604  14:57:21 WARNI| System python is too old, crash handling disabled
  16605  14:57:21 INFO | Setting LTP_TIMEOUT_MUL=50 for read_all_sys
  16606  14:57:21 ERROR| [stderr] -------------------------------------------
  16607  14:57:21 ERROR| [stderr] INFO: runltp script is deprecated, try kirk
  16608  14:57:21 ERROR| [stderr] https://github.com/linux-test-project/kirk
  16609  14:57:21 ERROR| [stderr] -------------------------------------------
  16610  14:57:21 DEBUG| [stdout] Checking for required user/group ids
  16611  14:57:21 DEBUG| [stdout]
  16612  14:57:21 DEBUG| [stdout] 'root' user id and group found.
  16613  14:57:21 DEBUG| [stdout] 'nobody' user id and group found.
  16614  14:57:21 DEBUG| [stdout] 'bin' user id and group found.
  16615  14:57:21 DEBUG| [stdout] 'daemon' user id and group found.
  16616  14:57:21 DEBUG| [stdout] Users group found.
  16617  14:57:21 DEBUG| [stdout] Sys group found.
  16618  14:57:21 DEBUG| [stdout] Required users/groups exist.
  16619  14:57:21 DEBUG| [stdout] no big block device was specified on commandline.
  16620  14:57:21 DEBUG| [stdout] Tests which require a big block device are disabled.
  16621  14:57:21 DEBUG| [stdout] You can specify it with option -z
  16622  14:57:21 DEBUG| [stdout] INFO: Test start time: Mon Oct 20 02:57:21 PM UTC 2025
  16623  14:57:21 DEBUG| [stdout] COMMAND: /opt/ltp/bin/ltp-pan -q -e -S -a 60304 -n 60304 -f /tmp/ltp-QUoNvysr8i/alltests -l /dev/null -C /dev/null -T /dev/null
  16624  14:57:21 DEBUG| [stdout] LOG File: /dev/null
  16625  14:57:21 DEBUG| [stdout] FAILED COMMAND File: /dev/null
  16626  14:57:21 DEBUG| [stdout] TCONF COMMAND File: /dev/null
  16627  14:57:21 DEBUG| [stdout] Running tests.......
  16628  14:57:21 DEBUG| [stdout] tst_test.c:1952: TINFO: LTP version: 20230929-1383-g3c1f992e2
  16629  14:57:21 DEBUG| [stdout] tst_test.c:1955: TINFO: Tested kernel: 6.17.0-7-generic #7-Ubuntu SMP Sat Oct 18 09:07:31 UTC 2025 s390x
  16630  14:57:21 DEBUG| [stdout] tst_kconfig.c:88: TINFO: Parsing kernel config '/lib/modules/6.17.0-7-generic/build/.config'
  16631  14:57:21 DEBUG| [stdout] tst_test.c:1773: TINFO: Overall timeout per run is 0h 26m 40s
  16632  14:57:21 DEBUG| [stdout] read_all.c:601: TINFO: Worker timeout set to 10% of runtime: 1000ms
  16633  14:57:23 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60353 (2): Stuck for 1883896us, restarting it
  16634  14:57:23 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60352 (1): Stuck for 1884084us, restarting it
  16635  14:57:23 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60354 (3): Stuck for 1885375us, restarting it
  16636  14:57:23 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60351 (0): Stuck for 1885608us, restarting it
  16637  14:57:23 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60355 (4): Stuck for 1886018us, restarting it
  16638  14:57:23 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60355 (4): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
  16639  14:57:23 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60356 (5): Stuck for 1886312us, restarting it
  16640  14:57:23 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60357 (6): Stuck for 1887080us, restarting it
  16641  14:57:24 DEBUG| [stdout] read_all.c:395: TINFO: Worker 60353 (2): Timeout waiting after kill
  16642  14:57:24 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60353 (2): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
  16643  14:57:24 DEBUG| [stdout] read_all.c:395: TINFO: Worker 60352 (1): Timeout waiting after kill
  16644  14:57:24 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60352 (1): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
  16645  14:57:24 DEBUG| [stdout] read_all.c:395: TINFO: Worker 60354 (3): Timeout waiting after kill
  16646  14:57:24 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60354 (3): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
  16647  14:57:24 DEBUG| [stdout] read_all.c:395: TINFO: Worker 60351 (0): Timeout waiting after kill
  16648  14:57:24 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60351 (0): Last popped '/sys/kernel/tracing/rv/available_monitors'
  16649  14:57:24 DEBUG| [stdout] read_all.c:395: TINFO: Worker 60356 (5): Timeout waiting after kill
  16650  14:57:24 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60356 (5): Last popped '/sys/kernel/tracing/rv/available_monitors'
  16651  14:57:24 DEBUG| [stdout] read_all.c:395: TINFO: Worker 60357 (6): Timeout waiting after kill
  16652  14:57:24 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60357 (6): Last popped '/sys/kernel/tracing/rv/available_monitors'
  16653  14:57:25 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60363 (2): Stuck for 1000076us, restarting it
  16654  14:57:25 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60366 (0): Stuck for 1000107us, restarting it
  16655  14:57:26 DEBUG| [stdout] read_all.c:395: TINFO: Worker 60363 (2): Timeout waiting after kill
  16656  14:57:26 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60363 (2): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
  16657  14:57:26 DEBUG| [stdout] read_all.c:395: TINFO: Worker 60366 (0): Timeout waiting after kill
  16658  14:57:26 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60366 (0): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
  16659  14:57:28 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60371 (0): Stuck for 1408969us, restarting it
  16660  14:57:28 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60371 (0): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
  16661  14:57:28 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60364 (1): Stuck for 3411562us, restarting it
  16662  14:57:28 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60364 (1): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
  16663  14:57:28 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60370 (2): Stuck for 1413387us, restarting it
  16664  14:57:28 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60370 (2): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
  16665  14:57:28 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60365 (3): Stuck for 3412587us, restarting it
  16666  14:57:28 DEBUG| [stdout] read_all.c:413: TINFO: Worker 60365 (3): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_256_xts'
  16667  14:57:28 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60362 (4): Stuck for 4412476us, restarting it
  16668  14:57:28 DEBUG| [stdout] read_all.c:477: TINFO: Worker 60367 (5): Stuck for 3412058us, restarting it
  16669  14:57:28 DEBUG| [stdout] read_all.c:454: TINFO: Silencing timeout warnings; consider increasing LTP_RUNTIME_MUL or removing -q
  16670  14:57:29 DEBUG| [stdout] read_all.c:660: TINFO: opendir(/sys/module/pkey_uv): ENOENT (2)
  16671  15:24:01 DEBUG| [stdout] Test timeouted, sending SIGKILL!
  16672  15:24:01 DEBUG| [stdout] tst_test.c:1836: TINFO: Killed the leftover descendant processes
  16673  15:24:01 DEBUG| [stdout] tst_test.c:1845: TINFO: If you are running on slow machine, try exporting LTP_TIMEOUT_MUL > 1
  16674  15:24:01 DEBUG| [stdout] tst_test.c:1847: TBROK: Test killed! (timeout?)
  16675  15:24:01 DEBUG| [stdout]
  16676  15:24:01 DEBUG| [stdout] Summary:
  16677  15:24:01 DEBUG| [stdout] passed 0
  16678  15:24:01 DEBUG| [stdout] failed 0
  16679  15:24:01 DEBUG| [stdout] broken 1
  16680  15:24:01 DEBUG| [stdout] skipped 0
  16681  15:24:01 DEBUG| [stdout] warnings 0
  16682  15:24:01 DEBUG| [stdout] INFO: ltp-pan reported some tests FAIL
  16683  15:24:01 DEBUG| [stdout] LTP Version: 20230929-1383-g3c1f992e2
  16684  15:24:01 DEBUG| [stdout] INFO: Test end time: Mon Oct 20 03:24:01 PM UTC 2025
  16685  15:24:01 ERROR| [stderr] -------------------------------------------
  16686  15:24:01 ERROR| [stderr] INFO: runltp script is deprecated, try kirk
  16687  15:24:01 ERROR| [stderr] https://github.com/linux-test-project/kirk
  16688  15:24:01 ERROR| [stderr] -------------------------------------------
  16689  15:24:01 ERROR| Exception escaping from test:
  16690  Traceback (most recent call last):
  16691   File "/home/ubuntu/autotest/client/shared/test.py", line 411, in _exec
  16692   _call_test_function(self.execute, *p_args, **p_dargs)
  16693   ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16694   File "/home/ubuntu/autotest/client/shared/test.py", line 823, in _call_test_function
  16695   return func(*args, **dargs)
  16696   File "/home/ubuntu/autotest/client/shared/test.py", line 290, in execute
  16697   self._call_run_once(constraints, profile_only,
  16698   ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16699   postprocess_profiled_run, args, dargs)
  16700   ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16701   File "/home/ubuntu/autotest/client/shared/test.py", line 212, in _call_run_once
  16702   self.run_once(*args, **dargs)
  16703   ~~~~~~~~~~~~~^^^^^^^^^^^^^^^^
  16704   File "/home/ubuntu/autotest/client/tests/ubuntu_ltp/ubuntu_ltp.py", line 138, in run_once
  16705   utils.system_output(cmd, verbose=False, retain_output=True)
  16706   ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16707   File "/home/ubuntu/autotest/client/shared/utils.py", line 1265, in system_output
  16708   out = run(command, timeout=timeout, ignore_status=ignore_status,
  16709   ~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16710   stdout_tee=TEE_TO_LOGS, stderr_tee=TEE_TO_LOGS,
  16711   ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16712   verbose=verbose, args=args).stdout
  16713   ^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16714   File "/home/ubuntu/autotest/client/shared/utils.py", line 916, in run
  16715   raise error.CmdError(command, bg_job.result,
  16716   "Command returned non-zero exit status")
  16717  autotest.client.shared.error.CmdError: Command failed, rc=1, Command returned non-zero exit status
  16718  * Command:
  16719   /opt/ltp/runltp -f /tmp/target -q -C /dev/null -l /dev/null -T /dev/null
  16720  Exit status: 1
  16721  Duration: 1600.021127462387
  16722
  16723  stdout:
  16724  Checking for required user/group ids
  16725
  16726  'root' user id and group found.
  16727  'nobody' user id and group found.
  16728  'bin' user id and group found.
  16729  'daemon' user id and group found.
  16730  Users group found.
  16731  Sys group found.
  16732  Required users/groups exist.
  16733  no big block device was specified on commandline.
  16734  Tests which require a big block device are disabled.
  16735  You can specify it with option -z
  16736  INFO: Test start time: Mon Oct 20 02:57:21 PM UTC 2025
  16737  COMMAND: /opt/ltp/bin/ltp-pan -q -e -S -a 60304 -n 60304 -f /tmp/ltp-QUoNvysr8i/alltests -l /dev/null -C /dev/null -T /dev/null
  16738  LOG File: /dev/null
  16739  FAILED COMMAND File: /dev/null
  16740  TCONF COMMAND File: /dev/null
  16741  Running tests.......
  16742  tst_test.c:1952: TINFO: LTP version: 20230929-1383-g3c1f992e2
  16743  tst_test.c:1955: TINFO: Tested kernel: 6.17.0-7-generic #7-Ubuntu SMP Sat Oct 18 09:07:31 UTC 2025 s390x
  16744  tst_kconfig.c:88: TINFO: Parsing kernel config '/lib/modules/6.17.0-7-generic/build/.config'
  16745  tst_test.c:1773: TINFO: Overall timeout per run is 0h 26m 40s
  16746  read_all.c:601: TINFO: Worker timeout set to 10% of runtime: 1000ms
  16747  read_all.c:477: TINFO: Worker 60353 (2): Stuck for 1883896us, restarting it
  16748  read_all.c:477: TINFO: Worker 60352 (1): Stuck for 1884084us, restarting it
  16749  read_all.c:477: TINFO: Worker 60354 (3): Stuck for 1885375us, restarting it
  16750  read_all.c:477: TINFO: Worker 60351 (0): Stuck for 1885608us, restarting it
  16751  read_all.c:477: TINFO: Worker 60355 (4): Stuck for 1886018us, restarting it
  16752  read_all.c:413: TINFO: Worker 60355 (4): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
  16753  read_all.c:477: TINFO: Worker 60356 (5): Stuck for 1886312us, restarting it
  16754  read_all.c:477: TINFO: Worker 60357 (6): Stuck for 1887080us, restarting it
  16755  read_all.c:395: TINFO: Worker 60353 (2): Timeout waiting after kill
  16756  read_all.c:413: TINFO: Worker 60353 (2): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
  16757  read_all.c:395: TINFO: Worker 60352 (1): Timeout waiting after kill
  16758  read_all.c:413: TINFO: Worker 60352 (1): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
  16759  read_all.c:395: TINFO: Worker 60354 (3): Timeout waiting after kill
  16760  read_all.c:413: TINFO: Worker 60354 (3): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
  16761  read_all.c:395: TINFO: Worker 60351 (0): Timeout waiting after kill
  16762  read_all.c:413: TINFO: Worker 60351 (0): Last popped '/sys/kernel/tracing/rv/available_monitors'
  16763  read_all.c:395: TINFO: Worker 60356 (5): Timeout waiting after kill
  16764  read_all.c:413: TINFO: Worker 60356 (5): Last popped '/sys/kernel/tracing/rv/available_monitors'
  16765  read_all.c:395: TINFO: Worker 60357 (6): Timeout waiting after kill
  16766  read_all.c:413: TINFO: Worker 60357 (6): Last popped '/sys/kernel/tracing/rv/available_monitors'
  16767  read_all.c:477: TINFO: Worker 60363 (2): Stuck for 1000076us, restarting it
  16768  read_all.c:477: TINFO: Worker 60366 (0): Stuck for 1000107us, restarting it
  16769  read_all.c:395: TINFO: Worker 60363 (2): Timeout waiting after kill
  16770  read_all.c:413: TINFO: Worker 60363 (2): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
  16771  read_all.c:395: TINFO: Worker 60366 (0): Timeout waiting after kill
  16772  read_all.c:413: TINFO: Worker 60366 (0): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
  16773  read_all.c:477: TINFO: Worker 60371 (0): Stuck for 1408969us, restarting it
  16774  read_all.c:413: TINFO: Worker 60371 (0): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
  16775  read_all.c:477: TINFO: Worker 60364 (1): Stuck for 3411562us, restarting it
  16776  read_all.c:413: TINFO: Worker 60364 (1): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
  16777  read_all.c:477: TINFO: Worker 60370 (2): Stuck for 1413387us, restarting it
  16778  read_all.c:413: TINFO: Worker 60370 (2): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
  16779  read_all.c:477: TINFO: Worker 60365 (3): Stuck for 3412587us, restarting it
  16780  read_all.c:413: TINFO: Worker 60365 (3): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_256_xts'
  16781  read_all.c:477: TINFO: Worker 60362 (4): Stuck for 4412476us, restarting it
  16782  read_all.c:477: TINFO: Worker 60367 (5): Stuck for 3412058us, restarting it
  16783  read_all.c:454: TINFO: Silencing timeout warnings; consider increasing LTP_RUNTIME_MUL or removing -q
  16784  read_all.c:660: TINFO: opendir(/sys/module/pkey_uv): ENOENT (2)
  16785  Test timeouted, sending SIGKILL!
  16786  tst_test.c:1836: TINFO: Killed the leftover descendant processes
  16787  tst_test.c:1845: TINFO: If you are running on slow machine, try exporting LTP_TIMEOUT_MUL > 1
  16788  tst_test.c:1847: TBROK: Test killed! (timeout?)
  16789
  16790  Summary:
  16791  passed 0
  16792  failed 0
  16793  broken 1
  16794  skipped 0
  16795  warnings 0
  16796  INFO: ltp-pan reported some tests FAIL
  16797  LTP Version: 20230929-1383-g3c1f992e2
  16798  INFO: Test end time: Mon Oct 20 03:24:01 PM UTC 2025
  16799  stderr:
  16800  -------------------------------------------
  16801  INFO: runltp script is deprecated, try kirk
  16802  https://github.com/linux-test-project/kirk
  16803  -------------------------------------------
  16804  -------------------------------------------
  16805  INFO: runltp script is deprecated, try kirk
  16806  https://github.com/linux-test-project/kirk
  16807  -------------------------------------------
  16808  15:24:01 INFO | Restore timeout multiplier LTP_TIMEOUT_MUL back to default
  16809  15:24:01 ERROR| child process failed
  16810  15:24:01 DEBUG| Traceback (most recent call last):
  16811  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 411, in _exec
  16812  15:24:01 DEBUG| _call_test_function(self.execute, *p_args, **p_dargs)
  16813  15:24:01 DEBUG| ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16814  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 823, in _call_test_function
  16815  15:24:01 DEBUG| return func(*args, **dargs)
  16816  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 290, in execute
  16817  15:24:01 DEBUG| self._call_run_once(constraints, profile_only,
  16818  15:24:01 DEBUG| ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16819  15:24:01 DEBUG| postprocess_profiled_run, args, dargs)
  16820  15:24:01 DEBUG| ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16821  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 212, in _call_run_once
  16822  15:24:01 DEBUG| self.run_once(*args, **dargs)
  16823  15:24:01 DEBUG| ~~~~~~~~~~~~~^^^^^^^^^^^^^^^^
  16824  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/tests/ubuntu_ltp/ubuntu_ltp.py", line 138, in run_once
  16825  15:24:01 DEBUG| utils.system_output(cmd, verbose=False, retain_output=True)
  16826  15:24:01 DEBUG| ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16827  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/utils.py", line 1265, in system_output
  16828  15:24:01 DEBUG| out = run(command, timeout=timeout, ignore_status=ignore_status,
  16829  15:24:01 DEBUG| ~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16830  15:24:01 DEBUG| stdout_tee=TEE_TO_LOGS, stderr_tee=TEE_TO_LOGS,
  16831  15:24:01 DEBUG| ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16832  15:24:01 DEBUG| verbose=verbose, args=args).stdout
  16833  15:24:01 DEBUG| ^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16834  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/utils.py", line 916, in run
  16835  15:24:01 DEBUG| raise error.CmdError(command, bg_job.result,
  16836  15:24:01 DEBUG| "Command returned non-zero exit status")
  16837  15:24:01 DEBUG| autotest.client.shared.error.CmdError: Command failed, rc=1, Command returned non-zero exit status
  16838  15:24:01 DEBUG| * Command:
  16839  15:24:01 DEBUG| /opt/ltp/runltp -f /tmp/target -q -C /dev/null -l /dev/null -T /dev/null
  16840  15:24:01 DEBUG| Exit status: 1
  16841  15:24:01 DEBUG| Duration: 1600.021127462387
  16842  15:24:01 DEBUG|
  16843  15:24:01 DEBUG| stdout:
  16844  15:24:01 DEBUG| Checking for required user/group ids
  16845  15:24:01 DEBUG|
  16846  15:24:01 DEBUG| 'root' user id and group found.
  16847  15:24:01 DEBUG| 'nobody' user id and group found.
  16848  15:24:01 DEBUG| 'bin' user id and group found.
  16849  15:24:01 DEBUG| 'daemon' user id and group found.
  16850  15:24:01 DEBUG| Users group found.
  16851  15:24:01 DEBUG| Sys group found.
  16852  15:24:01 DEBUG| Required users/groups exist.
  16853  15:24:01 DEBUG| no big block device was specified on commandline.
  16854  15:24:01 DEBUG| Tests which require a big block device are disabled.
  16855  15:24:01 DEBUG| You can specify it with option -z
  16856  15:24:01 DEBUG| INFO: Test start time: Mon Oct 20 02:57:21 PM UTC 2025
  16857  15:24:01 DEBUG| COMMAND: /opt/ltp/bin/ltp-pan -q -e -S -a 60304 -n 60304 -f /tmp/ltp-QUoNvysr8i/alltests -l /dev/null -C /dev/null -T /dev/null
  16858  15:24:01 DEBUG| LOG File: /dev/null
  16859  15:24:01 DEBUG| FAILED COMMAND File: /dev/null
  16860  15:24:01 DEBUG| TCONF COMMAND File: /dev/null
  16861  15:24:01 DEBUG| Running tests.......
  16862  15:24:01 DEBUG| tst_test.c:1952: TINFO: LTP version: 20230929-1383-g3c1f992e2
  16863  15:24:01 DEBUG| tst_test.c:1955: TINFO: Tested kernel: 6.17.0-7-generic #7-Ubuntu SMP Sat Oct 18 09:07:31 UTC 2025 s390x
  16864  15:24:01 DEBUG| tst_kconfig.c:88: TINFO: Parsing kernel config '/lib/modules/6.17.0-7-generic/build/.config'
  16865  15:24:01 DEBUG| tst_test.c:1773: TINFO: Overall timeout per run is 0h 26m 40s
  16866  15:24:01 DEBUG| read_all.c:601: TINFO: Worker timeout set to 10% of runtime: 1000ms
  16867  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60353 (2): Stuck for 1883896us, restarting it
  16868  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60352 (1): Stuck for 1884084us, restarting it
  16869  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60354 (3): Stuck for 1885375us, restarting it
  16870  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60351 (0): Stuck for 1885608us, restarting it
  16871  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60355 (4): Stuck for 1886018us, restarting it
  16872  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60355 (4): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
  16873  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60356 (5): Stuck for 1886312us, restarting it
  16874  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60357 (6): Stuck for 1887080us, restarting it
  16875  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60353 (2): Timeout waiting after kill
  16876  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60353 (2): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
  16877  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60352 (1): Timeout waiting after kill
  16878  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60352 (1): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
  16879  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60354 (3): Timeout waiting after kill
  16880  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60354 (3): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
  16881  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60351 (0): Timeout waiting after kill
  16882  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60351 (0): Last popped '/sys/kernel/tracing/rv/available_monitors'
  16883  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60356 (5): Timeout waiting after kill
  16884  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60356 (5): Last popped '/sys/kernel/tracing/rv/available_monitors'
  16885  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60357 (6): Timeout waiting after kill
  16886  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60357 (6): Last popped '/sys/kernel/tracing/rv/available_monitors'
  16887  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60363 (2): Stuck for 1000076us, restarting it
  16888  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60366 (0): Stuck for 1000107us, restarting it
  16889  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60363 (2): Timeout waiting after kill
  16890  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60363 (2): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
  16891  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60366 (0): Timeout waiting after kill
  16892  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60366 (0): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
  16893  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60371 (0): Stuck for 1408969us, restarting it
  16894  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60371 (0): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
  16895  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60364 (1): Stuck for 3411562us, restarting it
  16896  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60364 (1): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
  16897  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60370 (2): Stuck for 1413387us, restarting it
  16898  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60370 (2): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
  16899  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60365 (3): Stuck for 3412587us, restarting it
  16900  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60365 (3): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_256_xts'
  16901  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60362 (4): Stuck for 4412476us, restarting it
  16902  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60367 (5): Stuck for 3412058us, restarting it
  16903  15:24:01 DEBUG| read_all.c:454: TINFO: Silencing timeout warnings; consider increasing LTP_RUNTIME_MUL or removing -q
  16904  15:24:01 DEBUG| read_all.c:660: TINFO: opendir(/sys/module/pkey_uv): ENOENT (2)
  16905  15:24:01 DEBUG| Test timeouted, sending SIGKILL!
  16906  15:24:01 DEBUG| tst_test.c:1836: TINFO: Killed the leftover descendant processes
  16907  15:24:01 DEBUG| tst_test.c:1845: TINFO: If you are running on slow machine, try exporting LTP_TIMEOUT_MUL > 1
  16908  15:24:01 DEBUG| tst_test.c:1847: TBROK: Test killed! (timeout?)
  16909  15:24:01 DEBUG|
  16910  15:24:01 DEBUG| Summary:
  16911  15:24:01 DEBUG| passed 0
  16912  15:24:01 DEBUG| failed 0
  16913  15:24:01 DEBUG| broken 1
  16914  15:24:01 DEBUG| skipped 0
  16915  15:24:01 DEBUG| warnings 0
  16916  15:24:01 DEBUG| INFO: ltp-pan reported some tests FAIL
  16917  15:24:01 DEBUG| LTP Version: 20230929-1383-g3c1f992e2
  16918  15:24:01 DEBUG| INFO: Test end time: Mon Oct 20 03:24:01 PM UTC 2025
  16919  15:24:01 DEBUG| stderr:
  16920  15:24:01 DEBUG| -------------------------------------------
  16921  15:24:01 DEBUG| INFO: runltp script is deprecated, try kirk
  16922  15:24:01 DEBUG| https://github.com/linux-test-project/kirk
  16923  15:24:01 DEBUG| -------------------------------------------
  16924  15:24:01 DEBUG| -------------------------------------------
  16925  15:24:01 DEBUG| INFO: runltp script is deprecated, try kirk
  16926  15:24:01 DEBUG| https://github.com/linux-test-project/kirk
  16927  15:24:01 DEBUG| -------------------------------------------
  16928  15:24:01 DEBUG|
  16929  15:24:01 DEBUG| During handling of the above exception, another exception occurred:
  16930  15:24:01 DEBUG|
  16931  15:24:01 DEBUG| Traceback (most recent call last):
  16932  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 434, in _exec
  16933  15:24:01 DEBUG| raise exc_info[0](exc_info[1]).with_traceback(exc_info[2])
  16934  15:24:01 DEBUG| ~~~~~~~~~~~^^^^^^^^^^^^^
  16935  15:24:01 DEBUG| TypeError: CmdError.__init__() missing 1 required positional argument: 'result_obj'
  16936  15:24:01 DEBUG|
  16937  15:24:01 DEBUG| During handling of the above exception, another exception occurred:
  16938  15:24:01 DEBUG|
  16939  15:24:01 DEBUG| Traceback (most recent call last):
  16940  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/parallel.py", line 25, in fork_start
  16941  15:24:01 DEBUG| l()
  16942  15:24:01 DEBUG| ~^^
  16943  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/job.py", line 506, in
  16944  15:24:01 DEBUG| l = lambda: test.runtest(self, url, tag, args, dargs)
  16945  15:24:01 DEBUG| ~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16946  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/test.py", line 121, in runtest
  16947  15:24:01 DEBUG| common_test.runtest(job, url, tag, args, dargs, locals(), globals(),
  16948  15:24:01 DEBUG| ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16949  15:24:01 DEBUG| job.sysinfo.log_before_each_test,
  16950  15:24:01 DEBUG| ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16951  15:24:01 DEBUG| job.sysinfo.log_after_each_test,
  16952  15:24:01 DEBUG| ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16953  15:24:01 DEBUG| job.sysinfo.log_before_each_iteration,
  16954  15:24:01 DEBUG| ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16955  15:24:01 DEBUG| job.sysinfo.log_after_each_iteration)
  16956  15:24:01 DEBUG| ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16957  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 913, in runtest
  16958  15:24:01 DEBUG| mytest._exec(args, dargs)
  16959  15:24:01 DEBUG| ~~~~~~~~~~~~^^^^^^^^^^^^^
  16960  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 455, in _exec
  16961  15:24:01 DEBUG| raise error.UnhandledTestError(e)
  16962  15:24:01 DEBUG| autotest.client.shared.error.UnhandledTestError: Unhandled TypeError: CmdError.__init__() missing 1 required positional argument: 'result_obj'
  16963  15:24:01 DEBUG| Traceback (most recent call last):
  16964  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 411, in _exec
  16965  15:24:01 DEBUG| _call_test_function(self.execute, *p_args, **p_dargs)
  16966  15:24:01 DEBUG| ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16967  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 823, in _call_test_function
  16968  15:24:01 DEBUG| return func(*args, **dargs)
  16969  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 290, in execute
  16970  15:24:01 DEBUG| self._call_run_once(constraints, profile_only,
  16971  15:24:01 DEBUG| ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16972  15:24:01 DEBUG| postprocess_profiled_run, args, dargs)
  16973  15:24:01 DEBUG| ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16974  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 212, in _call_run_once
  16975  15:24:01 DEBUG| self.run_once(*args, **dargs)
  16976  15:24:01 DEBUG| ~~~~~~~~~~~~~^^^^^^^^^^^^^^^^
  16977  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/tests/ubuntu_ltp/ubuntu_ltp.py", line 138, in run_once
  16978  15:24:01 DEBUG| utils.system_output(cmd, verbose=False, retain_output=True)
  16979  15:24:01 DEBUG| ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16980  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/utils.py", line 1265, in system_output
  16981  15:24:01 DEBUG| out = run(command, timeout=timeout, ignore_status=ignore_status,
  16982  15:24:01 DEBUG| ~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16983  15:24:01 DEBUG| stdout_tee=TEE_TO_LOGS, stderr_tee=TEE_TO_LOGS,
  16984  15:24:01 DEBUG| ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16985  15:24:01 DEBUG| verbose=verbose, args=args).stdout
  16986  15:24:01 DEBUG| ^^^^^^^^^^^^^^^^^^^^^^^^^^^
  16987  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/utils.py", line 916, in run
  16988  15:24:01 DEBUG| raise error.CmdError(command, bg_job.result,
  16989  15:24:01 DEBUG| "Command returned non-zero exit status")
  16990  15:24:01 DEBUG| autotest.client.shared.error.CmdError: Command failed, rc=1, Command returned non-zero exit status
  16991  15:24:01 DEBUG| * Command:
  16992  15:24:01 DEBUG| /opt/ltp/runltp -f /tmp/target -q -C /dev/null -l /dev/null -T /dev/null
  16993  15:24:01 DEBUG| Exit status: 1
  16994  15:24:01 DEBUG| Duration: 1600.021127462387
  16995  15:24:01 DEBUG|
  16996  15:24:01 DEBUG| stdout:
  16997  15:24:01 DEBUG| Checking for required user/group ids
  16998  15:24:01 DEBUG|
  16999  15:24:01 DEBUG| 'root' user id and group found.
  17000  15:24:01 DEBUG| 'nobody' user id and group found.
  17001  15:24:01 DEBUG| 'bin' user id and group found.
  17002  15:24:01 DEBUG| 'daemon' user id and group found.
  17003  15:24:01 DEBUG| Users group found.
  17004  15:24:01 DEBUG| Sys group found.
  17005  15:24:01 DEBUG| Required users/groups exist.
  17006  15:24:01 DEBUG| no big block device was specified on commandline.
  17007  15:24:01 DEBUG| Tests which require a big block device are disabled.
  17008  15:24:01 DEBUG| You can specify it with option -z
  17009  15:24:01 DEBUG| INFO: Test start time: Mon Oct 20 02:57:21 PM UTC 2025
  17010  15:24:01 DEBUG| COMMAND: /opt/ltp/bin/ltp-pan -q -e -S -a 60304 -n 60304 -f /tmp/ltp-QUoNvysr8i/alltests -l /dev/null -C /dev/null -T /dev/null
  17011  15:24:01 DEBUG| LOG File: /dev/null
  17012  15:24:01 DEBUG| FAILED COMMAND File: /dev/null
  17013  15:24:01 DEBUG| TCONF COMMAND File: /dev/null
  17014  15:24:01 DEBUG| Running tests.......
  17015  15:24:01 DEBUG| tst_test.c:1952: TINFO: LTP version: 20230929-1383-g3c1f992e2
  17016  15:24:01 DEBUG| tst_test.c:1955: TINFO: Tested kernel: 6.17.0-7-generic #7-Ubuntu SMP Sat Oct 18 09:07:31 UTC 2025 s390x
  17017  15:24:01 DEBUG| tst_kconfig.c:88: TINFO: Parsing kernel config '/lib/modules/6.17.0-7-generic/build/.config'
  17018  15:24:01 DEBUG| tst_test.c:1773: TINFO: Overall timeout per run is 0h 26m 40s
  17019  15:24:01 DEBUG| read_all.c:601: TINFO: Worker timeout set to 10% of runtime: 1000ms
  17020  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60353 (2): Stuck for 1883896us, restarting it
  17021  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60352 (1): Stuck for 1884084us, restarting it
  17022  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60354 (3): Stuck for 1885375us, restarting it
  17023  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60351 (0): Stuck for 1885608us, restarting it
  17024  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60355 (4): Stuck for 1886018us, restarting it
  17025  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60355 (4): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
  17026  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60356 (5): Stuck for 1886312us, restarting it
  17027  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60357 (6): Stuck for 1887080us, restarting it
  17028  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60353 (2): Timeout waiting after kill
  17029  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60353 (2): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
  17030  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60352 (1): Timeout waiting after kill
  17031  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60352 (1): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
  17032  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60354 (3): Timeout waiting after kill
  17033  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60354 (3): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
  17034  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60351 (0): Timeout waiting after kill
  17035  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60351 (0): Last popped '/sys/kernel/tracing/rv/available_monitors'
  17036  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60356 (5): Timeout waiting after kill
  17037  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60356 (5): Last popped '/sys/kernel/tracing/rv/available_monitors'
  17038  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60357 (6): Timeout waiting after kill
  17039  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60357 (6): Last popped '/sys/kernel/tracing/rv/available_monitors'
  17040  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60363 (2): Stuck for 1000076us, restarting it
  17041  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60366 (0): Stuck for 1000107us, restarting it
  17042  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60363 (2): Timeout waiting after kill
  17043  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60363 (2): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
  17044  15:24:01 DEBUG| read_all.c:395: TINFO: Worker 60366 (0): Timeout waiting after kill
  17045  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60366 (0): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
  17046  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60371 (0): Stuck for 1408969us, restarting it
  17047  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60371 (0): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
  17048  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60364 (1): Stuck for 3411562us, restarting it
  17049  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60364 (1): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
  17050  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60370 (2): Stuck for 1413387us, restarting it
  17051  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60370 (2): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
  17052  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60365 (3): Stuck for 3412587us, restarting it
  17053  15:24:01 DEBUG| read_all.c:413: TINFO: Worker 60365 (3): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_256_xts'
  17054  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60362 (4): Stuck for 4412476us, restarting it
  17055  15:24:01 DEBUG| read_all.c:477: TINFO: Worker 60367 (5): Stuck for 3412058us, restarting it
  17056  15:24:01 DEBUG| read_all.c:454: TINFO: Silencing timeout warnings; consider increasing LTP_RUNTIME_MUL or removing -q
  17057  15:24:01 DEBUG| read_all.c:660: TINFO: opendir(/sys/module/pkey_uv): ENOENT (2)
  17058  15:24:01 DEBUG| Test timeouted, sending SIGKILL!
  17059  15:24:01 DEBUG| tst_test.c:1836: TINFO: Killed the leftover descendant processes
  17060  15:24:01 DEBUG| tst_test.c:1845: TINFO: If you are running on slow machine, try exporting LTP_TIMEOUT_MUL > 1
  17061  15:24:01 DEBUG| tst_test.c:1847: TBROK: Test killed! (timeout?)
  17062  15:24:01 DEBUG|
  17063  15:24:01 DEBUG| Summary:
  17064  15:24:01 DEBUG| passed 0
  17065  15:24:01 DEBUG| failed 0
  17066  15:24:01 DEBUG| broken 1
  17067  15:24:01 DEBUG| skipped 0
  17068  15:24:01 DEBUG| warnings 0
  17069  15:24:01 DEBUG| INFO: ltp-pan reported some tests FAIL
  17070  15:24:01 DEBUG| LTP Version: 20230929-1383-g3c1f992e2
  17071  15:24:01 DEBUG| INFO: Test end time: Mon Oct 20 03:24:01 PM UTC 2025
  17072  15:24:01 DEBUG| stderr:
  17073  15:24:01 DEBUG| -------------------------------------------
  17074  15:24:01 DEBUG| INFO: runltp script is deprecated, try kirk
  17075  15:24:01 DEBUG| https://github.com/linux-test-project/kirk
  17076  15:24:01 DEBUG| -------------------------------------------
  17077  15:24:01 DEBUG| -------------------------------------------
  17078  15:24:01 DEBUG| INFO: runltp script is deprecated, try kirk
  17079  15:24:01 DEBUG| https://github.com/linux-test-project/kirk
  17080  15:24:01 DEBUG| -------------------------------------------
  17081  15:24:01 DEBUG|
  17082  15:24:01 DEBUG| During handling of the above exception, another exception occurred:
  17083  15:24:01 DEBUG|
  17084  15:24:01 DEBUG| Traceback (most recent call last):
  17085  15:24:01 DEBUG| File "/home/ubuntu/autotest/client/shared/test.py", line 434, in _exec
  17086  15:24:01 DEBUG| raise exc_info[0](exc_info[1]).with_traceback(exc_info[2])
  17087  15:24:01 DEBUG| ~~~~~~~~~~~^^^^^^^^^^^^^
  17088  15:24:01 DEBUG| TypeError: CmdError.__init__() missing 1 required positional argument: 'result_obj'
  17089  15:24:01 DEBUG|
  17090  15:24:01 INFO | ERROR ubuntu_ltp.fs:read_all_sys ubuntu_ltp.fs:read_all_sys timestamp=1760973841 localtime=Oct 20 15:24:01 Unhandled TypeError: CmdError.__init__() missing 1 required positional argument: 'result_obj'
  17091   Traceback (most recent call last):
  17092   File "/home/ubuntu/autotest/client/shared/test.py", line 411, in _exec
  17093   _call_test_function(self.execute, *p_args, **p_dargs)
  17094   ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  17095   File "/home/ubuntu/autotest/client/shared/test.py", line 823, in _call_test_function
  17096   return func(*args, **dargs)
  17097   File "/home/ubuntu/autotest/client/shared/test.py", line 290, in execute
  17098   self._call_run_once(constraints, profile_only,
  17099   ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^
  17100   postprocess_profiled_run, args, dargs)
  17101   ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  17102   File "/home/ubuntu/autotest/client/shared/test.py", line 212, in _call_run_once
  17103   self.run_once(*args, **dargs)
  17104   ~~~~~~~~~~~~~^^^^^^^^^^^^^^^^
  17105   File "/home/ubuntu/autotest/client/tests/ubuntu_ltp/ubuntu_ltp.py", line 138, in run_once
  17106   utils.system_output(cmd, verbose=False, retain_output=True)
  17107   ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  17108   File "/home/ubuntu/autotest/client/shared/utils.py", line 1265, in system_output
  17109   out = run(command, timeout=timeout, ignore_status=ignore_status,
  17110   ~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  17111   stdout_tee=TEE_TO_LOGS, stderr_tee=TEE_TO_LOGS,
  17112   ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  17113   verbose=verbose, args=args).stdout
  17114   ^^^^^^^^^^^^^^^^^^^^^^^^^^^
  17115   File "/home/ubuntu/autotest/client/shared/utils.py", line 916, in run
  17116   raise error.CmdError(command, bg_job.result,
  17117   "Command returned non-zero exit status")
  17118   autotest.client.shared.error.CmdError: Command failed, rc=1, Command returned non-zero exit status
  17119   * Command:
  17120   /opt/ltp/runltp -f /tmp/target -q -C /dev/null -l /dev/null -T /dev/null
  17121   Exit status: 1
  17122   Duration: 1600.021127462387
  17123
  17124   stdout:
  17125   Checking for required user/group ids
  17126
  17127   'root' user id and group found.
  17128   'nobody' user id and group found.
  17129   'bin' user id and group found.
  17130   'daemon' user id and group found.
  17131   Users group found.
  17132   Sys group found.
  17133   Required users/groups exist.
  17134   no big block device was specified on commandline.
  17135   Tests which require a big block device are disabled.
  17136   You can specify it with option -z
  17137   INFO: Test start time: Mon Oct 20 02:57:21 PM UTC 2025
  17138   COMMAND: /opt/ltp/bin/ltp-pan -q -e -S -a 60304 -n 60304 -f /tmp/ltp-QUoNvysr8i/alltests -l /dev/null -C /dev/null -T /dev/null
  17139   LOG File: /dev/null
  17140   FAILED COMMAND File: /dev/null
  17141   TCONF COMMAND File: /dev/null
  17142   Running tests.......
  17143   tst_test.c:1952: TINFO: LTP version: 20230929-1383-g3c1f992e2
  17144   tst_test.c:1955: TINFO: Tested kernel: 6.17.0-7-generic #7-Ubuntu SMP Sat Oct 18 09:07:31 UTC 2025 s390x
  17145   tst_kconfig.c:88: TINFO: Parsing kernel config '/lib/modules/6.17.0-7-generic/build/.config'
  17146   tst_test.c:1773: TINFO: Overall timeout per run is 0h 26m 40s
  17147   read_all.c:601: TINFO: Worker timeout set to 10% of runtime: 1000ms
  17148   read_all.c:477: TINFO: Worker 60353 (2): Stuck for 1883896us, restarting it
  17149   read_all.c:477: TINFO: Worker 60352 (1): Stuck for 1884084us, restarting it
  17150   read_all.c:477: TINFO: Worker 60354 (3): Stuck for 1885375us, restarting it
  17151   read_all.c:477: TINFO: Worker 60351 (0): Stuck for 1885608us, restarting it
  17152   read_all.c:477: TINFO: Worker 60355 (4): Stuck for 1886018us, restarting it
  17153   read_all.c:413: TINFO: Worker 60355 (4): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
  17154   read_all.c:477: TINFO: Worker 60356 (5): Stuck for 1886312us, restarting it
  17155   read_all.c:477: TINFO: Worker 60357 (6): Stuck for 1887080us, restarting it
  17156   read_all.c:395: TINFO: Worker 60353 (2): Timeout waiting after kill
  17157   read_all.c:413: TINFO: Worker 60353 (2): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
  17158   read_all.c:395: TINFO: Worker 60352 (1): Timeout waiting after kill
  17159   read_all.c:413: TINFO: Worker 60352 (1): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
  17160   read_all.c:395: TINFO: Worker 60354 (3): Timeout waiting after kill
  17161   read_all.c:413: TINFO: Worker 60354 (3): Last popped '/sys/kernel/tracing/rv/enabled_monitors'
  17162   read_all.c:395: TINFO: Worker 60351 (0): Timeout waiting after kill
  17163   read_all.c:413: TINFO: Worker 60351 (0): Last popped '/sys/kernel/tracing/rv/available_monitors'
  17164   read_all.c:395: TINFO: Worker 60356 (5): Timeout waiting after kill
  17165   read_all.c:413: TINFO: Worker 60356 (5): Last popped '/sys/kernel/tracing/rv/available_monitors'
  17166   read_all.c:395: TINFO: Worker 60357 (6): Timeout waiting after kill
  17167   read_all.c:413: TINFO: Worker 60357 (6): Last popped '/sys/kernel/tracing/rv/available_monitors'
  17168   read_all.c:477: TINFO: Worker 60363 (2): Stuck for 1000076us, restarting it
  17169   read_all.c:477: TINFO: Worker 60366 (0): Stuck for 1000107us, restarting it
  17170   read_all.c:395: TINFO: Worker 60363 (2): Timeout waiting after kill
  17171   read_all.c:413: TINFO: Worker 60363 (2): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
  17172   read_all.c:395: TINFO: Worker 60366 (0): Timeout waiting after kill
  17173   read_all.c:413: TINFO: Worker 60366 (0): Last popped '/sys/kernel/tracing/rv/monitors/wwnr/reactors'
  17174   read_all.c:477: TINFO: Worker 60371 (0): Stuck for 1408969us, restarting it
  17175   read_all.c:413: TINFO: Worker 60371 (0): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
  17176   read_all.c:477: TINFO: Worker 60364 (1): Stuck for 3411562us, restarting it
  17177   read_all.c:413: TINFO: Worker 60364 (1): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
  17178   read_all.c:477: TINFO: Worker 60370 (2): Stuck for 1413387us, restarting it
  17179   read_all.c:413: TINFO: Worker 60370 (2): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_192'
  17180   read_all.c:477: TINFO: Worker 60365 (3): Stuck for 3412587us, restarting it
  17181   read_all.c:413: TINFO: Worker 60365 (3): Last popped '/sys/devices/virtual/misc/pkey/ccacipher/ccacipher_aes_256_xts'
  17182   read_all.c:477: TINFO: Worker 60362 (4): Stuck for 4412476us, restarting it
  17183   read_all.c:477: TINFO: Worker 60367 (5): Stuck for 3412058us, restarting it
  17184   read_all.c:454: TINFO: Silencing timeout warnings; consider increasing LTP_RUNTIME_MUL or removing -q
  17185   read_all.c:660: TINFO: opendir(/sys/module/pkey_uv): ENOENT (2)
  17186   Test timeouted, sending SIGKILL!
  17187   tst_test.c:1836: TINFO: Killed the leftover descendant processes
  17188   tst_test.c:1845: TINFO: If you are running on slow machine, try exporting LTP_TIMEOUT_MUL > 1
  17189   tst_test.c:1847: TBROK: Test killed! (timeout?)
  17190
  17191   Summary:
  17192   passed 0
  17193   failed 0
  17194   broken 1
  17195   skipped 0
  17196   warnings 0
  17197   INFO: ltp-pan reported some tests FAIL
  17198   LTP Version: 20230929-1383-g3c1f992e2
  17199   INFO: Test end time: Mon Oct 20 03:24:01 PM UTC 2025
  17200   stderr:
  17201   -------------------------------------------
  17202   INFO: runltp script is deprecated, try kirk
  17203   https://github.com/linux-test-project/kirk
  17204   -------------------------------------------
  17205   -------------------------------------------
  17206   INFO: runltp script is deprecated, try kirk
  17207   https://github.com/linux-test-project/kirk
  17208   -------------------------------------------
  17209
  17210   During handling of the above exception, another exception occurred:
  17211
  17212   Traceback (most recent call last):
  17213   File "/home/ubuntu/autotest/client/shared/test.py", line 434, in _exec
  17214   raise exc_info[0](exc_info[1]).with_traceback(exc_info[2])
  17215   ~~~~~~~~~~~^^^^^^^^^^^^^
  17216   TypeError: CmdError.__init__() missing 1 required positional argument: 'result_obj'
  17217

To manage notifications about this bug go to:
https://bugs.launchpad.net/ubuntu-kernel-tests/+bug/2129834/+subscriptions