canonical-ubuntu-qa team mailing list archive
-
canonical-ubuntu-qa team
-
Mailing list archive
-
Message #07994
[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