Using ViciBox_Redux.x86_64-3.1.15
perl 5, version 12, subversion 1 (v5.12.1),PHP 5.3.3 (cli),Asterisk 1.4.39.2-vici/Dahdi 2.6.1-9.1, Apache/2.2.15 (Linux/SUSE)
Vicidial build (VERSION: 2.2.1-237 BUILD: 100510-2015).
Server Settings
Max VICIDIAL Trunks: 96
Max Calls per Second: 2
System Settings
Max FILL Calls per Second: 2
Campaign - Mostly default settings when making a new one except for the following changes
VDAD Extension - 8364
Hopper - Tested from using 1 to 100.
Dial Method: Tried Ratio with Auto Dialer Level 3 to using the Adapt methods
Remote Agent 777 - 100 Available lines. External extension set to a recorded file 85100006
I setup my carrier trunk pointing to a local asterisk server to simply answer the call and loop a message back for 15 seconds and then hangup.
- Code: Select all
[Sep 16 10:37:01] == Parsing '/etc/asterisk/manager.conf': [Sep 16 10:37:01] Found
[Sep 16 10:37:01] == Manager 'sendcron' logged on from 127.0.0.1
[Sep 16 10:37:01] == Parsing '/etc/asterisk/manager.conf': [Sep 16 10:37:01] Found
[Sep 16 10:37:01] == Manager 'sendcron' logged on from 127.0.0.1
[Sep 16 10:37:01] == Manager 'sendcron' logged off from 127.0.0.1
[Sep 16 10:37:01] == Manager 'sendcron' logged off from 127.0.0.1
[Sep 16 10:37:03] == Parsing '/etc/asterisk/manager.conf': [Sep 16 10:37:03] Found
[Sep 16 10:37:03] == Manager 'sendcron' logged on from 127.0.0.1
[Sep 16 10:37:03] -- Executing [912129661105@default:1] AGI("Local/912129661105@default-088a,2", "agi://127.0.0.1:4577/call_log") in new stack
[Sep 16 10:37:03] -- AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[Sep 16 10:37:03] -- Executing [912129661105@default:2] Dial("Local/912129661105@default-088a,2", "SIP/test-carrier/2129661105||tTor") in new stack
[Sep 16 10:37:03] -- Called test-carrier/2129661105
[Sep 16 10:37:03] -- SIP/test-carrier-000075d3 is making progress passing it to Local/912129661105@default-088a,2
[Sep 16 10:37:03] == Parsing '/etc/asterisk/manager.conf': [Sep 16 10:37:03] Found
[Sep 16 10:37:03] == Manager 'sendcron' logged on from 127.0.0.1
[Sep 16 10:37:03] -- Executing [912129661106@default:1] AGI("Local/912129661106@default-62eb,2", "agi://127.0.0.1:4577/call_log") in new stack
[Sep 16 10:37:03] -- AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[Sep 16 10:37:03] -- Executing [912129661106@default:2] Dial("Local/912129661106@default-62eb,2", "SIP/test-carrier/2129661106||tTor") in new stack
[Sep 16 10:37:03] -- Called test-carrier/2129661106
[Sep 16 10:37:03] -- SIP/test-carrier-000075d4 is making progress passing it to Local/912129661106@default-62eb,2
[Sep 16 10:37:04] == Parsing '/etc/asterisk/manager.conf': [Sep 16 10:37:04] Found
[Sep 16 10:37:04] == Manager 'sendcron' logged on from 127.0.0.1
[Sep 16 10:37:04] -- Executing [912129661107@default:1] AGI("Local/912129661107@default-524c,2", "agi://127.0.0.1:4577/call_log") in new stack
[Sep 16 10:37:04] -- AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[Sep 16 10:37:04] -- Executing [912129661107@default:2] Dial("Local/912129661107@default-524c,2", "SIP/test-carrier/2129661107||tTor") in new stack
[Sep 16 10:37:04] -- Called test-carrier/2129661107
[Sep 16 10:37:04] -- SIP/test-carrier-000075d5 is making progress passing it to Local/912129661107@default-524c,2
[Sep 16 10:37:04] == Parsing '/etc/asterisk/manager.conf': [Sep 16 10:37:04] Found
[Sep 16 10:37:04] == Manager 'sendcron' logged on from 127.0.0.1
[Sep 16 10:37:04] -- Executing [912129661108@default:1] AGI("Local/912129661108@default-c17a,2", "agi://127.0.0.1:4577/call_log") in new stack
[Sep 16 10:37:04] -- AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[Sep 16 10:37:04] -- Executing [912129661108@default:2] Dial("Local/912129661108@default-c17a,2", "SIP/test-carrier/2129661108||tTor") in new stack
[Sep 16 10:37:04] -- Called test-carrier/2129661108
[Sep 16 10:37:04] -- SIP/test-carrier-000075d6 is making progress passing it to Local/912129661108@default-c17a,2
[Sep 16 10:37:05] -- SIP/test-carrier-000075d3 answered Local/912129661105@default-088a,2
[Sep 16 10:37:05] > Channel Local/912129661105@default-088a,1 was answered.
[Sep 16 10:37:05] -- Executing [8365@default:1] Playback("Local/912129661105@default-088a,1", "sip-silence") in new stack
[Sep 16 10:37:05] -- <Local/912129661105@default-088a,1> Playing 'sip-silence' (language 'en')
[Sep 16 10:37:05] WARNING[9953]: file.c:1297 waitstream_core: Unexpected control subclass '-1'
[Sep 16 10:37:05] == Parsing '/etc/asterisk/manager.conf': [Sep 16 10:37:05] Found
[Sep 16 10:37:05] == Manager 'sendcron' logged on from 127.0.0.1
[Sep 16 10:37:05] -- Executing [912129661109@default:1] AGI("Local/912129661109@default-6c3c,2", "agi://127.0.0.1:4577/call_log") in new stack
[Sep 16 10:37:05] -- AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[Sep 16 10:37:05] -- Executing [912129661109@default:2] Dial("Local/912129661109@default-6c3c,2", "SIP/test-carrier/2129661109||tTor") in new stack
[Sep 16 10:37:05] -- Called test-carrier/2129661109
[Sep 16 10:37:05] -- SIP/test-carrier-000075d7 is making progress passing it to Local/912129661109@default-6c3c,2
[Sep 16 10:37:05] -- Executing [h@default:1] DeadAGI("Local/912129661105@default-088a,2", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----2-----0") in new stack
[Sep 16 10:37:05] -- Executing [8365@default:2] AGI("SIP/test-carrier-000075d3", "agi://127.0.0.1:4577/call_log") in new stack
[Sep 16 10:37:05] -- AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[Sep 16 10:37:05] -- AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----2-----0 completed, returning 0
[Sep 16 10:37:05] -- Executing [8365@default:3] AGI("SIP/test-carrier-000075d3", "agi-VDAD_ALL_outbound.agi|NORMAL-----SO") in new stack
[Sep 16 10:37:05] -- Launched AGI Script /var/lib/asterisk/agi-bin/agi-VDAD_ALL_outbound.agi
[Sep 16 10:37:05] == Spawn extension (default, 912129661105, 2) exited non-zero on 'Local/912129661105@default-088a,2'
[Sep 16 10:37:05] ERROR[9953]: utils.c:967 ast_carefulwrite: write() returned error: Broken pipe
[Sep 16 10:37:05] -- AGI Script agi-VDAD_ALL_outbound.agi completed, returning 0
[Sep 16 10:37:05] -- Executing [85100006@default:1] Answer("SIP/test-carrier-000075d3", "") in new stack
[Sep 16 10:37:05] -- Executing [85100006@default:2] Playback("SIP/test-carrier-000075d3", "85100006") in new stack
[Sep 16 10:37:05] -- <SIP/test-carrier-000075d3> Playing '85100006' (language 'en')
[Sep 16 10:37:05] -- SIP/test-carrier-000075d4 answered Local/912129661106@default-62eb,2
[Sep 16 10:37:05] > Channel Local/912129661106@default-62eb,1 was answered.
[Sep 16 10:37:05] -- Executing [8365@default:1] Playback("Local/912129661106@default-62eb,1", "sip-silence") in new stack
[Sep 16 10:37:05] -- <Local/912129661106@default-62eb,1> Playing 'sip-silence' (language 'en')
[Sep 16 10:37:05] WARNING[9957]: file.c:1297 waitstream_core: Unexpected control subclass '-1'
[Sep 16 10:37:05] -- Executing [h@default:1] DeadAGI("Local/912129661106@default-62eb,2", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----2-----0") in new stack
[Sep 16 10:37:05] -- Executing [8365@default:2] AGI("SIP/test-carrier-000075d4", "agi://127.0.0.1:4577/call_log") in new stack
[Sep 16 10:37:05] -- AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[Sep 16 10:37:05] -- Executing [8365@default:3] AGI("SIP/test-carrier-000075d4", "agi-VDAD_ALL_outbound.agi|NORMAL-----SO") in new stack
[Sep 16 10:37:05] -- AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----2-----0 completed, returning 0
[Sep 16 10:37:05] -- Launched AGI Script /var/lib/asterisk/agi-bin/agi-VDAD_ALL_outbound.agi
[Sep 16 10:37:05] == Spawn extension (default, 912129661106, 2) exited non-zero on 'Local/912129661106@default-62eb,2'
[Sep 16 10:37:06] ERROR[9957]: utils.c:967 ast_carefulwrite: write() returned error: Broken pipe
[Sep 16 10:37:06] -- AGI Script agi-VDAD_ALL_outbound.agi completed, returning 0
[Sep 16 10:37:06] -- Executing [85100006@default:1] Answer("SIP/test-carrier-000075d4", "") in new stack
[Sep 16 10:37:06] -- Executing [85100006@default:2] Playback("SIP/test-carrier-000075d4", "85100006") in new stack
[Sep 16 10:37:06] -- <SIP/test-carrier-000075d4> Playing '85100006' (language 'en')
[Sep 16 10:37:06] == Parsing '/etc/asterisk/manager.conf': [Sep 16 10:37:06] Found
[Sep 16 10:37:06] == Manager 'sendcron' logged on from 127.0.0.1
[Sep 16 10:37:06] == Manager 'sendcron' logged off from 127.0.0.1
[Sep 16 10:37:06] -- SIP/test-carrier-000075d5 answered Local/912129661107@default-524c,2
[Sep 16 10:37:06] > Channel Local/912129661107@default-524c,1 was answered.
[Sep 16 10:37:06] -- Executing [8365@default:1] Playback("Local/912129661107@default-524c,1", "sip-silence") in new stack
[Sep 16 10:37:06] -- <Local/912129661107@default-524c,1> Playing 'sip-silence' (language 'en')
[Sep 16 10:37:06] WARNING[9961]: file.c:1297 waitstream_core: Unexpected control subclass '-1'
[Sep 16 10:37:06] -- Executing [8365@default:2] AGI("Local/912129661107@default-524c,1", "agi://127.0.0.1:4577/call_log") in new stack
[Sep 16 10:37:06] -- Executing [h@default:1] DeadAGI("Local/912129661107@default-524c,2", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----2-----0") in new stack
[Sep 16 10:37:06] -- AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[Sep 16 10:37:06] -- Executing [8365@default:3] AGI("SIP/test-carrier-000075d5", "agi-VDAD_ALL_outbound.agi|NORMAL-----SO") in new stack
[Sep 16 10:37:06] -- Launched AGI Script /var/lib/asterisk/agi-bin/agi-VDAD_ALL_outbound.agi
[Sep 16 10:37:06] -- AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----2-----0 completed, returning 0
[Sep 16 10:37:06] == Spawn extension (default, 912129661107, 2) exited non-zero on 'Local/912129661107@default-524c,2'
[Sep 16 10:37:06] ERROR[9961]: utils.c:967 ast_carefulwrite: write() returned error: Broken pipe
[Sep 16 10:37:06] -- AGI Script agi-VDAD_ALL_outbound.agi completed, returning 0
[Sep 16 10:37:06] -- Executing [85100006@default:1] Answer("SIP/test-carrier-000075d5", "") in new stack
[Sep 16 10:37:06] -- Executing [85100006@default:2] Playback("SIP/test-carrier-000075d5", "85100006") in new stack
[Sep 16 10:37:06] -- <SIP/test-carrier-000075d5> Playing '85100006' (language 'en')
[Sep 16 10:37:06] -- SIP/test-carrier-000075d6 answered Local/912129661108@default-c17a,2
[Sep 16 10:37:06] > Channel Local/912129661108@default-c17a,1 was answered.
[Sep 16 10:37:06] -- Executing [8365@default:1] Playback("Local/912129661108@default-c17a,1", "sip-silence") in new stack
[Sep 16 10:37:06] -- <Local/912129661108@default-c17a,1> Playing 'sip-silence' (language 'en')
[Sep 16 10:37:06] WARNING[9963]: file.c:1297 waitstream_core: Unexpected control subclass '-1'
[Sep 16 10:37:06] -- Executing [8365@default:2] AGI("Local/912129661108@default-c17a,1", "agi://127.0.0.1:4577/call_log") in new stack
[Sep 16 10:37:06] -- Executing [h@default:1] DeadAGI("Local/912129661108@default-c17a,2", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----2-----0") in new stack
[Sep 16 10:37:06] -- AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[Sep 16 10:37:06] -- Executing [8365@default:3] AGI("SIP/test-carrier-000075d6", "agi-VDAD_ALL_outbound.agi|NORMAL-----SO") in new stack
[Sep 16 10:37:06] -- Launched AGI Script /var/lib/asterisk/agi-bin/agi-VDAD_ALL_outbound.agi
[Sep 16 10:37:06] -- AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----2-----0 completed, returning 0
[Sep 16 10:37:06] == Spawn extension (default, 912129661108, 2) exited non-zero on 'Local/912129661108@default-c17a,2'
[Sep 16 10:37:07] ERROR[9963]: utils.c:967 ast_carefulwrite: write() returned error: Broken pipe
[Sep 16 10:37:07] -- AGI Script agi-VDAD_ALL_outbound.agi completed, returning 0
[Sep 16 10:37:07] -- Executing [85100006@default:1] Answer("SIP/test-carrier-000075d6", "") in new stack
[Sep 16 10:37:07] -- Executing [85100006@default:2] Playback("SIP/test-carrier-000075d6", "85100006") in new stack
[Sep 16 10:37:07] -- <SIP/test-carrier-000075d6> Playing '85100006' (language 'en')
[Sep 16 10:37:07] == Manager 'sendcron' logged off from 127.0.0.1
[Sep 16 10:37:07] -- SIP/test-carrier-000075d7 answered Local/912129661109@default-6c3c,2
[Sep 16 10:37:07] > Channel Local/912129661109@default-6c3c,1 was answered.
[Sep 16 10:37:07] -- Executing [8365@default:1] Playback("Local/912129661109@default-6c3c,1", "sip-silence") in new stack
[Sep 16 10:37:07] -- <Local/912129661109@default-6c3c,1> Playing 'sip-silence' (language 'en')
[Sep 16 10:37:07] WARNING[9966]: file.c:1297 waitstream_core: Unexpected control subclass '-1'
[Sep 16 10:37:07] -- Executing [8365@default:2] AGI("Local/912129661109@default-6c3c,1", "agi://127.0.0.1:4577/call_log") in new stack
[Sep 16 10:37:07] -- Executing [h@default:1] DeadAGI("Local/912129661109@default-6c3c,2", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----2-----0") in new stack
[Sep 16 10:37:07] -- AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[Sep 16 10:37:07] -- Executing [8365@default:3] AGI("SIP/test-carrier-000075d7", "agi-VDAD_ALL_outbound.agi|NORMAL-----SO") in new stack
[Sep 16 10:37:07] -- Launched AGI Script /var/lib/asterisk/agi-bin/agi-VDAD_ALL_outbound.agi
[Sep 16 10:37:07] -- AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----2-----0 completed, returning 0
[Sep 16 10:37:07] == Spawn extension (default, 912129661109, 2) exited non-zero on 'Local/912129661109@default-6c3c,2'
[Sep 16 10:37:07] ERROR[9966]: utils.c:967 ast_carefulwrite: write() returned error: Broken pipe
[Sep 16 10:37:07] -- AGI Script agi-VDAD_ALL_outbound.agi completed, returning 0
[Sep 16 10:37:07] -- Executing [85100006@default:1] Answer("SIP/test-carrier-000075d7", "") in new stack
[Sep 16 10:37:07] -- Executing [85100006@default:2] Playback("SIP/test-carrier-000075d7", "85100006") in new stack
[Sep 16 10:37:07] -- <SIP/test-carrier-000075d7> Playing '85100006' (language 'en')
[Sep 16 10:37:07] == Manager 'sendcron' logged off from 127.0.0.1
[Sep 16 10:37:08] == Manager 'sendcron' logged off from 127.0.0.1
[Sep 16 10:37:08] == Manager 'sendcron' logged off from 127.0.0.1
[Sep 16 10:37:09] == Manager 'sendcron' logged off from 127.0.0.1
[Sep 16 10:37:12] -- Executing [85100006@default:3] Hangup("SIP/test-carrier-000075d3", "") in new stack
[Sep 16 10:37:12] == Spawn extension (default, 85100006, 3) exited non-zero on 'SIP/test-carrier-000075d3'
[Sep 16 10:37:12] -- Executing [h@default:1] DeadAGI("SIP/test-carrier-000075d3", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16---------------") in new stack
[Sep 16 10:37:12] -- AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16--------------- completed, returning 0
[Sep 16 10:37:12] -- Executing [85100006@default:3] Hangup("SIP/test-carrier-000075d4", "") in new stack
[Sep 16 10:37:12] == Spawn extension (default, 85100006, 3) exited non-zero on 'SIP/test-carrier-000075d4'
[Sep 16 10:37:12] -- Executing [h@default:1] DeadAGI("SIP/test-carrier-000075d4", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16---------------") in new stack
[Sep 16 10:37:12] -- AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16--------------- completed, returning 0
[Sep 16 10:37:13] -- Executing [85100006@default:3] Hangup("SIP/test-carrier-000075d5", "") in new stack
[Sep 16 10:37:13] == Spawn extension (default, 85100006, 3) exited non-zero on 'SIP/test-carrier-000075d5'
[Sep 16 10:37:13] -- Executing [h@default:1] DeadAGI("SIP/test-carrier-000075d5", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16---------------") in new stack
[Sep 16 10:37:13] -- AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16--------------- completed, returning 0
[Sep 16 10:37:13] -- Executing [85100006@default:3] Hangup("SIP/test-carrier-000075d6", "") in new stack
[Sep 16 10:37:13] == Spawn extension (default, 85100006, 3) exited non-zero on 'SIP/test-carrier-000075d6'
[Sep 16 10:37:13] -- Executing [h@default:1] DeadAGI("SIP/test-carrier-000075d6", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16---------------") in new stack
[Sep 16 10:37:13] -- AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16--------------- completed, returning 0
[Sep 16 10:37:14] -- Executing [85100006@default:3] Hangup("SIP/test-carrier-000075d7", "") in new stack
[Sep 16 10:37:14] == Spawn extension (default, 85100006, 3) exited non-zero on 'SIP/test-carrier-000075d7'
[Sep 16 10:37:14] -- Executing [h@default:1] DeadAGI("SIP/test-carrier-000075d7", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16---------------") in new stack
[Sep 16 10:37:14] -- AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16--------------- completed, returning 0
Carrier
- Code: Select all
[test-carrier]
disallow=all
allow=ulaw
type=friend
host=<IP of test asterisk box>
dtmfmode=rfc2833
context=trunkinbound
exten => _91NXXNXXXXXX,1,AGI(agi://127.0.0.1:4577/call_log)
exten => _91NXXNXXXXXX,2,Dial(SIP/test-carrier/${EXTEN:2},,tTor)
exten => _91NXXNXXXXXX,3,Hangup
Call log looks clean. Every call was answered and properly terminated so I don't understand why the stats are reporting dropped calls. The only quirks with my installation was asterisk script did not start I believe maybe due to dahdi being upgraded by the OS update. So after a server boot, I start up dahdi manually using "service dahdi start" follow by /usr/share/astguiclient/start_asterisk_boot.pl
I'm new to vicidial but have 7 years of experience (dCAP certified) working on Asterisk and know my way around a linux system working with httpd/apache. I appreciate any help I can get.