the 1.2.1 asterisk version, have a problem:
when the voicemail app is called (su@), the SELECT search the context field empty:
Jan 6 17:04:19 DEBUG[3655] res_config_mysql.c: MySQL RealTime: Retrieve SQL: SELECT * FROM voicemail_users WHERE mailbox = ‘12010002’ AND context = ''
is doesn´t use any context name, because the app do not find the context…
if you use the field context NULL, the app find it.
context field empty, working:
Jan 6 17:04:19 DEBUG[3585] chan_sip.c: Allocating new SIP dialog for 5f21105e0a62dc1c05892ecf102840f2@xxx.xxx.xxx.xxx - INVITE (With RTP)
Jan 6 17:04:19 DEBUG[3585] chan_sip.c: **** Received INVITE (5) - Command in SIP INVITE
Jan 6 17:04:19 DEBUG[3585] chan_sip.c: Checking SIP call limits for device
Jan 6 17:04:19 DEBUG[3585] chan_sip.c: Updating call counter for incoming call
Jan 6 17:04:19 DEBUG[3585] chan_sip.c: build_route: Contact hop: sip:12010000@xxx.xxx.xxx.xxx
Jan 6 17:04:19 DEBUG[3574] chan_sip.c: Checking device state for peer xxx.xxx.xxx.xxx
Jan 6 17:04:19 DEBUG[3574] devicestate.c: Changing state for SIP/xxx.xxx.xxx.xxx - state 2 (In use)
Jan 6 17:04:19 DEBUG[3655] pbx.c: Launching ‘VoiceMail’
Jan 6 17:04:19 DEBUG[3656] app_queue.c: Device ‘SIP/xxx.xxx.xxx.xxx’ changed to state ‘2’ (In use)
Jan 6 17:04:19 VERBOSE[3655] logger.c: – Executing VoiceMail(“SIP/xxx.xxx.xxx.xxx-b7a01750”, “su12010002@teste”) in new stack
Jan 6 17:04:19 DEBUG[3655] chan_sip.c: sip_answer(SIP/xxx.xxx.xxx.xxx-b7a01750)
Jan 6 17:04:19 DEBUG[3574] chan_sip.c: Checking device state for peer xxx.xxx.xxx.xxx
Jan 6 17:04:19 DEBUG[3574] channel.c: Avoiding initial deadlock for ‘SIP/xxx.xxx.xxx.xxx-b7a01750’
Jan 6 17:04:19 DEBUG[3655] res_config_mysql.c: MySQL RealTime: Retrieve SQL: SELECT * FROM voicemail_users WHERE mailbox = ‘12010002’ AND context = ‘‘
Jan 6 17:04:19 DEBUG[3655] res_config_mysql.c: MySQL RealTime: Everything is fine.
Jan 6 17:04:19 DEBUG[3585] chan_sip.c: = Found Their Call ID: 5f21105e0a62dc1c05892ecf102840f2@xxx.xxx.xxx.xxx Their Tag as6a281e5d Our tag: as4e9f70bd
Jan 6 17:04:19 DEBUG[3585] chan_sip.c: **** Received ACK (6) - Command in SIP ACK
Jan 6 17:04:19 DEBUG[3585] chan_sip.c: Stopping retransmission on '5f21105e0a62dc1c05892ecf102840f2@xxx.xxx.xxx.xxx’ of Response 102: Match Found
Jan 6 17:04:19 DEBUG[3655] app_voicemail.c: /var/spool/asterisk/voicemail//12010002/unavail doesn’t exist, doing what we can
Jan 6 17:04:19 DEBUG[3655] channel.c: Set channel SIP/xxx.xxx.xxx.xxx-b7a01750 to write format gsm
Jan 6 17:04:19 DEBUG[3655] rtp.c: Ooh, format changed from unknown to gsm
Jan 6 17:04:19 VERBOSE[3655] logger.c: – Playing ‘vm-theperson’ (language ‘en’)
Jan 6 17:04:19 DEBUG[3574] devicestate.c: Changing state for SIP/xxx.xxx.xxx.xxx - state 2 (In use)
Jan 6 17:04:19 DEBUG[3657] app_queue.c: Device ‘SIP/xxx.xxx.xxx.xxx’ changed to state ‘2’ (In use)
Jan 6 17:04:21 DEBUG[3655] channel.c: Set channel SIP/xxx.xxx.xxx.xxx-b7a01750 to write format gsm
Jan 6 17:04:21 DEBUG[3655] channel.c: Set channel SIP/xxx.xxx.xxx.xxx-b7a01750 to write format gsm
Jan 6 17:04:21 VERBOSE[3655] logger.c: – Playing ‘digits/1’ (language ‘en’)
Jan 6 17:04:21 DEBUG[3655] channel.c: Set channel SIP/xxx.xxx.xxx.xxx-b7a01750 to write format gsm
Jan 6 17:04:21 DEBUG[3655] channel.c: Set channel SIP/xxx.xxx.xxx.xxx-b7a01750 to write format gsm
Jan 6 17:04:21 VERBOSE[3655] logger.c: – Playing ‘digits/2’ (language ‘en’)
Jan 6 17:04:22 DEBUG[3655] channel.c: Set channel SIP/xxx.xxx.xxx.xxx-b7a01750 to write format gsm
Jan 6 17:04:22 DEBUG[3655] channel.c: Set channel SIP/xxx.xxx.xxx.xxx-b7a01750 to write format gsm
Jan 6 17:04:22 VERBOSE[3655] logger.c: – Playing ‘digits/0’ (language ‘en’)
Jan 6 17:04:22 DEBUG[3585] chan_sip.c: = Found Their Call ID: 5f21105e0a62dc1c05892ecf102840f2@xxx.xxx.xxx.xxx Their Tag as6a281e5d Our tag: as4e9f70bd
Jan 6 17:04:22 DEBUG[3585] chan_sip.c: **** Received BYE (8) - Command in SIP BYE
Jan 6 17:04:22 DEBUG[3655] channel.c: Set channel SIP/xxx.xxx.xxx.xxx-b7a01750 to write format gsm
Jan 6 17:04:22 DEBUG[3655] app_voicemail.c: Hang up during prefile playback
Jan 6 17:04:22 DEBUG[3655] pbx.c: Spawn extension (default,**12010002,1) exited non-zero on ‘SIP/xxx.xxx.xxx.xxx-b7a01750’
Jan 6 17:04:22 DEBUG[3655] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record.
Jan 6 17:04:22 DEBUG[3655] cdr_addon_mysql.c: cdr_mysql: SQL command as follows: INSERT INTO cdr (calldate,clid,src,dst,dcontext,channel,dstchannel,lastapp,lastdata,duration,billsec,disposition,amaflags,accountcode,userfield) VALUES (‘2006-01-06 17:04:19’,’“Rafael Aquino” <12010000>’,‘12010000’,’**12010002’,‘default’, ‘SIP/xxx.xxx.xxx.xxx-b7a01750’,’’,‘VoiceMail’,‘su12010002@teste’,3,3,‘ANSWERED’,3,’’,’’)
Jan 6 17:04:22 DEBUG[3655] pbx.c: Function result is '“Rafael Aquino” <12010000>'
Jan 6 17:04:22 DEBUG[3655] pbx.c: Function result is '12010000’
Jan 6 17:04:22 DEBUG[3655] pbx.c: Function result is '**12010002’
Jan 6 17:04:22 DEBUG[3655] pbx.c: Function result is 'default’
Jan 6 17:04:22 DEBUG[3655] pbx.c: Function result is 'SIP/xxx.xxx.xxx.xxx-b7a01750’
Jan 6 17:04:22 DEBUG[3655] pbx.c: Function result is '(null)'
Jan 6 17:04:22 DEBUG[3655] pbx.c: Function result is 'VoiceMail’
Jan 6 17:04:22 DEBUG[3655] pbx.c: Function result is 'su12010002@teste’
Jan 6 17:04:22 DEBUG[3655] pbx.c: Function result is '2006-01-06 17:04:19’
Jan 6 17:04:22 DEBUG[3655] pbx.c: Function result is '2006-01-06 17:04:19’
Jan 6 17:04:22 DEBUG[3655] pbx.c: Function result is '2006-01-06 17:04:22’
Jan 6 17:04:22 DEBUG[3655] pbx.c: Function result is '3’
Jan 6 17:04:22 DEBUG[3655] pbx.c: Function result is '3’
Jan 6 17:04:22 DEBUG[3655] pbx.c: Function result is 'ANSWERED’
Jan 6 17:04:22 DEBUG[3655] pbx.c: Function result is 'DOCUMENTATION’
Jan 6 17:04:22 DEBUG[3655] pbx.c: Function result is '(null)'
Jan 6 17:04:22 DEBUG[3655] pbx.c: Function result is '1136574259.7’
Jan 6 17:04:22 DEBUG[3655] pbx.c: Function result is '(null)'
Jan 6 17:04:22 DEBUG[3655] channel.c: Hanging up channel 'SIP/xxx.xxx.xxx.xxx-b7a01750’
Jan 6 17:04:22 DEBUG[3655] chan_sip.c: Hangup call SIP/xxx.xxx.xxx.xxx-b7a01750, SIP callid 5f21105e0a62dc1c05892ecf102840f2@xxx.xxx.xxx.xxx)
Jan 6 17:04:22 DEBUG[3655] chan_sip.c: update_call_counter() - decrement call limit counter
Jan 6 17:04:22 DEBUG[3655] chan_sip.c: Updating call counter for incoming call
Jan 6 17:04:22 DEBUG[3574] chan_sip.c: Checking device state for peer xxx.xxx.xxx.xxx
Jan 6 17:04:22 DEBUG[3574] devicestate.c: Changing state for SIP/xxx.xxx.xxx.xxx - state 1 (Not in use)
Jan 6 17:04:22 DEBUG[3658] app_queue.c: Device ‘SIP/xxx.xxx.xxx.xxx’ changed to state ‘1’ (Not in use)
context field as teste, don´t working:
Jan 6 16:54:42 DEBUG[3585] chan_sip.c: Allocating new SIP dialog for 3d85c1e03f37ab9e28362a7054ec0e8b@xxx.xxx.xxx.xxx - INVITE (With RTP)
Jan 6 16:54:42 DEBUG[3585] chan_sip.c: **** Received INVITE (5) - Command in SIP INVITE
Jan 6 16:54:42 DEBUG[3585] chan_sip.c: Checking SIP call limits for device
Jan 6 16:54:42 DEBUG[3585] chan_sip.c: Updating call counter for incoming call
Jan 6 16:54:42 DEBUG[3585] chan_sip.c: build_route: Contact hop: sip:12010000@xxx.xxx.xxx.xxx
Jan 6 16:54:42 DEBUG[3574] chan_sip.c: Checking device state for peer xxx.xxx.xxx.xxx
Jan 6 16:54:42 DEBUG[3574] devicestate.c: Changing state for SIP/xxx.xxx.xxx.xxx - state 2 (In use)
Jan 6 16:54:42 DEBUG[3638] pbx.c: Launching ‘VoiceMail’
Jan 6 16:54:42 DEBUG[3639] app_queue.c: Device ‘SIP/xxx.xxx.xxx.xxx’ changed to state ‘2’ (In use)
Jan 6 16:54:42 VERBOSE[3638] logger.c: – Executing VoiceMail(“SIP/xxx.xxx.xxx.xxx-b7a01750”, “su12010002@teste”) in new stack
Jan 6 16:54:42 DEBUG[3638] chan_sip.c: sip_answer(SIP/xxx.xxx.xxx.xxx-b7a01750)
Jan 6 16:54:42 DEBUG[3574] chan_sip.c: Checking device state for peer xxx.xxx.xxx.xxx
Jan 6 16:54:42 DEBUG[3574] channel.c: Avoiding initial deadlock for ‘SIP/xxx.xxx.xxx.xxx-b7a01750’
Jan 6 16:54:42 DEBUG[3638] res_config_mysql.c: MySQL RealTime: Retrieve SQL: SELECT * FROM voicemail_users WHERE mailbox = ‘12010002’ AND context = ‘‘
Jan 6 16:54:42 DEBUG[3638] res_config_mysql.c: MySQL RealTime: Everything is fine.
Jan 6 16:54:42 WARNING[3638] app_voicemail.c: No entry in voicemail config file for ‘12010002’
Jan 6 16:54:42 DEBUG[3638] pbx.c: Launching ‘Hangup’
Jan 6 16:54:42 VERBOSE[3638] logger.c: – Executing Hangup(“SIP/xxx.xxx.xxx.xxx-b7a01750”, “”) in new stack
Jan 6 16:54:42 DEBUG[3638] pbx.c: Spawn extension (default,**12010002,2) exited non-zero on ‘SIP/xxx.xxx.xxx.xxx-b7a01750’
Jan 6 16:54:42 DEBUG[3638] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record.
Jan 6 16:54:42 DEBUG[3585] chan_sip.c: = Found Their Call ID: 3d85c1e03f37ab9e28362a7054ec0e8b@xxx.xxx.xxx.xxx Their Tag as1436ca77 Our tag: as0c3f6ed8
Jan 6 16:54:42 DEBUG[3585] chan_sip.c: Failed to grab lock, trying again…
Jan 6 16:54:42 DEBUG[3638] cdr_addon_mysql.c: cdr_mysql: SQL command as follows: INSERT INTO cdr (calldate,clid,src,dst,dcontext,channel,dstchannel,lastapp,lastdata,duration,billsec,disposition,amaflags,accountcode,userfield) VALUES (‘2006-01-06 16:54:42’,’“Rafael Aquino” <12010000>’,‘12010000’,’**12010002’,‘default’, ‘SIP/xxx.xxx.xxx.xxx-b7a01750’,’’,‘Hangup’,’’,0,0,‘ANSWERED’,3,’’,’’)
Jan 6 16:54:42 DEBUG[3574] channel.c: Avoiding initial deadlock for 'SIP/xxx.xxx.xxx.xxx-b7a01750’
Jan 6 16:54:42 DEBUG[3585] chan_sip.c: = Found Their Call ID: 3d85c1e03f37ab9e28362a7054ec0e8b@xxx.xxx.xxx.xxx Their Tag as1436ca77 Our tag: as0c3f6ed8
Jan 6 16:54:42 DEBUG[3585] chan_sip.c: Failed to grab lock, trying again…
Jan 6 16:54:42 DEBUG[3638] pbx.c: Function result is '“Rafael Aquino” <12010000>'
Jan 6 16:54:42 DEBUG[3638] pbx.c: Function result is '12010000’
Jan 6 16:54:42 DEBUG[3638] pbx.c: Function result is '**12010002’
Jan 6 16:54:42 DEBUG[3638] pbx.c: Function result is 'default’
Jan 6 16:54:42 DEBUG[3638] pbx.c: Function result is 'SIP/xxx.xxx.xxx.xxx-b7a01750’
Jan 6 16:54:42 DEBUG[3638] pbx.c: Function result is '(null)'
Jan 6 16:54:42 DEBUG[3638] pbx.c: Function result is 'Hangup’
Jan 6 16:54:42 DEBUG[3638] pbx.c: Function result is '(null)'
Jan 6 16:54:42 DEBUG[3638] pbx.c: Function result is '2006-01-06 16:54:42’
Jan 6 16:54:42 DEBUG[3638] pbx.c: Function result is '2006-01-06 16:54:42’
Jan 6 16:54:42 DEBUG[3638] pbx.c: Function result is '2006-01-06 16:54:42’
Jan 6 16:54:42 DEBUG[3638] pbx.c: Function result is '0’
Jan 6 16:54:42 DEBUG[3638] pbx.c: Function result is '0’
Jan 6 16:54:42 DEBUG[3638] pbx.c: Function result is 'ANSWERED’
Jan 6 16:54:42 DEBUG[3638] pbx.c: Function result is 'DOCUMENTATION’
Jan 6 16:54:42 DEBUG[3638] pbx.c: Function result is '(null)'
Jan 6 16:54:42 DEBUG[3638] pbx.c: Function result is '1136573682.5’
Jan 6 16:54:42 DEBUG[3638] pbx.c: Function result is '(null)'
Jan 6 16:54:42 DEBUG[3574] channel.c: Avoiding initial deadlock for ‘SIP/xxx.xxx.xxx.xxx-b7a01750’
Jan 6 16:54:42 DEBUG[3638] channel.c: Hanging up channel ‘SIP/xxx.xxx.xxx.xxx-b7a01750’
Jan 6 16:54:42 DEBUG[3638] chan_sip.c: Hangup call SIP/xxx.xxx.xxx.xxx-b7a01750, SIP callid 3d85c1e03f37ab9e28362a7054ec0e8b@xxx.xxx.xxx.xxx)
Jan 6 16:54:42 DEBUG[3638] chan_sip.c: update_call_counter() - decrement call limit counter
Jan 6 16:54:42 DEBUG[3638] chan_sip.c: Updating call counter for incoming call
Jan 6 16:54:42 DEBUG[3585] chan_sip.c: = Found Their Call ID: 3d85c1e03f37ab9e28362a7054ec0e8b@xxx.xxx.xxx.xxx Their Tag as1436ca77 Our tag: as0c3f6ed8
Jan 6 16:54:42 DEBUG[3585] chan_sip.c: **** Received ACK (6) - Command in SIP ACK
Jan 6 16:54:42 DEBUG[3585] chan_sip.c: Stopping retransmission on '3d85c1e03f37ab9e28362a7054ec0e8b@xxx.xxx.xxx.xxx’ of Response 102: Match Found
Jan 6 16:54:42 DEBUG[3585] chan_sip.c: = Found Their Call ID: 3d85c1e03f37ab9e28362a7054ec0e8b@xxx.xxx.xxx.xxx Their Tag as1436ca77 Our tag: as0c3f6ed8
Jan 6 16:54:42 DEBUG[3585] chan_sip.c: Stopping retransmission on '3d85c1e03f37ab9e28362a7054ec0e8b@xxx.xxx.xxx.xxx’ of Request 102: Match Found
Jan 6 16:54:42 DEBUG[3574] devicestate.c: Changing state for SIP/xxx.xxx.xxx.xxx - state 1 (Not in use)
Jan 6 16:54:42 DEBUG[3574] chan_sip.c: Checking device state for peer xxx.xxx.xxx.xxx
Jan 6 16:54:42 DEBUG[3574] devicestate.c: Changing state for SIP/xxx.xxx.xxx.xxx - state 1 (Not in use)
Jan 6 16:54:42 DEBUG[3640] app_queue.c: Device ‘SIP/xxx.xxx.xxx.xxx’ changed to state ‘1’ (Not in use)
Jan 6 16:54:42 DEBUG[3641] app_queue.c: Device ‘SIP/xxx.xxx.xxx.xxx’ changed to state ‘1’ (Not in use)
context field as default, don´t working:
Jan 6 16:49:16 DEBUG[3585] chan_sip.c: Allocating new SIP dialog for 5e4096623255d5756f8ff5c47a6f4dec@xxx.xxx.xxx.xxx - INVITE (With RTP)
Jan 6 16:49:16 DEBUG[3585] chan_sip.c: **** Received INVITE (5) - Command in SIP INVITE
Jan 6 16:49:16 DEBUG[3585] chan_sip.c: Checking SIP call limits for device
Jan 6 16:49:16 DEBUG[3585] chan_sip.c: Updating call counter for incoming call
Jan 6 16:49:16 DEBUG[3585] chan_sip.c: build_route: Contact hop: sip:12010000@xxx.xxx.xxx.xxx
Jan 6 16:49:16 DEBUG[3574] chan_sip.c: Checking device state for peer xxx.xxx.xxx.xxx
Jan 6 16:49:16 DEBUG[3574] devicestate.c: Changing state for SIP/xxx.xxx.xxx.xxx - state 2 (In use)
Jan 6 16:49:16 DEBUG[3610] app_queue.c: Device ‘SIP/xxx.xxx.xxx.xxx’ changed to state ‘2’ (In use)
Jan 6 16:49:16 DEBUG[3609] pbx.c: Launching 'VoiceMail’
Jan 6 16:49:16 VERBOSE[3609] logger.c: – Executing VoiceMail(“SIP/xxx.xxx.xxx.xxx-082e36f0”, “su12010002@default”) in new stack
Jan 6 16:49:16 DEBUG[3609] chan_sip.c: sip_answer(SIP/xxx.xxx.xxx.xxx-082e36f0)
Jan 6 16:49:16 DEBUG[3574] chan_sip.c: Checking device state for peer xxx.xxx.xxx.xxx
Jan 6 16:49:16 DEBUG[3574] channel.c: Avoiding initial deadlock for 'SIP/xxx.xxx.xxx.xxx-082e36f0’
Jan 6 16:49:16 DEBUG[3609] res_config_mysql.c: MySQL RealTime: Retrieve SQL: SELECT * FROM voicemail_users WHERE mailbox = ‘12010002’ AND context = ''
Jan 6 16:49:16 DEBUG[3609] res_config_mysql.c: MySQL RealTime: Everything is fine.
Jan 6 16:49:16 WARNING[3609] app_voicemail.c: No entry in voicemail config file for '12010002’
Jan 6 16:49:16 DEBUG[3609] pbx.c: Launching 'Hangup’
Jan 6 16:49:16 VERBOSE[3609] logger.c: – Executing Hangup(“SIP/xxx.xxx.xxx.xxx-082e36f0”, “”) in new stack
Jan 6 16:49:16 DEBUG[3585] chan_sip.c: = Found Their Call ID: 5e4096623255d5756f8ff5c47a6f4dec@xxx.xxx.xxx.xxx Their Tag as2b16677f Our tag: as2c778b80
Jan 6 16:49:16 DEBUG[3609] pbx.c: Spawn extension (default,**12010002,2) exited non-zero on ‘SIP/xxx.xxx.xxx.xxx-082e36f0’
Jan 6 16:49:16 DEBUG[3585] chan_sip.c: **** Received ACK (6) - Command in SIP ACK
Jan 6 16:49:16 DEBUG[3585] chan_sip.c: Stopping retransmission on '5e4096623255d5756f8ff5c47a6f4dec@xxx.xxx.xxx.xxx’ of Response 102: Match Found
Jan 6 16:49:16 DEBUG[3609] pbx.c: Function result is '“Rafael Aquino” <12010000>'
Jan 6 16:49:16 DEBUG[3609] pbx.c: Function result is '12010000’
Jan 6 16:49:16 DEBUG[3609] pbx.c: Function result is '**12010002’
Jan 6 16:49:16 DEBUG[3609] pbx.c: Function result is 'default’
Jan 6 16:49:16 DEBUG[3609] pbx.c: Function result is 'SIP/xxx.xxx.xxx.xxx-082e36f0’
Jan 6 16:49:16 DEBUG[3609] pbx.c: Function result is '(null)'
Jan 6 16:49:16 DEBUG[3609] pbx.c: Function result is 'Hangup’
Jan 6 16:49:16 DEBUG[3609] pbx.c: Function result is '(null)'
Jan 6 16:49:16 DEBUG[3609] pbx.c: Function result is ‘2006-01-06 16:49:16’
Jan 6 16:49:16 DEBUG[3609] pbx.c: Function result is ‘2006-01-06 16:49:16’
Jan 6 16:49:16 DEBUG[3609] pbx.c: Function result is ‘2006-01-06 16:49:16’
Jan 6 16:49:16 DEBUG[3609] pbx.c: Function result is ‘0’
Jan 6 16:49:16 DEBUG[3609] pbx.c: Function result is ‘0’
Jan 6 16:49:16 DEBUG[3609] pbx.c: Function result is ‘ANSWERED’
Jan 6 16:49:16 DEBUG[3609] pbx.c: Function result is ‘DOCUMENTATION’
Jan 6 16:49:16 DEBUG[3609] pbx.c: Function result is ‘(null)‘
Jan 6 16:49:16 DEBUG[3609] pbx.c: Function result is ‘1136573356.2’
Jan 6 16:49:16 DEBUG[3609] pbx.c: Function result is ‘(null)‘
Jan 6 16:49:16 DEBUG[3609] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record.
Jan 6 16:49:16 DEBUG[3609] cdr_addon_mysql.c: cdr_mysql: SQL command as follows: INSERT INTO cdr (calldate,clid,src,dst,dcontext,channel,dstchannel,lastapp,lastdata,duration,billsec,disposition,amaflags,accountcode,userfield) VALUES (‘2006-01-06 16:49:16’,’“Rafael Aquino” <12010000>’,‘12010000’,’**12010002’,‘default’, ‘SIP/xxx.xxx.xxx.xxx-082e36f0’,’’,‘Hangup’,’’,0,0,‘ANSWERED’,3,’’,’’)
Jan 6 16:49:16 DEBUG[3574] channel.c: Avoiding initial deadlock for 'SIP/xxx.xxx.xxx.xxx-082e36f0’
Jan 6 16:49:16 DEBUG[3574] channel.c: Avoiding initial deadlock for 'SIP/xxx.xxx.xxx.xxx-082e36f0’
Jan 6 16:49:16 DEBUG[3609] channel.c: Hanging up channel ‘SIP/xxx.xxx.xxx.xxx-082e36f0’
Jan 6 16:49:16 DEBUG[3609] chan_sip.c: Hangup call SIP/xxx.xxx.xxx.xxx-082e36f0, SIP callid 5e4096623255d5756f8ff5c47a6f4dec@xxx.xxx.xxx.xxx)
Jan 6 16:49:16 DEBUG[3609] chan_sip.c: update_call_counter() - decrement call limit counter
Jan 6 16:49:16 DEBUG[3609] chan_sip.c: Updating call counter for incoming call
Jan 6 16:49:16 DEBUG[3585] chan_sip.c: = Found Their Call ID: 5e4096623255d5756f8ff5c47a6f4dec@xxx.xxx.xxx.xxx Their Tag as2b16677f Our tag: as2c778b80
Jan 6 16:49:16 DEBUG[3585] chan_sip.c: Stopping retransmission on '5e4096623255d5756f8ff5c47a6f4dec@xxx.xxx.xxx.xxx’ of Request 102: Match Found
Jan 6 16:49:16 DEBUG[3574] devicestate.c: Changing state for SIP/xxx.xxx.xxx.xxx - state 1 (Not in use)
Jan 6 16:49:16 DEBUG[3574] chan_sip.c: Checking device state for peer xxx.xxx.xxx.xxx
Jan 6 16:49:16 DEBUG[3574] devicestate.c: Changing state for SIP/xxx.xxx.xxx.xxx - state 1 (Not in use)
Jan 6 16:49:16 DEBUG[3611] app_queue.c: Device ‘SIP/xxx.xxx.xxx.xxx’ changed to state ‘1’ (Not in use)
Jan 6 16:49:16 DEBUG[3612] app_queue.c: Device ‘SIP/xxx.xxx.xxx.xxx’ changed to state ‘1’ (Not in use)