public inbox for linux-kernel@vger.kernel.org
 help / color / mirror / Atom feed
* [BUG] 2.6.31-rt10
@ 2009-09-16 22:43 Knut Petersen
  2009-09-17  7:29 ` Thomas Gleixner
  0 siblings, 1 reply; 2+ messages in thread
From: Knut Petersen @ 2009-09-16 22:43 UTC (permalink / raw)
  To: tglx; +Cc: linux-kernel

[-- Attachment #1: Type: text/plain, Size: 752 bytes --]

Hi Thomas!

Well, I thought it was a good idea to test the rt patch.
Never did that before. Cyclictest output looked great, but then
i tried to do some audio recording. I used "chrt 80 arecord ..."
to record at 96kHz/16bit stereo from an RME Digi96/PAD.
That seemed to work fine on an idle machine. So I put
some extra load on the machine. A "make -j 16" kernel
compilation locks keyboard and screen within minutes,
no matter if X is running or not. The attached part of
/var/log/messages shows two of those events - I deleted all
but the very first log entries.

Hardware:
Aopen i915GMm-hfs, RME Digi96/PAD
Meinberg PCI32 DCF radio clock,
2GB RAM, Pentium M 1.86 MHz.

Software:
opensues 11.2 MS 7, kernel 2.6.31-rt10,
reiserfs partitions.

cu,
 Knut

[-- Attachment #2: messages --]
[-- Type: text/plain, Size: 20785 bytes --]

Sep 16 22:17:08 linux pppd[2362]: Script /etc/ppp/ip-down finished (pid 10148), status = 0x0
Sep 16 22:21:06 linux kernel: [13539.454613] BUG: sleeping function called from invalid context at kernel/rtmutex.c:684
Sep 16 22:21:06 linux kernel: [13539.454663] in_atomic(): 1, irqs_disabled(): 1, pid: 2397, name: Xorg
Sep 16 22:21:06 linux kernel: [13539.454694] Pid: 2397, comm: Xorg Not tainted 2.6.31-rt10-kape #11
Sep 16 22:21:06 linux kernel: [13539.454721] Call Trace:
Sep 16 22:21:06 linux kernel: [13539.454749]  [<c011add8>] __might_sleep+0xb1/0xb6
Sep 16 22:21:06 linux kernel: [13539.454778]  [<c03cc059>] rt_spin_lock+0x23/0x56
Sep 16 22:21:06 linux kernel: [13539.454805]  [<c03cbd1a>] __account_scheduler_latency+0x66/0x19b
Sep 16 22:21:06 linux kernel: [13539.454838]  [<c018d8f7>] ? poll_schedule_timeout+0x27/0x3e
Sep 16 22:21:06 linux kernel: [13539.454866]  [<c018dcb7>] ? do_sys_poll+0x33f/0x3be
Sep 16 22:21:06 linux kernel: [13539.454892]  [<c018de6e>] ? sys_poll+0x42/0x8b
Sep 16 22:21:06 linux kernel: [13539.454917]  [<c01027f0>] ? sysenter_do_call+0x12/0x22
Sep 16 22:21:06 linux kernel: [13539.454948]  [<c011d3ce>] enqueue_entity+0x15f/0x2df
Sep 16 22:21:06 linux kernel: [13539.454976]  [<c011d56d>] enqueue_task_fair+0x1f/0x59
Sep 16 22:21:06 linux kernel: [13539.455003]  [<c0119bf3>] enqueue_task+0x4f/0x5b
Sep 16 22:21:06 linux kernel: [13539.455029]  [<c0119d26>] activate_task+0x1f/0x24
Sep 16 22:21:06 linux kernel: [13539.455056]  [<c011de98>] try_to_wake_up+0xb9/0x1b3
Sep 16 22:21:06 linux kernel: [13539.455084]  [<c011df9f>] default_wake_function+0xd/0xf
Sep 16 22:21:06 linux kernel: [13539.455111]  [<c018e940>] pollwake+0x57/0x63
Sep 16 22:21:06 linux kernel: [13539.455137]  [<c011df92>] ? default_wake_function+0x0/0xf
Sep 16 22:21:06 linux kernel: [13539.455165]  [<c011a198>] __wake_up_common+0x34/0x5c
Sep 16 22:21:06 linux kernel: [13539.455193]  [<c011b3bf>] __wake_up_sync_key+0x30/0x3e
Sep 16 22:21:06 linux kernel: [13539.455221]  [<c011b3d7>] __wake_up_sync+0xa/0xd
Sep 16 22:21:06 linux kernel: [13539.455248]  [<c03be619>] unix_write_space+0x43/0x6d
Sep 16 22:21:06 linux kernel: [13539.455277]  [<c03636d1>] sock_wfree+0x2b/0x3e
Sep 16 22:21:06 linux kernel: [13539.455302]  [<c036662b>] skb_release_head_state+0x39/0x84
Sep 16 22:21:06 linux kernel: [13539.455330]  [<c0366457>] __kfree_skb+0xb/0x6d
Sep 16 22:21:06 linux kernel: [13539.455354]  [<c0366503>] kfree_skb+0x24/0x26
Sep 16 22:21:06 linux kernel: [13539.455379]  [<c03be0f7>] unix_stream_recvmsg+0x339/0x447
Sep 16 22:21:06 linux kernel: [13539.455410]  [<c0360901>] sock_aio_read+0x10c/0x116
Sep 16 22:21:06 linux kernel: [13539.455442]  [<c0181c23>] do_sync_read+0xa8/0xe3
Sep 16 22:21:06 linux kernel: [13539.455471]  [<c0133045>] ? autoremove_wake_function+0x0/0x2f
Sep 16 22:21:06 linux kernel: [13539.455502]  [<c0126546>] ? do_setitimer+0x16e/0x2b9
Sep 16 22:21:06 linux kernel: [13539.455532]  [<c01fb9e4>] ? security_file_permission+0xf/0x11
Sep 16 22:21:06 linux kernel: [13539.455562]  [<c0181cf6>] ? rw_verify_area+0x98/0xbb
Sep 16 22:21:06 linux kernel: [13539.455590]  [<c01826f6>] vfs_read+0x98/0x139
Sep 16 22:21:06 linux kernel: [13539.455616]  [<c018282e>] sys_read+0x3b/0x60
Sep 16 22:21:06 linux kernel: [13539.455641]  [<c01027f0>] sysenter_do_call+0x12/0x22
Sep 16 22:21:09 linux kernel: [13540.458987] BUG: sleeping function called from invalid context at kernel/rtmutex.c:684
Sep 16 22:21:09 linux kernel: [13540.459036] in_atomic(): 1, irqs_disabled(): 1, pid: 2397, name: Xorg
Sep 16 22:21:09 linux kernel: [13540.459068] Pid: 2397, comm: Xorg Not tainted 2.6.31-rt10-kape #11
Sep 16 22:21:09 linux kernel: [13540.459095] Call Trace:
Sep 16 22:21:09 linux kernel: [13540.459122]  [<c011add8>] __might_sleep+0xb1/0xb6
Sep 16 22:21:09 linux kernel: [13540.459152]  [<c03cc059>] rt_spin_lock+0x23/0x56
Sep 16 22:21:09 linux kernel: [13540.459179]  [<c03cbd1a>] __account_scheduler_latency+0x66/0x19b
Sep 16 22:21:09 linux kernel: [13540.459212]  [<c018d8f7>] ? poll_schedule_timeout+0x27/0x3e
Sep 16 22:21:09 linux kernel: [13540.459240]  [<c018dcb7>] ? do_sys_poll+0x33f/0x3be
Sep 16 22:21:09 linux kernel: [13540.459266]  [<c018de6e>] ? sys_poll+0x42/0x8b
Sep 16 22:21:09 linux kernel: [13540.459291]  [<c01027f0>] ? sysenter_do_call+0x12/0x22
Sep 16 22:21:09 linux kernel: [13540.459322]  [<c011d3ce>] enqueue_entity+0x15f/0x2df
Sep 16 22:21:09 linux kernel: [13540.459350]  [<c011d56d>] enqueue_task_fair+0x1f/0x59
Sep 16 22:21:09 linux kernel: [13540.459378]  [<c0119bf3>] enqueue_task+0x4f/0x5b
Sep 16 22:21:09 linux kernel: [13540.459403]  [<c0119d26>] activate_task+0x1f/0x24
Sep 16 22:21:09 linux kernel: [13540.459430]  [<c011de98>] try_to_wake_up+0xb9/0x1b3
Sep 16 22:21:09 linux kernel: [13540.459456]  [<c018e8e9>] ? pollwake+0x0/0x63
Sep 16 22:21:09 linux kernel: [13540.459483]  [<c011df9f>] default_wake_function+0xd/0xf
Sep 16 22:21:09 linux kernel: [13540.459509]  [<c018e940>] pollwake+0x57/0x63
Sep 16 22:21:09 linux kernel: [13540.459535]  [<c011df92>] ? default_wake_function+0x0/0xf
Sep 16 22:21:09 linux kernel: [13540.459564]  [<c011a198>] __wake_up_common+0x34/0x5c
Sep 16 22:21:09 linux kernel: [13540.459592]  [<c011b3bf>] __wake_up_sync_key+0x30/0x3e
Sep 16 22:21:09 linux kernel: [13540.459620]  [<c011b3d7>] __wake_up_sync+0xa/0xd
Sep 16 22:21:09 linux kernel: [13540.459646]  [<c03be619>] unix_write_space+0x43/0x6d
Sep 16 22:21:09 linux kernel: [13540.459676]  [<c03636d1>] sock_wfree+0x2b/0x3e
Sep 16 22:21:09 linux kernel: [13540.459701]  [<c036662b>] skb_release_head_state+0x39/0x84
Sep 16 22:21:09 linux kernel: [13540.459729]  [<c0366457>] __kfree_skb+0xb/0x6d
Sep 16 22:21:09 linux kernel: [13540.459753]  [<c0366503>] kfree_skb+0x24/0x26
Sep 16 22:21:09 linux kernel: [13540.459778]  [<c03be0f7>] unix_stream_recvmsg+0x339/0x447
Sep 16 22:21:09 linux kernel: [13540.459809]  [<c0360901>] sock_aio_read+0x10c/0x116
Sep 16 22:21:09 linux kernel: [13540.459841]  [<c0181c23>] do_sync_read+0xa8/0xe3
Sep 16 22:21:09 linux kernel: [13540.459869]  [<c0133045>] ? autoremove_wake_function+0x0/0x2f
Sep 16 22:21:09 linux kernel: [13540.459900]  [<c0126546>] ? do_setitimer+0x16e/0x2b9
Sep 16 22:21:09 linux kernel: [13540.459930]  [<c01fb9e4>] ? security_file_permission+0xf/0x11
Sep 16 22:21:09 linux kernel: [13540.459960]  [<c0181cf6>] ? rw_verify_area+0x98/0xbb
Sep 16 22:21:09 linux kernel: [13540.459988]  [<c01826f6>] vfs_read+0x98/0x139
Sep 16 22:21:09 linux kernel: [13540.460014]  [<c018282e>] sys_read+0x3b/0x60
Sep 16 22:21:09 linux kernel: [13540.460039]  [<c01027f0>] sysenter_do_call+0x12/0x22
Sep 16 22:21:09 linux kernel: [13541.457425] BUG: sleeping function called from invalid context at kernel/rtmutex.c:684
Sep 16 22:21:09 linux kernel: [13541.457458] in_atomic(): 1, irqs_disabled(): 1, pid: 40, name: irq/16-i915
Sep 16 22:21:09 linux kernel: [13541.457472] Pid: 40, comm: irq/16-i915 Not tainted 2.6.31-rt10-kape #11
Sep 16 22:21:09 linux kernel: [13541.457484] Call Trace:
Sep 16 22:21:09 linux kernel: [13541.457501]  [<c011add8>] __might_sleep+0xb1/0xb6
Sep 16 22:21:09 linux kernel: [13541.457515]  [<c03cc059>] rt_spin_lock+0x23/0x56
Sep 16 22:21:09 linux kernel: [13541.457527]  [<c03cbd1a>] __account_scheduler_latency+0x66/0x19b
Sep 16 22:21:09 linux kernel: [13541.457542]  [<c02aa6fd>] ? i915_wait_request+0x12e/0x1ae
Sep 16 22:21:09 linux kernel: [13541.457554]  [<c02aa806>] ? i915_gem_object_wait_rendering+0x28/0x2a
Sep 16 22:21:09 linux kernel: [13541.457568]  [<c02aa830>] ? i915_gem_object_set_to_gtt_domain+0x28/0x71
Sep 16 22:21:09 linux kernel: [13541.457581]  [<c02aad66>] ? i915_gem_set_domain_ioctl+0x99/0x113
Sep 16 22:21:09 linux kernel: [13541.457597]  [<c0298008>] ? drm_ioctl+0x1f5/0x282
Sep 16 22:21:09 linux kernel: [13541.457610]  [<c018c7c1>] ? vfs_ioctl+0x57/0x71
Sep 16 22:21:09 linux kernel: [13541.457621]  [<c018cd80>] ? do_vfs_ioctl+0x4ea/0x528
Sep 16 22:21:09 linux kernel: [13541.457633]  [<c018cdff>] ? sys_ioctl+0x41/0x61
Sep 16 22:21:09 linux kernel: [13541.457645]  [<c01027f0>] ? sysenter_do_call+0x12/0x22
Sep 16 22:21:09 linux kernel: [13541.457658]  [<c011d3ce>] enqueue_entity+0x15f/0x2df
Sep 16 22:21:09 linux kernel: [13541.457670]  [<c011d56d>] enqueue_task_fair+0x1f/0x59
Sep 16 22:21:09 linux kernel: [13541.457682]  [<c0119bf3>] enqueue_task+0x4f/0x5b
Sep 16 22:21:09 linux kernel: [13541.457693]  [<c0119d26>] activate_task+0x1f/0x24
Sep 16 22:21:09 linux kernel: [13541.457704]  [<c011de98>] try_to_wake_up+0xb9/0x1b3
Sep 16 22:21:09 linux kernel: [13541.457717]  [<c011df9f>] default_wake_function+0xd/0xf
Sep 16 22:21:09 linux kernel: [13541.457730]  [<c0133054>] autoremove_wake_function+0xf/0x2f
Sep 16 22:21:09 linux kernel: [13541.457743]  [<c011a198>] __wake_up_common+0x34/0x5c
Sep 16 22:21:09 linux kernel: [13541.457754]  [<c011b400>] __wake_up+0x26/0x34
Sep 16 22:21:09 linux kernel: [13541.457765]  [<c02a77e5>] i915_driver_irq_handler+0x8e8/0x93b
Sep 16 22:21:09 linux kernel: [13541.457778]  [<c03cab0d>] ? __schedule+0x417/0x467
Sep 16 22:21:09 linux kernel: [13541.457791]  [<c0153e92>] irq_thread+0xa7/0x151
Sep 16 22:21:09 linux kernel: [13541.457802]  [<c0153deb>] ? irq_thread+0x0/0x151
Sep 16 22:21:09 linux kernel: [13541.457813]  [<c0132e61>] kthread+0x68/0x6d
Sep 16 22:21:09 linux kernel: [13541.457823]  [<c0132df9>] ? kthread+0x0/0x6d
Sep 16 22:21:09 linux kernel: [13541.457834]  [<c01030e3>] kernel_thread_helper+0x7/0x10


[Restarted PC]


Sep 16 23:26:51 linux kernel: [  177.901615] BUG: sleeping function called from invalid context at kernel/rtmutex.c:684
Sep 16 23:26:51 linux kernel: [  177.901653] in_atomic(): 1, irqs_disabled(): 1, pid: 7, name: sirq-block/0
Sep 16 23:26:51 linux kernel: [  177.901681] Pid: 7, comm: sirq-block/0 Not tainted 2.6.31-rt10-kape #13
Sep 16 23:26:51 linux kernel: [  177.901705] Call Trace:
Sep 16 23:26:51 linux kernel: [  177.901728]  [<c011add8>] __might_sleep+0xb1/0xb6
Sep 16 23:26:51 linux kernel: [  177.901755]  [<c0399189>] rt_spin_lock+0x23/0x56
Sep 16 23:26:51 linux kernel: [  177.901779]  [<c0398e4a>] __account_scheduler_latency+0x66/0x19b
Sep 16 23:26:51 linux kernel: [  177.901809]  [<c019d739>] ? sync_buffer+0x2e/0x32
Sep 16 23:26:51 linux kernel: [  177.901831]  [<c019d6a8>] ? __wait_on_buffer+0x19/0x1c
Sep 16 23:26:51 linux kernel: [  177.901858]  [<c01d78d4>] ? search_by_key+0x142/0xee4
Sep 16 23:26:51 linux kernel: [  177.901882]  [<c01c9b1e>] ? reiserfs_read_locked_inode+0x5a/0x554
Sep 16 23:26:51 linux kernel: [  177.901909]  [<c01ca062>] ? reiserfs_iget+0x4a/0x7d
Sep 16 23:26:51 linux kernel: [  177.901931]  [<c01c6dd1>] ? reiserfs_lookup+0x81/0xd1
Sep 16 23:26:51 linux kernel: [  177.901956]  [<c0188636>] ? do_lookup+0xa7/0x151
Sep 16 23:26:51 linux kernel: [  177.901979]  [<c018a59b>] ? __link_path_walk+0x78f/0xb21
Sep 16 23:26:51 linux kernel: [  177.902003]  [<c018aa76>] ? path_walk+0x38/0x71
Sep 16 23:26:51 linux kernel: [  177.902026]  [<c018ab63>] ? do_path_lookup+0x21/0x6e
Sep 16 23:26:51 linux kernel: [  177.902050]  [<c018b38a>] ? user_path_at+0x39/0x5f
Sep 16 23:26:51 linux kernel: [  177.902072]  [<c0184e8f>] ? vfs_fstatat+0x2d/0x54
Sep 16 23:26:51 linux kernel: [  177.902097]  [<c011d4cf>] enqueue_entity+0x260/0x2df
Sep 16 23:26:51 linux kernel: [  177.902121]  [<c011d546>] ? enqueue_entity+0x2d7/0x2df
Sep 16 23:26:51 linux kernel: [  177.902147]  [<c011d56d>] enqueue_task_fair+0x1f/0x59
Sep 16 23:26:51 linux kernel: [  177.902171]  [<c0119bf3>] enqueue_task+0x4f/0x5b
Sep 16 23:26:51 linux kernel: [  177.902194]  [<c0119d26>] activate_task+0x1f/0x24
Sep 16 23:26:51 linux kernel: [  177.902217]  [<c011de98>] try_to_wake_up+0xb9/0x1b3
Sep 16 23:26:51 linux kernel: [  177.902240]  [<c0119d26>] ? activate_task+0x1f/0x24
Sep 16 23:26:51 linux kernel: [  177.902264]  [<c011df76>] ? try_to_wake_up+0x197/0x1b3
Sep 16 23:26:51 linux kernel: [  177.902289]  [<c011df9f>] default_wake_function+0xd/0xf
Sep 16 23:26:51 linux kernel: [  177.902315]  [<c0133054>] autoremove_wake_function+0xf/0x2f
Sep 16 23:26:51 linux kernel: [  177.902341]  [<c013309e>] wake_bit_function+0x2a/0x37
Sep 16 23:26:51 linux kernel: [  177.902365]  [<c011a198>] __wake_up_common+0x34/0x5c
Sep 16 23:26:51 linux kernel: [  177.902389]  [<c011b400>] __wake_up+0x26/0x34
Sep 16 23:26:51 linux kernel: [  177.902411]  [<c0132fe7>] __wake_up_bit+0x27/0x2a
Sep 16 23:26:51 linux kernel: [  177.902434]  [<c0133041>] wake_up_bit+0x57/0x5b
Sep 16 23:26:51 linux kernel: [  177.902456]  [<c019d74d>] unlock_buffer+0x10/0x12
Sep 16 23:26:51 linux kernel: [  177.902479]  [<c019d7e2>] end_buffer_read_sync+0x19/0x1f
Sep 16 23:26:51 linux kernel: [  177.902504]  [<c019c71e>] end_bio_bh_io_sync+0x2b/0x35
Sep 16 23:26:51 linux kernel: [  177.902529]  [<c019f668>] bio_endio+0x22/0x24
Sep 16 23:26:51 linux kernel: [  177.902553]  [<c02178ef>] req_bio_endio+0xa5/0xc7
Sep 16 23:26:51 linux kernel: [  177.902576]  [<c0217a0c>] blk_update_request+0xfb/0x28e
Sep 16 23:26:51 linux kernel: [  177.902602]  [<c0217bad>] blk_update_bidi_request+0xe/0x3c
Sep 16 23:26:51 linux kernel: [  177.902628]  [<c021849e>] blk_end_bidi_request+0x15/0x47
Sep 16 23:26:51 linux kernel: [  177.902654]  [<c0218504>] blk_end_request+0xa/0xc
Sep 16 23:26:51 linux kernel: [  177.902677]  [<c02b3b10>] scsi_io_completion+0x191/0x3bf
Sep 16 23:26:51 linux kernel: [  177.902702]  [<c02b38ae>] ? scsi_device_unbusy+0x7e/0x83
Sep 16 23:26:51 linux kernel: [  177.902729]  [<c02ae351>] scsi_finish_command+0xce/0xd6
Sep 16 23:26:51 linux kernel: [  177.902753]  [<c02b3e33>] scsi_softirq_done+0xe6/0xee
Sep 16 23:26:51 linux kernel: [  177.902778]  [<c021b861>] blk_done_softirq+0x55/0x62
Sep 16 23:26:51 linux kernel: [  177.902803]  [<c0127457>] ksoftirqd+0xed/0x1ac
Sep 16 23:26:51 linux kernel: [  177.902826]  [<c012736a>] ? ksoftirqd+0x0/0x1ac
Sep 16 23:26:51 linux kernel: [  177.902847]  [<c0132e61>] kthread+0x68/0x6d
Sep 16 23:26:51 linux kernel: [  177.902869]  [<c0132df9>] ? kthread+0x0/0x6d
Sep 16 23:26:51 linux kernel: [  177.902891]  [<c01030e3>] kernel_thread_helper+0x7/0x10
Sep 16 23:26:52 linux kernel: [  179.152586] BUG: sleeping function called from invalid context at kernel/rtmutex.c:684
Sep 16 23:26:52 linux kernel: [  179.152623] in_atomic(): 1, irqs_disabled(): 1, pid: 2721, name: smpppd
Sep 16 23:26:52 linux kernel: [  179.152652] Pid: 2721, comm: smpppd Not tainted 2.6.31-rt10-kape #13
Sep 16 23:26:52 linux kernel: [  179.152675] Call Trace:
Sep 16 23:26:52 linux kernel: [  179.152698]  [<c011add8>] __might_sleep+0xb1/0xb6
Sep 16 23:26:52 linux kernel: [  179.152724]  [<c0399189>] rt_spin_lock+0x23/0x56
Sep 16 23:26:52 linux kernel: [  179.152748]  [<c0398e4a>] __account_scheduler_latency+0x66/0x19b
Sep 16 23:26:52 linux kernel: [  179.152778]  [<c018d8f7>] ? poll_schedule_timeout+0x27/0x3e
Sep 16 23:26:52 linux kernel: [  179.152802]  [<c018e3ab>] ? do_select+0x4b5/0x4f0
Sep 16 23:26:52 linux kernel: [  179.152823]  [<c018e5ab>] ? core_sys_select+0x1c5/0x299
Sep 16 23:26:52 linux kernel: [  179.152846]  [<c018e829>] ? sys_select+0x6a/0x86
Sep 16 23:26:52 linux kernel: [  179.152868]  [<c01027f0>] ? sysenter_do_call+0x12/0x22
Sep 16 23:26:52 linux kernel: [  179.152894]  [<c011d3ce>] enqueue_entity+0x15f/0x2df
Sep 16 23:26:52 linux kernel: [  179.152919]  [<c011d56d>] enqueue_task_fair+0x1f/0x59
Sep 16 23:26:52 linux kernel: [  179.152943]  [<c0119bf3>] enqueue_task+0x4f/0x5b
Sep 16 23:26:52 linux kernel: [  179.152965]  [<c0119d26>] activate_task+0x1f/0x24
Sep 16 23:26:52 linux kernel: [  179.152988]  [<c011de98>] try_to_wake_up+0xb9/0x1b3
Sep 16 23:26:52 linux kernel: [  179.153012]  [<c011df9f>] default_wake_function+0xd/0xf
Sep 16 23:26:52 linux kernel: [  179.153035]  [<c018e940>] pollwake+0x57/0x63
Sep 16 23:26:52 linux kernel: [  179.153057]  [<c011df92>] ? default_wake_function+0x0/0xf
Sep 16 23:26:52 linux kernel: [  179.153082]  [<c011a198>] __wake_up_common+0x34/0x5c
Sep 16 23:26:52 linux kernel: [  179.153106]  [<c011b3bf>] __wake_up_sync_key+0x30/0x3e
Sep 16 23:26:52 linux kernel: [  179.153130]  [<c011b3d7>] __wake_up_sync+0xa/0xd
Sep 16 23:26:52 linux kernel: [  179.153155]  [<c038b989>] unix_write_space+0x43/0x6d
Sep 16 23:26:52 linux kernel: [  179.153178]  [<c0330a41>] sock_wfree+0x2b/0x3e
Sep 16 23:26:52 linux kernel: [  179.153201]  [<c033399b>] skb_release_head_state+0x39/0x84
Sep 16 23:26:52 linux kernel: [  179.153225]  [<c03337c7>] __kfree_skb+0xb/0x6d
Sep 16 23:26:52 linux kernel: [  179.153246]  [<c0333873>] kfree_skb+0x24/0x26
Sep 16 23:26:52 linux kernel: [  179.153268]  [<c038b467>] unix_stream_recvmsg+0x339/0x447
Sep 16 23:26:52 linux kernel: [  179.153298]  [<c032dc71>] sock_aio_read+0x10c/0x116
Sep 16 23:26:52 linux kernel: [  179.153325]  [<c0181c23>] do_sync_read+0xa8/0xe3
Sep 16 23:26:52 linux kernel: [  179.153350]  [<c0133045>] ? autoremove_wake_function+0x0/0x2f
Sep 16 23:26:52 linux kernel: [  179.153376]  [<c013a164>] ? ktime_get_ts+0xc0/0xca
Sep 16 23:26:52 linux kernel: [  179.153400]  [<c022943c>] ? copy_to_user+0x38/0x10e
Sep 16 23:26:52 linux kernel: [  179.153426]  [<c01fb9e4>] ? security_file_permission+0xf/0x11
Sep 16 23:26:52 linux kernel: [  179.153451]  [<c0181cf6>] ? rw_verify_area+0x98/0xbb
Sep 16 23:26:52 linux kernel: [  179.153475]  [<c01826f6>] vfs_read+0x98/0x139
Sep 16 23:26:52 linux kernel: [  179.153498]  [<c018282e>] sys_read+0x3b/0x60
Sep 16 23:26:52 linux kernel: [  179.153519]  [<c01027f0>] sysenter_do_call+0x12/0x22
Sep 16 23:26:53 linux kernel: [  180.176745] BUG: sleeping function called from invalid context at kernel/rtmutex.c:684
Sep 16 23:26:53 linux kernel: [  180.176780] in_atomic(): 1, irqs_disabled(): 1, pid: 2721, name: smpppd
Sep 16 23:26:53 linux kernel: [  180.176808] Pid: 2721, comm: smpppd Not tainted 2.6.31-rt10-kape #13
Sep 16 23:26:53 linux kernel: [  180.176832] Call Trace:
Sep 16 23:26:53 linux kernel: [  180.176854]  [<c011add8>] __might_sleep+0xb1/0xb6
Sep 16 23:26:53 linux kernel: [  180.176879]  [<c0399189>] rt_spin_lock+0x23/0x56
Sep 16 23:26:53 linux kernel: [  180.176903]  [<c0398e4a>] __account_scheduler_latency+0x66/0x19b
Sep 16 23:26:53 linux kernel: [  180.176932]  [<c018d8f7>] ? poll_schedule_timeout+0x27/0x3e
Sep 16 23:26:53 linux kernel: [  180.176956]  [<c018e3ab>] ? do_select+0x4b5/0x4f0
Sep 16 23:26:53 linux kernel: [  180.176977]  [<c018e5ab>] ? core_sys_select+0x1c5/0x299
Sep 16 23:26:53 linux kernel: [  180.177000]  [<c018e829>] ? sys_select+0x6a/0x86
Sep 16 23:26:53 linux kernel: [  180.177022]  [<c01027f0>] ? sysenter_do_call+0x12/0x22
Sep 16 23:26:53 linux kernel: [  180.177048]  [<c011d3ce>] enqueue_entity+0x15f/0x2df
Sep 16 23:26:53 linux kernel: [  180.177073]  [<c011d56d>] enqueue_task_fair+0x1f/0x59
Sep 16 23:26:53 linux kernel: [  180.177096]  [<c0119bf3>] enqueue_task+0x4f/0x5b
Sep 16 23:26:53 linux kernel: [  180.177118]  [<c0119d26>] activate_task+0x1f/0x24
Sep 16 23:26:53 linux kernel: [  180.177141]  [<c011de98>] try_to_wake_up+0xb9/0x1b3
Sep 16 23:26:53 linux kernel: [  180.177166]  [<c011df9f>] default_wake_function+0xd/0xf
Sep 16 23:26:53 linux kernel: [  180.177189]  [<c018e940>] pollwake+0x57/0x63
Sep 16 23:26:53 linux kernel: [  180.177211]  [<c011df92>] ? default_wake_function+0x0/0xf
Sep 16 23:26:53 linux kernel: [  180.177236]  [<c011a198>] __wake_up_common+0x34/0x5c
Sep 16 23:26:53 linux kernel: [  180.177260]  [<c011b3bf>] __wake_up_sync_key+0x30/0x3e
Sep 16 23:26:53 linux kernel: [  180.177284]  [<c011b3d7>] __wake_up_sync+0xa/0xd
Sep 16 23:26:53 linux kernel: [  180.177308]  [<c038b989>] unix_write_space+0x43/0x6d
Sep 16 23:26:53 linux kernel: [  180.177332]  [<c0330a41>] sock_wfree+0x2b/0x3e
Sep 16 23:26:53 linux kernel: [  180.177355]  [<c033399b>] skb_release_head_state+0x39/0x84
Sep 16 23:26:53 linux kernel: [  180.177379]  [<c03337c7>] __kfree_skb+0xb/0x6d
Sep 16 23:26:53 linux kernel: [  180.177400]  [<c0333873>] kfree_skb+0x24/0x26
Sep 16 23:26:53 linux kernel: [  180.177422]  [<c038b467>] unix_stream_recvmsg+0x339/0x447
Sep 16 23:26:53 linux kernel: [  180.177451]  [<c032dc71>] sock_aio_read+0x10c/0x116
Sep 16 23:26:53 linux kernel: [  180.177478]  [<c0181c23>] do_sync_read+0xa8/0xe3
Sep 16 23:26:53 linux kernel: [  180.177503]  [<c0133045>] ? autoremove_wake_function+0x0/0x2f
Sep 16 23:26:53 linux kernel: [  180.177529]  [<c013a164>] ? ktime_get_ts+0xc0/0xca
Sep 16 23:26:53 linux kernel: [  180.177552]  [<c022943c>] ? copy_to_user+0x38/0x10e
Sep 16 23:26:53 linux kernel: [  180.177577]  [<c01fb9e4>] ? security_file_permission+0xf/0x11
Sep 16 23:26:53 linux kernel: [  180.177603]  [<c0181cf6>] ? rw_verify_area+0x98/0xbb
Sep 16 23:26:53 linux kernel: [  180.177627]  [<c01826f6>] vfs_read+0x98/0x139
Sep 16 23:26:53 linux kernel: [  180.177649]  [<c018282e>] sys_read+0x3b/0x60
Sep 16 23:26:53 linux kernel: [  180.177670]  [<c01027f0>] sysenter_do_call+0x12/0x22

[-- Attachment #3: .config --]
[-- Type: application/x-config, Size: 63489 bytes --]

^ permalink raw reply	[flat|nested] 2+ messages in thread

* Re: [BUG] 2.6.31-rt10
  2009-09-16 22:43 [BUG] 2.6.31-rt10 Knut Petersen
@ 2009-09-17  7:29 ` Thomas Gleixner
  0 siblings, 0 replies; 2+ messages in thread
