canonical-ubuntu-qa team mailing list archive

Thread
Date
[Bug 2110619] Re: ubuntu_ltp:pty:pty07 Test timeouted, sending SIGKILL! on plucky oracular

To: canonical-ubuntu-qa@xxxxxxxxxxxxxxxxxxx
From: Edoardo Canepa <2110619@xxxxxxxxxxxxxxxxxx>
Date: Sun, 26 Oct 2025 11:42:30 -0000
Reply-to: Bug 2110619 <2110619@xxxxxxxxxxxxxxxxxx>
Sender: noreply@xxxxxxxxxxxxx
affects questing version 6.17.0-7.7. journal shows a deadlock

Oct 26 11:29:27.968469 questing-amd64 kernel: [TTM] Buffer eviction failed
Oct 26 11:29:43.328432 questing-amd64 kernel: [TTM] Buffer eviction failed
Oct 26 11:29:58.688638 questing-amd64 kernel: [TTM] Buffer eviction failed
Oct 26 11:30:14.048031 questing-amd64 kernel: [TTM] Buffer eviction failed
Oct 26 11:30:29.408785 questing-amd64 kernel: [TTM] Buffer eviction failed
Oct 26 11:30:44.768307 questing-amd64 kernel: [TTM] Buffer eviction failed
Oct 26 11:31:00.128227 questing-amd64 kernel: [TTM] Buffer eviction failed
Oct 26 11:31:15.488317 questing-amd64 kernel: [TTM] Buffer eviction failed
Oct 26 11:31:30.848482 questing-amd64 kernel: [TTM] Buffer eviction failed
Oct 26 11:31:41.091596 questing-amd64 kernel: INFO: task systemd-logind:781 blocked for more than 122 seconds.
Oct 26 11:31:41.092079 questing-amd64 kernel:       Not tainted 6.17.0-7-generic #7
Oct 26 11:31:41.092185 questing-amd64 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Oct 26 11:31:41.092250 questing-amd64 kernel: task:systemd-logind  state:D stack:0     pid:781   tgid:781   ppid:1      task_flags:0x400100 flags:0x00004002
Oct 26 11:31:41.092389 questing-amd64 kernel: Call Trace:
Oct 26 11:31:41.092448 questing-amd64 kernel:  <TASK>
Oct 26 11:31:41.092492 questing-amd64 kernel:  __schedule+0x2ed/0x7c0
Oct 26 11:31:41.092543 questing-amd64 kernel:  schedule+0x27/0x90
Oct 26 11:31:41.092582 questing-amd64 kernel:  schedule_preempt_disabled+0x15/0x30
Oct 26 11:31:41.092641 questing-amd64 kernel:  __mutex_lock.constprop.0+0x516/0xa40
Oct 26 11:31:41.092691 questing-amd64 kernel:  __mutex_lock_slowpath+0x13/0x20
Oct 26 11:31:41.092735 questing-amd64 kernel:  mutex_lock+0x3b/0x50
Oct 26 11:31:41.095278 questing-amd64 kernel:  tty_open+0x1ef/0x790
Oct 26 11:31:41.095316 questing-amd64 kernel:  ? __cgroup_bpf_check_dev_permission+0x100/0x190
Oct 26 11:31:41.095363 questing-amd64 kernel:  chrdev_open+0xb9/0x230
Oct 26 11:31:41.095402 questing-amd64 kernel:  ? __pfx_chrdev_open+0x10/0x10
Oct 26 11:31:41.095444 questing-amd64 kernel:  do_dentry_open+0x253/0x460
Oct 26 11:31:41.095474 questing-amd64 kernel:  vfs_open+0x2c/0x100
Oct 26 11:31:41.095505 questing-amd64 kernel:  do_open+0x178/0x400
Oct 26 11:31:41.095549 questing-amd64 kernel:  path_openat+0x113/0x290
Oct 26 11:31:41.095586 questing-amd64 kernel:  ? update_rq_clock+0x81/0x190
Oct 26 11:31:41.095625 questing-amd64 kernel:  do_filp_open+0xd4/0x1a0
Oct 26 11:31:41.095662 questing-amd64 kernel:  do_sys_openat2+0x87/0xe0
Oct 26 11:31:41.095694 questing-amd64 kernel:  __x64_sys_openat+0x5f/0xa0
Oct 26 11:31:41.095725 questing-amd64 kernel:  x64_sys_call+0x1bf2/0x2330
Oct 26 11:31:41.096799 questing-amd64 kernel:  do_syscall_64+0x81/0xc90
Oct 26 11:31:41.096860 questing-amd64 kernel:  ? n_tty_ioctl+0x95/0x130
Oct 26 11:31:41.096887 questing-amd64 kernel:  ? tty_ldisc_ref_wait+0x26/0x70
Oct 26 11:31:41.096937 questing-amd64 kernel:  ? tty_ldisc_deref+0x16/0x20
Oct 26 11:31:41.096969 questing-amd64 kernel:  ? tty_ioctl+0x156/0x9c0
Oct 26 11:31:41.097001 questing-amd64 kernel:  ? __seccomp_filter+0x45/0x5a0
Oct 26 11:31:41.097032 questing-amd64 kernel:  ? switch_fpu_return+0x5c/0xf0
Oct 26 11:31:41.097057 questing-amd64 kernel:  ? hook_file_ioctl+0x10/0x20
Oct 26 11:31:41.097087 questing-amd64 kernel:  ? security_file_ioctl+0x41/0x70
Oct 26 11:31:41.097119 questing-amd64 kernel:  ? __x64_sys_ioctl+0xa3/0x100
Oct 26 11:31:41.097144 questing-amd64 kernel:  ? arch_exit_to_user_mode_prepare.isra.0+0xd/0xe0
Oct 26 11:31:41.097169 questing-amd64 kernel:  ? do_syscall_64+0xb9/0xc90
Oct 26 11:31:41.097201 questing-amd64 kernel:  ? arch_exit_to_user_mode_prepare.isra.0+0xc2/0xe0
Oct 26 11:31:41.097225 questing-amd64 kernel:  ? do_syscall_64+0xb9/0xc90
Oct 26 11:31:41.097250 questing-amd64 kernel:  ? do_syscall_64+0xb9/0xc90
Oct 26 11:31:41.097279 questing-amd64 kernel:  ? do_syscall_64+0xb9/0xc90
Oct 26 11:31:41.097304 questing-amd64 kernel:  ? sysvec_apic_timer_interrupt+0x54/0xd0
Oct 26 11:31:41.097335 questing-amd64 kernel:  entry_SYSCALL_64_after_hwframe+0x76/0x7e
Oct 26 11:31:41.097367 questing-amd64 kernel: RIP: 0033:0x72a7248a0186
Oct 26 11:31:41.097405 questing-amd64 kernel: RSP: 002b:00007ffd03a21eb0 EFLAGS: 00000202 ORIG_RAX: 0000000000000101
Oct 26 11:31:41.097445 questing-amd64 kernel: RAX: ffffffffffffffda RBX: 000060d10ae5a420 RCX: 000072a7248a0186
Oct 26 11:31:41.097470 questing-amd64 kernel: RDX: 0000000000080102 RSI: 00007ffd03a21fa0 RDI: ffffffffffffff9c
Oct 26 11:31:41.097495 questing-amd64 kernel: RBP: 00007ffd03a21ec0 R08: 0000000000000000 R09: 0000000000000000
Oct 26 11:31:41.097533 questing-amd64 kernel: R10: 0000000000000000 R11: 0000000000000202 R12: 0000000000000015
Oct 26 11:31:41.097557 questing-amd64 kernel: R13: 0000000000080102 R14: 00007ffd03a21fa0 R15: 000060d10ae50c00
Oct 26 11:31:41.097589 questing-amd64 kernel:  </TASK>
Oct 26 11:31:41.097614 questing-amd64 kernel: INFO: task systemd-logind:781 is blocked on a mutex likely owned by task cached_setup_te:2667.
Oct 26 11:31:41.097654 questing-amd64 kernel: task:cached_setup_te state:D stack:0     pid:2667  tgid:2667  ppid:1366   task_flags:0x400100 flags:0x00004002
Oct 26 11:31:41.097679 questing-amd64 kernel: Call Trace:
Oct 26 11:31:41.097704 questing-amd64 kernel:  <TASK>
Oct 26 11:31:41.097728 questing-amd64 kernel:  __schedule+0x2ed/0x7c0
Oct 26 11:31:41.100724 questing-amd64 kernel:  schedule+0x27/0x90
Oct 26 11:31:41.100806 questing-amd64 kernel:  schedule_timeout+0xcf/0x110
Oct 26 11:31:41.100834 questing-amd64 kernel:  ___down_common+0xf2/0x160
Oct 26 11:31:41.100861 questing-amd64 kernel:  ? vsnprintf+0x14c/0x5e0
Oct 26 11:31:41.100884 questing-amd64 kernel:  ? klist_put+0x57/0xb0
Oct 26 11:31:41.100916 questing-amd64 kernel:  ? __pfx_device_match_devt+0x10/0x10
Oct 26 11:31:41.100939 questing-amd64 kernel:  __down_common+0x5e/0x180
Oct 26 11:31:41.100975 questing-amd64 kernel:  __down+0x1d/0x30
Oct 26 11:31:41.101008 questing-amd64 kernel:  down+0x5e/0x80
Oct 26 11:31:41.101037 questing-amd64 kernel:  console_lock+0x25/0x70
Oct 26 11:31:41.101078 questing-amd64 kernel:  con_install+0x21/0x1b0
Oct 26 11:31:41.101102 questing-amd64 kernel:  tty_init_dev.part.0+0x53/0x210
Oct 26 11:31:41.101138 questing-amd64 kernel:  tty_open+0x48f/0x790
Oct 26 11:31:41.101168 questing-amd64 kernel:  ? __cgroup_bpf_check_dev_permission+0x100/0x190
Oct 26 11:31:41.101191 questing-amd64 kernel:  chrdev_open+0xb9/0x230
Oct 26 11:31:41.101215 questing-amd64 kernel:  ? __pfx_chrdev_open+0x10/0x10
Oct 26 11:31:41.101239 questing-amd64 kernel:  do_dentry_open+0x253/0x460
Oct 26 11:31:41.101264 questing-amd64 kernel:  vfs_open+0x2c/0x100
Oct 26 11:31:41.101281 questing-amd64 kernel:  do_open+0x178/0x400
Oct 26 11:31:41.101305 questing-amd64 kernel:  path_openat+0x113/0x290
Oct 26 11:31:41.101329 questing-amd64 kernel:  do_filp_open+0xd4/0x1a0
Oct 26 11:31:41.101353 questing-amd64 kernel:  do_sys_openat2+0x87/0xe0
Oct 26 11:31:41.101376 questing-amd64 kernel:  __x64_sys_openat+0x5f/0xa0
Oct 26 11:31:41.101400 questing-amd64 kernel:  x64_sys_call+0x1bf2/0x2330
Oct 26 11:31:41.101424 questing-amd64 kernel:  do_syscall_64+0x81/0xc90
Oct 26 11:31:41.101441 questing-amd64 kernel:  ? arch_exit_to_user_mode_prepare.isra.0+0xd/0xe0
Oct 26 11:31:41.101458 questing-amd64 kernel:  ? do_syscall_64+0xb9/0xc90
Oct 26 11:31:41.101490 questing-amd64 kernel:  ? exc_page_fault+0x90/0x1b0
Oct 26 11:31:41.101508 questing-amd64 kernel:  entry_SYSCALL_64_after_hwframe+0x76/0x7e
Oct 26 11:31:41.101532 questing-amd64 kernel: RIP: 0033:0x7687236a0186
Oct 26 11:31:41.101562 questing-amd64 kernel: RSP: 002b:00007ffcd2c91230 EFLAGS: 00000202 ORIG_RAX: 0000000000000101
Oct 26 11:31:41.101594 questing-amd64 kernel: RAX: ffffffffffffffda RBX: 00005d0e66e92688 RCX: 00007687236a0186
Oct 26 11:31:41.101632 questing-amd64 kernel: RDX: 0000000000000000 RSI: 00005d0e66e92688 RDI: ffffffffffffff9c
Oct 26 11:31:41.101657 questing-amd64 kernel: RBP: 00007ffcd2c91240 R08: 0000000000000000 R09: 0000000000000000
Oct 26 11:31:41.101674 questing-amd64 kernel: R10: 0000000000000000 R11: 0000000000000202 R12: 0000000000000000
Oct 26 11:31:41.101705 questing-amd64 kernel: R13: 0000000000000000 R14: 00005d0e66e925b0 R15: 00005d0e66e92670
Oct 26 11:31:41.101743 questing-amd64 kernel:  </TASK>

