BUILD: 200318-1330
SVN Version: 3204
Cluster (1 WEB, 1 DB, 1 PBX)
Hey guys,
I have this weird issue when using the Canadian PRI callIDname. 80% of the time we only get one way audio (agent can hear the customer but customer can't hear the agent).
The same setup worked for me on other Vicidial installations:
In my /etc/asterisk/extensions.conf I have these lines:
- Code: Select all
; dial a USA long distance outbound number through the loopback-no-log context
exten => _91NXXNXXXXXX,1,AGI(agi://127.0.0.1:4577/call_log)
exten => _91NXXNXXXXXX,n,Dial(${TRUNKloop}/888${EXTEN:2},55,o)
exten => _91NXXNXXXXXX,n,Hangup()
exten => _888NXXNXXXXXX,1,Goto(loopback-no-log,91${EXTEN:3},1)
exten => _888NXXNXXXXXX,n,Hangup()
exten => 8889990011112,1,Goto(loopback-no-log,9990011112,1)
exten => 8889990011112,n,Hangup()
- Code: Select all
; special Canadian PRI callerIDname settings FOR USE IN LOOPBACK CONTEXT ONLY
exten => _91NXXNXXXXXX,1,Set(CALLERID(name)=${CALLERID(num)})
exten => _91NXXNXXXXXX,n,AGI(agi-CANADA_PRI_CIDname.agi)
exten => _91NXXNXXXXXX,n,Dial(${SMALLTRUNK}/${EXTEN:1},,To)
exten => _91NXXNXXXXXX,n,Hangup()
I don't feel like this is a NAT issue since we have two way audios on all calls if we don't go trough the internal loopback ?
Here's a log of a call with two way audio that use the loopback:
- Code: Select all
===== OK CALL =====
[Sep 10 11:19:42] -- Executing [8600056@default:1] MeetMe("Local/8600056@default-00000605;2", "8600056,F") in new stack
[Sep 10 11:19:42] > Channel Local/8600056@default-00000605;1 was answered
[Sep 10 11:19:42] -- Executing [914389291888@default:1] AGI("Local/8600056@default-00000605;1", "agi://127.0.0.1:4577/call_log") in new stack
[Sep 10 11:19:42] -- AGI Script Executing Application: (EXEC) Options: (Set(_CAMPCUST=4002))
[Sep 10 11:19:42] -- <Local/8600056@default-00000605;1>AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[Sep 10 11:19:42] -- Executing [914389291888@default:2] Dial("Local/8600056@default-00000605;1", "IAX2/ASTloop:jp0N8awDAr6lOSl@127.0.0.1:40569/8884389291888,55,o") in new stack
[Sep 10 11:19:42] -- Called IAX2/ASTloop:jp0N8awDAr6lOSl@127.0.0.1:40569/8884389291888
[Sep 10 11:19:42] -- Accepting AUTHENTICATED call from 127.0.0.1:
[Sep 10 11:19:42] -- > requested format = gsm,
[Sep 10 11:19:42] -- > requested prefs = (gsm|ulaw),
[Sep 10 11:19:42] -- > actual format = ulaw,
[Sep 10 11:19:42] -- > host prefs = (ulaw),
[Sep 10 11:19:42] -- > priority = mine
[Sep 10 11:19:42] -- Call accepted by 127.0.0.1 (format ulaw)
[Sep 10 11:19:42] -- Format for call is (ulaw)
[Sep 10 11:19:42] -- Executing [8884389291888@default:1] Goto("IAX2/ASTloop-11943", "loopback-no-log,914389291888,1") in new stack
[Sep 10 11:19:42] -- Goto (loopback-no-log,914389291888,1)
[Sep 10 11:19:42] -- Executing [914389291888@loopback-no-log:1] Set("IAX2/ASTloop-11943", "CALLERID(name)=7059994253") in new stack
[Sep 10 11:19:42] -- Executing [914389291888@loopback-no-log:2] AGI("IAX2/ASTloop-11943", "agi-CANADA_PRI_CIDname.agi") in new stack
[Sep 10 11:19:42] -- Launched AGI Script /usr/share/asterisk/agi-bin/agi-CANADA_PRI_CIDname.agi
[Sep 10 11:19:42] -- Executing [58600056@default:1] MeetMe("Local/58600056@default-00000606;2", "8600056,Fmq") in new stack
[Sep 10 11:19:42] > Channel Local/58600056@default-00000606;1 was answered
[Sep 10 11:19:42] -- Executing [8309@default:1] Answer("Local/58600056@default-00000606;1", "") in new stack
[Sep 10 11:19:42] -- Executing [8309@default:2] Monitor("Local/58600056@default-00000606;1", "wav,20200910-111942_4389291888_4002_6666") in new stack
[Sep 10 11:19:42] -- Executing [8309@default:3] Wait("Local/58600056@default-00000606;1", "3600") in new stack
[Sep 10 11:19:42] -- <IAX2/ASTloop-11943>AGI Script agi-CANADA_PRI_CIDname.agi completed, returning 0
[Sep 10 11:19:42] -- Executing [914389291888@loopback-no-log:3] Dial("IAX2/ASTloop-11943", "SIP/ANEXA3/14389291888,,To") in new stack
[Sep 10 11:19:42] == Using SIP RTP CoS mark 5
[Sep 10 11:19:42] -- Called SIP/ANEXA3/14389291888
[Sep 10 11:19:43] -- SIP/ANEXA3-000007fe is making progress passing it to IAX2/ASTloop-11943
[Sep 10 11:19:43] > 0x7f87cc0455c0 -- Probation passed - setting RTP source address to 50.23.148.141:31848
[Sep 10 11:19:43] -- IAX2/127.0.0.1:40569-5653 is making progress passing it to Local/8600056@default-00000605;1
[Sep 10 11:19:50] -- SIP/ANEXA3-000007fe answered IAX2/ASTloop-11943
[Sep 10 11:19:50] -- IAX2/127.0.0.1:40569-5653 answered Local/8600056@default-00000605;1
[Sep 10 11:19:54] == Spawn extension (loopback-no-log, 914389291888, 3) exited non-zero on 'IAX2/ASTloop-11943'
[Sep 10 11:19:54] -- Hungup 'IAX2/ASTloop-11943'
[Sep 10 11:19:54] -- Executing [h@default:1] AGI("Local/8600056@default-00000605;1", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----12-----4") in new stack
[Sep 10 11:19:54] -- <Local/8600056@default-00000605;1>AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----12-----4 completed, returning 0
[Sep 10 11:19:54] -- Hungup 'IAX2/127.0.0.1:40569-5653'
[Sep 10 11:19:54] == Spawn extension (default, 914389291888, 2) exited non-zero on 'Local/8600056@default-00000605;1'
[Sep 10 11:19:54] == Spawn extension (default, 8600056, 1) exited non-zero on 'Local/8600056@default-00000605;2'
[Sep 10 11:19:54] -- Executing [h@default:1] AGI("Local/8600056@default-00000605;2", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----0---------------") in new stack
[Sep 10 11:19:54] -- <Local/8600056@default-00000605;2>AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----0--------------- completed, returning 0
[Sep 10 11:20:00] -- SIP/ANEXA3-000007fd answered Local/8600052@default-00000603;1
[Sep 10 11:20:01] -- Remote UNIX connection
=====/OK CALL ========== OK CALL =====
[Sep 10 11:19:42] -- Executing [8600056@default:1] MeetMe("Local/8600056@default-00000605;2", "8600056,F") in new stack
[Sep 10 11:19:42] > Channel Local/8600056@default-00000605;1 was answered
[Sep 10 11:19:42] -- Executing [914389291888@default:1] AGI("Local/8600056@default-00000605;1", "agi://127.0.0.1:4577/call_log") in new stack
[Sep 10 11:19:42] -- AGI Script Executing Application: (EXEC) Options: (Set(_CAMPCUST=4002))
[Sep 10 11:19:42] -- <Local/8600056@default-00000605;1>AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[Sep 10 11:19:42] -- Executing [914389291888@default:2] Dial("Local/8600056@default-00000605;1", "IAX2/ASTloop:jp0N8awDAr6lOSl@127.0.0.1:40569/8884389291888,55,o") in new stack
[Sep 10 11:19:42] -- Called IAX2/ASTloop:jp0N8awDAr6lOSl@127.0.0.1:40569/8884389291888
[Sep 10 11:19:42] -- Accepting AUTHENTICATED call from 127.0.0.1:
[Sep 10 11:19:42] -- > requested format = gsm,
[Sep 10 11:19:42] -- > requested prefs = (gsm|ulaw),
[Sep 10 11:19:42] -- > actual format = ulaw,
[Sep 10 11:19:42] -- > host prefs = (ulaw),
[Sep 10 11:19:42] -- > priority = mine
[Sep 10 11:19:42] -- Call accepted by 127.0.0.1 (format ulaw)
[Sep 10 11:19:42] -- Format for call is (ulaw)
[Sep 10 11:19:42] -- Executing [8884389291888@default:1] Goto("IAX2/ASTloop-11943", "loopback-no-log,914389291888,1") in new stack
[Sep 10 11:19:42] -- Goto (loopback-no-log,914389291888,1)
[Sep 10 11:19:42] -- Executing [914389291888@loopback-no-log:1] Set("IAX2/ASTloop-11943", "CALLERID(name)=7059994253") in new stack
[Sep 10 11:19:42] -- Executing [914389291888@loopback-no-log:2] AGI("IAX2/ASTloop-11943", "agi-CANADA_PRI_CIDname.agi") in new stack
[Sep 10 11:19:42] -- Launched AGI Script /usr/share/asterisk/agi-bin/agi-CANADA_PRI_CIDname.agi
[Sep 10 11:19:42] -- Executing [58600056@default:1] MeetMe("Local/58600056@default-00000606;2", "8600056,Fmq") in new stack
[Sep 10 11:19:42] > Channel Local/58600056@default-00000606;1 was answered
[Sep 10 11:19:42] -- Executing [8309@default:1] Answer("Local/58600056@default-00000606;1", "") in new stack
[Sep 10 11:19:42] -- Executing [8309@default:2] Monitor("Local/58600056@default-00000606;1", "wav,20200910-111942_4389291888_4002_6666") in new stack
[Sep 10 11:19:42] -- Executing [8309@default:3] Wait("Local/58600056@default-00000606;1", "3600") in new stack
[Sep 10 11:19:42] -- <IAX2/ASTloop-11943>AGI Script agi-CANADA_PRI_CIDname.agi completed, returning 0
[Sep 10 11:19:42] -- Executing [914389291888@loopback-no-log:3] Dial("IAX2/ASTloop-11943", "SIP/ANEXA3/14389291888,,To") in new stack
[Sep 10 11:19:42] == Using SIP RTP CoS mark 5
[Sep 10 11:19:42] -- Called SIP/ANEXA3/14389291888
[Sep 10 11:19:43] -- SIP/ANEXA3-000007fe is making progress passing it to IAX2/ASTloop-11943
[Sep 10 11:19:43] > 0x7f87cc0455c0 -- Probation passed - setting RTP source address to 50.23.148.141:31848
[Sep 10 11:19:43] -- IAX2/127.0.0.1:40569-5653 is making progress passing it to Local/8600056@default-00000605;1
[Sep 10 11:19:50] -- SIP/ANEXA3-000007fe answered IAX2/ASTloop-11943
[Sep 10 11:19:50] -- IAX2/127.0.0.1:40569-5653 answered Local/8600056@default-00000605;1
[Sep 10 11:19:54] == Spawn extension (loopback-no-log, 914389291888, 3) exited non-zero on 'IAX2/ASTloop-11943'
[Sep 10 11:19:54] -- Hungup 'IAX2/ASTloop-11943'
[Sep 10 11:19:54] -- Executing [h@default:1] AGI("Local/8600056@default-00000605;1", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----12-----4") in new stack
[Sep 10 11:19:54] -- <Local/8600056@default-00000605;1>AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----12-----4 completed, returning 0
[Sep 10 11:19:54] -- Hungup 'IAX2/127.0.0.1:40569-5653'
[Sep 10 11:19:54] == Spawn extension (default, 914389291888, 2) exited non-zero on 'Local/8600056@default-00000605;1'
[Sep 10 11:19:54] == Spawn extension (default, 8600056, 1) exited non-zero on 'Local/8600056@default-00000605;2'
[Sep 10 11:19:54] -- Executing [h@default:1] AGI("Local/8600056@default-00000605;2", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----0---------------") in new stack
[Sep 10 11:19:54] -- <Local/8600056@default-00000605;2>AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----0--------------- completed, returning 0
[Sep 10 11:20:00] -- SIP/ANEXA3-000007fd answered Local/8600052@default-00000603;1
[Sep 10 11:20:01] -- Remote UNIX connection
=====/OK CALL =====
And one with sound only one way:
- Code: Select all
===== NOT OK CALL =====
[Sep 10 11:21:00] -- Executing [8600056@default:1] MeetMe("Local/8600056@default-0000060b;2", "8600056,F") in new stack
[Sep 10 11:21:00] > Channel Local/8600056@default-0000060b;1 was answered
[Sep 10 11:21:00] -- Executing [914389291888@default:1] AGI("Local/8600056@default-0000060b;1", "agi://127.0.0.1:4577/call_log") in new stack
[Sep 10 11:21:00] -- AGI Script Executing Application: (EXEC) Options: (Set(_CAMPCUST=4002))
[Sep 10 11:21:00] -- <Local/8600056@default-0000060b;1>AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[Sep 10 11:21:00] -- Executing [914389291888@default:2] Dial("Local/8600056@default-0000060b;1", "IAX2/ASTloop:jp0N8awDAr6lOSl@127.0.0.1:40569/8884389291888,55,o") in new stack
[Sep 10 11:21:00] -- Called IAX2/ASTloop:jp0N8awDAr6lOSl@127.0.0.1:40569/8884389291888
[Sep 10 11:21:00] -- Accepting AUTHENTICATED call from 127.0.0.1:
[Sep 10 11:21:00] -- > requested format = gsm,
[Sep 10 11:21:00] -- > requested prefs = (gsm|ulaw),
[Sep 10 11:21:00] -- > actual format = ulaw,
[Sep 10 11:21:00] -- > host prefs = (ulaw),
[Sep 10 11:21:00] -- > priority = mine
[Sep 10 11:21:00] -- Call accepted by 127.0.0.1 (format ulaw)
[Sep 10 11:21:00] -- Format for call is (ulaw)
[Sep 10 11:21:00] -- Executing [8884389291888@default:1] Goto("IAX2/ASTloop-14539", "loopback-no-log,914389291888,1") in new stack
[Sep 10 11:21:00] -- Goto (loopback-no-log,914389291888,1)
[Sep 10 11:21:00] -- Executing [914389291888@loopback-no-log:1] Set("IAX2/ASTloop-14539", "CALLERID(name)=7059994253") in new stack
[Sep 10 11:21:00] -- Executing [914389291888@loopback-no-log:2] AGI("IAX2/ASTloop-14539", "agi-CANADA_PRI_CIDname.agi") in new stack
[Sep 10 11:21:00] -- Launched AGI Script /usr/share/asterisk/agi-bin/agi-CANADA_PRI_CIDname.agi
[Sep 10 11:21:00] -- Executing [58600056@default:1] MeetMe("Local/58600056@default-0000060c;2", "8600056,Fmq") in new stack
[Sep 10 11:21:00] > Channel Local/58600056@default-0000060c;1 was answered
[Sep 10 11:21:00] -- Executing [8309@default:1] Answer("Local/58600056@default-0000060c;1", "") in new stack
[Sep 10 11:21:00] -- Executing [8309@default:2] Monitor("Local/58600056@default-0000060c;1", "wav,20200910-112100_4389291888_4002_6666") in new stack
[Sep 10 11:21:00] -- Executing [8309@default:3] Wait("Local/58600056@default-0000060c;1", "3600") in new stack
[Sep 10 11:21:00] -- <IAX2/ASTloop-14539>AGI Script agi-CANADA_PRI_CIDname.agi completed, returning 0
[Sep 10 11:21:00] -- Executing [914389291888@loopback-no-log:3] Dial("IAX2/ASTloop-14539", "SIP/ANEXA3/14389291888,,To") in new stack
[Sep 10 11:21:00] == Using SIP RTP CoS mark 5
[Sep 10 11:21:00] -- Called SIP/ANEXA3/14389291888
[Sep 10 11:21:02] -- SIP/ANEXA3-00000801 is making progress passing it to IAX2/ASTloop-14539
[Sep 10 11:21:02] > 0x7f8858014450 -- Probation passed - setting RTP source address to 50.23.148.141:37942
[Sep 10 11:21:02] -- IAX2/127.0.0.1:40569-4801 is making progress passing it to Local/8600056@default-0000060b;1
[Sep 10 11:21:07] -- SIP/ANEXA3-00000801 answered IAX2/ASTloop-14539
[Sep 10 11:21:07] -- IAX2/127.0.0.1:40569-4801 answered Local/8600056@default-0000060b;1
[Sep 10 11:21:11] == Spawn extension (loopback-no-log, 914389291888, 3) exited non-zero on 'IAX2/ASTloop-14539'
[Sep 10 11:21:11] -- Hungup 'IAX2/ASTloop-14539'
[Sep 10 11:21:11] -- Executing [h@default:1] AGI("Local/8600056@default-0000060b;1", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----11-----4") in new stack
[Sep 10 11:21:11] -- <Local/8600056@default-0000060b;1>AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----11-----4 completed, returning 0
[Sep 10 11:21:11] -- Hungup 'IAX2/127.0.0.1:40569-4801'
[Sep 10 11:21:11] == Spawn extension (default, 914389291888, 2) exited non-zero on 'Local/8600056@default-0000060b;1'
[Sep 10 11:21:11] == Spawn extension (default, 8600056, 1) exited non-zero on 'Local/8600056@default-0000060b;2'
[Sep 10 11:21:11] -- Executing [h@default:1] AGI("Local/8600056@default-0000060b;2", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----0---------------") in new stack
[Sep 10 11:21:11] -- <Local/8600056@default-0000060b;2>AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----0--------------- completed, returning 0
===== /NOT OK CALL =====
I don't see any difference between both calls on the log level, am I missing something ?
