hola tengo el mismo problema yo si escucho pero no me escuchan es una extencion IAX ya abri los puertos pero nada pego aquí mi log espero puedan ayudarme saludos
[2018-08-01 14:29:36] DEBUG[30954]: manager.c:5294 process_message: Running action 'DAHDIShowChannels'
[2018-08-01 14:29:36] DEBUG[30942][C-0000003a]: audiohook.c:308 audiohook_read_frame_both: Failed to get 160 samples from read factory 0x7f116c0053a8
[2018-08-01 14:29:36] DEBUG[30942][C-0000003a]: audiohook.c:275 audiohook_read_frame_both: Read factory 0x7f116c0053a8 and write factory 0x7f116c005fe8 both fail to provide 160 samples
[2018-08-01 14:29:36] DEBUG[30942][C-0000003a]: audiohook.c:308 audiohook_read_frame_both: Failed to get 160 samples from read factory 0x7f116c0053a8
[2018-08-01 14:29:36] DEBUG[30942][C-0000003a]: audiohook.c:275 audiohook_read_frame_both: Read factory 0x7f116c0053a8 and write factory 0x7f116c005fe8 both fail to provide 160 samples
[2018-08-01 14:29:36] DEBUG[2235]: chan_iax2.c:10468 socket_process_helper: Packet arrived out of order (expecting 3, got 2) (frametype = 2, subclass = 100004)
[2018-08-01 14:29:36] DEBUG[2235]: chan_iax2.c:10475 socket_process_helper: Acking anyway
> 0x7f116c0308d0 -- Strict RTP learning complete - Locking on source address 192.168.1.20:11798
[2018-08-01 14:29:39] DEBUG[2231]: chan_iax2.c:11031 socket_process_helper: Immediately destroying 344, having received hangup
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: channel.c:7652 ast_generic_bridge: Didn't get a frame from channel: IAX2/200-344
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: channel.c:8146 ast_channel_bridge: Bridge stops bridging channels IAX2/200-344 and SIP/100-0000003a
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: channel.c:2664 ast_softhangup_nolock: Soft-Hanging up channel 'IAX2/200-344'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:5005 pbx_extension_helper: Launching 'Macro'
-- Executing [h@macro-dial-one:1] Macro("IAX2/200-344", "hangupcall,") in new stack
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:4837 pbx_substitute_variables_helper_full: Function CDR(recordingfile) result is 'exten-100-200-20180801-142931-1533151771.106.wav'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:4905 pbx_substitute_variables_helper_full: Expression result is '0'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:5005 pbx_extension_helper: Launching 'GotoIf'
-- Executing [s@macro-hangupcall:1] GotoIf("IAX2/200-344", "0?endmixmoncheck") in new stack
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:12181 pbx_builtin_gotoif: Not taking any branch
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: app_macro.c:455 macro_exec: Executed application: GotoIf
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:4837 pbx_substitute_variables_helper_full: Function CDR(recordingfile) result is 'exten-100-200-20180801-142931-1533151771.106.wav'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:5005 pbx_extension_helper: Launching 'Set'
-- Executing [s@macro-hangupcall:2] Set("IAX2/200-344", "MIXMON_CALLFILENAME=/var/spool/asterisk/monitor/exten-100-200-20180801-142931-1533151771.106.wav") in new stack
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: app_macro.c:455 macro_exec: Executed application: Set
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:5005 pbx_extension_helper: Launching 'System'
-- Executing [s@macro-hangupcall:3] System("IAX2/200-344", "test -e /var/spool/asterisk/monitor/exten-100-200-20180801-142931-1533151771.106.wav") in new stack
[2018-08-01 14:29:39] DEBUG[30954]: manager.c:5294 process_message: Running action 'Logoff'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: app_macro.c:455 macro_exec: Executed application: System
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:5005 pbx_extension_helper: Launching 'NoOp'
-- Executing [s@macro-hangupcall:4] NoOp("IAX2/200-344", "SYSTEMSTATUS = APPERROR") in new stack
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: app_macro.c:455 macro_exec: Executed application: Noop
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:4905 pbx_substitute_variables_helper_full: Expression result is '0'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:5005 pbx_extension_helper: Launching 'GotoIf'
-- Executing [s@macro-hangupcall:5] GotoIf("IAX2/200-344", "0?finalcdr") in new stack
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:12181 pbx_builtin_gotoif: Not taking any branch
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: app_macro.c:455 macro_exec: Executed application: GotoIf
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:4837 pbx_substitute_variables_helper_full: Function CDR(recordingfile) result is 'exten-100-200-20180801-142931-1533151771.106.wav'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:5005 pbx_extension_helper: Launching 'Set'
-- Executing [s@macro-hangupcall:6] Set("IAX2/200-344", "MIXMON_CALLFILENAME=/var/spool/asterisk/monitor/2018/08/01/exten-100-200-20180801-142931-1533151771.106.wav") in new stack
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: app_macro.c:455 macro_exec: Executed application: Set
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:5005 pbx_extension_helper: Launching 'System'
-- Executing [s@macro-hangupcall:7] System("IAX2/200-344", "test -e /var/spool/asterisk/monitor/2018/08/01/exten-100-200-20180801-142931-1533151771.106.wav") in new stack
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: app_macro.c:455 macro_exec: Executed application: System
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:5005 pbx_extension_helper: Launching 'NoOp'
-- Executing [s@macro-hangupcall:8] NoOp("IAX2/200-344", "SYSTEMSTATUS = SUCCESS") in new stack
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: app_macro.c:455 macro_exec: Executed application: Noop
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:4905 pbx_substitute_variables_helper_full: Expression result is '1'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:5005 pbx_extension_helper: Launching 'GotoIf'
-- Executing [s@macro-hangupcall:9] GotoIf("IAX2/200-344", "1?mmtestsuccess1") in new stack
-- Goto (macro-hangupcall,s,11)
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: app_macro.c:455 macro_exec: Executed application: GotoIf
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:4837 pbx_substitute_variables_helper_full: Function CDR(recordingfile) result is 'exten-100-200-20180801-142931-1533151771.106.wav'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:5005 pbx_extension_helper: Launching 'Set'
-- Executing [s@macro-hangupcall:11] Set("IAX2/200-344", "CDR(recordingfile)=/var/spool/asterisk/monitor/2018/08/01/exten-100-200-20180801-142931-1533151771.106.wav") in new stack
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: app_macro.c:455 macro_exec: Executed application: Set
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:5005 pbx_extension_helper: Launching 'Goto'
-- Executing [s@macro-hangupcall:12] Goto("IAX2/200-344", "finalcdr") in new stack
-- Goto (macro-hangupcall,s,63)
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: app_macro.c:455 macro_exec: Executed application: Goto
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:4837 pbx_substitute_variables_helper_full: Function CDR(recordingfile) result is '/var/spool/asterisk/monitor/2018/08/01/exten-100-200-20180801-142931-1533151771.106.wav'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:5005 pbx_extension_helper: Launching 'NoOp'
-- Executing [s@macro-hangupcall:63] NoOp("IAX2/200-344", "CDR recordingfile set to: /var/spool/asterisk/monitor/2018/08/01/exten-100-200-20180801-142931-1533151771.106.wav") in new stack
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: app_macro.c:455 macro_exec: Executed application: Noop
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:4905 pbx_substitute_variables_helper_full: Expression result is '1'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:5005 pbx_extension_helper: Launching 'GotoIf'
-- Executing [s@macro-hangupcall:64] GotoIf("IAX2/200-344", "1?skiprg") in new stack
-- Goto (macro-hangupcall,s,67)
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: app_macro.c:455 macro_exec: Executed application: GotoIf
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:4905 pbx_substitute_variables_helper_full: Expression result is '1'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:5005 pbx_extension_helper: Launching 'GotoIf'
-- Executing [s@macro-hangupcall:67] GotoIf("IAX2/200-344", "1?skipblkvm") in new stack
-- Goto (macro-hangupcall,s,70)
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: app_macro.c:455 macro_exec: Executed application: GotoIf
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:4905 pbx_substitute_variables_helper_full: Expression result is '1'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:5005 pbx_extension_helper: Launching 'GotoIf'
-- Executing [s@macro-hangupcall:70] GotoIf("IAX2/200-344", "1?theend") in new stack
-- Goto (macro-hangupcall,s,72)
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: app_macro.c:455 macro_exec: Executed application: GotoIf
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:5005 pbx_extension_helper: Launching 'AGI'
-- Executing [s@macro-hangupcall:72] AGI("IAX2/200-344", "hangup.agi") in new stack
-- Launched AGI Script /var/lib/asterisk/agi-bin/hangup.agi
-- <IAX2/200-344>AGI Script hangup.agi completed, returning 0
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: app_macro.c:455 macro_exec: Executed application: AGI
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:5005 pbx_extension_helper: Launching 'Hangup'
-- Executing [s@macro-hangupcall:73] Hangup("IAX2/200-344", "") in new stack
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: channel.c:2664 ast_softhangup_nolock: Soft-Hanging up channel 'IAX2/200-344'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: app_macro.c:449 macro_exec: Spawn extension (macro-hangupcall,s,73) exited non-zero on 'IAX2/200-344' in macro 'hangupcall'
== Spawn extension (macro-hangupcall, s, 73) exited non-zero on 'IAX2/200-344' in macro 'hangupcall'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:6305 ast_pbx_h_exten_run: Spawn extension (macro-dial-one,h,1) exited non-zero on 'IAX2/200-344'
== Spawn extension (macro-dial-one, h, 1) exited non-zero on 'IAX2/200-344'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: cdr_mysql.c:343 mysql_log: Inserting a CDR record.
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: cdr_mysql.c:346 mysql_log: SQL command as follows: INSERT INTO cdr (calldate
,clid
,src
,dst
,dcontext
,channel
,dstchannel
,lastapp
,lastdata
,duration
,billsec
,disposition
,amaflags
,uniqueid
,recordingfile
,cnum
,cnam
) VALUES ('2018-08-01 14:29:31','\"israel\" <200>','200','100','from-internal','IAX2/200-344','SIP/100-0000003a','Dial','SIP/100,,TtrI','8','4','ANSWERED','3','1533151771.106','/var/spool/asterisk/monitor/2018/08/01/exten-100-200-20180801-142931-1533151771.106.wav','200','israel')
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:4837 pbx_substitute_variables_helper_full: Function CDR(start) result is '2018-08-01 14:29:31'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:4837 pbx_substitute_variables_helper_full: Function CDR(clid) result is '"israel" <200>'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:4837 pbx_substitute_variables_helper_full: Function CDR(dcontext) result is 'from-internal'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:4837 pbx_substitute_variables_helper_full: Function CDR(channel) result is 'IAX2/200-344'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:4837 pbx_substitute_variables_helper_full: Function CDR(dstchannel) result is 'SIP/100-0000003a'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:4837 pbx_substitute_variables_helper_full: Function CDR(lastapp) result is 'Dial'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:4837 pbx_substitute_variables_helper_full: Function CDR(lastdata) result is 'SIP/100,,TtrI'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:4837 pbx_substitute_variables_helper_full: Function CDR(duration) result is '8'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:4837 pbx_substitute_variables_helper_full: Function CDR(billsec) result is '4'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:4837 pbx_substitute_variables_helper_full: Function CDR(disposition) result is 'ANSWERED'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:4837 pbx_substitute_variables_helper_full: Function CDR(amaflags) result is 'DOCUMENTATION'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:4837 pbx_substitute_variables_helper_full: Function CDR(accountcode) result is '(null)'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:4837 pbx_substitute_variables_helper_full: Function CDR(uniqueid) result is '1533151771.106'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:4837 pbx_substitute_variables_helper_full: Function CDR(userfield) result is '(null)'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:4837 pbx_substitute_variables_helper_full: Function CDR(test) result is '(null)'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:4837 pbx_substitute_variables_helper_full: Function CDR(src) result is '200'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:4837 pbx_substitute_variables_helper_full: Function CDR(dst) result is '100'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: cdr_sqlite3_custom.c:261 write_cdr: About to log: INSERT INTO cdr (calldate,clid,dcontext,channel,dstchannel,lastapp,lastdata,duration,billsec,disposition,amaflags,accountcode,uniqueid,userfield,test,src,dst) VALUES ('2018-08-01 14:29:31','"israel" <200>','from-internal','IAX2/200-344','SIP/100-0000003a','Dial','SIP/100,,TtrI','8','4','ANSWERED','DOCUMENTATION','','1533151771.106','','','200','100')
[2018-08-01 14:29:39] DEBUG[30961]: manager.c:5294 process_message: Running action 'Login'
[2018-08-01 14:29:39] DEBUG[30961]: manager.c:5294 process_message: Running action 'MailboxCount'
[2018-08-01 14:29:39] DEBUG[30961]: manager.c:5294 process_message: Running action 'MailboxCount'
[2018-08-01 14:29:39] DEBUG[30961]: manager.c:5294 process_message: Running action 'MailboxCount'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: channel.c:2843 ast_hangup: Hanging up channel 'SIP/100-0000003a'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: chan_sip.c:6929 sip_hangup: Hangup call SIP/100-0000003a, SIP callid 4ed09d332a173fd85bb5411f0f2ecc86@192.168.1.10:5060
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: res_rtp_asterisk.c:5126 ast_rtp_remote_address_set: Setting RTCP address on RTP instance '0x7f116c18ae98'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: chan_sip.c:3731 sip_xmit: Trying to put 'BYE sip:100' onto UDP socket destined for 192.168.1.20:5062
[2018-08-01 14:29:39] DEBUG[30961]: manager.c:5294 process_message: Running action 'Command'
[2018-08-01 14:29:39] DEBUG[30961]: manager.c:5294 process_message: Running action 'Command'
[2018-08-01 14:29:39] DEBUG[30961]: manager.c:5294 process_message: Running action 'Command'
[2018-08-01 14:29:39] DEBUG[30961]: manager.c:5294 process_message: Running action 'Command'
[2018-08-01 14:29:39] DEBUG[30961]: manager.c:5294 process_message: Running action 'Command'
[2018-08-01 14:29:39] DEBUG[30961]: manager.c:5294 process_message: Running action 'SIPpeers'
[2018-08-01 14:29:39] DEBUG[30961]: manager.c:5294 process_message: Running action 'IAXpeerlist'
[2018-08-01 14:29:39] DEBUG[30961]: manager.c:5294 process_message: Running action 'Status'
[2018-08-01 14:29:39] DEBUG[30961]: manager.c:5294 process_message: Running action 'QueueStatus'
[2018-08-01 14:29:39] DEBUG[30961]: manager.c:5294 process_message: Running action 'MeetmeList'
[2018-08-01 14:29:39] DEBUG[30961]: manager.c:5294 process_message: Running action 'ParkedCalls'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: app_dial.c:3120 dial_exec_full: Exiting with DIALSTATUS=ANSWER.
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: app_macro.c:449 macro_exec: Spawn extension (macro-dial-one,s,43) exited non-zero on 'IAX2/200-344' in macro 'dial-one'
== Spawn extension (macro-dial-one, s, 43) exited non-zero on 'IAX2/200-344' in macro 'dial-one'
[2018-08-01 14:29:39] DEBUG[30961]: manager.c:5294 process_message: Running action 'DAHDIShowChannels'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: app_macro.c:449 _macro_exec: Spawn extension (macro-exten-vm,s,7) exited non-zero on 'IAX2/200-344' in macro 'exten-vm'
== Spawn extension (macro-exten-vm, s, 7) exited non-zero on 'IAX2/200-344' in macro 'exten-vm'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: pbx.c:6789 ast_pbx_run: Spawn extension (from-internal,100,2) exited non-zero on 'IAX2/200-344'
== Spawn extension (from-internal, 100, 2) exited non-zero on 'IAX2/200-344'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: channel.c:2664 ast_softhangup_nolock: Soft-Hanging up channel 'IAX2/200-344'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: channel.c:2843 ast_hangup: Hanging up channel 'IAX2/200-344'
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: chan_iax2.c:5389 iax2_hangup: We're hanging up IAX2/200-344 now...
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: chan_iax2.c:5406 iax2_hangup: Really destroying IAX2/200-344 now...
[2018-08-01 14:29:39] DEBUG[30941][C-0000003a]: chan_iax2.c:2908 sched_delay_remove: schedule decrement of callno used for 187.222.45.143 in 60 seconds
-- Hungup 'IAX2/200-344'
[2018-08-01 14:29:39] DEBUG[30942][C-0000003a]: autochan.c:71 ast_autochan_destroy: Removed autochan 0x7f116c1c9220 from the list, about to free it
== MixMonitor close filestream (mixed)
== End MixMonitor Recording IAX2/200-344
[2018-08-01 14:29:39] DEBUG[2245][C-0000003a]: chan_sip.c:4429 sip_ack: Stopping retransmission on '4ed09d332a173fd85bb5411f0f2ecc86@192.168.1.10:5060' of Request 103: Match Found
[2018-08-01 14:29:39] DEBUG[2245]: rtp_engine.c:232 instance_destructor: Destroyed RTP instance '0x7f116c18ae98'
[2018-08-01 14:29:39] DEBUG[30961]: manager.c:5294 process_message: Running action 'Logoff'
[2018-08-01 14:29:39] DEBUG[30964]: manager.c:5294 process_message: Running action 'Login'
[2018-08-01 14:29:39] DEBUG[30964]: manager.c:5294 process_message: Running action 'MailboxCount'
[2018-08-01 14:29:39] DEBUG[30964]: manager.c:5294 process_message: Running action 'MailboxCount'
[2018-08-01 14:29:39] DEBUG[30964]: manager.c:5294 process_message: Running action 'MailboxCount'
[2018-08-01 14:29:39] DEBUG[30964]: manager.c:5294 process_message: Running action 'Command'
[2018-08-01 14:29:39] DEBUG[30964]: manager.c:5294 process_message: Running action 'Command'
[2018-08-01 14:29:39] DEBUG[30964]: manager.c:5294 process_message: Running action 'Command'
[2018-08-01 14:29:39] DEBUG[30964]: manager.c:5294 process_message: Running action 'Command'
[2018-08-01 14:29:39] DEBUG[30964]: manager.c:5294 process_message: Running action 'Command'
[2018-08-01 14:29:39] DEBUG[30964]: manager.c:5294 process_message: Running action 'SIPpeers'
[2018-08-01 14:29:39] DEBUG[30964]: manager.c:5294 process_message: Running action 'IAXpeerlist'
[2018-08-01 14:29:39] DEBUG[30964]: manager.c:5294 process_message: Running action 'Status'
[2018-08-01 14:29:39] DEBUG[30964]: manager.c:5294 process_message: Running action 'QueueStatus'
[2018-08-01 14:29:39] DEBUG[30964]: manager.c:5294 process_message: Running action 'MeetmeList'
[2018-08-01 14:29:39] DEBUG[30964]: manager.c:5294 process_message: Running action 'ParkedCalls'
[2018-08-01 14:29:39] DEBUG[30964]: manager.c:5294 process_message: Running action 'DAHDIShowChannels'
[2018-08-01 14:29:39] DEBUG[30964]: manager.c:5294 process_message: Running action 'Logoff'
[2018-08-01 14:29:39] DEBUG[30967]: manager.c:5294 process_message: Running action 'Login'
[2018-08-01 14:29:39] DEBUG[30967]: manager.c:5294 process_message: Running action 'MailboxCount'
[2018-08-01 14:29:39] DEBUG[30967]: manager.c:5294 process_message: Running action 'MailboxCount'
[2018-08-01 14:29:39] DEBUG[30967]: manager.c:5294 process_message: Running action 'MailboxCount'
[2018-08-01 14:29:39] DEBUG[30967]: manager.c:5294 process_message: Running action 'Command'
[2018-08-01 14:29:39] DEBUG[30967]: manager.c:5294 process_message: Running action 'Command'
[2018-08-01 14:29:39] DEBUG[30967]: manager.c:5294 process_message: Running action 'Command'
[2018-08-01 14:29:39] DEBUG[30967]: manager.c:5294 process_message: Running action 'Command'
[2018-08-01 14:29:39] DEBUG[30967]: manager.c:5294 process_message: Running action 'Command'
[2018-08-01 14:29:39] DEBUG[30967]: manager.c:5294 process_message: Running action 'SIPpeers'
[2018-08-01 14:29:39] DEBUG[30967]: manager.c:5294 process_message: Running action 'IAXpeerlist'
[2018-08-01 14:29:39] DEBUG[30967]: manager.c:5294 process_message: Running action 'Status'
[2018-08-01 14:29:39] DEBUG[30967]: manager.c:5294 process_message: Running action 'QueueStatus'
[2018-08-01 14:29:39] DEBUG[30967]: manager.c:5294 process_message: Running action 'MeetmeList'
[2018-08-01 14:29:39] DEBUG[30967]: manager.c:5294 process_message: Running action 'ParkedCalls'
[2018-08-01 14:29:39] DEBUG[30967]: manager.c:5294 process_message: Running action 'DAHDIShowChannels'
[2018-08-01 14:29:47] DEBUG[2230]: chan_iax2.c:2584 peercnt_remove: ip callno count decremented to 4 for 187.222.45.143
[2018-08-01 14:29:48] DEBUG[2232]: chan_iax2.c:2552 peercnt_add: ip callno count incremented to 5 for 187.222.45.143
[2018-08-01 14:29:48] DEBUG[2239]: chan_iax2.c:2552 peercnt_add: ip callno count incremented to 6 for 187.222.45.143
[2018-08-01 14:29:48] DEBUG[2235]: chan_iax2.c:2552 peercnt_add: ip callno count incremented to 7 for 187.222.45.143
[2018-08-01 14:29:48] DEBUG[2231]: chan_iax2.c:2552 peercnt_add: ip callno count incremented to 8 for 187.222.45.143
[2018-08-01 14:29:48] DEBUG[2233]: chan_iax2.c:2908 sched_delay_remove: schedule decrement of callno used for 187.222.45.143 in 60 seconds
[2018-08-01 14:29:50] DEBUG[2230]: chan_iax2.c:2584 peercnt_remove: ip callno count decremented to 7 for 187.222.45.143
[2018-08-01 14:29:50] DEBUG[2236]: chan_iax2.c:2552 peercnt_add: ip callno count incremented to 8 for 187.222.45.143
[2018-08-01 14:29:50] DEBUG[2232]: chan_iax2.c:2908 sched_delay_remove: schedule decrement of callno used for 187.222.45.143 in 60 seconds
[2018-08-01 14:29:50] DEBUG[2232]: chan_iax2.c:11246 socket_process_helper: Peer 200: got pong, lastms 453, historicms 453, maxms 2000
[2018-08-01 14:29:57] DEBUG[2245]: chan_sip.c:8677 sip_alloc: Allocating new SIP dialog for 4e502ea8322f2f9a58c4cc0b4899d4fd@127.0.0.1:5060 - OPTIONS (No RTP)
[2018-08-01 14:29:57] DEBUG[2245]: chan_sip.c:8463 change_callid_pvt: SIP call-id changed from '4e502ea8322f2f9a58c4cc0b4899d4fd@127.0.0.1:5060' to '243a3b651392cb7b680a9eb824da83ca@192.168.1.10:5060'
[2018-08-01 14:29:57] DEBUG[2245]: chan_sip.c:3374 initialize_initreq: Initializing initreq for method OPTIONS - callid 243a3b651392cb7b680a9eb824da83ca@192.168.1.10:5060
[2018-08-01 14:29:57] DEBUG[2245]: chan_sip.c:3731 sip_xmit: Trying to put 'OPTIONS sip' onto UDP socket destined for 192.168.1.21:5062
[2018-08-01 14:29:57] DEBUG[2245]: chan_sip.c:4429 __sip_ack: Stopping retransmission on '243a3b651392cb7b680a9eb824da83ca@192.168.1.10:5060' of Request 102: Match Found
[2018-08-01 14:30:02] DEBUG[2230]: chan_iax2.c:2584 peercnt_remove: ip callno count decremented to 7 for 187.222.45.143
-- Remote UNIX connection
-- Remote UNIX connection disconnected
[2018-08-01 14:30:03] DEBUG[2235]: chan_iax2.c:2908 sched_delay_remove: schedule decrement of callno used for 187.222.45.143 in 60 seconds
issabel*CLI> [root@issabel ~]#