My statement that the problem is gone was premature. It just occured again.
Here is my complete dmesg output:
http://hastebin.com/etuvayezaq.vbsThe problems begin on line 479.
Here is an excerpt:
$this->bbcode_second_pass_code('', '[ 1297.376927] usb 1-1: timeout: still 3 active urbs on EP #1
[ 4434.131508] usb 1-1: timeout: still 3 active urbs on EP #1
[ 4435.131614] usb 1-1: timeout: still 3 active urbs on EP #1
[ 4438.141956] xhci_hcd 0000:00:01.0: xHCI host not responding to stop endpoint command.
[ 4438.149764] xhci_hcd 0000:00:01.0: Assuming host is dying, halting host.
[ 4438.156577] xhci_hcd 0000:00:01.0: HC died; cleaning up
[ 4438.161860] usb 1-1: USB disconnect, device number 2
[ 4438.169002] usb 2-2: USB disconnect, device number 2
[ 4438.175852] usb 2-2.1: USB disconnect, device number 3
[ 4438.181043] usb 2-2.1.1: USB disconnect, device number 7
[ 4438.372051] sd 3:0:0:0: [sdc] UNKNOWN Result: hostbyte=0x07 driverbyte=0x00
[ 4438.379002] sd 3:0:0:0: [sdc] CDB:
[ 4438.382513] cdb[0]=0x28: 28 00 17 38 28 22 00 00 01 00
[ 4438.387751] blk_update_request: I/O error, dev sdc, sector 3116450064
[ 4438.396372] EXT4-fs error (device sdc1): ext4_find_entry:1289: inode #97386500: comm nfsd: reading directory lblock 0
[ 4438.492075] sd 3:0:0:0: [sdc] UNKNOWN Result: hostbyte=0x07 driverbyte=0x00
[ 4438.499062] sd 3:0:0:0: [sdc] CDB:
[ 4438.502566] cdb[0]=0x2a: 2a 00 00 00 08 00 00 00 01 00
[ 4438.507812] blk_update_request: I/O error, dev sdc, sector 16384
[ 4438.513836] Buffer I/O error on dev sdc1, logical block 0, lost sync page write
[ 4438.622079] sd 3:0:0:0: [sdc] UNKNOWN Result: hostbyte=0x07 driverbyte=0x00
[ 4438.629024] sd 3:0:0:0: [sdc] CDB:
[ 4438.632529] cdb[0]=0x28: 28 00 17 38 28 22 00 00 01 00
[ 4438.637749] blk_update_request: I/O error, dev sdc, sector 3116450064
[ 4438.644232] EXT4-fs error (device sdc1): ext4_find_entry:1289: inode #97386500: comm nfsd: reading directory lblock 0
[ 4438.654839] EXT4-fs (sdc1): previous I/O error to superblock detected
[ 4438.742110] sd 3:0:0:0: [sdc] UNKNOWN Result: hostbyte=0x07 driverbyte=0x00
[ 4438.749086] sd 3:0:0:0: [sdc] CDB:
[ 4438.752588] cdb[0]=0x2a: 2a 00 00 00 08 00 00 00 01 00
[ 4438.757844] blk_update_request: I/O error, dev sdc, sector 16384
[ 4438.763871] Buffer I/O error on dev sdc1, logical block 0, lost sync page write
[ 4438.872106] sd 3:0:0:0: [sdc] UNKNOWN Result: hostbyte=0x07 driverbyte=0x00
[ 4438.879051] sd 3:0:0:0: [sdc] CDB:
[ 4438.882555] cdb[0]=0x28: 28 00 17 38 28 22 00 00 01 00
[ 4438.887782] blk_update_request: I/O error, dev sdc, sector 3116450064
[ 4438.894267] EXT4-fs error (device sdc1): ext4_find_entry:1289: inode #97386500: comm nfsd: reading directory lblock 0
[ 4438.904948] EXT4-fs (sdc1): previous I/O error to superblock detected
[ 4438.992134] sd 3:0:0:0: [sdc] UNKNOWN Result: hostbyte=0x07 driverbyte=0x00
[ 4438.999088] sd 3:0:0:0: [sdc] CDB:
[ 4439.002586] cdb[0]=0x2a: 2a 00 00 00 08 00 00 00 01 00
[ 4439.007842] blk_update_request: I/O error, dev sdc, sector 16384
[ 4439.013870] Buffer I/O error on dev sdc1, logical block 0, lost sync page write
[ 4439.122178] sd 3:0:0:0: [sdc] UNKNOWN Result: hostbyte=0x07 driverbyte=0x00
[ 4439.129177] sd 3:0:0:0: [sdc] CDB:
[ 4439.132681] cdb[0]=0x28: 28 00 17 38 28 22 00 00 01 00
[ 4439.137919] blk_update_request: I/O error, dev sdc, sector 3116450064
[ 4439.144436] EXT4-fs error (device sdc1): ext4_find_entry:1289: inode #97386500: comm nfsd: reading directory lblock 0
[ 4439.155085] EXT4-fs (sdc1): previous I/O error to superblock detected
[ 4439.242152] sd 3:0:0:0: [sdc] UNKNOWN Result: hostbyte=0x07 driverbyte=0x00
[ 4439.249102] sd 3:0:0:0: [sdc] CDB:
[ 4439.252608] cdb[0]=0x2a: 2a 00 00 00 08 00 00 00 01 00
[ 4439.257832] blk_update_request: I/O error, dev sdc, sector 16384
[ 4439.263843] Buffer I/O error on dev sdc1, logical block 0, lost sync page write
[ 4449.033315] sd 3:0:0:0: [sdc] UNKNOWN Result: hostbyte=0x07 driverbyte=0x00
[ 4449.040260] sd 3:0:0:0: [sdc] CDB:
[ 4449.043774] cdb[0]=0x28: 28 00 18 40 08 20 00 00 01 00
[ 4449.049010] blk_update_request: I/O error, dev sdc, sector 3254796544
[ 4449.055797] EXT4-fs error (device sdc1): __ext4_get_inode_loc:3769: inode #101711875: block 406847520: comm nfsd: unable to read itable block
[ 4449.073335] EXT4-fs (sdc1): previous I/O error to superblock detected
[ 4449.153315] sd 3:0:0:0: [sdc] UNKNOWN Result: hostbyte=0x07 driverbyte=0x00
[ 4449.160260] sd 3:0:0:0: [sdc] CDB:
[ 4449.163764] cdb[0]=0x2a: 2a 00 00 00 08 00 00 00 01 00
[ 4449.168983] blk_update_request: I/O error, dev sdc, sector 16384
[ 4449.174996] Buffer I/O error on dev sdc1, logical block 0, lost sync page write
[ 4449.273441] sd 3:0:0:0: [sdc] UNKNOWN Result: hostbyte=0x07 driverbyte=0x00
[ 4449.280412] sd 3:0:0:0: [sdc] CDB:
[ 4449.283928] cdb[0]=0x28: 28 00 18 40 08 20 00 00 01 00
[ 4449.289158] blk_update_request: I/O error, dev sdc, sector 3254796544
[ 4449.302312] EXT4-fs error (device sdc1): __ext4_get_inode_loc:3769: inode #101711874: block 406847520: comm nfsd: unable to read itable block
[ 4449.315331] EXT4-fs (sdc1): previous I/O error to superblock detected
[ 4449.403373] sd 3:0:0:0: [sdc] UNKNOWN Result: hostbyte=0x07 driverbyte=0x00
[ 4449.410347] sd 3:0:0:0: [sdc] CDB:
[ 4449.413848] cdb[0]=0x2a: 2a 00 00 00 08 00 00 00 01 00
[ 4449.419094] blk_update_request: I/O error, dev sdc, sector 16384
[ 4449.425122] Buffer I/O error on dev sdc1, logical block 0, lost sync page write
[ 4449.533377] sd 3:0:0:0: [sdc] UNKNOWN Result: hostbyte=0x07 driverbyte=0x00
[ 4449.540326] sd 3:0:0:0: [sdc] CDB:
[ 4449.543839] cdb[0]=0x28: 28 00 18 40 08 20 00 00 01 00
[ 4449.549075] blk_update_request: I/O error, dev sdc, sector 3254796544
[ 4449.562304] EXT4-fs error (device sdc1): __ext4_get_inode_loc:3769: inode #101711875: block 406847520: comm nfsd: unable to read itable block
[ 4449.575274] EXT4-fs (sdc1): previous I/O error to superblock detected
[ 4449.653425] sd 3:0:0:0: [sdc] UNKNOWN Result: hostbyte=0x07 driverbyte=0x00
[ 4449.660400] sd 3:0:0:0: [sdc] CDB:
[ 4449.663913] cdb[0]=0x2a: 2a 00 00 00 08 00 00 00 01 00
[ 4449.669136] blk_update_request: I/O error, dev sdc, sector 16384
[ 4449.675152] Buffer I/O error on dev sdc1, logical block 0, lost sync page write
[ 4449.783386] sd 3:0:0:0: [sdc] UNKNOWN Result: hostbyte=0x07 driverbyte=0x00
[ 4449.790340] sd 3:0:0:0: [sdc] CDB:
[ 4449.793853] cdb[0]=0x28: 28 00 18 40 08 20 00 00 01 00
[ 4449.799073] blk_update_request: I/O error, dev sdc, sector 3254796544
[ 4449.812267] EXT4-fs error (device sdc1): __ext4_get_inode_loc:3769: inode #101711874: block 406847520: comm nfsd: unable to read itable block
[ 4449.825253] EXT4-fs (sdc1): previous I/O error to superblock detected
[ 4449.913403] sd 3:0:0:0: [sdc] UNKNOWN Result: hostbyte=0x07 driverbyte=0x00
[ 4449.920349] sd 3:0:0:0: [sdc] CDB:
[ 4449.923852] cdb[0]=0x2a: 2a 00 00 00 08 00 00 00 01 00
[ 4449.929079] blk_update_request: I/O error, dev sdc, sector 16384
[ 4449.935115] Buffer I/O error on dev sdc1, logical block 0, lost sync page write
[ 4450.033744] sd 3:0:0:0: [sdc] UNKNOWN Result: hostbyte=0x07 driverbyte=0x00
[ 4450.040715] sd 3:0:0:0: [sdc] CDB:
[ 4450.044239] cdb[0]=0x28: 28 00 18 40 08 20 00 00 01 00
[ 4450.049462] blk_update_request: I/O error, dev sdc, sector 3254796544
[ 4450.062830] EXT4-fs error (device sdc1): __ext4_get_inode_loc:3769: inode #101711875: block 406847520: comm nfsd: unable to read itable block
[ 4450.077809] EXT4-fs (sdc1): previous I/O error to superblock detected
[ 4450.173442] sd 3:0:0:0: [sdc] UNKNOWN Result: hostbyte=0x07 driverbyte=0x00
[ 4450.180414] sd 3:0:0:0: [sdc] CDB:
[ 4450.183911] cdb[0]=0x2a: 2a 00 00 00 08 00 00 00 01 00
[ 4450.189152] blk_update_request: I/O error, dev sdc, sector 16384
[ 4450.195177] Buffer I/O error on dev sdc1, logical block 0, lost sync page write
[ 4450.293510] EXT4-fs error (device sdc1): __ext4_get_inode_loc:3769: inode #101711874: block 406847520: comm nfsd: unable to read itable block
[ 4450.306220] EXT4-fs (sdc1): previous I/O error to superblock detected
[ 4450.393452] Buffer I/O error on dev sdc1, logical block 0, lost sync page write
[ 4450.493608] EXT4-fs error (device sdc1): __ext4_get_inode_loc:3769: inode #101711875: block 406847520: comm nfsd: unable to read itable block
[ 4450.506328] EXT4-fs (sdc1): previous I/O error to superblock detected
[ 4450.593476] Buffer I/O error on dev sdc1, logical block 0, lost sync page write
[ 4450.693536] EXT4-fs error (device sdc1): __ext4_get_inode_loc:3769: inode #101711875: block 406847520: comm nfsd: unable to read itable block
[ 4450.706230] EXT4-fs (sdc1): previous I/O error to superblock detected
[ 4450.793518] Buffer I/O error on dev sdc1, logical block 0, lost sync page write
[ 4450.893558] EXT4-fs error (device sdc1): __ext4_get_inode_loc:3769: inode #101711875: block 406847520: comm nfsd: unable to read itable block
[ 4450.906253] EXT4-fs (sdc1): previous I/O error to superblock detected
[ 4450.993556] Buffer I/O error on dev sdc1, logical block 0, lost sync page write
[ 4451.093579] EXT4-fs error (device sdc1): __ext4_get_inode_loc:3769: inode #101711875: block 406847520: comm nfsd: unable to read itable block
[ 4451.106275] EXT4-fs (sdc1): previous I/O error to superblock detected
[ 4451.193550] Buffer I/O error on dev sdc1, logical block 0, lost sync page write
[ 4455.174011] scsi_io_completion: 18 callbacks suppressed
[ 4455.179240] sd 3:0:0:0: [sdc] UNKNOWN Result: hostbyte=0x07 driverbyte=0x00
[ 4455.186212] sd 3:0:0:0: [sdc] CDB:
[ 4455.189686] cdb[0]=0x28: 28 00 18 40 08 20 00 00 01 00
[ 4455.194932] blk_update_request: 18 callbacks suppressed
[ 4455.200134] blk_update_request: I/O error, dev sdc, sector 3254796544
[ 4455.214032] EXT4-fs error: 4 callbacks suppressed
[ 4455.218737] EXT4-fs error (device sdc1): __ext4_get_inode_loc:3769: inode #101711874: block 406847520: comm nfsd: unable to read itable block
[ 4455.231477] EXT4-fs: 4 callbacks suppressed
[ 4455.235702] EXT4-fs (sdc1): previous I/O error to superblock detected
[ 4455.334054] sd 3:0:0:0: [sdc] UNKNOWN Result: hostbyte=0x07 driverbyte=0x00
[ 4455.340998] sd 3:0:0:0: [sdc] CDB:
[ 4455.344512] cdb[0]=0x2a: 2a 00 00 00 08 00 00 00 01 00
[ 4455.349754] blk_update_request: I/O error, dev sdc, sector 16384
[ 4455.355765] buffer_io_error: 4 callbacks suppressed
[ 4455.360623] Buffer I/O error on dev sdc1, logical block 0, lost sync page write
[ 4459.524525] sd 3:0:0:0: [sdc] UNKNOWN Result: hostbyte=0x07 driverbyte=0x00
[...]
[ 4805.051382] cdb[0]=0x2a: 2a 00 00 00 08 00 00 00 01 00
[ 4805.056623] blk_update_request: I/O error, dev sdc, sector 16384
[ 4805.062644] Buffer I/O error on dev sdc1, logical block 0, lost sync page write
[ 4813.421719] INFO: task output:Wohnzimm:630 blocked for more than 120 seconds.
[ 4813.428926] Tainted: G O 3.19.0-1-ARCH #1
[ 4813.437530] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 4813.446827] output:Wohnzimm D c056e85c 0 630 1 0x00000000
[ 4813.454692] [<c056e85c>] (__schedule) from [<c057179c>] (schedule_timeout+0x1d0/0x270)
[ 4813.464033] [<c057179c>] (schedule_timeout) from [<c056f7f8>] (wait_for_common+0x8c/0x1bc)
[ 4813.473685] [<c056f7f8>] (wait_for_common) from [<c0433138>] (xhci_configure_endpoint+0xcc/0x68c)
[ 4813.483921] [<c0433138>] (xhci_configure_endpoint) from [<c0433dc0>] (xhci_check_bandwidth+0x164/0x2c0)
[ 4813.496018] [<c0433dc0>] (xhci_check_bandwidth) from [<c0414748>] (usb_hcd_alloc_bandwidth+0x28c/0x308)
[ 4813.507268] [<c0414748>] (usb_hcd_alloc_bandwidth) from [<c04173f8>] (usb_set_interface+0xb4/0x318)
[ 4813.520271] [<c04173f8>] (usb_set_interface) from [<bf225478>] (snd_usb_pcm_close.isra.14+0x4c/0x78 [snd_usb_audio])
[ 4813.533183] [<bf225478>] (snd_usb_pcm_close.isra.14 [snd_usb_audio]) from [<bf1d0190>] (snd_pcm_release_substream.part.37+0x40/0x94 [snd_pcm])
[ 4813.546149] [<bf1d0190>] (snd_pcm_release_substream.part.37 [snd_pcm]) from [<bf1d0284>] (snd_pcm_release+0x88/0x94 [snd_pcm])
[ 4813.560707] [<bf1d0284>] (snd_pcm_release [snd_pcm]) from [<c0114d18>] (__fput+0x80/0x204)
[ 4813.570530] [<c0114d18>] (__fput) from [<c0034b24>] (task_work_run+0x9c/0xb4)
[ 4813.579417] [<c0034b24>] (task_work_run) from [<c000bf9c>] (do_work_pending+0x98/0xc0)
[ 4813.589067] [<c000bf9c>] (do_work_pending) from [<c00095e0>] (work_pending+0xc/0x20)
[ 4813.598494] INFO: task kworker/0:3:2207 blocked for more than 120 seconds.
[ 4813.607008] Tainted: G O 3.19.0-1-ARCH #1
[ 4813.614252] sd 7:0:0:0: [sdg] UNKNOWN Result: hostbyte=0x07 driverbyte=0x00
[ 4813.621228] sd 7:0:0:0: [sdg] CDB:
[ 4813.624736] cdb[0]=0x28: 28 00 2b aa 12 f0 00 00 01 00
[ 4813.629984] blk_update_request: I/O error, dev sdg, sector 5860530048
[ 4813.639623] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 4813.655198] kworker/0:3 D c056e85c 0 2207 2 0x00000000
[ 4813.662150] Workqueue: usb_hub_wq hub_event
[ 4813.666461] [<c056e85c>] (__schedule) from [<c056f00c>] (schedule_preempt_disabled+0x14/0x20)
[ 4813.679283] [<c056f00c>] (schedule_preempt_disabled) from [<c057077c>] (__mutex_lock_slowpath+0x74/0x16c)
[ 4813.690586] [<c057077c>] (__mutex_lock_slowpath) from [<c040c48c>] (usb_unlocked_disable_lpm+0x1c/0x40)
[ 4813.701638] [<c040c48c>] (usb_unlocked_disable_lpm) from [<c04195d8>] (usb_unbind_interface+0x3c/0x280)
[ 4813.712773] [<c04195d8>] (usb_unbind_interface) from [<c036d1d8>] (__device_release_driver+0x70/0xc8)
[ 4813.722211] [<c036d1d8>] (__device_release_driver) from [<c036d24c>] (device_release_driver+0x1c/0x28)
[ 4813.731573] [<c036d24c>] (device_release_driver) from [<c036ccd0>] (bus_remove_device+0xd8/0x10c)
[ 4813.741932] sd 7:0:0:0: [sdg] UNKNOWN Result: hostbyte=0x07 driverbyte=0x00
[ 4813.748899] sd 7:0:0:0: [sdg] CDB:
[ 4813.752403] cdb[0]=0x28: 28 00 2b aa 12 f0 00 00 01 00
[ 4813.757649] blk_update_request: I/O error, dev sdg, sector 5860530048
[ 4813.764095] Buffer I/O error on dev sdg1, logical block 732566000, async page read
[ 4813.781851] [<c036ccd0>] (bus_remove_device) from [<c0369f24>] (device_del+0x108/0x210)
[ 4813.789850] [<c0369f24>] (device_del) from [<c0417144>] (usb_disable_device+0xa0/0x1e4)
[ 4813.803662] [<c0417144>] (usb_disable_device) from [<c040e6bc>] (usb_disconnect+0x64/0x254)
[ 4813.812180] [<c040e6bc>] (usb_disconnect) from [<c040e904>] (hub_quiesce+0x58/0xa8)
[ 4813.819914] [<c040e904>] (hub_quiesce) from [<c040fdec>] (hub_event+0x368/0x1100)
[ 4813.831794] [<c040fdec>] (hub_event) from [<c00316c0>] (process_one_work+0x130/0x490)
[ 4813.841129] [<c00316c0>] (process_one_work) from [<c0032304>] (worker_thread+0x3c/0x518)
[ 4813.851017] [<c0032304>] (worker_thread) from [<c00362c4>] (kthread+0xc0/0xdc)
[ 4813.859890] [<c00362c4>] (kthread) from [<c0009638>] (ret_from_fork+0x14/0x3c)
[ 4813.868885] INFO: task kworker/0:0:2261 blocked for more than 120 seconds.
[ 4813.877426] Tainted: G O 3.19.0-1-ARCH #1
[ 4813.884669] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 4813.893991] kworker/0:0 D c056e85c 0 2261 2 0x00000000
[ 4813.900605] Workqueue: usb_hub_wq hub_event
[ 4813.906469] [<c056e85c>] (__schedule) from [<c056f00c>] (schedule_preempt_disabled+0x14/0x20)
[ 4813.918001] [<c056f00c>] (schedule_preempt_disabled) from [<c057077c>] (__mutex_lock_slowpath+0x74/0x16c)
[ 4813.929254] [<c057077c>] (__mutex_lock_slowpath) from [<c040c48c>] (usb_unlocked_disable_lpm+0x1c/0x40)
[ 4813.940227] [<c040c48c>] (usb_unlocked_disable_lpm) from [<c04195d8>] (usb_unbind_interface+0x3c/0x280)
[ 4813.951539] [<c04195d8>] (usb_unbind_interface) from [<c036d1d8>] (__device_release_driver+0x70/0xc8)
[ 4813.962344] [<c036d1d8>] (__device_release_driver) from [<c036d24c>] (device_release_driver+0x1c/0x28)
[ 4813.973282] [<c036d24c>] (device_release_driver) from [<c036ccd0>] (bus_remove_device+0xd8/0x10c)
[ 4813.982273] [<c036ccd0>] (bus_remove_device) from [<c0369f24>] (device_del+0x108/0x210)
[ 4813.990320] [<c0369f24>] (device_del) from [<c0417144>] (usb_disable_device+0xa0/0x1e4)
[ 4814.001883] [<c0417144>] (usb_disable_device) from [<c040e6bc>] (usb_disconnect+0x64/0x254)
[ 4814.013094] [<c040e6bc>] (usb_disconnect) from [<c040e824>] (usb_disconnect+0x1cc/0x254)
[...]
')
Thanks in advance,
Jan