vicidial.org

Ok, i am getting a heavy number of NAs, checked leads to make sure they was fine, and even ran some leads that i know are hot. But i am still getting over 90% NA on my files.

When was checking the CLI and i seen something i dont think i seen before

exited non-zero on 'Local/817068605021@default-b5f4,2'


my provider is xcast, and next line i will post my dailplan see if there is anything that can be resolved there

[xcast]
host=38.102.250.50
type=friend
disallow=all
allow=ulaw
trustrpid=yes
sendrpid=yes
qualify=yes
insecure=port,invite
dtmfmode=rfc2833
canreinvite=no
nat=no
host=38.102.250.60
context=trunkinbound

the next box

exten=> _81XXXXXXXXXX,1,AGI(agi://127.0.0.1:4577/call_log)
exten=> _81XXXXXXXXXX,2,Dial(SIP/Xcast/${EXTEN:1},,tTr)
exten=> _81XXXXXXXXXX,3,Hangup



CLI spam incoming

[Sep 23 17:41:40] == Manager 'sendcron' logged on from 127.0.0.1
[Sep 23 17:41:40] -- Executing [816063531598@default:1] AGI("Local/816063531598@default-3e23,2", "agi://127.0.0.1:4577/call_log") in new stack
[Sep 23 17:41:40] DTMF[14501]: channel.c:2536 __ast_read: DTMF begin '1' received on SIP/Xcast-000006fd
[Sep 23 17:41:40] DTMF[14501]: channel.c:2546 __ast_read: DTMF begin passthrough '1' on SIP/Xcast-000006fd
[Sep 23 17:41:40] == Parsing '/etc/asterisk/manager.conf': [Sep 23 17:41:40] Found
[Sep 23 17:41:40] == Manager 'sendcron' logged on from 127.0.0.1
[Sep 23 17:41:40] -- Executing [813366219744@default:1] AGI("Local/813366219744@default-d652,2", "agi://127.0.0.1:4577/call_log") in new stack
[Sep 23 17:41:40] -- SIP/Xcast-00000708 answered Local/818438710057@default-7803,2
[Sep 23 17:41:40] > Channel Local/818438710057@default-7803,1 was answered.
[Sep 23 17:41:40] -- AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[Sep 23 17:41:40] -- Executing [813366219744@default:2] Dial("Local/813366219744@default-d652,2", "SIP/Xcast/13366219744||tTr") in new stack
[Sep 23 17:41:40] -- Called Xcast/13366219744
[Sep 23 17:41:40] -- AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[Sep 23 17:41:40] -- Executing [816063531598@default:2] Dial("Local/816063531598@default-3e23,2", "SIP/Xcast/16063531598||tTr") in new stack
[Sep 23 17:41:40] -- AGI Script agi://127.0.0.1:4577/call_log--HVcauses ... --23-----0 completed, returning 0
[Sep 23 17:41:40] == Spawn extension (default, 813364279868, 2) exited non-zero on 'Local/813364279868@default-e90e,2'
[Sep 23 17:41:40] -- Called Xcast/16063531598
[Sep 23 17:41:40] DTMF[14501]: channel.c:2455 __ast_read: DTMF end '1' received on SIP/Xcast-000006fd, duration 45 ms
[Sep 23 17:41:40] DTMF[14501]: channel.c:2492 __ast_read: DTMF end accepted with begin '1' on SIP/Xcast-000006fd
[Sep 23 17:41:40] DTMF[14501]: channel.c:2507 __ast_read: DTMF end '1' detected to have actual duration 39 on the wire, emulation will be triggered on SIP/Xcast-000006fd
[Sep 23 17:41:40] DTMF[14501]: channel.c:2514 __ast_read: DTMF end '1' has duration 39 but want minimum 80, emulating on SIP/Xcast-000006fd
[Sep 23 17:41:40] -- Executing [8369@default:1] Playback("Local/818438710057@default-7803,1", "sip-silence") in new stack
[Sep 23 17:41:40] -- <Local/818438710057@default-7803,1> Playing 'sip-silence' (language 'en')
[Sep 23 17:41:40] WARNING[14896]: file.c:1297 waitstream_core: Unexpected control subclass '-1'
[Sep 23 17:41:40] DTMF[14501]: channel.c:2569 __ast_read: DTMF end emulation of '1' queued on SIP/Xcast-000006fd
[Sep 23 17:41:40] -- AGI Script agi://127.0.0.1:4577/call_log--HVcauses ... ---------- completed, returning 0
[Sep 23 17:41:40] -- Executing [8369@default:2] AGI("Local/818438710057@default-7803,1", "agi://127.0.0.1:4577/call_log") in new stack
[Sep 23 17:41:40] -- Executing [h@default:1] DeadAGI("Local/818438710057@default-7803,2", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----22-----0") in new stack
[Sep 23 17:41:40] -- AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[Sep 23 17:41:40] -- Executing [8369@default:3] AMD("SIP/Xcast-00000708", "2000|2000|1000|5000|120|50|4|256") in new stack
[Sep 23 17:41:40] -- AMD: SIP/Xcast-00000708 (null) (null) (Fmt: 64)
[Sep 23 17:41:40] -- AMD: initialSilence [2000] greeting [2000] afterGreetingSilence [1000] totalAnalysisTime [5000] minimumWordLength [120] betweenWordsSilence [50] maximumNumberOfWords [4] silenceThreshold [256]
[Sep 23 17:41:40] -- AGI Script agi://127.0.0.1:4577/call_log--HVcauses ... ---------- completed, returning 0
[Sep 23 17:41:40] -- AGI Script agi://127.0.0.1:4577/call_log--HVcauses ... --27-----0 completed, returning 0
[Sep 23 17:41:40] == Spawn extension (default, 817045975002, 2) exited non-zero on 'Local/817045975002@default-fe17,2'
[Sep 23 17:41:40] == Parsing '/etc/asterisk/manager.conf': [Sep 23 17:41:40] Found
[Sep 23 17:41:40] == Manager 'sendcron' logged on from 127.0.0.1
[Sep 23 17:41:40] -- AMD: Changed state to STATE_IN_SILENCE
[Sep 23 17:41:40] -- Executing [819108583629@default:1] AGI("Local/819108583629@default-f618,2", "agi://127.0.0.1:4577/call_log") in new stack
[Sep 23 17:41:40] -- AMD: Changed state to STATE_IN_SILENCE
[Sep 23 17:41:40] == Parsing '/etc/asterisk/manager.conf': [Sep 23 17:41:40] Found
[Sep 23 17:41:40] == Manager 'sendcron' logged on from 127.0.0.1
[Sep 23 17:41:40] -- AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[Sep 23 17:41:40] -- Executing [819108583629@default:2] Dial("Local/819108583629@default-f618,2", "SIP/Xcast/19108583629||tTr") in new stack
[Sep 23 17:41:40] -- AMD: HUMAN: silenceDuration:1000 afterGreetingSilence:1000
[Sep 23 17:41:40] -- Executing [8369@default:4] AGI("SIP/Xcast-00000702", "VD_amd.agi|8369") in new stack
[


Any other info that i can give you to help get to the bottom of this i will be happy to provide

Do you see any different pattern (on the NAs) if you disable AMD? It looks like it is dialing the carrier OK, but I can only see one full attempt. Your output has a lot of other stuff that distracts my attention and does not give us enough examples. I'm guessing that this is an output of a production server while in production. Try to send an output of just one single person making a couple of calls. Also check if disabling AMD makes a difference....

I ran into this problem recently and found increasing the dial timeout in the campaign settings resolved matters . Turns out my carrier must have been taking longer to connect calls than normal.