From: Thomas Gleixner @ 2009-09-17  7:29 UTC (permalink / raw)
  To: Knut Petersen; +Cc: linux-kernel

Knut,

On Thu, 17 Sep 2009, Knut Petersen wrote:
> Hi Thomas!
> 
> Well, I thought it was a good idea to test the rt patch.
> Never did that before. Cyclictest output looked great, but then
> i tried to do some audio recording. I used "chrt 80 arecord ..."
> to record at 96kHz/16bit stereo from an RME Digi96/PAD.
> That seemed to work fine on an idle machine. So I put
> some extra load on the machine. A "make -j 16" kernel
> compilation locks keyboard and screen within minutes,
> no matter if X is running or not. The attached part of
> /var/log/messages shows two of those events - I deleted all
> but the very first log entries.

Duh, never used latencytop on RT. Patch below should fix that.

Thanks,

	tglx
---
diff --git a/kernel/latencytop.c b/kernel/latencytop.c
index ca07c5c..34311e1 100644
--- a/kernel/latencytop.c
+++ b/kernel/latencytop.c
@@ -59,7 +59,7 @@
 #include <linux/slab.h>
 #include <linux/stacktrace.h>
 
-static DEFINE_SPINLOCK(latency_lock);
+static DEFINE_ATOMIC_SPINLOCK(latency_lock);
 
 #define MAXLR 128
 static struct latency_record latency_record[MAXLR];
