[Kamailio-Users] Kernel Message
Daniel-Constantin Mierla
miconda at gmail.com
Thu Feb 12 22:04:16 CET 2009
Hello,
correlating messages:
Feb 12 20:27:22 sw1 kernel: [3273100.093090] INFO: task kamailio:22821
blocked for more than 120 seconds.
and
Process:: ID=14 PID=22821 Type=MI Datagram
seems that one of your MI datagram was blocked for some time. Are you
using MI datagram commands often? What are they?
Cheers,
Daniel
On 02/12/2009 11:00 PM, Brian Chamberlain wrote:
> Hi Daniel
>
>
> Process:: ID=0 PID=22803 Type=attendant
> Process:: ID=1 PID=22804 Type=SIP receiver udp:x.x.x.x:5060
> Process:: ID=2 PID=22805 Type=SIP receiver udp:x.x.x.x:5060
> Process:: ID=3 PID=22806 Type=SIP receiver udp:x.x.x.x:5060
> Process:: ID=4 PID=22807 Type=SIP receiver udp:x.x.x.x:5060
> Process:: ID=5 PID=22808 Type=SIP receiver udp:x.x.x.x:5060
> Process:: ID=6 PID=22809 Type=SIP receiver udp:x.x.x.x:5060
> Process:: ID=7 PID=22810 Type=SIP receiver udp:x.x.x.x:5060
> Process:: ID=8 PID=22811 Type=SIP receiver udp:x.x.x.x:5060
> Process:: ID=9 PID=22812 Type=SIP receiver udp:x.x.x.x:5060
> Process:: ID=10 PID=22813 Type=SIP receiver udp:x.x.x.x:5060
> Process:: ID=11 PID=22814 Type=timer
> Process:: ID=12 PID=22816 Type=MI Datagram
> Process:: ID=13 PID=22820 Type=MI Datagram
> Process:: ID=14 PID=22821 Type=MI Datagram
> Process:: ID=15 PID=22824 Type=MI FIFO
>
>
> Thanks,
> Brian
>
> On 12 Feb 2009, at 20:40, Daniel-Constantin Mierla wrote:
>
>> Hello,
>>
>> yes, there is something to worry until you discovered the cause and
>> might be something not to worry :-) ...
>>
>> can you get the type of that process? Do:
>> kamctl ps
>>
>> and you will see the list of kamailio processes. If it is a SIP
>> worker, then either is a dns block, tcp block (looks like due to
>> timeout) or lock block.
>>
>> Cheers,
>> Daniel
>>
>>
>> On 02/12/2009 10:29 PM, Brian Chamberlain wrote:
>>> Hi All,
>>>
>>> Is this something I should worry about?
>>>
>>> Feb 12 20:27:22 sw1 kernel: [3273100.087148] INFO: task
>>> kamailio:1845 blocked for more than 120 seconds.
>>> Feb 12 20:27:22 sw1 kernel: [3273100.087206] "echo 0 >
>>> /proc/sys/kernel/hung_task_timeout_secs" disables this message.
>>> Feb 12 20:27:22 sw1 kernel: [3273100.087291] kamailio D
>>> 8ce9265a 0 1845 1829
>>> Feb 12 20:27:22 sw1 kernel: [3273100.087346] f6a98da0
>>> 00000082 23f7e426 8ce9265a 000701ae f6a98f2c c302bfa0 00000002
>>> Feb 12 20:27:22 sw1 kernel: [3273100.087427] c01344f6
>>> 001e17ce 00000001 00000000 c01190e6 f6a98da0 f6a98da0 c02c4dc0
>>> Feb 12 20:27:22 sw1 kernel: [3273100.087538] f74eea84
>>> f74eea8c f74eea88 f6a98da0 c02b8846 f68c3d68 f74eea8c f6a98da0
>>> Feb 12 20:27:22 sw1 kernel: [3273100.087648] Call Trace:
>>> Feb 12 20:27:22 sw1 kernel: [3273100.087730] [<c01344f6>]
>>> ktime_get+0xd/0x21
>>> Feb 12 20:27:22 sw1 kernel: [3273100.087784] [<c01190e6>]
>>> hrtick_start_fair+0xeb/0x12c
>>> Feb 12 20:27:22 sw1 kernel: [3273100.087840] [<c02b8846>]
>>> __mutex_lock_slowpath+0x50/0x7b
>>> Feb 12 20:27:22 sw1 kernel: [3273100.087896] [<c02b86dc>]
>>> mutex_lock+0xa/0xb
>>> Feb 12 20:27:22 sw1 kernel: [3273100.087945] [<c02a7ea9>]
>>> unix_dgram_recvmsg+0x3e/0x245
>>> Feb 12 20:27:22 sw1 kernel: [3273100.087998] [<c01318e9>]
>>> autoremove_wake_function+0xd/0x2d
>>> Feb 12 20:27:22 sw1 kernel: [3273100.088055] [<c011845d>]
>>> __wake_up_common+0x2e/0x58
>>> Feb 12 20:27:22 sw1 kernel: [3273100.088109] [<c024ef76>]
>>> sock_recvmsg+0xde/0xf9
>>> Feb 12 20:27:22 sw1 kernel: [3273100.088165] [<c01318dc>]
>>> autoremove_wake_function+0x0/0x2d
>>> Feb 12 20:27:22 sw1 kernel: [3273100.088223] [<c0117c67>]
>>> kunmap_atomic+0x55/0x8a
>>> Feb 12 20:27:22 sw1 kernel: [3273100.088273] [<c0117c79>]
>>> kunmap_atomic+0x67/0x8a
>>> Feb 12 20:27:22 sw1 kernel: [3273100.088327] [<c015ae91>]
>>> get_page_from_freelist+0x34f/0x3e3
>>> Feb 12 20:27:22 sw1 kernel: [3273100.088387] [<c024fd9a>]
>>> sys_recvfrom+0xb4/0x116
>>> Feb 12 20:27:22 sw1 kernel: [3273100.088438] [<c015b0fb>]
>>> __alloc_pages_internal+0xb5/0x34e
>>> Feb 12 20:27:22 sw1 kernel: [3273100.088497] [<c0163cd3>]
>>> handle_mm_fault+0x257/0x690
>>> Feb 12 20:27:22 sw1 kernel: [3273100.088554] [<c025024d>]
>>> sys_socketcall+0x135/0x19e
>>> Feb 12 20:27:22 sw1 kernel: [3273100.088610] [<c0103853>]
>>> sysenter_past_esp+0x78/0xb1
>>> Feb 12 20:27:22 sw1 kernel: [3273100.091119] [<c02b0000>]
>>> acpi_pci_root_add+0x165/0x296
>>> Feb 12 20:27:22 sw1 kernel: [3273100.091174] =======================
>>> Feb 12 20:27:22 sw1 kernel: [3273100.091218] INFO: task
>>> kamailio:1846 blocked for more than 120 seconds.
>>> Feb 12 20:27:22 sw1 kernel: [3273100.091274] "echo 0 >
>>> /proc/sys/kernel/hung_task_timeout_secs" disables this message.
>>> Feb 12 20:27:22 sw1 kernel: [3273100.091358] kamailio D
>>> 00000002 0 1846 1829
>>> Feb 12 20:27:22 sw1 kernel: [3273100.091413] f6a995e0
>>> 00000086 00000000 00000002 00000000 f6a9976c c3017fa0 00000000
>>> Feb 12 20:27:22 sw1 kernel: [3273100.091495] ffffffff
>>> 1d621a39 00000000 00000000 00000000 00000000 00000000 000000ff
>>> Feb 12 20:27:22 sw1 kernel: [3273100.091605] f74eea84
>>> f74eea8c f74eea88 f6a995e0 c02b8846 f74eea8c f6b21d68 f6a995e0
>>> Feb 12 20:27:22 sw1 kernel: [3273100.091715] Call Trace:
>>> Feb 12 20:27:22 sw1 kernel: [3273100.091790] [<c02b8846>]
>>> __mutex_lock_slowpath+0x50/0x7b
>>> Feb 12 20:27:22 sw1 kernel: [3273100.091847] [<c02b86dc>]
>>> mutex_lock+0xa/0xb
>>> Feb 12 20:27:22 sw1 kernel: [3273100.091895] [<c02a7ea9>]
>>> unix_dgram_recvmsg+0x3e/0x245
>>> Feb 12 20:27:22 sw1 kernel: [3273100.091949] [<c0129ab0>]
>>> lock_timer_base+0x19/0x35
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092002] [<c0129b10>]
>>> try_to_del_timer_sync+0x44/0x4a
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092057] [<c024ef76>]
>>> sock_recvmsg+0xde/0xf9
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092108] [<c01297ec>]
>>> process_timeout+0x0/0x5
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092163] [<c01318dc>]
>>> autoremove_wake_function+0x0/0x2d
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092219] [<c015a0d0>]
>>> __rmqueue+0x13/0x174
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092221] [<c0117c67>]
>>> kunmap_atomic+0x55/0x8a
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092221] [<c0117c79>]
>>> kunmap_atomic+0x67/0x8a
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092221] [<c015ae91>]
>>> get_page_from_freelist+0x34f/0x3e3
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092221] [<c024fd9a>]
>>> sys_recvfrom+0xb4/0x116
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092221] [<c015b0fb>]
>>> __alloc_pages_internal+0xb5/0x34e
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092221] [<c0163cd3>]
>>> handle_mm_fault+0x257/0x690
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092221] [<c025024d>]
>>> sys_socketcall+0x135/0x19e
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092221] [<c0103853>]
>>> sysenter_past_esp+0x78/0xb1
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092221] [<c02b0000>]
>>> acpi_pci_root_add+0x165/0x296
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092221] =======================
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092221] INFO: task
>>> kamailio:22820 blocked for more than 120 seconds.
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092221] "echo 0 >
>>> /proc/sys/kernel/hung_task_timeout_secs" disables this message.
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092221] kamailio D
>>> 854aa937 0 22820 22803
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092221] f762fa40
>>> 00000086 2603ada4 854aa937 000767a5 f762fbcc c3021fa0 00000001
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092221] c01344f6
>>> 001fcdbd 00000001 00000000 c01190e6 f762fa40 f762fa40 c02c4dc0
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092221] f6b38544
>>> f6b3854c f6b38548 f762fa40 c02b8846 f68a3d68 f6b3854c f762fa40
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092221] Call Trace:
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092221] [<c01344f6>]
>>> ktime_get+0xd/0x21
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092221] [<c01190e6>]
>>> hrtick_start_fair+0xeb/0x12c
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092221] [<c02b8846>]
>>> __mutex_lock_slowpath+0x50/0x7b
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092221] [<c02b86dc>]
>>> mutex_lock+0xa/0xb
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092274] [<c02a7ea9>]
>>> unix_dgram_recvmsg+0x3e/0x245
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092328] [<c01318e9>]
>>> autoremove_wake_function+0xd/0x2d
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092383] [<c015a05d>]
>>> __rmqueue_smallest+0x83/0xe3
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092438] [<c024ef76>]
>>> sock_recvmsg+0xde/0xf9
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092493] [<c01318dc>]
>>> autoremove_wake_function+0x0/0x2d
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092551] [<c0117c67>]
>>> kunmap_atomic+0x55/0x8a
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092601] [<c0117c79>]
>>> kunmap_atomic+0x67/0x8a
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092653] [<c015ae91>]
>>> get_page_from_freelist+0x34f/0x3e3
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092712] [<c024fd9a>]
>>> sys_recvfrom+0xb4/0x116
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092764] [<c015b0fb>]
>>> __alloc_pages_internal+0xb5/0x34e
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092822] [<c0163cd3>]
>>> handle_mm_fault+0x257/0x690
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092881] [<c025024d>]
>>> sys_socketcall+0x135/0x19e
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092937] [<c0103853>]
>>> sysenter_past_esp+0x78/0xb1
>>> Feb 12 20:27:22 sw1 kernel: [3273100.092991] [<c02b0000>]
>>> acpi_pci_root_add+0x165/0x296
>>> Feb 12 20:27:22 sw1 kernel: [3273100.093046] =======================
>>> Feb 12 20:27:22 sw1 kernel: [3273100.093090] INFO: task
>>> kamailio:22821 blocked for more than 120 seconds.
>>> Feb 12 20:27:22 sw1 kernel: [3273100.093146] "echo 0 >
>>> /proc/sys/kernel/hung_task_timeout_secs" disables this message.
>>> Feb 12 20:27:22 sw1 kernel: [3273100.093230] kamailio D
>>> 8543066c 0 22821 22803
>>> Feb 12 20:27:22 sw1 kernel: [3273100.110119] f762ede0
>>> 00000082 2603ada4 8543066c 000767a5 f762ef6c c3017fa0 00000000
>>> Feb 12 20:27:22 sw1 kernel: [3273100.110201] c01344f6
>>> 001fcdbd 00000002 00000000 c01190e6 f762ede0 f762ede0 c02c4dc0
>>> Feb 12 20:27:22 sw1 kernel: [3273100.110312] f6b38544
>>> f6b3854c f6b38548 f762ede0 c02b8846 f6b3854c f6bfdd68 f762ede0
>>> Feb 12 20:27:22 sw1 kernel: [3273100.110422] Call Trace:
>>> Feb 12 20:27:22 sw1 kernel: [3273100.110493] [<c01344f6>]
>>> ktime_get+0xd/0x21
>>> Feb 12 20:27:22 sw1 kernel: [3273100.110543] [<c01190e6>]
>>> hrtick_start_fair+0xeb/0x12c
>>> Feb 12 20:27:22 sw1 kernel: [3273100.110598] [<c02b8846>]
>>> __mutex_lock_slowpath+0x50/0x7b
>>> Feb 12 20:27:22 sw1 kernel: [3273100.110653] [<c02b86dc>]
>>> mutex_lock+0xa/0xb
>>> Feb 12 20:27:22 sw1 kernel: [3273100.110702] [<c02a7ea9>]
>>> unix_dgram_recvmsg+0x3e/0x245
>>> Feb 12 20:27:22 sw1 kernel: [3273100.110755] [<c01318e9>]
>>> autoremove_wake_function+0xd/0x2d
>>> Feb 12 20:27:22 sw1 kernel: [3273100.110810] [<c011845d>]
>>> __wake_up_common+0x2e/0x58
>>> Feb 12 20:27:22 sw1 kernel: [3273100.110864] [<c024ef76>]
>>> sock_recvmsg+0xde/0xf9
>>> Feb 12 20:27:22 sw1 kernel: [3273100.110919] [<c01318dc>]
>>> autoremove_wake_function+0x0/0x2d
>>> Feb 12 20:27:22 sw1 kernel: [3273100.110976] [<c0117c67>]
>>> kunmap_atomic+0x55/0x8a
>>> Feb 12 20:27:22 sw1 kernel: [3273100.111027] [<c0117c79>]
>>> kunmap_atomic+0x67/0x8a
>>> Feb 12 20:27:22 sw1 kernel: [3273100.111079] [<c015ae91>]
>>> get_page_from_freelist+0x34f/0x3e3
>>> Feb 12 20:27:22 sw1 kernel: [3273100.111138] [<c024fd9a>]
>>> sys_recvfrom+0xb4/0x116
>>> Feb 12 20:27:22 sw1 kernel: [3273100.111189] [<c015b0fb>]
>>> __alloc_pages_internal+0xb5/0x34e
>>> Feb 12 20:27:22 sw1 kernel: [3273100.111248] [<c0163cd3>]
>>> handle_mm_fault+0x257/0x690
>>> Feb 12 20:27:22 sw1 kernel: [3273100.111307] [<c025024d>]
>>> sys_socketcall+0x135/0x19e
>>> Feb 12 20:27:22 sw1 kernel: [3273100.111362] [<c0103853>]
>>> sysenter_past_esp+0x78/0xb1
>>> Feb 12 20:27:22 sw1 kernel: [3273100.111417] [<c02b0000>]
>>> acpi_pci_root_add+0x165/0x296
>>> Feb 12 20:27:22 sw1 kernel: [3273100.111471] =======================
>>>
>>>
>>> ------------------------------------------------------------------------
>>>
>>>
>>> _______________________________________________
>>> Kamailio (OpenSER) - Users mailing list
>>> Users at lists.kamailio.org
>>> http://lists.kamailio.org/cgi-bin/mailman/listinfo/users
>>> http://lists.openser-project.org/cgi-bin/mailman/listinfo/users
>>
>> --
>> Daniel-Constantin Mierla
>> http://www.asipto.com
>>
>>
>
>
>
>
>
>
>
--
Daniel-Constantin Mierla
http://www.asipto.com
More information about the Users
mailing list