-- 
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/2110619

Title:
  ubuntu_ltp:pty:pty07 Test timeouted, sending SIGKILL! on plucky
  oracular

Status in ubuntu-kernel-tests:
  New

Bug description:
  Seen on openstack:amd64 with plucky version 6.14.0-17.17:

  157316  23:02:03 INFO | START ubuntu_ltp.pty:pty07 ubuntu_ltp.pty:pty07 timeout=6300 timestamp=1746140523 localtime=May 01 23:02:03
  157317  23:02:03 DEBUG| Persistent state client._record_indent now set to 2
  157318  23:02:03 DEBUG| Persistent state client.unexpected_reboot now set to ('ubuntu_ltp.pty:pty07', 'ubuntu_ltp.pty:pty07')
  157319  23:02:03 DEBUG| Waiting for pid 268699 for 6300 seconds
  157320  23:02:03 WARNI| System python is too old, crash handling disabled
  157321  23:02:03 ERROR| [stderr] -------------------------------------------
  157322  23:02:03 ERROR| [stderr] INFO: runltp script is deprecated, try kirk
  157323  23:02:03 ERROR| [stderr] https://github.com/linux-test-project/kirk
  157324  23:02:03 ERROR| [stderr] -------------------------------------------
  157325  23:02:03 DEBUG| [stdout] Checking for required user/group ids
  157326  23:02:03 DEBUG| [stdout]
  157327  23:02:03 DEBUG| [stdout] 'root' user id and group found.
  157328  23:02:03 DEBUG| [stdout] 'nobody' user id and group found.
  157329  23:02:03 DEBUG| [stdout] 'bin' user id and group found.
  157330  23:02:03 DEBUG| [stdout] 'daemon' user id and group found.
  157331  23:02:03 DEBUG| [stdout] Users group found.
  157332  23:02:03 DEBUG| [stdout] Sys group found.
  157333  23:02:03 DEBUG| [stdout] Required users/groups exist.
  157334  23:02:03 DEBUG| [stdout] no big block device was specified on commandline.
  157335  23:02:03 DEBUG| [stdout] Tests which require a big block device are disabled.
  157336  23:02:03 DEBUG| [stdout] You can specify it with option -z
  157337  23:02:03 DEBUG| [stdout] INFO: Test start time: Thu May 1 23:02:03 UTC 2025
  157338  23:02:03 DEBUG| [stdout] COMMAND: /opt/ltp/bin/ltp-pan -q -e -S -a 268704 -n 268704 -f /tmp/ltp-sUOsQsCCA9/alltests -l /dev/null -C /dev/null -T /dev/null
  157339  23:02:03 DEBUG| [stdout] LOG File: /dev/null
  157340  23:02:03 DEBUG| [stdout] FAILED COMMAND File: /dev/null
  157341  23:02:03 DEBUG| [stdout] TCONF COMMAND File: /dev/null
  157342  23:02:03 DEBUG| [stdout] Running tests.......
  157343  23:02:03 DEBUG| [stdout] tst_test.c:1900: TINFO: LTP version: 20230929-1055-g48dda81b1
  157344  23:02:03 DEBUG| [stdout] tst_test.c:1904: TINFO: Tested kernel: 6.14.0-17-generic #17-Ubuntu SMP PREEMPT_DYNAMIC Thu May 1 11:39:26 UTC 2025 x86_64
  157345  23:02:03 DEBUG| [stdout] tst_kconfig.c:88: TINFO: Parsing kernel config '/lib/modules/6.14.0-17-generic/build/.config'
  157346  23:02:03 DEBUG| [stdout] tst_kconfig.c:667: TINFO: CONFIG_LATENCYTOP kernel option detected which might slow the execution
  157347  23:02:03 DEBUG| [stdout] tst_test.c:1722: TINFO: Overall timeout per run is 0h 04m 30s
  157348  23:02:03 DEBUG| [stdout] pty07.c:92: TINFO: Saving active console 1
  157349  23:03:10 DEBUG| [stdout] ../../../include/tst_fuzzy_sync.h:484: TINFO: Minimum sampling period ended
  157350  23:03:10 DEBUG| [stdout] ../../../include/tst_fuzzy_sync.h:307: TINFO: loop = 1024, delay_bias = 0
  157351  23:03:10 DEBUG| [stdout] ../../../include/tst_fuzzy_sync.h:295: TINFO: start_a - start_b: { avg = 684998ns, avg_dev = 428210ns, dev_ratio = 0.63 }
  157352  23:03:10 DEBUG| [stdout] ../../../include/tst_fuzzy_sync.h:295: TINFO: end_a - start_a : { avg = 1523220ns, avg_dev = 336151ns, dev_ratio = 0.22 }
  157353  23:03:10 DEBUG| [stdout] ../../../include/tst_fuzzy_sync.h:295: TINFO: end_b - start_b : { avg = 58234056ns, avg_dev = 6575444ns, dev_ratio = 0.11 }
  157354  23:03:10 DEBUG| [stdout] ../../../include/tst_fuzzy_sync.h:295: TINFO: end_a - end_b : { avg = -56025840ns, avg_dev = 6248774ns, dev_ratio = 0.11 }
  157355  23:03:10 DEBUG| [stdout] ../../../include/tst_fuzzy_sync.h:295: TINFO: spins : { avg = 11260598 , avg_dev = 1738238 , dev_ratio = 0.15 }
  157356  23:06:33 DEBUG| [stdout] Test timeouted, sending SIGKILL!
  157357  23:06:38 DEBUG| [stdout] Test timeouted, sending SIGKILL!
  157358  23:06:43 DEBUG| [stdout] Test timeouted, sending SIGKILL!
  157359  23:06:48 DEBUG| [stdout] Test timeouted, sending SIGKILL!
  157360  23:06:53 DEBUG| [stdout] Test timeouted, sending SIGKILL!
  157361  23:06:58 DEBUG| [stdout] Test timeouted, sending SIGKILL!
  157362  23:07:03 DEBUG| [stdout] Test timeouted, sending SIGKILL!
  157363  23:07:08 DEBUG| [stdout] Test timeouted, sending SIGKILL!
  157364  23:07:13 DEBUG| [stdout] Test timeouted, sending SIGKILL!
  157365  23:07:18 DEBUG| [stdout] Test timeouted, sending SIGKILL!
  157366  23:07:23 DEBUG| [stdout] Test timeouted, sending SIGKILL!
  157367  23:07:23 DEBUG| [stdout] Cannot kill test processes!
  157368  23:07:23 DEBUG| [stdout] Congratulation, likely test hit a kernel bug.
  157369  23:07:23 DEBUG| [stdout] Exiting uncleanly...
  157370  23:07:23 DEBUG| [stdout] INFO: ltp-pan reported some tests FAIL
  157371  23:07:23 DEBUG| [stdout] LTP Version: 20230929-1055-g48dda81b1
  157372  23:07:23 DEBUG| [stdout] INFO: Test end time: Thu May 1 23:07:23 UTC 2025
  157373  23:07:23 ERROR| [stderr] -------------------------------------------
  157374  23:07:23 ERROR| [stderr] INFO: runltp script is deprecated, try kirk
  157375  23:07:23 ERROR| [stderr] https://github.com/linux-test-project/kirk
  157376  23:07:23 ERROR| [stderr] -------------------------------------------

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

[Bug 2110619] [NEW] ubuntu_ltp:pty:pty07 Test timeouted, sending SIGKILL! on plucky oracular
From: Mehmet Basaran, 2025-05-14