@@ -73,19 +73,19 @@ void clear_all_latency_tracing(struct task_struct *p)
 	if (!latencytop_enabled)
 		return;
 
-	spin_lock_irqsave(&latency_lock, flags);
+	atomic_spin_lock_irqsave(&latency_lock, flags);
 	memset(&p->latency_record, 0, sizeof(p->latency_record));
 	p->latency_record_count = 0;
-	spin_unlock_irqrestore(&latency_lock, flags);
+	atomic_spin_unlock_irqrestore(&latency_lock, flags);
 }
 
 static void clear_global_latency_tracing(void)
 {
 	unsigned long flags;
 
-	spin_lock_irqsave(&latency_lock, flags);
+	atomic_spin_lock_irqsave(&latency_lock, flags);
 	memset(&latency_record, 0, sizeof(latency_record));
-	spin_unlock_irqrestore(&latency_lock, flags);
+	atomic_spin_unlock_irqrestore(&latency_lock, flags);
 }
 
 static void __sched
@@ -191,7 +191,7 @@ __account_scheduler_latency(struct task_struct *tsk, int usecs, int inter)
 	lat.max = usecs;
 	store_stacktrace(tsk, &lat);
 
-	spin_lock_irqsave(&latency_lock, flags);
+	atomic_spin_lock_irqsave(&latency_lock, flags);
 
 	account_global_scheduler_latency(tsk, &lat);
 
@@ -233,7 +233,7 @@ __account_scheduler_latency(struct task_struct *tsk, int usecs, int inter)
 	memcpy(&tsk->latency_record[i], &lat, sizeof(struct latency_record));
 
 out_unlock:
-	spin_unlock_irqrestore(&latency_lock, flags);
+	atomic_spin_unlock_irqrestore(&latency_lock, flags);
 }
 
 static int lstats_show(struct seq_file *m, void *v)


^ permalink raw reply related	[flat|nested] 2+ messages in thread

end of thread, other threads:[~2009-09-17  7:29 UTC | newest]

Thread overview: 2+ messages (download: mbox.gz follow: Atom feed
-- links below jump to the message on this page --
2009-09-16 22:43 [BUG] 2.6.31-rt10 Knut Petersen
2009-09-17  7:29 ` Thomas Gleixner

This is a public inbox, see mirroring instructions
for how to clone and mirror all data and code used for this inbox