Mintでブラウザ動画再生時にフリーズする現象のメモ
以前から発生してたのですが、Mintを17にしてからフリーズしやすくなったのでメモ。
現象メモ
まず、現象から。
Firefoxで動画再生(例えばYoutube)を最大化して再生している時に発生しやすい。
これが発生するとマウスは動くが、操作が一切出来ないので電源OFFしか道はない。
強制再起動なのでログが確認出来ないので何が起こったのかすら不明。
で、今回ssh-serverをインストールした後に、この現象が発生。
どうもsshログインはできるのでちょっとシステム周りを見れたのでメモ。
さて、まずはビデオカード。
古いけど普段は問題なく動いている。SteamのCiv5も動いていて久々にプレイしてクリアしたばかり。
昔からLinuxはビデオカードは最新だと色々問題があって古いほうが結構安心出来るし当分このまま使うつもり。
$ lspci -nnk |grep NVIDIA 02:00.0 VGA compatible controller [0300]: NVIDIA Corporation GT200b [GeForce GTX 275] [10de:05e6] (rev a1) Subsystem: NVIDIA Corporation Device [10de:069e]
まず、topするとxorgとmigration/6が暴走している。
ちなみに、migrationはこのあたりによると、kernel processらしい。
The migration kernel process distributes workload across CPU cores.
You should have one migration process per processor core.
top
$ top top - 19:41:20 up 19:08, 7 users, load average: 15.09, 6.18, 3.10 Tasks: 305 total, 6 running, 298 sleeping, 0 stopped, 1 zombie %Cpu(s): 13.1 us, 12.9 sy, 0.0 ni, 73.8 id, 0.0 wa, 0.0 hi, 0.0 si, 0.0 st KiB Mem: 16315736 total, 9776240 used, 6539496 free, 479716 buffers KiB Swap: 0 total, 0 used, 0 free. 3770444 cached Mem PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND 53 root rt 0 0 0 0 R 100.0 0.0 0:54.54 migration/6 1504 root 20 0 260600 121432 53900 R 100.0 0.7 72:52.60 Xorg 2330 longicorn 9 -11 703044 7820 5252 S 1.7 0.0 37:16.70 pulseaudio 11266 longicorn 20 0 1149572 160500 75536 S 1.7 1.0 66:51.05 chrome 20496 longicorn 20 0 369228 140880 8112 S 1.7 0.9 1:57.02 ruby 21674 longicorn 20 0 1319492 225780 19848 S 1.7 1.4 118:01.98 chrome 11644 longicorn 20 0 893588 189100 29624 S 1.0 1.2 1:50.40 chrome 11543 longicorn 20 0 764688 63888 24028 S 0.3 0.4 0:07.69 chrome 11631 longicorn 20 0 901316 197176 31400 S 0.3 1.2 2:08.14 chrome 1 root 20 0 33944 3312 1492 S 0.0 0.0 0:01.12 init 2 root 20 0 0 0 0 S 0.0 0.0 0:00.02 kthreadd 3 root 20 0 0 0 0 S 0.0 0.0 0:00.38 ksoftirqd/0 5 root 0 -20 0 0 0 S 0.0 0.0 0:00.00 kworker/0:0H 7 root 20 0 0 0 0 S 0.0 0.0 1:17.93 rcu_sched 8 root 20 0 0 0 0 S 0.0 0.0 0:24.43 rcuos/0 9 root 20 0 0 0 0 S 0.0 0.0 0:25.09 rcuos/1 10 root 20 0 0 0 0 S 0.0 0.0 0:25.49 rcuos/2 11 root 20 0 0 0 0 S 0.0 0.0 0:23.55 rcuos/3 12 root 20 0 0 0 0 S 0.0 0.0 0:11.03 rcuos/4 13 root 20 0 0 0 0 S 0.0 0.0 0:12.24 rcuos/5 14 root 20 0 0 0 0 S 0.0 0.0 0:12.44 rcuos/6 15 root 20 0 0 0 0 S 0.0 0.0 0:09.06 rcuos/7
syslog
Aug 15 19:39:11 Sagittarius kernel: [68721.908469] [sched_delayed] sched: RT throttling activated Aug 15 19:39:21 Sagittarius kernel: [68730.995271] Watchdog[11318]: segfault at 0 ip 00007f3023066dfe sp 00007f301264c670 error 6 in chrome[7f301f140000+51d2000] Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: snd_pcm_avail() は 例外的に大きな値を返しました: 411664 バイト（2333 ms）。 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: これは多分、ALSA ドライバー 'snd_hda_intel' 内のバグです。この問題は ALSA 開発者宛に 報告を提出して下さい。 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: snd_pcm_dump(): Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: Soft volume PCM Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: Control: PCM Playback Volume Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: min_dB: -51 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: max_dB: 0 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: resolution: 256 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: Its setup is: Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: stream : PLAYBACK Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: access : MMAP_INTERLEAVED Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: format : S16_LE Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: subformat : STD Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: channels : 2 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: rate : 44100 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: exact rate : 44100 (44100/1) Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: msbits : 16 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: buffer_size : 16384 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: period_size : 8192 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: period_time : 185759 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: tstamp_mode : ENABLE Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: period_step : 1 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: avail_min : 15239 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: period_event : 0 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: start_threshold : -1 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: stop_threshold : 4611686018427387904 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: silence_threshold: 0 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: silence_size : 0 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: boundary : 4611686018427387904 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: Slave: Hardware PCM card 0 'HDA Intel PCH' device 0 subdevice 0 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: Its setup is: Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: stream : PLAYBACK Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: access : MMAP_INTERLEAVED Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: format : S16_LE Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: subformat : STD Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: channels : 2 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: rate : 44100 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: exact rate : 44100 (44100/1) Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: msbits : 16 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: buffer_size : 16384 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: period_size : 8192 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: period_time : 185759 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: tstamp_mode : ENABLE Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: period_step : 1 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: avail_min : 15239 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: period_event : 0 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: start_threshold : -1 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: stop_threshold : 4611686018427387904 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: silence_threshold: 0 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: silence_size : 0 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: boundary : 4611686018427387904 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: appl_ptr : 2713138004 Aug 15 19:39:24 Sagittarius pulseaudio[2330]: [alsa-sink-ALC898 Analog] alsa-util.c: hw_ptr : 2713224536 Aug 15 19:43:10 Sagittarius kernel: [68960.662124] INFO: task plugin-containe:28037 blocked for more than 120 seconds. Aug 15 19:43:10 Sagittarius kernel: [68960.662128] Tainted: PF O 3.13.0-24-generic #47-Ubuntu Aug 15 19:43:10 Sagittarius kernel: [68960.662129] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Aug 15 19:43:10 Sagittarius kernel: [68960.662130] plugin-containe D ffff88042f3d4440 0 28037 2555 0x00000006 Aug 15 19:43:10 Sagittarius kernel: [68960.662133] ffff8800ae30d9a0 0000000000000002 ffff8803ee13c7d0 ffff8800ae30dfd8 Aug 15 19:43:10 Sagittarius kernel: [68960.662135] 0000000000014440 0000000000014440 ffff8803ee13c7d0 ffff880414621228 Aug 15 19:43:10 Sagittarius kernel: [68960.662137] 7fffffffffffffff ffff8803ee13c7d0 0000000000000002 0000000000000000 Aug 15 19:43:10 Sagittarius kernel: [68960.662139] Call Trace: Aug 15 19:43:10 Sagittarius kernel: [68960.662144] [] schedule+0x29/0x70 Aug 15 19:43:10 Sagittarius kernel: [68960.662146] [ ] schedule_timeout+0x239/0x2d0 Aug 15 19:43:10 Sagittarius kernel: [68960.662149] [ ] ? sched_clock_cpu+0xb5/0x100 Aug 15 19:43:10 Sagittarius kernel: [68960.662151] [ ] ? check_preempt_curr+0x75/0xa0 Aug 15 19:43:10 Sagittarius kernel: [68960.662154] [ ] ? read_tsc+0x9/0x20 Aug 15 19:43:10 Sagittarius kernel: [68960.662156] [ ] __down_common+0xf7/0x144 Aug 15 19:43:10 Sagittarius kernel: [68960.662163] [ ] __down+0x1d/0x1f Aug 15 19:43:10 Sagittarius kernel: [68960.662165] [ ] down+0x41/0x50 Aug 15 19:43:10 Sagittarius kernel: [68960.662216] [ ] os_acquire_mutex+0x3f/0x50 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.662254] [ ] _nv014839rm+0x1c/0x21 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.662288] [ ] ? _nv016464rm+0x6c/0x100 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.662326] [ ] ? rm_free_unused_clients+0x78/0x12d [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.662362] [ ] ? nv_kern_ctl_close+0x69/0x100 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.662399] [ ] ? nv_kern_close+0x3b3/0x450 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.662402] [ ] ? __fput+0xe4/0x260 Aug 15 19:43:10 Sagittarius kernel: [68960.662403] [ ] ? ____fput+0xe/0x10 Aug 15 19:43:10 Sagittarius kernel: [68960.662406] [ ] ? task_work_run+0xc4/0xe0 Aug 15 19:43:10 Sagittarius kernel: [68960.662409] [ ] ? do_exit+0x2ab/0xa50 Aug 15 19:43:10 Sagittarius kernel: [68960.662411] [ ] ? __unqueue_futex+0x31/0x60 Aug 15 19:43:10 Sagittarius kernel: [68960.662413] [ ] ? futex_wait+0x126/0x290 Aug 15 19:43:10 Sagittarius kernel: [68960.662414] [ ] ? do_group_exit+0x3f/0xa0 Aug 15 19:43:10 Sagittarius kernel: [68960.662417] [ ] ? get_signal_to_deliver+0x1d0/0x6f0 Aug 15 19:43:10 Sagittarius kernel: [68960.662420] [ ] ? do_signal+0x48/0x960 Aug 15 19:43:10 Sagittarius kernel: [68960.662423] [ ] ? acct_account_cputime+0x1c/0x20 Aug 15 19:43:10 Sagittarius kernel: [68960.662424] [ ] ? account_user_time+0x8b/0xa0 Aug 15 19:43:10 Sagittarius kernel: [68960.662426] [ ] ? vtime_account_user+0x54/0x60 Aug 15 19:43:10 Sagittarius kernel: [68960.662428] [ ] ? do_notify_resume+0x69/0xb0 Aug 15 19:43:10 Sagittarius kernel: [68960.662430] [ ] ? int_signal+0x12/0x17 Aug 15 19:43:10 Sagittarius kernel: [68960.662464] INFO: task kworker/2:0:27996 blocked for more than 120 seconds. Aug 15 19:43:10 Sagittarius kernel: [68960.662465] Tainted: PF O 3.13.0-24-generic #47-Ubuntu Aug 15 19:43:10 Sagittarius kernel: [68960.662466] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Aug 15 19:43:10 Sagittarius kernel: [68960.662466] kworker/2:0 D ffff88042f294440 0 27996 2 0x00000000 Aug 15 19:43:10 Sagittarius kernel: [68960.662504] Workqueue: events os_execute_work_item [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.662505] ffff8800ae329b70 0000000000000002 ffff88038efd8000 ffff8800ae329fd8 Aug 15 19:43:10 Sagittarius kernel: [68960.662506] 0000000000014440 0000000000014440 ffff88038efd8000 ffff880414621228 Aug 15 19:43:10 Sagittarius kernel: [68960.662508] 7fffffffffffffff ffff88038efd8000 0000000000000002 0000000000000000 Aug 15 19:43:10 Sagittarius kernel: [68960.662510] Call Trace: Aug 15 19:43:10 Sagittarius kernel: [68960.662512] [ ] schedule+0x29/0x70 Aug 15 19:43:10 Sagittarius kernel: [68960.662513] [ ] schedule_timeout+0x239/0x2d0 Aug 15 19:43:10 Sagittarius kernel: [68960.662515] [ ] __down_common+0xf7/0x144 Aug 15 19:43:10 Sagittarius kernel: [68960.662517] [ ] ? __getnstimeofday+0x20/0xc0 Aug 15 19:43:10 Sagittarius kernel: [68960.662519] [ ] __down+0x1d/0x1f Aug 15 19:43:10 Sagittarius kernel: [68960.662520] [ ] down+0x41/0x50 Aug 15 19:43:10 Sagittarius kernel: [68960.662556] [ ] os_acquire_mutex+0x3f/0x50 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.662593] [ ] _nv014839rm+0x1c/0x21 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.662626] [ ] ? _nv016464rm+0x6c/0x100 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.662680] [ ] ? _nv015397rm+0x211/0x358 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.662717] [ ] ? _nv001082rm+0x298/0x97d [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.662754] [ ] ? rm_execute_work_item+0x4c/0xc2 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.662790] [ ] ? os_execute_work_item+0x46/0x80 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.662792] [ ] ? process_one_work+0x182/0x450 Aug 15 19:43:10 Sagittarius kernel: [68960.662794] [ ] ? worker_thread+0x121/0x410 Aug 15 19:43:10 Sagittarius kernel: [68960.662796] [ ] ? rescuer_thread+0x3e0/0x3e0 Aug 15 19:43:10 Sagittarius kernel: [68960.662798] [ ] ? kthread+0xd2/0xf0 Aug 15 19:43:10 Sagittarius kernel: [68960.662800] [ ] ? kthread_create_on_node+0x1d0/0x1d0 Aug 15 19:43:10 Sagittarius kernel: [68960.662801] [ ] ? ret_from_fork+0x7c/0xb0 Aug 15 19:43:10 Sagittarius kernel: [68960.662803] [ ] ? kthread_create_on_node+0x1d0/0x1d0 Aug 15 19:43:10 Sagittarius kernel: [68960.662804] INFO: task kworker/6:0:29676 blocked for more than 120 seconds. Aug 15 19:43:10 Sagittarius kernel: [68960.662805] Tainted: PF O 3.13.0-24-generic #47-Ubuntu Aug 15 19:43:10 Sagittarius kernel: [68960.662806] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Aug 15 19:43:10 Sagittarius kernel: [68960.662806] kworker/6:0 D ffff88042f394440 0 29676 2 0x00000000 Aug 15 19:43:10 Sagittarius kernel: [68960.662842] Workqueue: events os_execute_work_item [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.662843] ffff8803a0891b70 0000000000000002 ffff88038b3d5fc0 ffff8803a0891fd8 Aug 15 19:43:10 Sagittarius kernel: [68960.662845] 0000000000014440 0000000000014440 ffff88038b3d5fc0 ffff880414621228 Aug 15 19:43:10 Sagittarius kernel: [68960.662846] 7fffffffffffffff ffff88038b3d5fc0 0000000000000002 0000000000000000 Aug 15 19:43:10 Sagittarius kernel: [68960.662848] Call Trace: Aug 15 19:43:10 Sagittarius kernel: [68960.662850] [ ] schedule+0x29/0x70 Aug 15 19:43:10 Sagittarius kernel: [68960.662851] [ ] schedule_timeout+0x239/0x2d0 Aug 15 19:43:10 Sagittarius kernel: [68960.662854] [ ] ? cpufreq_stats_update+0x5c/0x70 Aug 15 19:43:10 Sagittarius kernel: [68960.662855] [ ] ? cpufreq_stats_update+0x5c/0x70 Aug 15 19:43:10 Sagittarius kernel: [68960.662857] [ ] __down_common+0xf7/0x144 Aug 15 19:43:10 Sagittarius kernel: [68960.662858] [ ] ? __getnstimeofday+0x20/0xc0 Aug 15 19:43:10 Sagittarius kernel: [68960.662860] [ ] __down+0x1d/0x1f Aug 15 19:43:10 Sagittarius kernel: [68960.662861] [ ] down+0x41/0x50 Aug 15 19:43:10 Sagittarius kernel: [68960.662896] [ ] os_acquire_mutex+0x3f/0x50 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.662933] [ ] _nv014839rm+0x1c/0x21 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.662966] [ ] ? _nv016464rm+0x6c/0x100 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.663019] [ ] ? _nv015397rm+0x211/0x358 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.663056] [ ] ? _nv001082rm+0x298/0x97d [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.663093] [ ] ? rm_execute_work_item+0x4c/0xc2 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.663128] [ ] ? os_execute_work_item+0x46/0x80 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.663130] [ ] ? process_one_work+0x182/0x450 Aug 15 19:43:10 Sagittarius kernel: [68960.663132] [ ] ? worker_thread+0x121/0x410 Aug 15 19:43:10 Sagittarius kernel: [68960.663134] [ ] ? rescuer_thread+0x3e0/0x3e0 Aug 15 19:43:10 Sagittarius kernel: [68960.663135] [ ] ? kthread+0xd2/0xf0 Aug 15 19:43:10 Sagittarius kernel: [68960.663137] [ ] ? kthread_create_on_node+0x1d0/0x1d0 Aug 15 19:43:10 Sagittarius kernel: [68960.663138] [ ] ? ret_from_fork+0x7c/0xb0 Aug 15 19:43:10 Sagittarius kernel: [68960.663140] [ ] ? kthread_create_on_node+0x1d0/0x1d0 Aug 15 19:43:10 Sagittarius kernel: [68960.663142] INFO: task kworker/2:1:13483 blocked for more than 120 seconds. Aug 15 19:43:10 Sagittarius kernel: [68960.663142] Tainted: PF O 3.13.0-24-generic #47-Ubuntu Aug 15 19:43:10 Sagittarius kernel: [68960.663143] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Aug 15 19:43:10 Sagittarius kernel: [68960.663144] kworker/2:1 D ffff88042f294440 0 13483 2 0x00000000 Aug 15 19:43:10 Sagittarius kernel: [68960.663179] Workqueue: events os_execute_work_item [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.663180] ffff8800aa15bb70 0000000000000002 ffff88038fbc17f0 ffff8800aa15bfd8 Aug 15 19:43:10 Sagittarius kernel: [68960.663182] 0000000000014440 0000000000014440 ffff88038fbc17f0 ffff880414621228 Aug 15 19:43:10 Sagittarius kernel: [68960.663183] 7fffffffffffffff ffff88038fbc17f0 0000000000000002 0000000000000000 Aug 15 19:43:10 Sagittarius kernel: [68960.663185] Call Trace: Aug 15 19:43:10 Sagittarius kernel: [68960.663187] [ ] schedule+0x29/0x70 Aug 15 19:43:10 Sagittarius kernel: [68960.663188] [ ] schedule_timeout+0x239/0x2d0 Aug 15 19:43:10 Sagittarius kernel: [68960.663190] [ ] ? __schedule+0x381/0x7d0 Aug 15 19:43:10 Sagittarius kernel: [68960.663191] [ ] __down_common+0xf7/0x144 Aug 15 19:43:10 Sagittarius kernel: [68960.663193] [ ] ? __getnstimeofday+0x20/0xc0 Aug 15 19:43:10 Sagittarius kernel: [68960.663194] [ ] __down+0x1d/0x1f Aug 15 19:43:10 Sagittarius kernel: [68960.663196] [ ] down+0x41/0x50 Aug 15 19:43:10 Sagittarius kernel: [68960.663231] [ ] os_acquire_mutex+0x3f/0x50 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.663268] [ ] _nv014839rm+0x1c/0x21 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.663300] [ ] ? _nv016464rm+0x6c/0x100 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.663353] [ ] ? _nv015397rm+0x211/0x358 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.663390] [ ] ? _nv001082rm+0x298/0x97d [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.663427] [ ] ? rm_execute_work_item+0x4c/0xc2 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.663462] [ ] ? os_execute_work_item+0x46/0x80 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.663464] [ ] ? process_one_work+0x182/0x450 Aug 15 19:43:10 Sagittarius kernel: [68960.663466] [ ] ? worker_thread+0x121/0x410 Aug 15 19:43:10 Sagittarius kernel: [68960.663468] [ ] ? rescuer_thread+0x3e0/0x3e0 Aug 15 19:43:10 Sagittarius kernel: [68960.663469] [ ] ? kthread+0xd2/0xf0 Aug 15 19:43:10 Sagittarius kernel: [68960.663471] [ ] ? kthread_create_on_node+0x1d0/0x1d0 Aug 15 19:43:10 Sagittarius kernel: [68960.663472] [ ] ? ret_from_fork+0x7c/0xb0 Aug 15 19:43:10 Sagittarius kernel: [68960.663474] [ ] ? kthread_create_on_node+0x1d0/0x1d0 Aug 15 19:43:10 Sagittarius kernel: [68960.663475] INFO: task kworker/6:2:10349 blocked for more than 120 seconds. Aug 15 19:43:10 Sagittarius kernel: [68960.663476] Tainted: PF O 3.13.0-24-generic #47-Ubuntu Aug 15 19:43:10 Sagittarius kernel: [68960.663477] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Aug 15 19:43:10 Sagittarius kernel: [68960.663478] kworker/6:2 D ffff88042f394440 0 10349 2 0x00000000 Aug 15 19:43:10 Sagittarius kernel: [68960.663513] Workqueue: events os_execute_work_item [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.663514] ffff88039ee53b70 0000000000000002 ffff88038efddfc0 ffff88039ee53fd8 Aug 15 19:43:10 Sagittarius kernel: [68960.663516] 0000000000014440 0000000000014440 ffff88038efddfc0 ffff880414621228 Aug 15 19:43:10 Sagittarius kernel: [68960.663518] 7fffffffffffffff ffff88038efddfc0 0000000000000002 0000000000000000 Aug 15 19:43:10 Sagittarius kernel: [68960.663519] Call Trace: Aug 15 19:43:10 Sagittarius kernel: [68960.663521] [ ] schedule+0x29/0x70 Aug 15 19:43:10 Sagittarius kernel: [68960.663522] [ ] schedule_timeout+0x239/0x2d0 Aug 15 19:43:10 Sagittarius kernel: [68960.663524] [ ] ? __schedule+0x381/0x7d0 Aug 15 19:43:10 Sagittarius kernel: [68960.663525] [ ] __down_common+0xf7/0x144 Aug 15 19:43:10 Sagittarius kernel: [68960.663527] [ ] ? __getnstimeofday+0x20/0xc0 Aug 15 19:43:10 Sagittarius kernel: [68960.663528] [ ] __down+0x1d/0x1f Aug 15 19:43:10 Sagittarius kernel: [68960.663530] [ ] down+0x41/0x50 Aug 15 19:43:10 Sagittarius kernel: [68960.663565] [ ] os_acquire_mutex+0x3f/0x50 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.663602] [ ] _nv014839rm+0x1c/0x21 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.663634] [ ] ? _nv016464rm+0x6c/0x100 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.663687] [ ] ? _nv015397rm+0x211/0x358 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.663724] [ ] ? _nv001082rm+0x298/0x97d [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.663760] [ ] ? rm_execute_work_item+0x4c/0xc2 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.663796] [ ] ? os_execute_work_item+0x46/0x80 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.663798] [ ] ? process_one_work+0x182/0x450 Aug 15 19:43:10 Sagittarius kernel: [68960.663799] [ ] ? worker_thread+0x121/0x410 Aug 15 19:43:10 Sagittarius kernel: [68960.663801] [ ] ? rescuer_thread+0x3e0/0x3e0 Aug 15 19:43:10 Sagittarius kernel: [68960.663803] [ ] ? kthread+0xd2/0xf0 Aug 15 19:43:10 Sagittarius kernel: [68960.663804] [ ] ? kthread_create_on_node+0x1d0/0x1d0 Aug 15 19:43:10 Sagittarius kernel: [68960.663806] [ ] ? ret_from_fork+0x7c/0xb0 Aug 15 19:43:10 Sagittarius kernel: [68960.663807] [ ] ? kthread_create_on_node+0x1d0/0x1d0 Aug 15 19:43:10 Sagittarius kernel: [68960.663808] INFO: task kworker/4:2:10350 blocked for more than 120 seconds. Aug 15 19:43:10 Sagittarius kernel: [68960.663809] Tainted: PF O 3.13.0-24-generic #47-Ubuntu Aug 15 19:43:10 Sagittarius kernel: [68960.663810] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Aug 15 19:43:10 Sagittarius kernel: [68960.663810] kworker/4:2 D ffff88042f314440 0 10350 2 0x00000000 Aug 15 19:43:10 Sagittarius kernel: [68960.663846] Workqueue: events os_execute_work_item [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.663847] ffff88039ee55b70 0000000000000002 ffff8800aa00dfc0 ffff88039ee55fd8 Aug 15 19:43:10 Sagittarius kernel: [68960.663848] 0000000000014440 0000000000014440 ffff8800aa00dfc0 ffff880414621228 Aug 15 19:43:10 Sagittarius kernel: [68960.663850] 7fffffffffffffff ffff8800aa00dfc0 0000000000000002 0000000000000000 Aug 15 19:43:10 Sagittarius kernel: [68960.663852] Call Trace: Aug 15 19:43:10 Sagittarius kernel: [68960.663853] [ ] schedule+0x29/0x70 Aug 15 19:43:10 Sagittarius kernel: [68960.663855] [ ] schedule_timeout+0x239/0x2d0 Aug 15 19:43:10 Sagittarius kernel: [68960.663856] [ ] __down_common+0xf7/0x144 Aug 15 19:43:10 Sagittarius kernel: [68960.663858] [ ] ? __getnstimeofday+0x20/0xc0 Aug 15 19:43:10 Sagittarius kernel: [68960.663859] [ ] __down+0x1d/0x1f Aug 15 19:43:10 Sagittarius kernel: [68960.663861] [ ] down+0x41/0x50 Aug 15 19:43:10 Sagittarius kernel: [68960.663896] [ ] os_acquire_mutex+0x3f/0x50 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.663933] [ ] _nv014839rm+0x1c/0x21 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.663965] [ ] ? _nv016464rm+0x6c/0x100 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.664019] [ ] ? _nv015397rm+0x211/0x358 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.664055] [ ] ? _nv001082rm+0x298/0x97d [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.664092] [ ] ? rm_execute_work_item+0x4c/0xc2 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.664127] [ ] ? os_execute_work_item+0x46/0x80 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.664129] [ ] ? process_one_work+0x182/0x450 Aug 15 19:43:10 Sagittarius kernel: [68960.664131] [ ] ? worker_thread+0x121/0x410 Aug 15 19:43:10 Sagittarius kernel: [68960.664133] [ ] ? rescuer_thread+0x3e0/0x3e0 Aug 15 19:43:10 Sagittarius kernel: [68960.664134] [ ] ? kthread+0xd2/0xf0 Aug 15 19:43:10 Sagittarius kernel: [68960.664136] [ ] ? kthread_create_on_node+0x1d0/0x1d0 Aug 15 19:43:10 Sagittarius kernel: [68960.664137] [ ] ? ret_from_fork+0x7c/0xb0 Aug 15 19:43:10 Sagittarius kernel: [68960.664139] [ ] ? kthread_create_on_node+0x1d0/0x1d0 Aug 15 19:43:10 Sagittarius kernel: [68960.664140] INFO: task kworker/4:1:21707 blocked for more than 120 seconds. Aug 15 19:43:10 Sagittarius kernel: [68960.664141] Tainted: PF O 3.13.0-24-generic #47-Ubuntu Aug 15 19:43:10 Sagittarius kernel: [68960.664142] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Aug 15 19:43:10 Sagittarius kernel: [68960.664142] kworker/4:1 D ffff88042f314440 0 21707 2 0x00000000 Aug 15 19:43:10 Sagittarius kernel: [68960.664178] Workqueue: events os_execute_work_item [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.664179] ffff88039ed99b70 0000000000000002 ffff88039f9f8000 ffff88039ed99fd8 Aug 15 19:43:10 Sagittarius kernel: [68960.664181] 0000000000014440 0000000000014440 ffff88039f9f8000 ffff880414621228 Aug 15 19:43:10 Sagittarius kernel: [68960.664182] 7fffffffffffffff ffff88039f9f8000 0000000000000002 0000000000000000 Aug 15 19:43:10 Sagittarius kernel: [68960.664184] Call Trace: Aug 15 19:43:10 Sagittarius kernel: [68960.664185] [ ] schedule+0x29/0x70 Aug 15 19:43:10 Sagittarius kernel: [68960.664187] [ ] schedule_timeout+0x239/0x2d0 Aug 15 19:43:10 Sagittarius kernel: [68960.664188] [ ] ? __schedule+0x381/0x7d0 Aug 15 19:43:10 Sagittarius kernel: [68960.664190] [ ] __down_common+0xf7/0x144 Aug 15 19:43:10 Sagittarius kernel: [68960.664191] [ ] ? __getnstimeofday+0x20/0xc0 Aug 15 19:43:10 Sagittarius kernel: [68960.664193] [ ] __down+0x1d/0x1f Aug 15 19:43:10 Sagittarius kernel: [68960.664194] [ ] down+0x41/0x50 Aug 15 19:43:10 Sagittarius kernel: [68960.664229] [ ] os_acquire_mutex+0x3f/0x50 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.664266] [ ] _nv014839rm+0x1c/0x21 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.664299] [ ] ? _nv016464rm+0x6c/0x100 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.664352] [ ] ? _nv015397rm+0x211/0x358 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.664388] [ ] ? _nv001082rm+0x298/0x97d [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.664425] [ ] ? rm_execute_work_item+0x4c/0xc2 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.664460] [ ] ? os_execute_work_item+0x46/0x80 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.664462] [ ] ? process_one_work+0x182/0x450 Aug 15 19:43:10 Sagittarius kernel: [68960.664464] [ ] ? worker_thread+0x121/0x410 Aug 15 19:43:10 Sagittarius kernel: [68960.664466] [ ] ? rescuer_thread+0x3e0/0x3e0 Aug 15 19:43:10 Sagittarius kernel: [68960.664467] [ ] ? kthread+0xd2/0xf0 Aug 15 19:43:10 Sagittarius kernel: [68960.664469] [ ] ? kthread_create_on_node+0x1d0/0x1d0 Aug 15 19:43:10 Sagittarius kernel: [68960.664470] [ ] ? ret_from_fork+0x7c/0xb0 Aug 15 19:43:10 Sagittarius kernel: [68960.664472] [ ] ? kthread_create_on_node+0x1d0/0x1d0 Aug 15 19:43:10 Sagittarius kernel: [68960.664474] INFO: task kworker/6:1:28417 blocked for more than 120 seconds. Aug 15 19:43:10 Sagittarius kernel: [68960.664475] Tainted: PF O 3.13.0-24-generic #47-Ubuntu Aug 15 19:43:10 Sagittarius kernel: [68960.664475] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Aug 15 19:43:10 Sagittarius kernel: [68960.664476] kworker/6:1 D ffff88042f394440 0 28417 2 0x00000000 Aug 15 19:43:10 Sagittarius kernel: [68960.664511] Workqueue: events os_execute_work_item [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.664512] ffff8800a7ba3b70 0000000000000002 ffff88038ff517f0 ffff8800a7ba3fd8 Aug 15 19:43:10 Sagittarius kernel: [68960.664514] 0000000000014440 0000000000014440 ffff88038ff517f0 ffff880414621228 Aug 15 19:43:10 Sagittarius kernel: [68960.664516] 7fffffffffffffff ffff88038ff517f0 0000000000000002 0000000000000000 Aug 15 19:43:10 Sagittarius kernel: [68960.664517] Call Trace: Aug 15 19:43:10 Sagittarius kernel: [68960.664519] [ ] schedule+0x29/0x70 Aug 15 19:43:10 Sagittarius kernel: [68960.664520] [ ] schedule_timeout+0x239/0x2d0 Aug 15 19:43:10 Sagittarius kernel: [68960.664522] [ ] ? __schedule+0x381/0x7d0 Aug 15 19:43:10 Sagittarius kernel: [68960.664523] [ ] __down_common+0xf7/0x144 Aug 15 19:43:10 Sagittarius kernel: [68960.664525] [ ] ? __getnstimeofday+0x20/0xc0 Aug 15 19:43:10 Sagittarius kernel: [68960.664526] [ ] __down+0x1d/0x1f Aug 15 19:43:10 Sagittarius kernel: [68960.664528] [ ] down+0x41/0x50 Aug 15 19:43:10 Sagittarius kernel: [68960.664563] [ ] os_acquire_mutex+0x3f/0x50 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.664599] [ ] _nv014839rm+0x1c/0x21 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.664632] [ ] ? _nv016464rm+0x6c/0x100 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.664685] [ ] ? _nv015397rm+0x211/0x358 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.664722] [ ] ? _nv001082rm+0x298/0x97d [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.664759] [ ] ? rm_execute_work_item+0x4c/0xc2 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.664794] [ ] ? os_execute_work_item+0x46/0x80 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.664796] [ ] ? process_one_work+0x182/0x450 Aug 15 19:43:10 Sagittarius kernel: [68960.664798] [ ] ? worker_thread+0x121/0x410 Aug 15 19:43:10 Sagittarius kernel: [68960.664799] [ ] ? rescuer_thread+0x3e0/0x3e0 Aug 15 19:43:10 Sagittarius kernel: [68960.664801] [ ] ? kthread+0xd2/0xf0 Aug 15 19:43:10 Sagittarius kernel: [68960.664802] [ ] ? kthread_create_on_node+0x1d0/0x1d0 Aug 15 19:43:10 Sagittarius kernel: [68960.664804] [ ] ? ret_from_fork+0x7c/0xb0 Aug 15 19:43:10 Sagittarius kernel: [68960.664805] [ ] ? kthread_create_on_node+0x1d0/0x1d0 Aug 15 19:43:10 Sagittarius kernel: [68960.664806] INFO: task kworker/6:3:28418 blocked for more than 120 seconds. Aug 15 19:43:10 Sagittarius kernel: [68960.664807] Tainted: PF O 3.13.0-24-generic #47-Ubuntu Aug 15 19:43:10 Sagittarius kernel: [68960.664808] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Aug 15 19:43:10 Sagittarius kernel: [68960.664809] kworker/6:3 D ffff88042f394440 0 28418 2 0x00000000 Aug 15 19:43:10 Sagittarius kernel: [68960.664844] Workqueue: events os_execute_work_item [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.664845] ffff8800aabd5b70 0000000000000002 ffff88039f9f97f0 ffff8800aabd5fd8 Aug 15 19:43:10 Sagittarius kernel: [68960.664846] 0000000000014440 0000000000014440 ffff88039f9f97f0 ffff880414621228 Aug 15 19:43:10 Sagittarius kernel: [68960.664848] 7fffffffffffffff ffff88039f9f97f0 0000000000000002 0000000000000000 Aug 15 19:43:10 Sagittarius kernel: [68960.664850] Call Trace: Aug 15 19:43:10 Sagittarius kernel: [68960.664851] [ ] schedule+0x29/0x70 Aug 15 19:43:10 Sagittarius kernel: [68960.664853] [ ] schedule_timeout+0x239/0x2d0 Aug 15 19:43:10 Sagittarius kernel: [68960.664854] [ ] ? cpufreq_stats_update+0x5c/0x70 Aug 15 19:43:10 Sagittarius kernel: [68960.664856] [ ] ? cpufreq_stat_notifier_trans+0xb9/0xc0 Aug 15 19:43:10 Sagittarius kernel: [68960.664857] [ ] __down_common+0xf7/0x144 Aug 15 19:43:10 Sagittarius kernel: [68960.664859] [ ] ? __getnstimeofday+0x20/0xc0 Aug 15 19:43:10 Sagittarius kernel: [68960.664860] [ ] __down+0x1d/0x1f Aug 15 19:43:10 Sagittarius kernel: [68960.664862] [ ] down+0x41/0x50 Aug 15 19:43:10 Sagittarius kernel: [68960.664897] [ ] os_acquire_mutex+0x3f/0x50 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.664933] [ ] _nv014839rm+0x1c/0x21 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.664966] [ ] ? _nv016464rm+0x6c/0x100 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.665019] [ ] ? _nv015397rm+0x211/0x358 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.665056] [ ] ? _nv001082rm+0x298/0x97d [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.665093] [ ] ? rm_execute_work_item+0x4c/0xc2 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.665128] [ ] ? os_execute_work_item+0x46/0x80 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.665130] [ ] ? process_one_work+0x182/0x450 Aug 15 19:43:10 Sagittarius kernel: [68960.665132] [ ] ? worker_thread+0x121/0x410 Aug 15 19:43:10 Sagittarius kernel: [68960.665133] [ ] ? rescuer_thread+0x3e0/0x3e0 Aug 15 19:43:10 Sagittarius kernel: [68960.665135] [ ] ? kthread+0xd2/0xf0 Aug 15 19:43:10 Sagittarius kernel: [68960.665136] [ ] ? kthread_create_on_node+0x1d0/0x1d0 Aug 15 19:43:10 Sagittarius kernel: [68960.665138] [ ] ? ret_from_fork+0x7c/0xb0 Aug 15 19:43:10 Sagittarius kernel: [68960.665139] [ ] ? kthread_create_on_node+0x1d0/0x1d0 Aug 15 19:43:10 Sagittarius kernel: [68960.665141] INFO: task kworker/4:0:28556 blocked for more than 120 seconds. Aug 15 19:43:10 Sagittarius kernel: [68960.665142] Tainted: PF O 3.13.0-24-generic #47-Ubuntu Aug 15 19:43:10 Sagittarius kernel: [68960.665142] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Aug 15 19:43:10 Sagittarius kernel: [68960.665143] kworker/4:0 D ffff88042f314440 0 28556 2 0x00000000 Aug 15 19:43:10 Sagittarius kernel: [68960.665179] Workqueue: events os_execute_work_item [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.665179] ffff88039f7e7b70 0000000000000002 ffff8803a1b00000 ffff88039f7e7fd8 Aug 15 19:43:10 Sagittarius kernel: [68960.665181] 0000000000014440 0000000000014440 ffff8803a1b00000 ffff880414621228 Aug 15 19:43:10 Sagittarius kernel: [68960.665183] 7fffffffffffffff ffff8803a1b00000 0000000000000002 0000000000000000 Aug 15 19:43:10 Sagittarius kernel: [68960.665184] Call Trace: Aug 15 19:43:10 Sagittarius kernel: [68960.665186] [ ] schedule+0x29/0x70 Aug 15 19:43:10 Sagittarius kernel: [68960.665187] [ ] schedule_timeout+0x239/0x2d0 Aug 15 19:43:10 Sagittarius kernel: [68960.665189] [ ] ? __schedule+0x381/0x7d0 Aug 15 19:43:10 Sagittarius kernel: [68960.665190] [ ] __down_common+0xf7/0x144 Aug 15 19:43:10 Sagittarius kernel: [68960.665192] [ ] ? __getnstimeofday+0x20/0xc0 Aug 15 19:43:10 Sagittarius kernel: [68960.665193] [ ] __down+0x1d/0x1f Aug 15 19:43:10 Sagittarius kernel: [68960.665195] [ ] down+0x41/0x50 Aug 15 19:43:10 Sagittarius kernel: [68960.665230] [ ] os_acquire_mutex+0x3f/0x50 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.665267] [ ] _nv014839rm+0x1c/0x21 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.665299] [ ] ? _nv016464rm+0x6c/0x100 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.665352] [ ] ? _nv015397rm+0x211/0x358 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.665389] [ ] ? _nv001082rm+0x298/0x97d [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.665426] [ ] ? rm_execute_work_item+0x4c/0xc2 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.665461] [ ] ? os_execute_work_item+0x46/0x80 [nvidia] Aug 15 19:43:10 Sagittarius kernel: [68960.665463] [ ] ? process_one_work+0x182/0x450 Aug 15 19:43:10 Sagittarius kernel: [68960.665465] [ ] ? worker_thread+0x121/0x410 Aug 15 19:43:10 Sagittarius kernel: [68960.665466] [ ] ? rescuer_thread+0x3e0/0x3e0 Aug 15 19:43:10 Sagittarius kernel: [68960.665468] [ ] ? kthread+0xd2/0xf0 Aug 15 19:43:10 Sagittarius kernel: [68960.665469] [ ] ? kthread_create_on_node+0x1d0/0x1d0 Aug 15 19:43:10 Sagittarius kernel: [68960.665471] [ ] ? ret_from_fork+0x7c/0xb0 Aug 15 19:43:10 Sagittarius kernel: [68960.665472] [ ] ? kthread_create_on_node+0x1d0/0x1d0 Aug 15 19:47:50 Sagittarius rsyslogd: [origin software="rsyslogd" swVersion="7.4.4" x-pid="799" x-info="http://www.rsyslog.com"] exiting on signal 15. Aug 15 19:51:57 Sagittarius rsyslogd: [origin software="rsyslogd" swVersion="7.4.4" x-pid="652" x-info="http://www.rsyslog.com"] start Aug 15 19:51:57 Sagittarius rsyslogd: rsyslogd's groupid changed to 103 Aug 15 19:51:57 Sagittarius rsyslogd: rsyslogd's userid changed to 101 Aug 15 19:51:57 Sagittarius kernel: [ 0.000000] Initializing cgroup subsys cpuset Aug 15 19:51:57 Sagittarius kernel: [ 0.000000] Initializing cgroup subsys cpu Aug 15 19:51:57 Sagittarius kernel: [ 0.000000] Initializing cgroup subsys cpuacct
なんか、chromeがセグっている。確かにchromeでも動画を開いていたけど再生してないし、なんで関係ないプロセスがセグるのかが分からない。
まあ、ともかくエラーを見てみると、snd_pcm_avail()とALSA ドライバー 'snd_hda_intel'あたりが怪しいらしい。
原因を追って見る
ということで、原因解決はしなくても良いのでとりあえず少し追ってみた。
まずは、エラーを出しているpulseaudioのsnd_pcm_avail()から。
ソースコードをaptから取得する
まずはソースコードを取ってくる
準備としてapt lineの'deb
例えば、Debian系でlsのソースコードを取るにはこうする。
$ which ls /bin/ls $ dpkg -S /bin/ls coreutils: /bin/ls $ apt-get source coreutils
追って見る
pulseaudioのコードを取得する
$ apt-get source pulseaudio
grepすると確かにalsa-util.cでsnd_pcm_avail()が呼ばれている。
しかし、snd_pcm_avail()の実体はない。別のパッケージにあるようだ。
$ grep -r snd_pcm_avail . 〜略〜 ./src/modules/alsa/alsa-util.c: n = snd_pcm_avail(pcm); ./src/modules/alsa/alsa-util.c: pa_log(_("snd_pcm_avail() returned a value that is exceptionally large: %lu bytes (%lu ms).\n" ./src/modules/alsa/alsa-util.c: pa_log(_("snd_pcm_avail() returned a value that is exceptionally large: %lu bytes (%lu ms).\n" ./src/modules/alsa/alsa-util.c: pa_log(_("snd_pcm_avail_delay() returned strange values: delay %lu is less than avail %lu.\n" ./src/modules/alsa/alsa-source.c: if *1 == 0) ./src/modules/alsa/alsa-source.c: "We were woken up with POLLIN set -- however a subsequent snd_pcm_avail() returned 0 or another value < min_avail."), ./src/modules/alsa/alsa-source.c: if *2 == 0) ./src/modules/alsa/alsa-source.c: "We were woken up with POLLIN set -- however a subsequent snd_pcm_avail() returned 0 or another value < min_avail."), 〜略〜
さて実体がないとするとライブラリ側にあると考えるのが普通です。
で、grepすると怪しいのはlibasound.so.2.0.0、libalsa-utilあたり。
$ grep -r snd_pcm_avail /usr/lib/ 〜略〜 バイナリファイル /usr/lib/virtualbox/VBoxDD.so に一致しました バイナリファイル /usr/lib/thunderbird/libxul.so に一致しました バイナリファイル /usr/lib/i386-linux-gnu/libasound.so.2.0.0 に一致しました バイナリファイル /usr/lib/i386-linux-gnu/wine/winealsa.drv.so に一致しました バイナリファイル /usr/lib/i386-linux-gnu/libopenal.so.1.14.0 に一致しました バイナリファイル /usr/lib/pulse-4.0/modules/libalsa-util.so に一致しました バイナリファイル /usr/lib/jvm/java-7-openjdk-amd64/jre/lib/amd64/libjsoundalsa.so に一致しました バイナリファイル /usr/lib/x86_64-linux-gnu/libasound.so.2.0.0 に一致しました バイナリファイル /usr/lib/x86_64-linux-gnu/libportaudio.so.2.0.0 に一致しました バイナリファイル /usr/lib/x86_64-linux-gnu/wine/winealsa.drv.so に一致しました バイナリファイル /usr/lib/x86_64-linux-gnu/libopenal.so.1.14.0 に一致しました バイナリファイル /usr/lib/firefox/libxul.so に一致しました バイナリファイル /usr/lib/adobe-flashplugin/libflashplayer.so に一致しました 〜略〜
ということでlibasound2あたりを見てみます。
$ dpkg -S /usr/lib/i386-linux-gnu/libasound.so.2.0.0 libasound2:i386: /usr/lib/i386-linux-gnu/libasound.so.2.0.0 $ apt-get source libasound2 パッケージリストを読み込んでいます... 完了 依存関係ツリーを作成しています 状態情報を読み取っています... 完了 'libasound2' の代わりに 'alsa-lib' をソースパッケージとして選出しています 注意: 'alsa-lib' パッケージは以下の場所の 'Bzr' バージョン制御システムで保守されています: 〜略〜
どうも実体はalsa-libらしいです。ちなみにlibalsa-utilはpulseaudioなので関係なしです。
$ dpkg -S /usr/lib/pulse-4.0/modules/libalsa-util.so pulseaudio: /usr/lib/pulse-4.0/modules/libalsa-util.so
src/pcm/pcm.c
$ grep -r snd_pcm_avail . 〜略〜 ./src/pcm/pcm.c:snd_pcm_sframes_t snd_pcm_avail(snd_pcm_t *pcm) 〜略〜
実装を見てもsnd_hda_intelなんか無い。
snd_pcm_sframes_t snd_pcm_avail(snd_pcm_t *pcm)
{
int err;
assert(pcm);
if (CHECK_SANITY(! pcm->setup)) {
SNDMSG("PCM not set up");
return -EIO;
}
err = pcm->fast_ops->hwsync(pcm->fast_op_arg);
if (err < 0)
return err;
return pcm->fast_ops->avail_update(pcm->fast_op_arg);
}
色々探すと、alsa-driverおよびLinux Kernelにsnd_hda_intelがある事がわかった。
ここ結構分からなくて、手当たりしだい関係してそうなソースコードをダウンロードしてやっと見つけた。
Linuxのドキュメントにsnd_hda_intelの事が書いてあるようだ。
どうも/sysにファイルがあるらしく、きちんと追っていないがalsa-libは多分このファイルをopenしているかもしれない(勝手な憶測)。
linux-3.8.7/Documentation/sound/alsa/HD-Audio.txt:power-saving. See /sys/module/snd_hda_intel/parameters/power_save to
しんどいのでここで追跡は一旦終了。
