Bug#523709: Plasma/Dolphin hangs on mousehover over a file in Dolphin browser
Package: dolphin
Severity: important
How to reproduce:
1. Login to KDE
2. Open File Browser (Dolphin)
3. Hover/click once on a file
4. Dolphin and KDE panel stops responding
I upgraded to KDE 4.2.2 earlier this week (I think 7th of April) and have noticed that Dolphin/Plasma hangs when I open the file browser and hover over a file (or sometimes if I click on the file once). After that, I can continue to use Konsole and Iceweasel but neither of the file browser or the KDE panel works.
I have tried to remove my ~/.kde and other temporary files from /tmp hoping it was some configuration/file remaining from KDE3.5 but I can always reproduce the behaviour. If I quit KDE when dolphin/plasma hangs (Ctrl+Alt+Backspace), and go to a tty1, I cannot delete my ~/.kde folder. The command just hangs out there (can't kill or Ctrl+C doesn't work either).
During this both the dolphin and plasma processes are in "D" state according to ps uax and hence cannot be killed.
Temporary way out for this is to restart and try not to use dolphin. However, this behaviour renders KDE unusable as a user might forget to not to use Dolphin.
This is similar to behaviour described in:
https://bugs.launchpad.net/kdebase/+bug/261106
https://bugs.kde.org/show_bug.cgi?id=167885
Below are a few lines form /var/log/syslog
----------------------
Apr 11 19:10:01 gurh /USR/SBIN/CRON[26118]: (root) CMD (if [ -x /usr/bin/vnstat ] && [ `ls /var/lib/vnstat/ | wc -l` -ge 1 ]; then /usr/bin/vnstat -u; fi)
Apr 11 19:10:01 gurh /USR/SBIN/CRON[26119]: (root) CMD (/usr/share/vzctl/scripts/vpsreboot)
Apr 11 19:10:01 gurh /USR/SBIN/CRON[26120]: (root) CMD (/usr/share/vzctl/scripts/vpsnetclean)
Apr 11 19:15:01 gurh /USR/SBIN/CRON[26439]: (root) CMD (if [ -x /usr/bin/vnstat ] && [ `ls /var/lib/vnstat/ | wc -l` -ge 1 ]; then /usr/bin/vnstat -u; fi)
Apr 11 19:15:01 gurh /USR/SBIN/CRON[26440]: (root) CMD (/usr/share/vzctl/scripts/vpsreboot)
Apr 11 19:15:01 gurh /USR/SBIN/CRON[26441]: (root) CMD (/usr/share/vzctl/scripts/vpsnetclean)
Apr 11 19:15:02 gurh kernel: [14969.036364] INFO: task plasma:5374 blocked for more than 120 seconds.
Apr 11 19:15:02 gurh kernel: [14969.036369] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Apr 11 19:15:02 gurh kernel: [14969.036373] plasma D f5920bd0 0 5374 1
Apr 11 19:15:02 gurh kernel: [14969.036376] f5920bd0 00000086 c013e9f4 00a91654 f481fde4 f5920d5c c2212fa0 00000000
Apr 11 19:15:02 gurh kernel: [14969.036383] d0db97be 0000168f 00000000 f490fe24 f5d03f44 0000010b 00000000 00000000
Apr 11 19:15:02 gurh kernel: [14969.036389] 00000000 ffffffff f4cad310 f4cad318 f4cad314 f5920bd0 c02c414c f4cad318
Apr 11 19:15:02 gurh kernel: [14969.036395] Call Trace:
Apr 11 19:15:02 gurh kernel: [14969.036409] [<c013e9f4>] getnstimeofday+0x37/0xbc
Apr 11 19:15:02 gurh kernel: [14969.036427] [<c02c414c>] __mutex_lock_slowpath+0x50/0x7b
Apr 11 19:15:02 gurh kernel: [14969.036436] [<c02c3fe2>] mutex_lock+0xa/0xb
Apr 11 19:15:02 gurh kernel: [14969.036439] [<c018a8b5>] do_lookup+0x88/0x16f
Apr 11 19:15:02 gurh kernel: [14969.036449] [<c018c546>] __link_path_walk+0x7e4/0xbc6
Apr 11 19:15:02 gurh kernel: [14969.036458] [<c018a892>] do_lookup+0x65/0x16f
Apr 11 19:15:02 gurh kernel: [14969.036464] [<c01dddde>] idr_get_empty_slot+0x11e/0x1ef
Apr 11 19:15:02 gurh kernel: [14969.036474] [<c018c95f>] path_walk+0x37/0x70
Apr 11 19:15:02 gurh kernel: [14969.036482] [<c018cc0e>] do_path_lookup+0x122/0x184
Apr 11 19:15:02 gurh kernel: [14969.036490] [<c018d46b>] __user_walk_fd+0x29/0x3a
Apr 11 19:15:02 gurh kernel: [14969.036497] [<c018738a>] vfs_stat_fd+0x15/0x3c
Apr 11 19:15:02 gurh kernel: [14969.036510] [<c01977dd>] mntput_no_expire+0x13/0xd2
Apr 11 19:15:02 gurh kernel: [14969.036517] [<c01a98c0>] sys_inotify_add_watch+0xcb/0xd7
Apr 11 19:15:02 gurh kernel: [14969.036524] [<c0187466>] sys_stat64+0xf/0x23
Apr 11 19:15:02 gurh kernel: [14969.036531] [<c0185f58>] deactivate_super+0x15/0x60
Apr 11 19:15:02 gurh kernel: [14969.036537] [<c01a8d34>] inotify_rm_wd+0x91/0x9a
Apr 11 19:15:02 gurh kernel: [14969.036547] [<c0108972>] syscall_call+0x7/0xb
Apr 11 19:15:02 gurh kernel: [14969.037741] =======================
Apr 11 19:15:02 gurh kernel: [14969.037745] INFO: task krunner:5402 blocked for more than 120 seconds.
Apr 11 19:15:02 gurh kernel: [14969.037748] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Apr 11 19:15:02 gurh kernel: [14969.037751] krunner D f592f550 0 5402 1
Apr 11 19:15:02 gurh kernel: [14969.037755] f592f550 00000086 00000c2b f592f6dc c221dfa0 f592f6dc c221dfa0 00000001
Apr 11 19:15:02 gurh kernel: [14969.037761] b312d567 0000168f 00000001 ffffffff f49cc200 00000286 00000000 00000000
Apr 11 19:15:02 gurh kernel: [14969.037767] 00000000 ffffffff f51cc34c f51cc354 f51cc350 f592f550 c02c414c f51cc354
Apr 11 19:15:02 gurh kernel: [14969.037773] Call Trace:
Apr 11 19:15:02 gurh kernel: [14969.037789] [<c02c414c>] __mutex_lock_slowpath+0x50/0x7b
Apr 11 19:15:02 gurh kernel: [14969.037798] [<c02c3fe2>] mutex_lock+0xa/0xb
Apr 11 19:15:02 gurh kernel: [14969.037801] [<c01a94fd>] inotify_poll+0x25/0x40
Apr 11 19:15:02 gurh kernel: [14969.037807] [<c018f0a8>] do_sys_poll+0x156/0x2e7
Apr 11 19:15:02 gurh kernel: [14969.037815] [<c018fb6f>] __pollwait+0x0/0xac
Apr 11 19:15:02 gurh kernel: [14969.037823] [<c0121695>] default_wake_function+0x0/0x8
Apr 11 19:15:02 gurh kernel: [14969.037831] [<c0121695>] default_wake_function+0x0/0x8
Apr 11 19:15:02 gurh kernel: [14969.037840] [<c0121695>] default_wake_function+0x0/0x8
Apr 11 19:15:02 gurh kernel: [14969.037849] [<c0121695>] default_wake_function+0x0/0x8
Apr 11 19:15:02 gurh kernel: [14969.037857] [<c0121695>] default_wake_function+0x0/0x8
Apr 11 19:15:02 gurh kernel: [14969.037865] [<c0121695>] default_wake_function+0x0/0x8
Apr 11 19:15:02 gurh kernel: [14969.037874] [<c0121695>] default_wake_function+0x0/0x8
Apr 11 19:15:02 gurh kernel: [14969.037886] [<f8d32b42>] ext3_get_blocks_handle+0x87/0x7c6 [ext3]
Apr 11 19:15:02 gurh kernel: [14969.037898] [<c012d4f9>] it_real_fn+0x12/0x15
Apr 11 19:15:02 gurh kernel: [14969.037902] [<c013c81c>] run_hrtimer_pending+0x59/0xdd
Apr 11 19:15:02 gurh kernel: [14969.037911] [<c012df66>] __do_softirq+0x9b/0x14e
Apr 11 19:15:02 gurh kernel: [14969.037915] [<c01a0fb5>] __find_get_block+0x176/0x180
Apr 11 19:15:02 gurh kernel: [14969.037924] [<c012e364>] irq_exit+0x84/0x9b
Apr 11 19:15:02 gurh kernel: [14969.037926] [<c011560a>] smp_apic_timer_interrupt+0x6b/0x75
Apr 11 19:15:02 gurh kernel: [14969.037933] [<c0109408>] apic_timer_interrupt+0x28/0x30
Apr 11 19:15:02 gurh kernel: [14969.037940] [<c01a0fe6>] __getblk+0x27/0x24e
Apr 11 19:15:02 gurh kernel: [14969.037950] [<c0143a07>] charge_dcache+0x52/0x9b
Apr 11 19:15:02 gurh kernel: [14969.037957] [<f9d8b1c7>] sim_systemcall+0x4f/0x370 [simfs]
Apr 11 19:15:02 gurh kernel: [14969.037961] [<c0143b3b>] __ub_dentry_charge+0x3a/0x127
Apr 11 19:15:02 gurh kernel: [14969.037967] [<c025abce>] skb_dequeue+0x42/0x48
Apr 11 19:15:02 gurh kernel: [14969.037972] [<c02b226f>] unix_stream_recvmsg+0x390/0x42f
Apr 11 19:15:02 gurh kernel: [14969.037991] [<c02558be>] sock_aio_read+0xb9/0xc7
Apr 11 19:15:02 gurh kernel: [14969.038010] [<c01841fa>] do_sync_read+0xbf/0xfe
Apr 11 19:15:02 gurh kernel: [14969.038016] [<c0186df1>] cp_new_stat64+0xfc/0x10e
Apr 11 19:15:02 gurh kernel: [14969.038028] [<c013a1c0>] autoremove_wake_function+0x0/0x2d
Apr 11 19:15:02 gurh kernel: [14969.038042] [<c0187475>] sys_stat64+0x1e/0x23
Apr 11 19:15:02 gurh kernel: [14969.038050] [<c018497c>] vfs_read+0x92/0x11e
Apr 11 19:15:02 gurh kernel: [14969.038058] [<c018f274>] sys_poll+0x3b/0x6e
Apr 11 19:15:02 gurh kernel: [14969.038065] [<c0108972>] syscall_call+0x7/0xb
Apr 11 19:15:02 gurh kernel: [14969.038080] =======================
Apr 11 19:15:02 gurh kernel: [14969.038080] =======================
Apr 11 19:15:02 gurh kernel: [14969.038084] INFO: task kwrite:25911 blocked for more than 120 seconds.
Apr 11 19:15:02 gurh kernel: [14969.038087] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Apr 11 19:15:02 gurh kernel: [14969.038090] kwrite D f303ba70 0 25911 5027
Apr 11 19:15:02 gurh kernel: [14969.038093] f303ba70 00000082 00000001 04952824 00000c2b f303bbfc c2212fa0 00000000
Apr 11 19:15:02 gurh kernel: [14969.038099] b3befcaf 0000168f 00000000 c013ce74 00000001 00000000 c013cea8 00003442
Apr 11 19:15:02 gurh kernel: [14969.038105] 35904329 01312cff f0923fdc f0923fe4 f0923fe0 f303ba70 c02c414c f0923fe4
Apr 11 19:15:02 gurh kernel: [14969.038111] Call Trace:
Apr 11 19:15:02 gurh kernel: [14969.038121] [<c013ce74>] ktime_get_ts+0x22/0x49
Apr 11 19:15:02 gurh kernel: [14969.038126] [<c013cea8>] ktime_get+0xd/0x21
Apr 11 19:15:02 gurh kernel: [14969.038134] [<c02c414c>] __mutex_lock_slowpath+0x50/0x7b
Apr 11 19:15:02 gurh kernel: [14969.038142] [<c02c3fe2>] mutex_lock+0xa/0xb
Apr 11 19:15:02 gurh kernel: [14969.038145] [<c01a8a55>] inotify_inode_is_dead+0x18/0x6c
Apr 11 19:15:02 gurh kernel: [14969.038153] [<c0192639>] dentry_iput+0x50/0x7f
Apr 11 19:15:02 gurh kernel: [14969.038159] [<c01926e4>] d_kill+0x2d/0x46
Apr 11 19:15:02 gurh kernel: [14969.038164] [<c019364c>] dput+0xed/0x11d
Apr 11 19:15:02 gurh kernel: [14969.038169] [<c018a60d>] path_put+0xb/0x20
Apr 11 19:15:02 gurh kernel: [14969.038174] [<c01a8c3c>] put_inotify_watch+0x22/0x56
Apr 11 19:15:02 gurh kernel: [14969.038179] [<c01a9394>] inotify_dev_queue_event+0x3d/0x109
Apr 11 19:15:02 gurh kernel: [14969.038187] [<c01a8a37>] inotify_remove_watch_locked+0x24/0x2a
Apr 11 19:15:02 gurh kernel: [14969.038195] [<c01a8a7e>] inotify_inode_is_dead+0x41/0x6c
Apr 11 19:15:02 gurh kernel: [14969.038203] [<c0192639>] dentry_iput+0x50/0x7f
Apr 11 19:15:02 gurh kernel: [14969.038209] [<c0194691>] d_delete+0x39/0xa0
Apr 11 19:15:02 gurh kernel: [14969.038214] [<c018b827>] vfs_unlink+0xa5/0xc4
Apr 11 19:15:02 gurh kernel: [14969.038221] [<c018cfcd>] do_unlinkat+0xa2/0x136
Apr 11 19:15:02 gurh kernel: [14969.038237] [<c018ce4c>] sys_rename+0x11/0x15
Apr 11 19:15:02 gurh kernel: [14969.038243] [<c0108972>] syscall_call+0x7/0xb
Apr 11 19:15:02 gurh kernel: [14969.038258] =======================
Apr 11 19:17:01 gurh /USR/SBIN/CRON[26851]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly)
Apr 11 19:20:01 gurh /USR/SBIN/CRON[27062]: (root) CMD (if [ -x /usr/bin/vnstat ] && [ `ls /var/lib/vnstat/ | wc -l` -ge 1 ]; then /usr/bin/vnstat -u; fi)
Apr 11 19:20:01 gurh /USR/SBIN/CRON[27063]: (root) CMD (/usr/share/vzctl/scripts/vpsreboot)
Apr 11 19:20:01 gurh /USR/SBIN/CRON[27064]: (root) CMD (/usr/share/vzctl/scripts/vpsnetclean)
Apr 11 19:20:02 gurh kernel: [15284.716353] INFO: task plasma:5374 blocked for more than 120 seconds.
Apr 11 19:20:02 gurh kernel: [15284.716359] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Apr 11 19:20:02 gurh kernel: [15284.716363] plasma D f5920bd0 0 5374 1
Apr 11 19:20:02 gurh kernel: [15284.716367] f5920bd0 00000086 c013e9f4 00a91654 f481fde4 f5920d5c c2212fa0 00000000
Apr 11 19:20:02 gurh kernel: [15284.716374] d0db97be 0000168f 00000000 f490fe24 f5d03f44 0000010b 00000000 00000000
Apr 11 19:20:02 gurh kernel: [15284.716380] 00000000 ffffffff f4cad310 f4cad318 f4cad314 f5920bd0 c02c414c f2497e10
Apr 11 19:20:02 gurh kernel: [15284.716386] Call Trace:
Apr 11 19:20:02 gurh kernel: [15284.716400] [<c013e9f4>] getnstimeofday+0x37/0xbc
Apr 11 19:20:02 gurh kernel: [15284.716417] [<c02c414c>] __mutex_lock_slowpath+0x50/0x7b
Apr 11 19:20:02 gurh kernel: [15284.716427] [<c02c3fe2>] mutex_lock+0xa/0xb
Apr 11 19:20:02 gurh kernel: [15284.716430] [<c018a8b5>] do_lookup+0x88/0x16f
Apr 11 19:20:02 gurh kernel: [15284.716440] [<c018c546>] __link_path_walk+0x7e4/0xbc6
Apr 11 19:20:02 gurh kernel: [15284.716449] [<c018a892>] do_lookup+0x65/0x16f
Apr 11 19:20:02 gurh kernel: [15284.716455] [<c01dddde>] idr_get_empty_slot+0x11e/0x1ef
Apr 11 19:20:02 gurh kernel: [15284.716465] [<c018c95f>] path_walk+0x37/0x70
Apr 11 19:20:02 gurh kernel: [15284.716473] [<c018cc0e>] do_path_lookup+0x122/0x184
Apr 11 19:20:02 gurh kernel: [15284.716481] [<c018d46b>] __user_walk_fd+0x29/0x3a
Apr 11 19:20:02 gurh kernel: [15284.716488] [<c018738a>] vfs_stat_fd+0x15/0x3c
Apr 11 19:20:02 gurh kernel: [15284.716501] [<c01977dd>] mntput_no_expire+0x13/0xd2
Apr 11 19:20:02 gurh kernel: [15284.716508] [<c01a98c0>] sys_inotify_add_watch+0xcb/0xd7
Apr 11 19:20:02 gurh kernel: [15284.716516] [<c0187466>] sys_stat64+0xf/0x23
Apr 11 19:20:02 gurh kernel: [15284.716522] [<c0185f58>] deactivate_super+0x15/0x60
Apr 11 19:20:02 gurh kernel: [15284.716528] [<c01a8d34>] inotify_rm_wd+0x91/0x9a
Apr 11 19:20:02 gurh kernel: [15284.719553] [<c0108972>] syscall_call+0x7/0xb
Apr 11 19:20:02 gurh kernel: [15284.719568] =======================
-- System Information:
Debian Release: squeeze/sid
APT prefers unstable
APT policy: (500, 'unstable'), (500, 'testing')
Architecture: i386 (i686)
Kernel: Linux 2.6.26-1-openvz-686 (SMP w/2 CPU cores)
Locale: LANG=en_CA.UTF-8, LC_CTYPE=en_CA.UTF-8 (charmap=UTF-8)
Shell: /bin/sh linked to /bin/bash
Reply to: