Calls to Remote agent stuck as INCALL after hangup.

[rockgeneral]

I have a scenario where I need calls to a particular DID to be transferred to an outside center. I decided to use an in-group with a Remote Agent as the only agent to accomplish this. I went with this option as I wanted the calls to be recorded after the they were transferred. I set the Remote Agent External Extension to call my cell phone for testing purposes. I set the Remote Agent to active, which logs in to the campaign and shows up in the real-time screen. When I place a call to the DID it properly routes to the in-group, which in turn calls the Remote Agent's External Extension and viola my cell phone rings. So far, so good.

However, when I hang up the call on my cell, the real-time screen still shows the call as INCALL. It never "hangs up" and goes back to READY. I've checked the CDR with my voip provider and the call terminates as soon as I hang up. When I search for the lead, the "Modify Lead" screen has nothing in the LENGTH field and has XFER in the STATUS field for the call. This is in the CLOSER RECORDS FOR THIS LEAD: section. Below in the RECORDINGS FOR THIS LEAD: section there are recordings with the duration in the SECONDS field matching the actual duration of the call. So to some extent, vicidial is hanging up the call and stopping the recording but is obviously skipping some DB update/s that are responsible for setting the length of the call and removing it from the vicidial_auto_calls table.

For testing, I have Number of Lines set to 1 for the Remote Agent. Since the agent never moves from INCALL back to READY, I cannot accept a second call. I am stumped.

Any help would be greatly appreciated.

[rockgeneral]

Help me Obi-wan Kenobi, you're my only hope.

[mflorell]

If all you want is to record the call, why not use the DID-level recording option and just transfer the call directly from the DID?

[rockgeneral]

Matt,

I need to be able to control the number of concurrent transfers to the outside center and it seemed that the remote agent Number of Lines features was the only way I could accomplish that.

It was my assumption that when the outside center hung up the call the Remote Agent would go from INCALL back to READY so it could take another call.

What is actually supposed to happen when the call to the External Extension is hung up? And if it is supposed to go from INCALL back to READY, do you have any thoughts as to what might be stopping it from doing so?

I really appreciate your help!

[mflorell]

My guess is there's something wrong with your dialplan, the "h" extension is not executing from where the Dial is run.

[rockgeneral]

Matt,

Thanks again for all your help. I came in today and placed a test call with no one else in the system to make it easier to get CLI output just for the test call. Perhaps with the information below you can help me figure out what is incorrect with my dialplan/setup?

Edit: After checking "Do not automatically parse URLs" I was able to post the output of 'dialplan show' in my next post.

The External Extension for the Remote Agent is:
618007721213

Carrier associated with dial prefix 6:
Carrier ID: ve_out_new2
Global String: VOIPESS2 = SIP/ve_out_new2

