Comment 2 for bug 2018687

Revision history for this message
Ian! D. Allen (idallen) wrote :

I now have a Perl script running that is removing duplicate files by doing thousands of hard links on a different external USB3 disk and it is locking up or timing out many disk-related things on all my other disks. Both this USB3 external drive and the one above are plugged directly into the motherboard (HP Z440 Workstation).

F UID PID PPID PRI NI VSZ RSS WCHAN STAT TTY TIME COMMAND
4 0 2210112 2210111 20 0 53680 42588 blk_mq D+ pts/24 3:00 /usr/bin/perl [...]

May 14 13:37:49 kernel: [259424.745462] INFO: task smartd:2719 blocked for more than 120 seconds.
May 15 00:08:09 kernel: [297244.761855] INFO: task smartd:2719 blocked for more than 120 seconds.
May 15 00:10:10 kernel: [297365.592485] INFO: task smartd:2719 blocked for more than 241 seconds.
May 15 01:08:34 kernel: [300869.682961] INFO: task smartd:2719 blocked for more than 120 seconds.
May 15 01:28:43 kernel: [302077.989582] INFO: task hdparm:2052842 blocked for more than 120 seconds.
May 15 01:30:43 kernel: [302198.820278] INFO: task hdparm:2052842 blocked for more than 241 seconds.
May 15 01:32:44 kernel: [302319.654907] INFO: task hdparm:2052842 blocked for more than 362 seconds.
May 15 01:34:45 kernel: [302440.481601] INFO: task hdparm:2052842 blocked for more than 483 seconds.
May 15 01:36:46 kernel: [302561.316237] INFO: task hdparm:2052842 blocked for more than 604 seconds.
May 15 02:06:58 kernel: [304373.770194] INFO: task smartd:2719 blocked for more than 120 seconds.

From one of the logged events:

May 15 02:06:58 kernel: [304373.770194] INFO: task smartd:2719 blocked for more than 120 seconds.
May 15 02:06:58 kernel: [304373.770209] Tainted: G O 5.15.0-72-generic #79~20.04.1-Ubuntu
May 15 02:06:58 kernel: [304373.770215] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
May 15 02:06:58 kernel: [304373.770218] task:smartd state:D stack: 0 pid: 2719 ppid: 1 flags:0x00000000
May 15 02:06:58 kernel: [304373.770226] Call Trace:
May 15 02:06:58 kernel: [304373.770230] <TASK>
May 15 02:06:58 kernel: [304373.770236] __schedule+0x2cd/0x890
May 15 02:06:58 kernel: [304373.770251] schedule+0x69/0x110
May 15 02:06:58 kernel: [304373.770260] schedule_preempt_disabled+0xe/0x20
May 15 02:06:58 kernel: [304373.770269] __mutex_lock.isra.0+0x20c/0x470
May 15 02:06:58 kernel: [304373.770276] ? iput.part.0+0x61/0x1e0
May 15 02:06:58 kernel: [304373.770287] __mutex_lock_slowpath+0x13/0x20
May 15 02:06:58 kernel: [304373.770294] mutex_lock+0x36/0x40
May 15 02:06:58 kernel: [304373.770299] blkdev_get_by_dev+0x11d/0x2d0
May 15 02:06:58 kernel: [304373.770309] ? blkdev_close+0x30/0x30
May 15 02:06:58 kernel: [304373.770318] blkdev_open+0x50/0x90
May 15 02:06:58 kernel: [304373.770325] do_dentry_open+0x169/0x3e0
May 15 02:06:58 kernel: [304373.770336] vfs_open+0x2d/0x40
May 15 02:06:58 kernel: [304373.770342] do_open.isra.0+0x20d/0x480
May 15 02:06:58 kernel: [304373.770351] path_openat+0x18e/0xe50
May 15 02:06:58 kernel: [304373.770361] ? put_device+0x13/0x20
May 15 02:06:58 kernel: [304373.770371] ? scsi_device_put+0x31/0x40
May 15 02:06:58 kernel: [304373.770380] ? sd_release+0x3b/0xb0
May 15 02:06:58 kernel: [304373.770388] do_filp_open+0xb2/0x120
May 15 02:06:58 kernel: [304373.770398] ? __check_object_size+0x14f/0x160
May 15 02:06:58 kernel: [304373.770408] do_sys_openat2+0x249/0x330
May 15 02:06:58 kernel: [304373.770418] do_sys_open+0x46/0x80
May 15 02:06:58 kernel: [304373.770424] __x64_sys_openat+0x20/0x30
May 15 02:06:58 kernel: [304373.770430] do_syscall_64+0x5c/0xc0
May 15 02:06:58 kernel: [304373.770440] ? do_syscall_64+0x69/0xc0
May 15 02:06:58 kernel: [304373.770448] entry_SYSCALL_64_after_hwframe+0x61/0xcb
May 15 02:06:58 kernel: [304373.770458] RIP: 0033:0x7f9b0d188d3b
May 15 02:06:58 kernel: [304373.770465] RSP: 002b:00007ffd72a3caf0 EFLAGS: 00000246 ORIG_RAX: 0000000000000101
May 15 02:06:58 kernel: [304373.770473] RAX: ffffffffffffffda RBX: 000055f1346783c0 RCX: 00007f9b0d188d3b
May 15 02:06:58 kernel: [304373.770479] RDX: 0000000000000800 RSI: 000055f1346783f8 RDI: 00000000ffffff9c
May 15 02:06:58 kernel: [304373.770484] RBP: 000055f1346783f8 R08: 0000000000000001 R09: 0000000000000000
May 15 02:06:58 kernel: [304373.770488] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000800
May 15 02:06:58 kernel: [304373.770493] R13: 0000000000000000 R14: 000055f1334c26a4 R15: 00007f9b0cd17250
May 15 02:06:58 kernel: [304373.770500] </TASK>