Bug#861104: linux-image-4.9.0-2-amd64: Kernel deadlock with CIFS mounts

2017-04-25 Thread Richard Braun
The problem is still present in linux-image-4.10.0-rc6-amd64-unsigned.

-- 
Richard Braun



Bug#861104: linux-image-4.9.0-2-amd64: Kernel deadlock with CIFS mounts

2017-04-24 Thread Richard Braun
Package: src:linux
Version: 4.9.18-1
Severity: important

Hello,

Please find a dmesg trace showing an apparent deadlock in the CIFS code
of the kernel. This didn't happen with versions before 4.9 (e.g. with
the jessie kernel or the 4.8 kernels backported for jessie).

This results in loss of work and a forced reboot, and may happen at any
time, sometimes very soon after mounting.

Thanks.

-- Package-specific info:
** Version:
Linux version 4.9.0-2-amd64 (debian-ker...@lists.debian.org) (gcc version 6.3.0 
20170321 (Debian 6.3.0-11) ) #1 SMP Debian 4.9.18-1 (2017-03-30)

** Command line:
BOOT_IMAGE=/boot/vmlinuz-4.9.0-2-amd64 
root=UUID=36b24c2a-d9da-41a2-9191-e1e35e6e73ac ro elevator=deadline 
hugepagesz=1GB hugepages=4 quiet

** Not tainted

** Kernel log:
[ 7975.857963]  [] ? strncpy_from_user+0x48/0x160
[ 7975.857969]  [] ? cifs_getattr+0x4f/0x110 [cifs]
[ 7975.857970]  [] ? vfs_fstatat+0x6a/0xb0
[ 7975.857971]  [] ? SYSC_newstat+0x2a/0x60
[ 7975.857972]  [] ? task_work_run+0x7e/0xa0
[ 7975.857973]  [] ? exit_to_usermode_loop+0x8c/0xb0
[ 7975.857974]  [] ? system_call_fast_compare_end+0xc/0x9b
[ 7975.857975] INFO: task df:4026 blocked for more than 120 seconds.
[ 7975.857976]   Not tainted 4.9.0-2-amd64 #1
[ 7975.857976] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this 
message.
[ 7975.857977] df  D0  4026   4019 0x0004
[ 7975.857978]  8be248c70800  8be08de19040 
8be25dd981c0
[ 7975.857979]  8be24b207080 b7b348f03a88 98df6403 
0001
[ 7975.857980]  00ff8be25dffbb80 8be25dd981c0 0001 
8be08de19040
[ 7975.857981] Call Trace:
[ 7975.857982]  [] ? __schedule+0x233/0x6d0
[ 7975.857984]  [] ? schedule+0x32/0x80
[ 7975.857985]  [] ? schedule_preempt_disabled+0xa/0x10
[ 7975.857986]  [] ? __mutex_lock_slowpath+0xb4/0x130
[ 7975.857986]  [] ? mutex_lock+0x1b/0x30
[ 7975.857991]  [] ? cifs_reconnect_tcon+0x8f/0x320 [cifs]
[ 7975.857992]  [] ? __wake_up+0x34/0x50
[ 7975.857997]  [] ? smb_init+0x27/0x80 [cifs]
[ 7975.858002]  [] ? CIFSSMBQPathInfo+0x66/0x310 [cifs]
[ 7975.858005]  [] ? dput+0x38/0x250
[ 7975.858011]  [] ? cifs_query_path_info+0x6c/0x180 [cifs]
[ 7975.858013]  [] ? lookup_fast+0x52/0x2e0
[ 7975.858013]  [] ? lookup_fast+0xd8/0x2e0
[ 7975.858020]  [] ? cifs_get_inode_info+0x402/0x920 [cifs]
[ 7975.858026]  [] ? build_path_from_dentry+0xeb/0x3f0 [cifs]
[ 7975.858032]  [] ? cifs_revalidate_dentry_attr+0x1d3/0x250 
[cifs]
[ 7975.858033]  [] ? strncpy_from_user+0x48/0x160
[ 7975.858039]  [] ? cifs_getattr+0x4f/0x110 [cifs]
[ 7975.858039]  [] ? vfs_fstatat+0x6a/0xb0
[ 7975.858040]  [] ? SYSC_newstat+0x2a/0x60
[ 7975.858041]  [] ? system_call_fast_compare_end+0xc/0x9b
[ 8096.688928] INFO: task kworker/u8:1:3692 blocked for more than 120 seconds.
[ 8096.688931]   Not tainted 4.9.0-2-amd64 #1
[ 8096.688931] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this 
message.
[ 8096.688932] kworker/u8:1D0  3692  2 0x
[ 8096.688937] Workqueue: writeback wb_workfn (flush-cifs-1)
[ 8096.688938]  8be249867400  8be08de95040 
8be25dd981c0
[ 8096.688939]  8be24b207080 b7b348a7b928 98df6403 

[ 8096.688956]  00040002 8be25dd981c0 8be08de95040 
8be08de95040
[ 8096.688958] Call Trace:
[ 8096.688960]  [] ? __schedule+0x233/0x6d0
[ 8096.688962]  [] ? schedule+0x32/0x80
[ 8096.688963]  [] ? schedule_preempt_disabled+0xa/0x10
[ 8096.688964]  [] ? __mutex_lock_slowpath+0xb4/0x130
[ 8096.688966]  [] ? mutex_lock+0x1b/0x30
[ 8096.688973]  [] ? cifs_reconnect_tcon+0x8f/0x320 [cifs]
[ 8096.688978]  [] ? small_smb_init+0x22/0x70 [cifs]
[ 8096.688983]  [] ? cifs_readv_callback+0x200/0x200 [cifs]
[ 8096.688988]  [] ? cifs_async_writev+0xa1/0x2f0 [cifs]
[ 8096.688994]  [] ? cifs_writepages+0x492/0x920 [cifs]
[ 8096.688995]  [] ? __writeback_single_inode+0x3d/0x310
[ 8096.688996]  [] ? writeback_sb_inodes+0x221/0x4f0
[ 8096.688997]  [] ? __writeback_inodes_wb+0x87/0xb0
[ 8096.688998]  [] ? wb_writeback+0x278/0x310
[ 8096.688999]  [] ? wb_workfn+0x208/0x3d0
[ 8096.689000]  [] ? process_one_work+0x184/0x410
[ 8096.689001]  [] ? worker_thread+0x4d/0x480
[ 8096.689002]  [] ? process_one_work+0x410/0x410
[ 8096.689003]  [] ? kthread+0xce/0xf0
[ 8096.689004]  [] ? __switch_to+0x2c1/0x6c0
[ 8096.689005]  [] ? kthread_park+0x60/0x60
[ 8096.689006]  [] ? ret_from_fork+0x25/0x30
[ 8096.689007] INFO: task bash:4007 blocked for more than 120 seconds.
[ 8096.689008]   Not tainted 4.9.0-2-amd64 #1
[ 8096.689009] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this 
message.
[ 8096.689009] bashD0  4007   3997 0x
[ 8096.689010]  8be0c9a96400  8be08ddb5040 
8be25dc181c0
[ 8096.689011]  9940e500 b7b348eb7a88 98df6403 

[ 8096.689013]  00ff98b47179 8be25dc181c0 989832a6 
8be08ddb5040
[ 8096.689014] Call