exten => _61NXXNXXXXXX,1,AGI(agi://127.0.0.1:4577/call_log)
exten => _61NXXNXXXXXX,2,Dial(${VOIPESS2}/${EXTEN:1},,tTo)
exten => _61NXXNXXXXXX,3,Hangup

For privacy, I replaced the following in the asterisk CLI output for the test call below:
AAAAAAAAAA = DID
BBBBBBBBBB = Phone number of inbound caller

[Apr 1 13:09:47] -- Executing [AAAAAAAAAA@trunkinbound:1] AGI("SIP/ve_inbound_new-00000020", "agi-DID_route.agi") in new stack
[Apr 1 13:09:47] -- Launched AGI Script /usr/share/asterisk/agi-bin/agi-DID_route.agi
[Apr 1 13:09:47] -- <SIP/ve_inbound_new-00000020>AGI Script agi-DID_route.agi completed, returning 0
[Apr 1 13:09:47] -- Executing [99909*54***DID@default:1] Answer("SIP/ve_inbound_new-00000020", "") in new stack
[Apr 1 13:09:48] -- Executing [99909*54***DID@default:2] AGI("SIP/ve_inbound_new-00000020", "agi-VDAD_ALL_inbound.agi") in new stack
[Apr 1 13:09:48] -- Launched AGI Script /usr/share/asterisk/agi-bin/agi-VDAD_ALL_inbound.agi
[Apr 1 13:09:48] -- <SIP/ve_inbound_new-00000020> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[Apr 1 13:09:48] -- <SIP/ve_inbound_new-00000020> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[Apr 1 13:09:48] -- <SIP/ve_inbound_new-00000020> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[Apr 1 13:09:48] -- <SIP/ve_inbound_new-00000020> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[Apr 1 13:09:48] -- AGI Script Executing Application: (Monitor) Options: (wav,/var/spool/asterisk/monitor/MIX/20170401-130948_BBBBBBBBBB)
[Apr 1 13:09:48] -- <SIP/ve_inbound_new-00000020> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[Apr 1 13:09:48] -- <SIP/ve_inbound_new-00000020> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[Apr 1 13:09:48] -- <SIP/ve_inbound_new-00000020> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[Apr 1 13:09:48] -- <SIP/ve_inbound_new-00000020> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[Apr 1 13:09:49] -- <SIP/ve_inbound_new-00000020>AGI Script agi-VDAD_ALL_inbound.agi completed, returning 0
[Apr 1 13:09:49] -- Executing [192*168*001*011*618007721213@default:1] Goto("SIP/ve_inbound_new-00000020", "default,618007721213,1") in new stack
[Apr 1 13:09:49] -- Goto (default,618007721213,1)
[Apr 1 13:09:49] -- Executing [618007721213@default:1] AGI("SIP/ve_inbound_new-00000020", "agi://127.0.0.1:4577/call_log") in new stack
[Apr 1 13:09:49] -- <SIP/ve_inbound_new-00000020>AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[Apr 1 13:09:49] -- Executing [618007721213@default:2] Dial("SIP/ve_inbound_new-00000020", "SIP/ve_out_new2/18007721213,,tTo") in new stack
[Apr 1 13:09:49] -- Called SIP/ve_out_new2/18007721213
[Apr 1 13:09:50] -- SIP/ve_out_new2-00000021 is making progress passing it to SIP/ve_inbound_new-00000020
[Apr 1 13:09:52] -- SIP/ve_out_new2-00000021 answered SIP/ve_inbound_new-00000020
[Apr 1 13:10:08] -- Executing [h@default:1] AGI("SIP/ve_inbound_new-00000020", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----21-----16") in new stack
[Apr 1 13:10:08] -- <SIP/ve_inbound_new-00000020>AGI Script agi://127.0.0.1:4577/call_log--HVcauses ... -21-----16 completed, returning 0
[Apr 1 13:10:08] == Spawn extension (default, 618007721213, 2) exited non-zero on 'SIP/ve_inbound_new-00000020'

Thanks again!!!

[rockgeneral]

Matt,

I checked "Do not automatically parse URLs" it allowed me to post the output of 'dialplan show'

[ Context 'parkedcalls' created by 'features' ]
'700' => 1. Park() [features]

[ Context 'iaxregistration' created by 'IAX2' ]
'ASTblind' => 1. Noop(ASTblind) [IAX2]
'ASTloop' => 1. Noop(ASTloop) [IAX2]
'ASTplay' => 1. Noop(ASTplay) [IAX2]

[ Context 'monitor_exit' created by 'pbx_config' ]
'#' => 1. Goto(monitor,s,1) [pbx_config]
2. Hangup() [pbx_config]
'h' => 1. AGI(agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----${HANGUPCAUSE}-----${DIALSTATUS}-----${DIALEDTIME}-----${ANSWEREDTIME}) [pbx_config]
'i' => 1. Goto(monitor,s,1) [pbx_config]
2. Hangup() [pbx_config]
't' => 1. Goto(monitor,s,1) [pbx_config]
2. Hangup() [pbx_config]
'_X' => 1. Goto(monitor,s,1) [pbx_config]
2. Hangup() [pbx_config]

[ Context 'monitor' created by 'pbx_config' ]
'#' => 1. Goto(monitor_exit,s,1) [pbx_config]
2. Hangup() [pbx_config]
'h' => 1. AGI(agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----${HANGUPCAUSE}-----${DIALSTATUS}-----${DIALEDTIME}-----${ANSWEREDTIME}) [pbx_config]
'i' => 1. Goto(monitor_exit,s,1) [pbx_config]
2. Hangup() [pbx_config]
's' => 1. Set(TIMEOUT(digit)=10) [pbx_config]
2. Set(TIMEOUT(response)=10) [pbx_config]
3. Set(MEETME_EXIT_CONTEXT=monitor_exit) [pbx_config]
4. Background(vm-extension) [pbx_config]
5. WaitExten(10) [pbx_config]
6. Hangup() [pbx_config]
't' => 1. Goto(monitor_exit,s,1) [pbx_config]
2. Hangup() [pbx_config]
'_8[0-2]XX' => 1. Meetme(8600${EXTEN:1},mqX) [pbx_config]
2. Hangup() [pbx_config]
'_99[0-2]XX' => 1. Meetme(8600${EXTEN:2},X) [pbx_config]
2. Hangup() [pbx_config]

[ Context 'default' created by 'pbx_config' ]
'#' => 1. Playback(invalid) [pbx_config]
2. Hangup() [pbx_config]
'34567890123456789' => 1. Answer() [pbx_config]
2. Goto(monitor,s,1) [pbx_config]
3. Hangup() [pbx_config]
'8159' => 1. ZapBarge() [pbx_config]
2. Hangup() [pbx_config]
'8162' => 1. Dial(${TRUNKblind}/34567890123456789,55,to) [pbx_config]
2. Hangup() [pbx_config]
'8300' => 1. Hangup() [pbx_config]
'8301' => 1. Answer() [pbx_config]
2. AGI(park_CID.agi) [pbx_config]
3. Playback(park) [pbx_config]
4. Hangup() [pbx_config]
'8302' => 1. Answer() [pbx_config]
2. Playback(conf) [pbx_config]
3. Hangup() [pbx_config]
'8303' => 1. Answer() [pbx_config]
2. AGI(park_CID.agi) [pbx_config]
3. Playback(conf) [pbx_config]
4. Hangup() [pbx_config]
'8304' => 1. Answer() [pbx_config]
2. Playback(ding) [pbx_config]
3. Hangup() [pbx_config]
'8307' => 1. Answer() [pbx_config]
2. Playback(vm-goodbye) [pbx_config]
3. Hangup() [pbx_config]
'8320' => 1. AGI(VD_amd.agi,${EXTEN}-----YES) [pbx_config]
2. Hangup() [pbx_config]
'8352' => 1. AGI(agi-VDADselective_CID_hangup.agi,${EXTEN}) [pbx_config]
2. Playback(safe_harbor) [pbx_config]
3. Hangup() [pbx_config]
'8364' => 1. Playback(sip-silence) [pbx_config]
2. AGI(agi://127.0.0.1:4577/call_log) [pbx_config]
3. AGI(agi-VDAD_ALL_outbound.agi,NORMAL-----LB) [pbx_config]
4. AGI(agi-VDAD_ALL_outbound.agi,NORMAL-----LB) [pbx_config]
5. Hangup() [pbx_config]
'8365' => 1. Playback(sip-silence) [pbx_config]
2. AGI(agi://127.0.0.1:4577/call_log) [pbx_config]
3. AGI(agi-VDAD_ALL_outbound.agi,NORMAL-----SO) [pbx_config]
4. AGI(agi-VDAD_ALL_outbound.agi,NORMAL-----SO) [pbx_config]
5. Hangup() [pbx_config]
'8366' => 1. Playback(sip-silence) [pbx_config]
2. AGI(agi://127.0.0.1:4577/call_log) [pbx_config]
3. AGI(agi-VDAD_ALL_outbound.agi,SURVEYCAMP-----LB) [pbx_config]
4. AGI(agi-VDAD_ALL_outbound.agi,SURVEYCAMP-----LB) [pbx_config]
5. Hangup() [pbx_config]
'8367' => 1. Playback(sip-silence) [pbx_config]
2. AGI(agi://127.0.0.1:4577/call_log) [pbx_config]
3. AGI(agi-VDAD_ALL_outbound.agi,NORMAL-----LO) [pbx_config]
4. AGI(agi-VDAD_ALL_outbound.agi,NORMAL-----LO) [pbx_config]
5. Hangup() [pbx_config]
'8368' => 1. Playback(sip-silence) [pbx_config]
2. AGI(agi://127.0.0.1:4577/call_log) [pbx_config]
3. AGI(agi-VDAD_ALL_outbound.agi,NORMAL-----LB) [pbx_config]
4. AGI(agi-VDAD_ALL_outbound.agi,NORMAL-----LB) [pbx_config]
5. Hangup() [pbx_config]
'8369' => 1. Playback(sip-silence) [pbx_config]
2. AGI(agi://127.0.0.1:4577/call_log) [pbx_config]
3. AMD(2000,2000,1000,5000,120,50,4,256) [pbx_config]
4. AGI(VD_amd.agi,${EXTEN}) [pbx_config]
5. AGI(agi-VDAD_ALL_outbound.agi,NORMAL-----LB) [pbx_config]
6. AGI(agi-VDAD_ALL_outbound.agi,NORMAL-----LB) [pbx_config]
7. Hangup() [pbx_config]
'8372' => 1. Playback(sip-silence) [pbx_config]
2. AGI(agi://127.0.0.1:4577/call_log) [pbx_config]
3. AGI(agi-VDADautoREMINDER.agi,${EXTEN}) [pbx_config]
4. AGI(agi-VDADautoREMINDER.agi,${EXTEN}) [pbx_config]
5. Hangup() [pbx_config]
'8373' => 1. Playback(sip-silence) [pbx_config]
2. AGI(agi://127.0.0.1:4577/call_log) [pbx_config]
3. AMD(2000,2000,1000,5000,120,50,4,256) [pbx_config]
4. AGI(VD_amd.agi,${EXTEN}) [pbx_config]
5. AGI(agi-VDAD_ALL_outbound.agi,SURVEYCAMP-----LB) [pbx_config]
6. AGI(agi-VDAD_ALL_outbound.agi,SURVEYCAMP-----LB) [pbx_config]
7. Hangup() [pbx_config]
'8374' => 1. Playback(sip-silence) [pbx_config]
2. AGI(agi://127.0.0.1:4577/call_log) [pbx_config]
3. AGI(agi-VDAD_ALL_outbound.agi,SURVEYCAMPCEP-----LB) [pbx_config]
4. AGI(agi-VDAD_ALL_outbound.agi,SURVEYCAMPCEP-----LB) [pbx_config]
5. Hangup() [pbx_config]
'8375' => 1. Playback(sip-silence) [pbx_config]
2. AGI(agi://127.0.0.1:4577/call_log) [pbx_config]
3. AMD(2000,2000,1000,5000,120,50,4,256) [pbx_config]
4. AGI(VD_amd.agi,${EXTEN}) [pbx_config]
5. AGI(agi-VDAD_ALL_outbound.agi,SURVEYCAMPCEP-----LB) [pbx_config]
6. AGI(agi-VDAD_ALL_outbound.agi,SURVEYCAMPCEP-----LB) [pbx_config]
7. Hangup() [pbx_config]
'8377' => 1. Playback(sip-silence) [pbx_config]
2. AGI(agi://127.0.0.1:4577/call_log) [pbx_config]
3. Set(LRct=1) [pbx_config]
4. While($[${LRct} < 100]) [pbx_config]
5. AGI(agi-VDAD_ALL_outboundBETA.agi,NORMAL-----LB) [pbx_config]
6. Set(LRct=$[${LRct} + 1]) [pbx_config]
7. EndWhile() [pbx_config]
8. AGI(agi-VDAD_ALL_outboundBETA.agi,NORMAL-----LB) [pbx_config]
9. Hangup() [pbx_config]
'8500998' => 1. Answer() [pbx_config]
2. Playback(silence) [pbx_config]
3. AGI(agi-dtmf.agi) [pbx_config]
4. Hangup() [pbx_config]
'8889990011112' => 1. Goto(loopback-no-log,9990011112,1) [pbx_config]
2. Hanguo() [pbx_config]
'h' => 1. AGI(agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----${HANGUPCAUSE}-----${DIALSTATUS}-----${DIALEDTIME}-----${ANSWEREDTIME}) [pbx_config]
'i' => 1. Playback(invalid) [pbx_config]
2. Hangup() [pbx_config]
't' => 1. Goto(#,1) [pbx_config]
2. Hangup() [pbx_config]
'_08600XXX' => 1. Dial(${TRUNKblind}/6${EXTEN:1},55,To) [pbx_config]
2. Hangup() [pbx_config]
'_55558600XXX' => 1. MeetMeAdmin(${EXTEN:4},K) [pbx_config]
2. Hangup() [pbx_config]
'_558600XXX' => 1. Meetme(${EXTEN:2},Fmq) [pbx_config]
2. Hangup() [pbx_config]
'_58600XXX' => 1. Meetme(${EXTEN:1},Fmq) [pbx_config]
2. Hangup() [pbx_config]
'_6851XXXXX' => 1. Answer() [pbx_config]
2. WaitForSilence(2000,1,90) [pbx_config]
3. Playback(sip-silence) [pbx_config]
4. Playback(${EXTEN:1}) [pbx_config]
5. Hangup() [pbx_config]
'_68600XXX' => 1. Meetme(${EXTEN:1},Fmq) [pbx_config]
2. Hangup() [pbx_config]
'_7851XXXXX' => 1. WaitForSilence(2000,2) [pbx_config]
2. Playback(${EXTEN:1}) [pbx_config]
3. AGI(VD_amd_post.agi,${EXTEN:1}) [pbx_config]
4. Hangup() [pbx_config]
'_78600XXX*.' => 1. AGI(agi-VDADfixCXFER.agi) [pbx_config]
2. Hangup() [pbx_config]
'_78600XXX' => 1. Meetme(${EXTEN:1},Fq) [pbx_config]
2. Hangup() [pbx_config]
'_8320*.' => 1. AGI(VD_amd.agi,${EXTEN}-----YES) [pbx_config]
2. Hangup() [pbx_config]
'_8331*.' => 1. Playback(sip-silence) [pbx_config]
2. AGI(agi-VDAD_RINGALL.agi,${EXTEN}) [pbx_config]
3. AGI(agi-VDAD_RINGALL.agi,${EXTEN}) [pbx_config]
4. AGI(agi-VDAD_RINGALL.agi,${EXTEN}) [pbx_config]
5. Hangup() [pbx_config]
'_851XXXXX' => 1. Answer() [pbx_config]
2. Playback(${EXTEN}) [pbx_config]
3. Hangup() [pbx_config]
'_86000[0-4]X' => 1. Meetme(${EXTEN},q) [pbx_config]
2. Hangup() [pbx_config]
'_86000[5-9]X' => 1. Meetme(${EXTEN},F) [pbx_config]
2. Hangup() [pbx_config]
'_86009XX' => 1. Meetme(${EXTEN},Fmq) [pbx_config]
'_8600[1-2]XX' => 1. Meetme(${EXTEN},F) [pbx_config]
2. Hangup() [pbx_config]
'_8600XXX*.' => 1. AGI(agi-VDADfixCXFER.agi) [pbx_config]
2. Hangup() [pbx_config]
'_86120XX' => 1. ZapBarge(${EXTEN:5}) [pbx_config]
2. Hangup() [pbx_config]
'_881NXXNXXXXXX' => 1. Answer() [pbx_config]
2. Dial(${TRUNKloop}/9${EXTEN:2},,To) [pbx_config]
3. Hangup() [pbx_config]
'_90009.' => 1. Answer() [pbx_config]
2. Dial(${TRUNKloop}/9${EXTEN},,to) [pbx_config]
3. Hangup() [pbx_config]
'_9118XXXXXXXX' => 1. Dial(${TRUNKblind}/9998818112,55,to) [pbx_config]
2. Hangup() [pbx_config]
'_9119XXXXXXXX' => 1. Dial(${TRUNKblind}/9998819112,55,to) [pbx_config]
2. Hangup() [pbx_config]
'_986009XX' => 1. Meetme(${EXTEN:1}) [pbx_config]
'_990009.' => 1. Answer() [pbx_config]
2. AGI(agi-VDAD_ALL_inbound.agi,CLOSER-----LB-----CL_TESTCAMP-----7275551212-----Closer-----park----------999-----1) [pbx_config]
3. Hangup() [pbx_config]
'_99909*.' => 1. Answer() [pbx_config]
2. AGI(agi-VDAD_ALL_inbound.agi) [pbx_config]
3. Hangup() [pbx_config]
'_999XX11112' => 1. Wait(2) [pbx_config]
2. Answer() [pbx_config]
3. Playback(ss-noservice) [pbx_config]
4. Playback(vm-goodbye) [pbx_config]
5. Hangup() [pbx_config]
'_999XX18112' => 1. Wait(2) [pbx_config]
2. Answer() [pbx_config]
3. Playback(vtiger-fax) [pbx_config]
4. Playback(vtiger-fax) [pbx_config]
5. Hangup() [pbx_config]
'_999XX19112' => 1. Wait(2) [pbx_config]
2. Answer() [pbx_config]
3. Playback(vtiger-email) [pbx_config]
4. Playback(vtiger-email) [pbx_config]
5. Hangup() [pbx_config]
'_999XXXX112' => 1. Wait(5) [pbx_config]
2. Answer() [pbx_config]
3. Playback(demo-instruct) [pbx_config]
4. Playback(demo-instruct) [pbx_config]
5. Hangup() [pbx_config]
'_999XXXXXX0' => 1. Wait(5) [pbx_config]
2. Answer() [pbx_config]
3. Playback(vm-goodbye) [pbx_config]
4. Hangup() [pbx_config]
'_999XXXXXX1' => 1. Answer() [pbx_config]
2. Wait(2) [pbx_config]
3. Playback(vicidial-welcome) [pbx_config]
4. Hangup() [pbx_config]
'_999XXXXXX2' => 1. Wait(8) [pbx_config]
2. Answer() [pbx_config]
3. Playback(demo-instruct) [pbx_config]
4. Hangup() [pbx_config]
'_999XXXXXX3' => 1. Set(PRI_CAUSE=1) [pbx_config]
2. Hangup() [pbx_config]
'_999XXXXXX4' => 1. Set(PRI_CAUSE=27) [pbx_config]
2. Hangup() [pbx_config]
'_999XXXXXX5' => 1. Ringing() [pbx_config]
2. Wait(120) [pbx_config]
3. Hangup() [pbx_config]
'_999XXXXXX6' => 1. Wait(10) [pbx_config]
2. Answer() [pbx_config]
3. Playback(demo-instruct) [pbx_config]
4. Hangup() [pbx_config]
'_999XXXXXX7' => 1. Wait(12) [pbx_config]
2. Answer() [pbx_config]
3. Playback(demo-enterkeywords) [pbx_config]
4. Hangup() [pbx_config]
'_999XXXXXX8' => 1. Set(PRI_CAUSE=17) [pbx_config]
2. Hangup() [pbx_config]
'_999XXXXXX9' => 1. Wait(6) [pbx_config]
2. Answer() [pbx_config]
3. Playback(demo-abouttotry) [pbx_config]
4. Hangup() [pbx_config]
'_X18600XXX' => 1. MeetMeAdmin(${EXTEN:2},M,${EXTEN:0:1}) [pbx_config]
2. Hangup() [pbx_config]
'_X28600XXX' => 1. MeetMeAdmin(${EXTEN:2},m,${EXTEN:0:1}) [pbx_config]
2. Hangup() [pbx_config]
'_X38600XXX' => 1. MeetMeAdmin(${EXTEN:2},t,${EXTEN:0:1}) [pbx_config]
2. Hangup() [pbx_config]
'_X48600XXX' => 1. MeetMeAdmin(${EXTEN:2},T,${EXTEN:0:1}) [pbx_config]
2. Hangup() [pbx_config]
Include => 'vicidial-auto' [pbx_config]

[ Context 'loopback-no-log' created by 'pbx_config' ]
'_999XX11112' => 1. Wait(2) [pbx_config]
2. Answer() [pbx_config]
3. Playback(ss-noservice) [pbx_config]
4. Playback(vm-goodbye) [pbx_config]
5. Hangup() [pbx_config]

[ Context 'trunkinbound' created by 'pbx_config' ]
'h' => 1. AGI(agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----${HANGUPCAUSE}-----${DIALSTATUS}-----${DIALEDTIME}-----${ANSWEREDTIME}) [pbx_config]
'_X.' => 1. AGI(agi-DID_route.agi) [pbx_config]
2. Hangup() [pbx_config]

[ Context 'vicidial-auto' created by 'pbx_config' ]
'h' => 1. AGI(agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----${HANGUPCAUSE}-----${DIALSTATUS}-----${DIALEDTIME}-----${ANSWEREDTIME}) [pbx_config]
Include => 'vicidial-auto-internal' [pbx_config]
Include => 'vicidial-auto-phones' [pbx_config]
Include => 'vicidial-auto-external' [pbx_config]

[ Context 'vicidial-auto-phones' created by 'pbx_config' ]
'100' => 1. Dial(SIP/100,60,) [pbx_config]
2. Goto(default,85026666666666100,1) [pbx_config]
3. Hangup() [pbx_config]
'101' => 1. Dial(SIP/101,60,) [pbx_config]
2. Goto(default,85026666666666101,1) [pbx_config]
3. Hangup() [pbx_config]
'102' => 1. Dial(SIP/102,60,) [pbx_config]
2. Goto(default,85026666666666102,1) [pbx_config]
3. Hangup() [pbx_config]
'103' => 1. Dial(SIP/103,60,) [pbx_config]
2. Goto(default,85026666666666103,1) [pbx_config]
3. Hangup() [pbx_config]
'104' => 1. Dial(SIP/104,60,) [pbx_config]
2. Goto(default,85026666666666104,1) [pbx_config]
3. Hangup() [pbx_config]
'105' => 1. Dial(SIP/105,60,) [pbx_config]
2. Goto(default,85026666666666105,1) [pbx_config]
3. Hangup() [pbx_config]
'106' => 1. Dial(SIP/106,60,) [pbx_config]
2. Goto(default,85026666666666106,1) [pbx_config]
3. Hangup() [pbx_config]
'107' => 1. Dial(SIP/107,60,) [pbx_config]
2. Goto(default,85026666666666107,1) [pbx_config]
3. Hangup() [pbx_config]
'108' => 1. Dial(SIP/108,60,) [pbx_config]
2. Goto(default,85026666666666108,1) [pbx_config]
3. Hangup() [pbx_config]
'109' => 1. Dial(SIP/109,60,) [pbx_config]
2. Goto(default,85026666666666109,1) [pbx_config]
3. Hangup() [pbx_config]
'110' => 1. Dial(SIP/110,60,) [pbx_config]
2. Goto(default,85026666666666110,1) [pbx_config]
3. Hangup() [pbx_config]
'111' => 1. Dial(SIP/111,60,) [pbx_config]
2. Goto(default,85026666666666111,1) [pbx_config]
3. Hangup() [pbx_config]
'112' => 1. Dial(SIP/112,60,) [pbx_config]
2. Goto(default,85026666666666112,1) [pbx_config]
3. Hangup() [pbx_config]
'113' => 1. Dial(SIP/113,60,) [pbx_config]
2. Goto(default,85026666666666113,1) [pbx_config]
3. Hangup() [pbx_config]
'114' => 1. Dial(SIP/114,60,) [pbx_config]
2. Goto(default,85026666666666114,1) [pbx_config]
3. Hangup() [pbx_config]
'115' => 1. Dial(SIP/115,60,) [pbx_config]
2. Goto(default,85026666666666115,1) [pbx_config]
3. Hangup() [pbx_config]
'116' => 1. Dial(SIP/116,60,) [pbx_config]
2. Goto(default,85026666666666116,1) [pbx_config]
3. Hangup() [pbx_config]
'117' => 1. Dial(SIP/117,60,) [pbx_config]
2. Goto(default,85026666666666117,1) [pbx_config]
3. Hangup() [pbx_config]
'118' => 1. Dial(SIP/118,60,) [pbx_config]
2. Goto(default,85026666666666118,1) [pbx_config]
3. Hangup() [pbx_config]
'119' => 1. Dial(SIP/119,60,) [pbx_config]
2. Goto(default,85026666666666119,1) [pbx_config]
3. Hangup() [pbx_config]
'120' => 1. Dial(IAX2/120,60,) [pbx_config]
2. Goto(default,85026666666666120,1) [pbx_config]
3. Hangup() [pbx_config]
'121' => 1. Dial(SIP/121,60,) [pbx_config]
2. Goto(default,85026666666666121,1) [pbx_config]
3. Hangup() [pbx_config]
'122' => 1. Dial(SIP/122,60,) [pbx_config]
2. Goto(default,85026666666666122,1) [pbx_config]
3. Hangup() [pbx_config]
'123' => 1. Dial(SIP/123,60,) [pbx_config]
2. Goto(default,85026666666666123,1) [pbx_config]
3. Hangup() [pbx_config]
'124' => 1. Dial(SIP/124,60,) [pbx_config]
2. Goto(default,85026666666666124,1) [pbx_config]
3. Hangup() [pbx_config]
'125' => 1. Dial(SIP/125,60,) [pbx_config]
2. Goto(default,85026666666666125,1) [pbx_config]
3. Hangup() [pbx_config]
'126' => 1. Dial(SIP/126,60,) [pbx_config]
2. Goto(default,85026666666666126,1) [pbx_config]
3. Hangup() [pbx_config]
'127' => 1. Dial(SIP/127,60,) [pbx_config]
2. Goto(default,85026666666666127,1) [pbx_config]
3. Hangup() [pbx_config]
'128' => 1. Dial(SIP/128,60,) [pbx_config]
2. Goto(default,85026666666666128,1) [pbx_config]
3. Hangup() [pbx_config]
'129' => 1. Dial(SIP/129,60,) [pbx_config]
2. Goto(default,85026666666666129,1) [pbx_config]
3. Hangup() [pbx_config]
'130' => 1. Dial(SIP/130,60,) [pbx_config]
2. Goto(default,85026666666666130,1) [pbx_config]
3. Hangup() [pbx_config]
'131' => 1. Dial(SIP/131,60,) [pbx_config]
2. Goto(default,85026666666666131,1) [pbx_config]
3. Hangup() [pbx_config]
'132' => 1. Dial(SIP/132,60,) [pbx_config]
2. Goto(default,85026666666666132,1) [pbx_config]
3. Hangup() [pbx_config]
'133' => 1. Dial(SIP/133,60,) [pbx_config]
2. Goto(default,85026666666666133,1) [pbx_config]
3. Hangup() [pbx_config]
'134' => 1. Dial(SIP/134,60,) [pbx_config]
2. Goto(default,85026666666666134,1) [pbx_config]
3. Hangup() [pbx_config]
'135' => 1. Dial(SIP/135,60,) [pbx_config]
2. Goto(default,85026666666666135,1) [pbx_config]
3. Hangup() [pbx_config]
'136' => 1. Dial(SIP/136,60,) [pbx_config]
2. Goto(default,85026666666666136,1) [pbx_config]
3. Hangup() [pbx_config]
'137' => 1. Dial(SIP/137,60,) [pbx_config]
2. Goto(default,85026666666666137,1) [pbx_config]
3. Hangup() [pbx_config]
'138' => 1. Dial(SIP/138,60,) [pbx_config]
2. Goto(default,85026666666666138,1) [pbx_config]
3. Hangup() [pbx_config]
'139' => 1. Dial(SIP/139,60,) [pbx_config]
2. Goto(default,85026666666666139,1) [pbx_config]
3. Hangup() [pbx_config]
'140' => 1. Dial(SIP/140,60,) [pbx_config]
2. Goto(default,85026666666666140,1) [pbx_config]
3. Hangup() [pbx_config]
'141' => 1. Dial(SIP/141,60,) [pbx_config]
2. Goto(default,85026666666666141,1) [pbx_config]
3. Hangup() [pbx_config]
'142' => 1. Dial(SIP/142,60,) [pbx_config]
2. Goto(default,85026666666666142,1) [pbx_config]
3. Hangup() [pbx_config]
'143' => 1. Dial(SIP/143,60,) [pbx_config]
2. Goto(default,85026666666666143,1) [pbx_config]
3. Hangup() [pbx_config]
'144' => 1. Dial(SIP/144,60,) [pbx_config]
2. Goto(default,85026666666666144,1) [pbx_config]
3. Hangup() [pbx_config]
'145' => 1. Dial(SIP/145,60,) [pbx_config]
2. Goto(default,85026666666666145,1) [pbx_config]
3. Hangup() [pbx_config]
'146' => 1. Dial(SIP/146,60,) [pbx_config]
2. Goto(default,85026666666666146,1) [pbx_config]
3. Hangup() [pbx_config]
'147' => 1. Dial(SIP/147,60,) [pbx_config]
2. Goto(default,85026666666666147,1) [pbx_config]
3. Hangup() [pbx_config]
'148' => 1. Dial(SIP/148,60,) [pbx_config]
2. Goto(default,85026666666666148,1) [pbx_config]
3. Hangup() [pbx_config]
'149' => 1. Dial(SIP/149,60,) [pbx_config]
2. Goto(default,85026666666666149,1) [pbx_config]
3. Hangup() [pbx_config]
'150' => 1. Dial(SIP/150,60,) [pbx_config]
2. Goto(default,85026666666666150,1) [pbx_config]
3. Hangup() [pbx_config]
'500' => 1. Dial(SIP/500,60,) [pbx_config]
2. Goto(default,85026666666666500,1) [pbx_config]
3. Hangup() [pbx_config]
'h' => 1. AGI(agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----${HANGUPCAUSE}-----${DIALSTATUS}-----${DIALEDTIME}-----${ANSWEREDTIME}) [pbx_config]

[ Context 'vicidial-auto-internal' created by 'pbx_config' ]
'8167' => 1. Answer() [pbx_config]
2. AGI(agi-record_prompts.agi,wav-----720000) [pbx_config]
3. Hangup() [pbx_config]
'8168' => 1. Answer() [pbx_config]
2. AGI(agi-record_prompts.agi,gsm-----720000) [pbx_config]
3. Hangup() [pbx_config]
'83047777777777' => 1. Answer() [pbx_config]
2. Playback(${CALLERID(name)}) [pbx_config]
3. Hangup() [pbx_config]
'8309' => 1. Answer() [pbx_config]
2. Monitor(wav,${CALLERID(name)}) [pbx_config]
3. Wait(3600) [pbx_config]
4. Hangup() [pbx_config]
'8310' => 1. Answer() [pbx_config]
2. Monitor(gsm,${CALLERID(name)}) [pbx_config]
3. Wait(3600) [pbx_config]
4. Hangup() [pbx_config]
'8500' => 1. VoicemailMain() [pbx_config]
2. Goto(s,6) [pbx_config]
3. Hangup() [pbx_config]
'8501' => 1. VoicemailMain(s${CALLERID(num)}) [pbx_config]
2. Hangup() [pbx_config]
'h' => 1. AGI(agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----${HANGUPCAUSE}-----${DIALSTATUS}-----${DIALEDTIME}-----${ANSWEREDTIME}) [pbx_config]
'_8305888888888888X999' => 1. Answer() [pbx_config]
2. Wait(3600) [pbx_config]
3. Hangup() [pbx_config]
'_8305888888888888.' => 1. Answer() [pbx_config]
2. Wait(${EXTEN:16:1}) [pbx_config]
3. Dial(${TRUNKloop}/${EXTEN:17},,To) [pbx_config]
4. Hangup() [pbx_config]
'_85026666666666.' => 1. Wait(1) [pbx_config]
2. Voicemail(${EXTEN:14},u) [pbx_config]
3. Hangup() [pbx_config]
'_85026666666667.' => 1. Wait(1) [pbx_config]
2. Voicemail(${EXTEN:14},su) [pbx_config]
3. Hangup() [pbx_config]

[ Context 'vicidial-auto-external' created by 'pbx_config' ]
'473782138521111' => 1. Answer() [pbx_config]
2. Wait(5) [pbx_config]
3. Hangup() [pbx_config]
'473782158521111' => 1. Answer() [pbx_config]
2. ControlPlayback(${CALLERID(name)},99999,0,1,2,3,4) [pbx_config]
3. Hangup() [pbx_config]
'h' => 1. AGI(agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----${HANGUPCAUSE}-----${DIALSTATUS}-----${DIALEDTIME}-----${ANSWEREDTIME}) [pbx_config]
'_**192*168*001*011*.' => 1. Goto(default,${EXTEN:18},1) [pbx_config]
2. Hangup() [pbx_config]
'_192*168*001*011*.' => 1. Goto(default,${EXTEN:16},1) [pbx_config]
2. Hangup() [pbx_config]
'_473782148521111.' => 1. Answer() [pbx_config]
2. SendDTMF(${CALLERID(num)},250,250,IAX2/ASTplay-${EXTEN:15}) [pbx_config]
3. Hangup() [pbx_config]
'_473782168600XXX' => 1. Dial(${TRUNKplay}/47378217${EXTEN:8},5,To) [pbx_config]
2. Hangup() [pbx_config]
'_473782178600XXX' => 1. Meetme(${EXTEN:8},q) [pbx_config]
2. Hangup() [pbx_config]
'_473782188600XXX' => 1. Answer() [pbx_config]
2. Wait(1) [pbx_config]
3. AGI(getAGENTchannel.agi) [pbx_config]
4. NoOp(${agent_zap_channel}) [pbx_config]
5. GotoIf($[ "${agent_zap_channel}" = "101" ]?fin) [pbx_config]
6. ChanSpy(${agent_zap_channel},qw) [pbx_config]
[fin] 7. Hangup() [pbx_config]
'_51NXXNXXXXXX' => 1. AGI(agi://127.0.0.1:4577/call_log) [pbx_config]
2. Dial(${VOIPESSMAN2}/729${EXTEN:1},,tTo) [pbx_config]
3. Hangup() [pbx_config]
'_61NXXNXXXXXX' => 1. AGI(agi://127.0.0.1:4577/call_log) [pbx_config]
2. Dial(${VOIPESS2}/${EXTEN:1},,tTo) [pbx_config]
3. Hangup() [pbx_config]
'_71NXXNXXXXXX' => 1. AGI(agi://127.0.0.1:4577/call_log) [pbx_config]
2. Dial(${VOIPESSMAN}/729${EXTEN:1},,tTo) [pbx_config]
3. Hangup() [pbx_config]
'_81NXXNXXXXXX' => 1. AGI(agi://127.0.0.1:4577/call_log) [pbx_config]
2. Dial(${VOIPESS}/${EXTEN:1},,tTo) [pbx_config]
3. Hangup() [pbx_config]

[ Context 'SURVEY_RXCARD_MAILER' created by 'pbx_config' ]
'1' => 1. AGI(agi-VDAD_ALL_inbound.agi,VIDPROMPTLOOKUPRL-----LB-----SURVEY_RXCARD-----SURVEY_RXCARD_MAILER--------------------977-----1-----TENS---------------Survey_RXCard_IVR_Enter_Claim_Number-----Sruvey_RXCard_IVR_You_have_entered-----Survey_RXCard_IVR_Press_1_to_confirm-----) [pbx_config]
2. Hangup() [pbx_config]
'h' => 1. AGI(agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----${HANGUPCAUSE}-----${DIALSTATUS}-----${DIALEDTIME}-----${ANSWEREDTIME}) [pbx_config]
'i' => 1. Goto(s,4) [pbx_config]
2. Hangup() [pbx_config]
's' => 1. Answer() [pbx_config]
2. AGI(agi-VDAD_inbound_calltime_check.agi,CALLMENU-----YES-----SURVEY_RXCARD_MAILER-------------------------NO) [pbx_config]
3. Set(INVCOUNT=0) [pbx_config]
4. Background(Survey_RXCard_IVR_Greeting) [pbx_config]
5. WaitExten(5) [pbx_config]
6. Background(Survey_RXCard_IVR_Greeting) [pbx_config]
7. WaitExten(5) [pbx_config]
't' => 1. Playback(goodbye) [pbx_config]
2. Playback(goodbye) [pbx_config]
3. Hangup() [pbx_config]

[ Context 'MISDIAL_IVR_BRACES' created by 'pbx_config' ]
'0' => 1. Playback(goodbye) [pbx_config]
2. Hangup() [pbx_config]
'1' => 1. AGI(agi-VDAD_ALL_inbound.agi,CIDLOOKUPRL-----LB-----MISDIAL_BRACES-----MISDIAL_IVR_BRACES--------------------984-----1-----TENS------------------------------) [pbx_config]
2. Hangup() [pbx_config]
'h' => 1. AGI(agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----${HANGUPCAUSE}-----${DIALSTATUS}-----${DIALEDTIME}-----${ANSWEREDTIME}) [pbx_config]
'i' => 1. AGI(agi-VDAD_ALL_inbound.agi,CIDLOOKUPRL-----LB-----MISDIAL_TRANSFER_OUT-----MISDIAL_IVR_BRACES--------------------978-----1-----MD_XFER------------------------------) [pbx_config]
2. Hangup() [pbx_config]
's' => 1. Answer() [pbx_config]
2. AGI(agi-VDAD_inbound_calltime_check.agi,CALLMENU-----YES-----MISDIAL_IVR_BRACES-------------------------NO) [pbx_config]
3. Set(INVCOUNT=0) [pbx_config]
4. Background(Misdial_KneeBrace_08242015_8k) [pbx_config]
5. WaitExten(5) [pbx_config]
6. Background(Misdial_KneeBrace_08242015_8k) [pbx_config]
7. WaitExten(5) [pbx_config]
't' => 1. Playback(goodbye) [pbx_config]
2. Playback(goodbye) [pbx_config]
3. Hangup() [pbx_config]

[ Context 'defaultlog' created by 'pbx_config' ]
'h' => 1. AGI(agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----${HANGUPCAUSE}-----${DIALSTATUS}-----${DIALEDTIME}-----${ANSWEREDTIME}) [pbx_config]
'i' => 1. Goto(s,4) [pbx_config]
2. Hangup() [pbx_config]
's' => 1. Answer() [pbx_config]
2. AGI(agi-VDAD_inbound_calltime_check.agi,-----NO-----defaultlog-------------------------NO) [pbx_config]
3. Set(INVCOUNT=0) [pbx_config]
4. Background(sip-silence) [pbx_config]
5. WaitExten(20) [pbx_config]
't' => 1. Playback(vm-goodbye) [pbx_config]
2. Hangup() [pbx_config]
'_X.' => 1. AGI(agi-NVA_recording.agi,BOTH------Y---Y---Y) [pbx_config]
2. Goto(default,${EXTEN},1) [pbx_config]

-= 304 extensions (900 priorities) in 14 contexts. =-

[rockgeneral]

If there is any other conf or log file I can post that would help pinpoint where the problem is let me know and I will post.

Thanks again for the help!

[mflorell]

The Asterisk CLI output looks fine.

Is the "AST_VDremote_agents"(option 4) set to run on your dialer in the /etc/astguiclient.conf file?

[rockgeneral]

If my understanding of the syntax is correct, yes it appears to be set to run. (See below)

However, I noticed for item 7 (# 7 - AST_VDauto_dial_FILL (only for multi-server, this must only be on one server)) it seems to imply that it is only for a multi-server setup. I am running a single server. Would running this on a single server cause any problems?

# Alpha-Numeric list of the astGUIclient processes to be kept running
# (value should be listing of characters with no spaces: 123456)
# X - NO KEEPALIVE PROCESSES (use only if you want none to be keepalive)
# 1 - AST_update
# 2 - AST_send_listen
# 3 - AST_VDauto_dial
# 4 - AST_VDremote_agents
# 5 - AST_VDadapt (If multi-server system, this must only be on one server)
# 6 - FastAGI_log
# 7 - AST_VDauto_dial_FILL (only for multi-server, this must only be on one server)
# 8 - ip_relay (used for blind agent monitoring)
# 9 - Timeclock auto logout
VARactive_keepalives => 123456789E

[mflorell]

No, enabling 7 on a single-server wouldn't cause problems, but it is a slight waste of CPU cycles.

As for the ASTVDremote process, when you attach to that screen, do you see any output?

[rockgeneral]

I activated the Remote Agent this morning and then attached to the screen for ASTVDRemote and then called in. As usual once I hung up the call it remains listed as INCALL on the realtime screen. Below is the output from the screen:

vicibox2016:~ # screen -r 220906
1 live remote agents ACTIVE
0 remote agents on calls
0
CALL WIPE UPDATE: 0E0|READY|||

CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9102|1||2000|
TIME DEBUG: -5|-4|1| GMT: 12:10
1 live remote agents ACTIVE
0 remote agents on calls
0
CALL WIPE UPDATE: 0E0|READY|||

CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9101|1||2000|
TIME DEBUG: -5|-4|1| GMT: 12:10
1 live remote agents ACTIVE
0 remote agents on calls
0
CALL WIPE UPDATE: 0E0|READY|||

CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9100|1||2000|
TIME DEBUG: -5|-4|1| GMT: 12:10
checking to see if listener is dead |1|
1 live remote agents ACTIVE
0 remote agents on calls
0
CALL WIPE UPDATE: 0E0|READY|||

CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9099|1||2000|
TIME DEBUG: -5|-4|1| GMT: 12:10
1 live remote agents ACTIVE
0 remote agents on calls
0
CALL WIPE UPDATE: 0E0|READY|||

CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9098|1||2000|
TIME DEBUG: -5|-4|1| GMT: 12:10
1 live remote agents ACTIVE
0 remote agents on calls
0
CALL WIPE UPDATE: 0E0|READY|||

CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9097|1||2000|
TIME DEBUG: -5|-4|1| GMT: 12:10
1 live remote agents ACTIVE
0 remote agents on calls
0
CALL WIPE UPDATE: 0E0|READY|||

CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9096|1||2000|
TIME DEBUG: -5|-4|1| GMT: 12:10
1 live remote agents ACTIVE
0 remote agents on calls
0
CALL WIPE UPDATE: 0E0|READY|||

CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9095|1||2000|
TIME DEBUG: -5|-4|1| GMT: 12:10
checking to see if listener is dead |1|
1 live remote agents ACTIVE
0 remote agents on calls
0
CALL WIPE UPDATE: 0E0|READY|||

CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9094|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:10
1 live remote agents ACTIVE
0 remote agents on calls
CALL WIPE UPDATE: 0E0|READY|||
CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9093|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:10
1 live remote agents ACTIVE
0 remote agents on calls
CALL WIPE UPDATE: 0E0|READY|||
CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9092|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:10
1 live remote agents ACTIVE
0 remote agents on calls
CALL WIPE UPDATE: 0E0|READY|||
CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9091|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:10
1 live remote agents ACTIVE
0 remote agents on calls
CALL WIPE UPDATE: 0E0|READY|||
CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9090|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:10
checking to see if listener is dead |1|
1 live remote agents ACTIVE
0 remote agents on calls
CALL WIPE UPDATE: 0E0|READY|||
CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9089|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:10
1 live remote agents ACTIVE
0 remote agents on calls
CALL WIPE UPDATE: 0E0|READY|||
CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9097|1||2000|
TIME DEBUG: -5|-4|1| GMT: 12:10
1 live remote agents ACTIVE
0 remote agents on calls
0
CALL WIPE UPDATE: 0E0|READY|||

CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9096|1||2000|
TIME DEBUG: -5|-4|1| GMT: 12:10
1 live remote agents ACTIVE
0 remote agents on calls
0
CALL WIPE UPDATE: 0E0|READY|||

CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9095|1||2000|
TIME DEBUG: -5|-4|1| GMT: 12:10
checking to see if listener is dead |1|
1 live remote agents ACTIVE
0 remote agents on calls
0
CALL WIPE UPDATE: 0E0|READY|||

CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9094|1||2000|
TIME DEBUG: -5|-4|1| GMT: 12:10
1 live remote agents ACTIVE
0 remote agents on calls
0
CALL WIPE UPDATE: 0E0|READY|||

CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9093|1||2000|
TIME DEBUG: -5|-4|1| GMT: 12:10
1 live remote agents ACTIVE
0 remote agents on calls
0
CALL WIPE UPDATE: 0E0|READY|||

CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9092|1||2000|
TIME DEBUG: -5|-4|1| GMT: 12:10
1 live remote agents ACTIVE
0 remote agents on calls
0
CALL WIPE UPDATE: 0E0|READY|||

CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9091|1||2000|
TIME DEBUG: -5|-4|1| GMT: 12:10
1 live remote agents ACTIVE
0 remote agents on calls
0
CALL WIPE UPDATE: 0E0|READY|||

CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9090|1||2000|
TIME DEBUG: -5|-4|1| GMT: 12:10
checking to see if listener is dead |1|
1 live remote agents ACTIVE
0 remote agents on calls
0
CALL WIPE UPDATE: 0E0|READY|||

CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9089|1||2000|
TIME DEBUG: -5|-4|1| GMT: 12:10
1 live remote agents ACTIVE
0 remote agents on calls
0
CALL WIPE UPDATE: 0E0|READY|||

CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9088|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:10
1 live remote agents ACTIVE
0 remote agents on calls
CALL WIPE UPDATE: 0E0|READY|||
CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9087|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:10
1 live remote agents ACTIVE
0 remote agents on calls
CALL WIPE UPDATE: 0E0|READY|||
CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9086|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:10
1 live remote agents ACTIVE
0 remote agents on calls
CALL WIPE UPDATE: 0E0|READY|||
CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9085|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:10
checking to see if listener is dead |1|
1 live remote agents ACTIVE
0 remote agents on calls
CALL WIPE UPDATE: 0E0|READY|||
CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9084|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:11
1 live remote agents ACTIVE
0 remote agents on calls
CALL WIPE UPDATE: 0E0|READY|||
CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9083|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:11
1 live remote agents ACTIVE
0 remote agents on calls
CALL WIPE UPDATE: 0E0|READY|||
CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9082|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:11
1 live remote agents ACTIVE
0 remote agents on calls
CALL WIPE UPDATE: 0E0|READY|||
CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9081|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:11
1 live remote agents ACTIVE
0 remote agents on calls
CALL WIPE UPDATE: 0E0|READY|||
CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9080|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:11
checking to see if listener is dead |1|
1 live remote agents ACTIVE
0 remote agents on calls
CALL WIPE UPDATE: 0E0|READY|||
CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9079|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:11
1 live remote agents ACTIVE
0 remote agents on calls
CALL WIPE UPDATE: 0E0|READY|||
CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9078|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:11
1 live remote agents ACTIVE
0 remote agents on calls
CALL WIPE UPDATE: 0E0|READY|||
CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9077|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:11
1 live remote agents ACTIVE
0 remote agents on calls
CALL WIPE UPDATE: 0E0|READY|||
CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9076|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:11
1 live remote agents ACTIVE
0 remote agents on calls
CALL WIPE UPDATE: 0E0|READY|||
CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9075|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:11
checking to see if listener is dead |1|
1 live remote agents ACTIVE
0 remote agents on calls
CALL WIPE UPDATE: 0E0|READY|||
CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9074|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:11
1 live remote agents ACTIVE
0 remote agents on calls
CALL WIPE UPDATE: 0E0|READY|||
CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9073|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:11
1 live remote agents ACTIVE
0 remote agents on calls
CALL WIPE UPDATE: 0E0|READY|||
CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9072|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:11
1 live remote agents ACTIVE
0 remote agents on calls
CALL WIPE UPDATE: 0E0|READY|||
CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9071|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:11
1 live remote agents ACTIVE
0 remote agents on calls
CALL WIPE UPDATE: 0E0|READY|||
CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9070|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:11
checking to see if listener is dead |1|
1 live remote agents ACTIVE
0 remote agents on calls
CALL WIPE UPDATE: 0E0|READY|||
CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9069|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:11
1 live remote agents ACTIVE
0 remote agents on calls
CALL WIPE UPDATE: 0E0|READY|||
CALL WIPE UPDATE: 0E0|READY|||

loop counter: |9068|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:11
1 live remote agents ACTIVE
1 remote agents on calls

loop counter: |9067|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:11
1 live remote agents ACTIVE
1 remote agents on calls

loop counter: |9066|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:11
1 live remote agents ACTIVE
1 remote agents on calls

loop counter: |9065|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:11
2017-04-05 08:11:38|| QUEUEd listing UPDATEd: |1|1|1|2|0E0| |227618|10596244|1491394290.79249|8888|IN|SHORELINE_1||
checking to see if listener is dead |1|
1 live remote agents ACTIVE
1 remote agents on calls

loop counter: |9064|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:11
1 live remote agents ACTIVE
1 remote agents on calls

loop counter: |9063|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:11
1 live remote agents ACTIVE
1 remote agents on calls

loop counter: |9062|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:11
1 live remote agents ACTIVE
1 remote agents on calls

loop counter: |9061|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:11
1 live remote agents ACTIVE
1 remote agents on calls

loop counter: |9060|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:11
checking to see if listener is dead |1|
1 live remote agents ACTIVE
1 remote agents on calls

loop counter: |9059|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:11
1 live remote agents ACTIVE
1 remote agents on calls

loop counter: |9058|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:11
1 live remote agents ACTIVE
1 remote agents on calls

loop counter: |9057|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:11
1 live remote agents ACTIVE
1 remote agents on calls

loop counter: |9056|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:11
1 live remote agents ACTIVE
1 remote agents on calls

loop counter: |9055|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:11
checking to see if listener is dead |1|
1 live remote agents ACTIVE
1 remote agents on calls

loop counter: |9054|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:12
1 live remote agents ACTIVE
1 remote agents on calls

loop counter: |9053|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:12
1 live remote agents ACTIVE
1 remote agents on calls

loop counter: |9052|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:12
1 live remote agents ACTIVE
1 remote agents on calls

loop counter: |9051|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:12
1 live remote agents ACTIVE
1 remote agents on calls

loop counter: |9050|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:12
checking to see if listener is dead |1|
1 live remote agents ACTIVE
1 remote agents on calls

loop counter: |9049|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:12
1 live remote agents ACTIVE
1 remote agents on calls

loop counter: |9048|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:12
1 live remote agents ACTIVE
1 remote agents on calls

loop counter: |9047|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:12
1 live remote agents ACTIVE
1 remote agents on calls

loop counter: |9046|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:12
1 live remote agents ACTIVE
1 remote agents on calls

loop counter: |9045|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:12
checking to see if listener is dead |1|
1 live remote agents ACTIVE
1 remote agents on calls

loop counter: |9044|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:12
1 live remote agents ACTIVE
1 remote agents on calls

loop counter: |9043|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:12
1 live remote agents ACTIVE
1 remote agents on calls

loop counter: |9042|1| |2000|
TIME DEBUG: -5|-4|1| GMT: 12:12
1 live remote agents ACTIVE
1 remote agents on calls

[detached from 22906.ASTVDremote]

[rockgeneral]

I have 1 other issue that I am having ever since upgrading to this version of vicidial. I am not sure if it is related to the issue I am having with the Remote Agent calls, but based on the symptoms it seems like it may have the same root cause. The only major difference is it happens intermittently where as the Remote Agent issue happens 100% of the time.

A handful of times a day an inbound call will get stuck in the vicidial_auto_calls table. Unlike the Remote Agent calls though they do not continue to show in the real-time screen as still being connected to an agent. They are reflected in the "current active calls" count. Soon after the upgrade, I noticed at the end of the shift the real-time screen would say we had active calls when I knew we did not. After some digging, I found them still in the vicidial_auto_calls table.

As I mentioned the Remote Agent issue happens with ever call. The issue of some inbound calls being stuck in the vicidial_auto_calls table happens occasionally. For example yesterday we took 511 inbound calls by the end of the day there were probably 10 inbound calls "stuck" in the table. (I don't have an exact count as the system seems to clear these out nightly.) It occurred to me that this information may be helpful in diagnosing the overall problem.

Thanks again for your help.

[mflorell]

What version of vicidial were you on before?

Did you upgrade Asterisk at the same time?

Is the Server set to the proper version of Asterisk in the modify server page?

Do you regularly reboot your server?

[rockgeneral]

What version of vicidial were you on before?

VERSION: 2.4b0.5 BUILD: 110506-1612
Asterisk 1.4.21.2-vici

I actually upgraded in an effort to try to fix an issue I was having with the Filter Phone by URL functionality. I had posted looking for help, and you noted that you hadn't seen the issue before and pointed out that I was on a 5-year-old version and should consider upgrading. There are a lot of nice new features btw. viewtopic.php?f=4&t=36599

Did you upgrade Asterisk at the same time?

Yes. The process I followed was:
1) Installed new server using Vicibox 7.0.3.
2) Restored asterisk DB from the production server.
3) Ran, in order, upgrade_2.4.sql, upgrade_2.6.sql, upgrade_2.8.sql, upgrade_2.10.sql, upgrade_2.12.sql and upgrade_2.14.sql
4) Ran perl ./install.pl
6) Set Rebuild conf files = Y
7) Ran /usr/share/astguiclient/ADMIN_area_code_populate.pl --purge-table --debug
8) Copied over voicemails and custom sounds from old server.
9) Enabled FTP uploading of recordings to another server for archiving purposes.

Is the Server set to the proper version of Asterisk in the modify server page?

Output of "core show version": Asterisk 11.25.1-vici built by abuild @ cloud101 on a x86_64 running Linux on 2017-03-28 05:47:09 UTC
Admin Servers Page: Asterisk Version: 11.25.1-vici

On the advice of Michael Cargile I recently ran a 'zypper ref' and 'zypper dup' to update asterisk to fix a bug where asterisk didn't properly update the Admin Servers asterisk version during vicibox install. I had already manually fixed the asterisk version on Servers page setting manually, but I was hoping the updated asterisk package would fix the current issue but it didn't.

Do you regularly reboot your server?

No. However, I rebooted on 04/01/2017 after the "zypper" process and the issue still happens.

Thanks again for all your help!

[mflorell]

I'm not really sure what could be causing this issue, but I'm pretty sure it's related to the calls staying in vicidial_auto_calls after they are hung up. There is probably some issue where the hangups aren't getting caught somewhere.

I would suggest going to the System Settings page and forcing a refresh of the dialplan to see if there are any changes that were not put into effect after the upgrade.

Beyond that, take a look at the fastAGI log for a specific call that was not removed from the vicidial_auto_calls table to see if there are any indicators of what happened when the call hung up.

[rockgeneral]

It wasn't quite clear on the System Settings page where to trigger the refresh of the dialplan, so I just clicked the Submit button. I also set 'Rebuild conf files' to Y in the Servers page. I waited until the 'Rebuild conf files' reset back to N. Lastly, I ran a 'dialplan reload' in asterisk just to be sure. For the future, what is the proper/preferred method for refreshing the dialplan?

I grabbed a copy of the the "dialplan show" command prior to doing the above and then grabbed another after and I am going to compare them now to see if there are any changes. After that, I will take a look at the fastAGI log.

Thanks again!

[rockgeneral]

Matt,

The only difference between the "diaplan show" output was the order of the frst two context entries, otherwise the files were identical:

Pre refresh started with:
[ Context 'parkedcalls' created by 'features' ]
'700' => 1. Park() [features]

[ Context 'iaxregistration' created by 'IAX2' ]
'ASTblind' => 1. Noop(ASTblind) [IAX2]
'ASTloop' => 1. Noop(ASTloop) [IAX2]
'ASTplay' => 1. Noop(ASTplay) [IAX2]

Post refresh started with:
[ Context 'iaxregistration' created by 'IAX2' ]
'ASTblind' => 1. Noop(ASTblind) [IAX2]
'ASTloop' => 1. Noop(ASTloop) [IAX2]
'ASTplay' => 1. Noop(ASTplay) [IAX2]

[ Context 'parkedcalls' created by 'features' ]
'700' => 1. Park() [features]

Below I included the fast agi output from the test call I placed on 04/01/2017:

For privacy, I replaced the following in the fast agi output below:
AAAAAAAAAA = DID
BBBBBBBBBB = Phone number of inbound caller

FASTagiout:

2017-04-01 13:09:49|VDfastAGI|begin|+++++++++++++++++ FastAGI Start ++++++++++++++++++++++++++++++++++++++++
2017-04-01 13:09:49|VDfastAGI|begin|Perl Environment Dump:
2017-04-01 13:09:49|VDfastAGI|begin|0|--debug
2017-04-01 13:09:49|VDfastAGI|begin|AGI Environment Dump:
2017-04-01 13:09:49|VDfastAGI|begin| -- accountcode =
2017-04-01 13:09:49|VDfastAGI|begin| -- callerid = BBBBBBBBBB
2017-04-01 13:09:49|VDfastAGI|begin| -- calleridname = Y4011309480010596244
2017-04-01 13:09:49|VDfastAGI|begin| -- callingani2 = 0
2017-04-01 13:09:49|VDfastAGI|begin| -- callingpres = 0
2017-04-01 13:09:49|VDfastAGI|begin| -- callingtns = 0
2017-04-01 13:09:49|VDfastAGI|begin| -- callington = 0
2017-04-01 13:09:49|VDfastAGI|begin| -- channel = SIP/ve_inbound_new-00000020
2017-04-01 13:09:49|VDfastAGI|begin| -- context = default
2017-04-01 13:09:49|VDfastAGI|begin| -- dnid = AAAAAAAAAA
2017-04-01 13:09:49|VDfastAGI|begin| -- enhanced = 0.0
2017-04-01 13:09:49|VDfastAGI|begin| -- extension = 618007721213
2017-04-01 13:09:49|VDfastAGI|begin| -- language = en
2017-04-01 13:09:49|VDfastAGI|begin| -- network = yes
2017-04-01 13:09:49|VDfastAGI|begin| -- network_script = call_log
2017-04-01 13:09:49|VDfastAGI|begin| -- priority = 1
2017-04-01 13:09:49|VDfastAGI|begin| -- rdnis = unknown
2017-04-01 13:09:49|VDfastAGI|begin| -- request = agi://127.0.0.1:4577/call_log
2017-04-01 13:09:49|VDfastAGI|begin| -- threadid = 140182918919936
2017-04-01 13:09:49|VDfastAGI|begin| -- type = SIP
2017-04-01 13:09:49|VDfastAGI|begin| -- uniqueid = 1491066587.69
2017-04-01 13:09:49|VDfastAGI|begin| -- version = 11.25.1-vici
2017-04-01 13:09:49|VDfastAGI|begin|AGI Variables: |1491066587.69|SIP/ve_inbound_new-00000020|618007721213|SIP|Y4011309480010596244|
2017-04-01 13:09:49|VDfastAGI|call_log|Process to run: |agi://127.0.0.1:4577/call_log|call_log|START|
2017-04-01 13:09:49|VDfastAGI|call_log|+++++ CALL LOG START : 2017-04-01 13:09:49
2017-04-01 13:09:49|VDfastAGI|call_log||INSERT INTO call_log (uniqueid,channel,channel_group,type,server_ip,extension,number_dialed,start_time,start_epoch,end_time,end_epoch,length_in_sec,length_in_min,caller_code) values('1491066587.69','SIP/ve_inbound_new','','SIP','192.168.1.11','ve_inbound_new','618007721213','2017-04-01 13:09:49','1491066589','','','','','Y4011309480010596244')|
2017-04-01 13:10:08|VDfastAGI|begin|+++++++++++++++++ FastAGI Start ++++++++++++++++++++++++++++++++++++++++
2017-04-01 13:10:08|VDfastAGI|begin|Perl Environment Dump:
2017-04-01 13:10:08|VDfastAGI|begin|0|--debug
2017-04-01 13:10:08|VDfastAGI|begin|URL HVcauses: |PRI|NODEBUG|16|ANSWER|22|12|
2017-04-01 13:10:08|VDfastAGI|begin|AGI Environment Dump:
2017-04-01 13:10:08|VDfastAGI|begin| -- accountcode =
2017-04-01 13:10:08|VDfastAGI|begin| -- callerid = BBBBBBBBBB
2017-04-01 13:10:08|VDfastAGI|begin| -- calleridname = Y4011309480010596244
2017-04-01 13:10:08|VDfastAGI|begin| -- callingani2 = 0
2017-04-01 13:10:08|VDfastAGI|begin| -- callingpres = 0
2017-04-01 13:10:08|VDfastAGI|begin| -- callingtns = 0
2017-04-01 13:10:08|VDfastAGI|begin| -- callington = 0
2017-04-01 13:10:08|VDfastAGI|begin| -- channel = SIP/ve_inbound_new-00000020
2017-04-01 13:10:08|VDfastAGI|begin| -- context = default
2017-04-01 13:10:08|VDfastAGI|begin| -- dnid = AAAAAAAAAA
2017-04-01 13:10:08|VDfastAGI|begin| -- enhanced = 0.0
2017-04-01 13:10:08|VDfastAGI|begin| -- extension = h
2017-04-01 13:10:08|VDfastAGI|begin| -- language = en
2017-04-01 13:10:08|VDfastAGI|begin| -- network = yes
2017-04-01 13:10:08|VDfastAGI|begin| -- network_script = call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----21-----16
2017-04-01 13:10:08|VDfastAGI|begin| -- priority = 1
2017-04-01 13:10:08|VDfastAGI|begin| -- rdnis = unknown
2017-04-01 13:10:08|VDfastAGI|begin| -- request = agi://127.0.0.1:4577/call_log--HVcauses ... -21-----16
2017-04-01 13:10:08|VDfastAGI|begin| -- threadid = 140182918919936
2017-04-01 13:10:08|VDfastAGI|begin| -- type = SIP
2017-04-01 13:10:08|VDfastAGI|begin| -- uniqueid = 1491066587.69
2017-04-01 13:10:08|VDfastAGI|begin| -- version = 11.25.1-vici
2017-04-01 13:10:08|VDfastAGI|begin|AGI Variables: |1491066587.69|SIP/ve_inbound_new-00000020|h|SIP|Y4011309480010596244|
2017-04-01 13:10:08|VDfastAGI|call_log|Process to run: |agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----21-----16|call_log|END|
2017-04-01 13:10:08|VDfastAGI|call_log||CALL HUNG UP|
2017-04-01 13:10:08|VDfastAGI|call_log|URL HVcauses: |PRI|NODEBUG|16|ANSWER|21|5|
2017-04-01 13:10:08|VDfastAGI|call_log||1491066587.69|1491066587|SIP/ve_inbound_new-00000020|1491066588|
2017-04-01 13:10:08|VDfastAGI|call_log||DELETE from live_inbound where uniqueid IN('1491066587.69','1491066587.69') and server_ip='192.168.1.11'|
2017-04-01 13:10:08|VDfastAGI|call_log|+++++ CALL LOG HUNGUP: |1491066587.69|SIP/ve_inbound_new-00000020|h|2017-04-01 13:10:08|min: 0.95|
2017-04-01 13:10:08|VDfastAGI|call_log|DEBUG: NODEBUG
2017-04-01 13:10:08|VDfastAGI|call_log|VD_hangup : Y4011309480010596244 SIP/ve_inbound_new-00000020 1 10596244
2017-04-01 13:10:08|VDfastAGI|call_log||SELECT lead_id,callerid,campaign_id,alt_dial,stage,UNIX_TIMESTAMP(call_time),uniqueid,status,call_time,phone_code,phone_number,queue_position,server_ip FROM vicidial_auto_calls where uniqueid = '1491066587.69' or callerid = 'Y4011309480010596244' limit 1;|
2017-04-01 13:10:08|VDfastAGI|call_log||SELECT channel from parked_channels where channel_group='Y4011309480010596244';|
2017-04-01 13:10:08|VDfastAGI|call_log||SELECT channel,server_ip from parked_channels_recent where channel_group='Y4011309480010596244' and park_end_time > "2017-04-01 11:10:08" order by park_end_time desc limit 1;|
2017-04-01 13:10:08|VDfastAGI|call_log|VD hangup: VDAC record found with park record OTHER SERVER: SIP/ve_inbound_new-00000020(0|0) 1491066587.69 Y4011309480010596244 192.168.1.11|
2017-04-01 13:10:08|VDfastAGI|call_log|VD hangup: VDAC record found with park record: SIP/ve_inbound_new-00000020(0|0) 1491066587.69 Y4011309480010596244 192.168.1.11

[mflorell]

I don't know why I didn't catch this sooner, but according to your signature you are only on DB Schema version 1482, Is that true? If so, please upgrade to the latest svn/trunk, there are some bugs related to these issues that may be causing this problem that were fixed months ago.

[rockgeneral]

Matt,

Yes I am on DB Schema 1482. I will upgrade as soon as possible, re-test and then let you know how I make out.

Thanks again.

[rockgeneral]

Matt,

I performed the SVN trunk upgrade and I initially thought it didn't fix the issue. Well after gathering a ton of logs and information to post for you to look at, it occurred to me that I hadn't rebooted after the upgrade. Well, I just rebooted and then placed another call to the did that was routing to the remote agent and voila, the call released as soon as I hung up.

THANK YOU SO MUCH FOR YOUR HELP!!!!!!

[mflorell]

Did you restart the server after your upgrade?

[rockgeneral]

Wow you are quick! I was updating my post to reflect that it was fixed after the reboot.

Thanks again.