-- Executing [15@internalgrp:1] NoOp("Local/15@internalgrp-003d;2", "Internanruf") in new stack -- Executing [15@internalgrp:2] Macro("Local/15@internalgrp-003d;2", "internanruf,15") in new stack -- Executing [s@macro-internanruf:1] Progress("Local/15@internalgrp-003d;2", "") in new stack -- Local/15@internalgrp-003d;1 is making progress passing it to SIP/20-00000020 -- Executing [s@macro-internanruf:2] ExecIf("Local/15@internalgrp-003d;2", "0?Set(TRANSFER_TIMEOUT=35)") in new stack -- Executing [s@macro-internanruf:3] GotoIf("Local/15@internalgrp-003d;2", "0?multi_call,1") in new stack -- Executing [s@macro-internanruf:4] GotoIf("Local/15@internalgrp-003d;2", "0?transfered_call,1") in new stack -- Executing [s@macro-internanruf:5] Goto("Local/15@internalgrp-003d;2", "direct_call,1") in new stack -- Goto (macro-internanruf,direct_call,1) -- Executing [direct_call@macro-internanruf:1] Set("Local/15@internalgrp-003d;2", "TIMEOUT=") in new stack -- Executing [direct_call@macro-internanruf:2] Set("Local/15@internalgrp-003d;2", "__CALLSOURCE=int") in new stack -- Executing [direct_call@macro-internanruf:3] ExecIf("Local/15@internalgrp-003d;2", "0?AGI(ldap_lookup_number.php,15)") in new stack -- Executing [direct_call@macro-internanruf:4] ExecIf("Local/15@internalgrp-003d;2", "0?Set(CALLERID(name)=)") in new stack -- Executing [direct_call@macro-internanruf:5] Goto("Local/15@internalgrp-003d;2", "execute_call,1") in new stack -- Goto (macro-internanruf,execute_call,1) -- Executing [execute_call@macro-internanruf:1] ExecIf("Local/15@internalgrp-003d;2", "0?Set(__CALLSOURCE=ext)") in new stack -- Executing [execute_call@macro-internanruf:2] SIPAddHeader("Local/15@internalgrp-003d;2", ""Alert-Info:\;info=alert-internal\;x-line-id=0"") in new stack -- Executing [execute_call@macro-internanruf:3] AGI("Local/15@internalgrp-003d;2", "lookup_user.php,15") in new stack -- Launched AGI Script /var/lib/asterisk/agi-bin/lookup_user.php -- AGI Script lookup_user.php completed, returning 0 -- Executing [execute_call@macro-internanruf:4] Set("Local/15@internalgrp-003d;2", "_TRANSFER_CONTEXT=internal") in new stack -- Executing [execute_call@macro-internanruf:5] Set("Local/15@internalgrp-003d;2", "_FORWARD_CONTEXT=internal") in new stack -- Executing [execute_call@macro-internanruf:6] AGI("Local/15@internalgrp-003d;2", "extend_dialstring.php,SIP/15,int") in new stack -- Launched AGI Script /var/lib/asterisk/agi-bin/extend_dialstring.php -- extend_dialstring.php,SIP/15,int: REQUESTING_PEER = Local/15@internalgrp -- extend_dialstring.php,SIP/15,int: REDIRECT_FROM = > extend_dialstring.php,SIP/15,int: ==> __SRC_EXTEN_15 = 15 -- AGI Script extend_dialstring.php completed, returning 0 -- Executing [execute_call@macro-internanruf:7] ExecIf("Local/15@internalgrp-003d;2", "0?Set(TIMEOUT=10)") in new stack -- Executing [execute_call@macro-internanruf:8] Set("Local/15@internalgrp-003d;2", "TIMEOUT=10") in new stack -- Executing [execute_call@macro-internanruf:9] ExecIf("Local/15@internalgrp-003d;2", "0?Set(CALLERID(name)=RWS von :)") in new stack -- Executing [execute_call@macro-internanruf:10] Set("Local/15@internalgrp-003d;2", "TIMEOUT=60") in new stack -- Executing [execute_call@macro-internanruf:11] Set("Local/15@internalgrp-003d;2", "ESKALATION=0") in new stack -- Executing [execute_call@macro-internanruf:12] Set("Local/15@internalgrp-003d;2", "DURCHWAHL=15") in new stack -- Executing [execute_call@macro-internanruf:13] NoOp("Local/15@internalgrp-003d;2", "---DURCHWAHL: 15") in new stack -- Executing [execute_call@macro-internanruf:14] ExecIf("Local/15@internalgrp-003d;2", "1?Set(TIMEOUT=60)") in new stack -- Executing [execute_call@macro-internanruf:15] ExecIf("Local/15@internalgrp-003d;2", "1?Set(REDIRRING=0)") in new stack -- Executing [execute_call@macro-internanruf:16] ExecIf("Local/15@internalgrp-003d;2", "1?Set(CALLERID(num)=20)") in new stack -- Executing [execute_call@macro-internanruf:17] NoOp("Local/15@internalgrp-003d;2", "---incalllimit:1 ") in new stack -- Executing [execute_call@macro-internanruf:18] Set("Local/15@internalgrp-003d;2", "GROUP()=15") in new stack -- Executing [execute_call@macro-internanruf:19] Set("Local/15@internalgrp-003d;2", "GROUPCOUNT=1") in new stack -- Executing [execute_call@macro-internanruf:20] ExecIf("Local/15@internalgrp-003d;2", "0?Set(incalllimit=1)") in new stack -- Executing [execute_call@macro-internanruf:21] GotoIf("Local/15@internalgrp-003d;2", "0?busy") in new stack -- Executing [execute_call@macro-internanruf:22] Dial("Local/15@internalgrp-003d;2", "SIP/15,60,rjw%(M)") in new stack == Using SIP RTP CoS mark 5 -- Called SIP/15 -- Local/15@internalgrp-003d;1 is ringing == Extension Changed 15[autohint] new state Ringing for Notify User 20 -- SIP/15-00000021 is ringing -- Local/15@internalgrp-003d;1 is ringing == Extension Changed 20[autohint] new state Idle for Notify User 15 == Extension Changed 20[autohint] new state Idle for Notify User 20 ubuntu*CLI> core show locks ======================================================================= === Currently Held Locks ============================================== ======================================================================= === === (): (times locked) === === Thread ID: 0x7f2b5ec48700 (do_monitor started at [25114] chan_sip.c restart_monitor()) === ---> Lock #0 (chan_sip.c): MUTEX 24629 handle_request_do &netlock 0x7f2b6d5e9f60 (1) /usr/sbin/asterisk(ast_bt_get_addresses+0xe) [0x4e149e] /usr/sbin/asterisk(__ast_pthread_mutex_lock+0xb8) [0x4d6d28] /usr/lib/asterisk/modules/chan_sip.so(+0x83774) [0x7f2b6d3c3774] /usr/lib/asterisk/modules/chan_sip.so(+0x8516e) [0x7f2b6d3c516e] /usr/sbin/asterisk(ast_io_wait+0x6f) [0x4d0acf] /usr/lib/asterisk/modules/chan_sip.so(+0x72062) [0x7f2b6d3b2062] /usr/sbin/asterisk() [0x552105] /lib/x86_64-linux-gnu/libpthread.so.0(+0x6d8c) [0x7f2b83dfad8c] /lib/x86_64-linux-gnu/libc.so.6(clone+0x6d) [0x7f2b8465004d] === ---> Waiting for Lock #1 (chan_sip.c): MUTEX 7771 sip_pvt_lock_full chan 0x1ae0df8 (1) /usr/sbin/asterisk(ast_bt_get_addresses+0xe) [0x4e149e] /usr/sbin/asterisk(__ast_pthread_mutex_lock+0xb8) [0x4d6d28] /usr/lib/asterisk/modules/chan_sip.so(+0x838d1) [0x7f2b6d3c38d1] /usr/lib/asterisk/modules/chan_sip.so(+0x8516e) [0x7f2b6d3c516e] /usr/sbin/asterisk(ast_io_wait+0x6f) [0x4d0acf] /usr/lib/asterisk/modules/chan_sip.so(+0x72062) [0x7f2b6d3b2062] /usr/sbin/asterisk() [0x552105] /lib/x86_64-linux-gnu/libpthread.so.0(+0x6d8c) [0x7f2b83dfad8c] /lib/x86_64-linux-gnu/libc.so.6(clone+0x6d) [0x7f2b8465004d] === --- ---> Locked Here: channel.c line 3714 (__ast_read) === ------------------------------------------------------------------- === === Thread ID: 0x7f2b5ddb6700 (pbx_thread started at [ 5199] pbx.c ast_pbx_start()) === ---> Lock #0 (channel.c): MUTEX 3714 __ast_read chan 0x1ae0df8 (1) /usr/sbin/asterisk(ast_bt_get_addresses+0xe) [0x4e149e] /usr/sbin/asterisk(__ast_pthread_mutex_lock+0xb8) [0x4d6d28] /usr/lib/asterisk/modules/chan_sip.so(+0x838d1) [0x7f2b6d3c38d1] /usr/lib/asterisk/modules/chan_sip.so(+0x8516e) [0x7f2b6d3c516e] /usr/sbin/asterisk(ast_io_wait+0x6f) [0x4d0acf] /usr/lib/asterisk/modules/chan_sip.so(+0x72062) [0x7f2b6d3b2062] /usr/sbin/asterisk() [0x552105] /lib/x86_64-linux-gnu/libpthread.so.0(+0x6d8c) [0x7f2b83dfad8c] /lib/x86_64-linux-gnu/libc.so.6(clone+0x6d) [0x7f2b8465004d] === ------------------------------------------------------------------- === ======================================================================= -- Nobody picked up in 60000 ms == Extension Changed 15[autohint] new state Idle for Notify User 20 -- Executing [execute_call@macro-internanruf:23] Set("Local/15@internalgrp-003d;2", "target_dialstring=SIP/15") in new stack -- Executing [execute_call@macro-internanruf:24] ExecIf("Local/15@internalgrp-003d;2", "0?AGI(extend_dialstring.php,SIP/15,int,notime)") in new stack -- Executing [execute_call@macro-internanruf:25] ExecIf("Local/15@internalgrp-003d;2", "0?Dial(SIP/15,,jw%(M))") in new stack -- Executing [execute_call@macro-internanruf:26] GotoIf("Local/15@internalgrp-003d;2", "0?callback,1") in new stack -- Executing [execute_call@macro-internanruf:27] ExecIf("Local/15@internalgrp-003d;2", "0?Voicemail(15)") in new stack -- Executing [execute_call@macro-internanruf:28] Goto("Local/15@internalgrp-003d;2", "act_busy,1") in new stack -- Goto (macro-internanruf,act_busy,1) -- Executing [act_busy@macro-internanruf:1] NoOp("Local/15@internalgrp-003d;2", "case act_busy") in new stack -- Executing [act_busy@macro-internanruf:2] Macro("Local/15@internalgrp-003d;2", "busy-hangup") in new stack -- Executing [s@macro-busy-hangup:1] Hangup("Local/15@internalgrp-003d;2", "17") in new stack == Spawn extension (macro-busy-hangup, s, 1) exited non-zero on 'Local/15@internalgrp-003d;2' in macro 'busy-hangup' == Spawn extension (macro-internanruf, act_busy, 2) exited non-zero on 'Local/15@internalgrp-003d;2' in macro 'internanruf' == Spawn extension (internalgrp, 15, 2) exited non-zero on 'Local/15@internalgrp-003d;2' ubuntu*CLI> core show locks ======================================================================= === Currently Held Locks ============================================== ======================================================================= === === (): (times locked) === === Thread ID: 0x7f2b5ec48700 (do_monitor started at [25114] chan_sip.c restart_monitor()) === ---> Lock #0 (chan_sip.c): MUTEX 24629 handle_request_do &netlock 0x7f2b6d5e9f60 (1) /usr/sbin/asterisk(ast_bt_get_addresses+0xe) [0x4e149e] /usr/sbin/asterisk(__ast_pthread_mutex_lock+0xb8) [0x4d6d28] /usr/lib/asterisk/modules/chan_sip.so(+0x83774) [0x7f2b6d3c3774] /usr/lib/asterisk/modules/chan_sip.so(+0x8516e) [0x7f2b6d3c516e] /usr/sbin/asterisk(ast_io_wait+0x6f) [0x4d0acf] /usr/lib/asterisk/modules/chan_sip.so(+0x72062) [0x7f2b6d3b2062] /usr/sbin/asterisk() [0x552105] /lib/x86_64-linux-gnu/libpthread.so.0(+0x6d8c) [0x7f2b83dfad8c] /lib/x86_64-linux-gnu/libc.so.6(clone+0x6d) [0x7f2b8465004d] === ---> Waiting for Lock #1 (chan_sip.c): MUTEX 7771 sip_pvt_lock_full chan 0x1ae0df8 (1) /usr/sbin/asterisk(ast_bt_get_addresses+0xe) [0x4e149e] /usr/sbin/asterisk(__ast_pthread_mutex_lock+0xb8) [0x4d6d28] /usr/lib/asterisk/modules/chan_sip.so(+0x838d1) [0x7f2b6d3c38d1] /usr/lib/asterisk/modules/chan_sip.so(+0x8516e) [0x7f2b6d3c516e] /usr/sbin/asterisk(ast_io_wait+0x6f) [0x4d0acf] /usr/lib/asterisk/modules/chan_sip.so(+0x72062) [0x7f2b6d3b2062] /usr/sbin/asterisk() [0x552105] /lib/x86_64-linux-gnu/libpthread.so.0(+0x6d8c) [0x7f2b83dfad8c] /lib/x86_64-linux-gnu/libc.so.6(clone+0x6d) [0x7f2b8465004d] === --- ---> Locked Here: channel.c line 3714 (__ast_read) === ------------------------------------------------------------------- === === Thread ID: 0x7f2b5ddb6700 (pbx_thread started at [ 5199] pbx.c ast_pbx_start()) === ---> Lock #0 (channel.c): MUTEX 3714 __ast_read chan 0x1ae0df8 (1) /usr/sbin/asterisk(ast_bt_get_addresses+0xe) [0x4e149e] /usr/sbin/asterisk(__ast_pthread_mutex_lock+0xb8) [0x4d6d28] /usr/lib/asterisk/modules/chan_sip.so(+0x838d1) [0x7f2b6d3c38d1] /usr/lib/asterisk/modules/chan_sip.so(+0x8516e) [0x7f2b6d3c516e] /usr/sbin/asterisk(ast_io_wait+0x6f) [0x4d0acf] /usr/lib/asterisk/modules/chan_sip.so(+0x72062) [0x7f2b6d3b2062] /usr/sbin/asterisk() [0x552105] /lib/x86_64-linux-gnu/libpthread.so.0(+0x6d8c) [0x7f2b83dfad8c] /lib/x86_64-linux-gnu/libc.so.6(clone+0x6d) [0x7f2b8465004d] === ------------------------------------------------------------------- === =======================================================================