vicidial.org

VICIDIAL astGUIclient discussion forum
http://forum.eflo.net/VICIDIALforum/

Multiple VD_AMD.AGI running

http://forum.eflo.net/VICIDIALforum/viewtopic.php?f=4&t=40695

Page 1 of 1

Multiple VD_AMD.AGI running

PostPosted: Thu Mar 04, 2021 1:56 pm
by jessiekidfernando
Hello Everyone,

Our connect rate could be affected by this. Any idea what could be the reason? Thanks in advance.

VERSION: 2.14-780a
BUILD: 201201-1944


Every 1.0s: ps aux | grep asterisk Thu Mar 4 13:56:05 2021

root 2193 0.4 0.0 12180 3188 pts/1 S+ 13:35 0:05 watch -n 1 ps aux | grep asterisk
root 5341 11.5 2.2 1889964 86652 ? Ssl 07:14 46:11 /usr/sbin/asterisk -fn
root 23315 0.3 0.3 47844 12932 ? S 13:55 0:00 /usr/bin/perl /usr/share/asterisk/agi-bin/VD_amd.agi 8387
root 23316 0.4 0.3 47844 12860 ? S 13:55 0:00 /usr/bin/perl /usr/share/asterisk/agi-bin/VD_amd.agi 8387
root 23363 0.5 0.3 47844 12864 ? S 13:56 0:00 /usr/bin/perl /usr/share/asterisk/agi-bin/VD_amd.agi 8387
root 23386 0.6 0.3 47836 12100 ? S 13:56 0:00 /usr/bin/perl /usr/share/asterisk/agi-bin/VD_amd.agi 8387
root 23387 0.8 0.3 47844 12892 ? S 13:56 0:00 /usr/bin/perl /usr/share/asterisk/agi-bin/VD_amd.agi 8387
root 23477 2.5 0.3 47844 12848 ? S 13:56 0:00 /usr/bin/perl /usr/share/asterisk/agi-bin/VD_amd.agi 8387
root 23481 2.3 0.3 47844 12848 ? S 13:56 0:00 /usr/bin/perl /usr/share/asterisk/agi-bin/VD_amd.agi 8387
root 23487 10.3 0.3 47844 12936 ? S 13:56 0:00 /usr/bin/perl /usr/share/asterisk/agi-bin/VD_amd.agi 8387
root 23488 0.0 0.0 12176 1280 pts/1 S+ 13:56 0:00 watch -n 1 ps aux | grep asterisk
root 23489 0.0 0.0 11872 2600 pts/1 S+ 13:56 0:00 sh -c ps aux | grep asterisk
root 23491 0.0 0.0 9292 1652 pts/1 S+ 13:56 0:00 grep asterisk

Re: Multiple VD_AMD.AGI running

PostPosted: Thu Mar 04, 2021 2:39 pm
by jessiekidfernando
Sample debug.

Code: Select all

sea2-AST1:/var/log/astguiclient # cat /var/log/asterisk/messages | grep C-0000bd04
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] pbx.c: Executing [813236911763@default:1] AGI("Local/813236911763@default-00006d1a;2", "agi://127.0.0.1:4577/call_log") in new stack
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: AGI Tx >> agi_network: yes
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: AGI Tx >> agi_network_script: call_log
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_request: agi://127.0.0.1:4577/call_log
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_channel: Local/813236911763@default-00006d1a;2
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_language: en
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_type: Local
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_uniqueid: 1614886459.82497
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_version: 13.34.0-vici
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_callerid: 3237458460
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_calleridname: V3041434190000105650
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_callingpres: 0
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_callingani2: 0
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_callington: 0
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_callingtns: 0
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_dnid: unknown
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_rdnis: unknown
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_context: default
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_extension: 813236911763
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_priority: 1
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_enhanced: 0.0
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_accountcode:
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_threadid: 139749839107840
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >>
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Rx << EXEC EXEC Set(_CAMPCUST=OUTSOURC) ""
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: AGI Script Executing Application: (EXEC) Options: (Set(_CAMPCUST=OUTSOURC))
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> 200 result=0
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> HANGUP
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] pbx.c: Executing [813236911763@default:2] Set("Local/813236911763@default-00006d1a;2", "CallerIDString=3237458460") in new stack
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] pbx.c: Executing [813236911763@default:3] Set("Local/813236911763@default-00006d1a;2", "CALLERID(num)=+13237458460") in new stack
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] pbx.c: Executing [813236911763@default:4] NoOp("Local/813236911763@default-00006d1a;2", "CallerID : +13237458460") in new stack
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] pbx.c: Executing [813236911763@default:5] Dial("Local/813236911763@default-00006d1a;2", "SIP/primarySBC/13236911763,,tTo") in new stack
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] netsock2.c: Using SIP RTP CoS mark 5
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] app_dial.c: Called SIP/primarySBC/13236911763
[Mar  4 14:34:22] VERBOSE[13687][C-0000bd04] res_rtp_asterisk.c: 0x7f1a400ddf30 -- Strict RTP learning after remote address set to: 172.29.11.10:18496
[Mar  4 14:34:22] VERBOSE[4344][C-0000bd04] app_dial.c: SIP/primarySBC-000067b5 is making progress passing it to Local/813236911763@default-00006d1a;2
[Mar  4 14:34:23] VERBOSE[4344][C-0000bd04] app_dial.c: SIP/primarySBC-000067b5 is ringing
[Mar  4 14:34:23] VERBOSE[4344][C-0000bd04] app_dial.c: SIP/primarySBC-000067b5 is making progress passing it to Local/813236911763@default-00006d1a;2
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] app_dial.c: SIP/primarySBC-000067b5 answered Local/813236911763@default-00006d1a;2
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] bridge_channel.c: Channel SIP/primarySBC-000067b5 joined 'simple_bridge' basic-bridge <b99af038-237e-4f68-a3d5-e7fff52cf4a5>
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] bridge_channel.c: Channel Local/813236911763@default-00006d1a;2 joined 'simple_bridge' basic-bridge <b99af038-237e-4f68-a3d5-e7fff52cf4a5>
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] bridge_channel.c: Channel SIP/primarySBC-000067b5 left 'simple_bridge' basic-bridge <b99af038-237e-4f68-a3d5-e7fff52cf4a5>
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] pbx.c: Executing [8387@default:1] Playback("SIP/primarySBC-000067b5", "sip-silence") in new stack
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] bridge_channel.c: Channel Local/813236911763@default-00006d1a;2 left 'simple_bridge' basic-bridge <b99af038-237e-4f68-a3d5-e7fff52cf4a5>
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] pbx.c: Spawn extension (default, 813236911763, 5) exited non-zero on 'Local/813236911763@default-00006d1a;2'
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] pbx.c: Executing [h@default:1] AGI("Local/813236911763@default-00006d1a;2", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----33-----0-----SIP 200 OK)") in new stack
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: AGI Tx >> agi_network: yes
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: AGI Tx >> agi_network_script: call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----33-----0-----SIP 200 OK)
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_request: agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----33-----0-----SIP 200 OK)
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_channel: Local/813236911763@default-00006d1a;2
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_language: en
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_type: Local
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_uniqueid: 1614886459.82497
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_version: 13.34.0-vici
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] file.c: <SIP/primarySBC-000067b5> Playing 'sip-silence.gsm' (language 'en')
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_callerid: +13237458460
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_calleridname: V3041434190000105650
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_callingpres: 0
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_callingani2: 0
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_callington: 0
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_callingtns: 0
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_dnid: unknown
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_rdnis: unknown
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_context: default
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_extension: h
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_priority: 1
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_enhanced: 0.0
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_accountcode:
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_threadid: 139749839107840
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >>
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] pbx.c: Executing [8387@default:2] AGI("SIP/primarySBC-000067b5", "agi://127.0.0.1:4577/call_log") in new stack
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: AGI Tx >> agi_network: yes
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: AGI Tx >> agi_network_script: call_log
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_request: agi://127.0.0.1:4577/call_log
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_channel: SIP/primarySBC-000067b5
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_language: en
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_type: SIP
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_uniqueid: 1614886459.82498
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_version: 13.34.0-vici
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_callerid: +13237458460
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_calleridname: V3041434190000105650
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_callingpres: 0
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_callingani2: 0
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_callington: 0
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_callingtns: 0
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_dnid: unknown
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_rdnis: unknown
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_context: default
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_extension: 8387
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_priority: 2
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_enhanced: 0.0
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_accountcode:
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_threadid: 139749804570368
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >>
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Rx << EXEC EXEC Set(_CAMPCUST=OUTSOURC) ""
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: AGI Script Executing Application: (EXEC) Options: (Set(_CAMPCUST=OUTSOURC))
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> 200 result=0
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> HANGUP
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] pbx.c: Executing [8387@default:3] AMD("SIP/primarySBC-000067b5", "2500,2000,1000,5000,120,50,4,256") in new stack
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] app_amd.c: AMD: SIP/primarySBC-000067b5 (N/A) (N/A) (Fmt: slin)
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] app_amd.c: AMD: initialSilence [2500] greeting [2000] afterGreetingSilence [1000] totalAnalysisTime [5000] minimumWordLength [120] betweenWordsSilence [50] maximumNumberOfWords [4] silenceThreshold [256] maximumWordLength [5000]
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_rtp_asterisk.c: 0x7f1a400ddf30 -- Strict RTP switching to RTP target address 172.29.11.10:18496 as source
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_rtp_asterisk.c: 0x7f1a400ddf30 -- Strict RTP learning complete - Locking on source address 172.29.11.10:18496
[Mar  4 14:34:54] VERBOSE[4808][C-0000bd04] app_amd.c: AMD: Channel [SIP/primarySBC-000067b5]. Changed state to STATE_IN_SILENCE
[Mar  4 14:34:54] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----33-----0-----SIP 200 OK) completed, returning 0
[Mar  4 14:34:54] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> HANGUP
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] app_amd.c: AMD: Channel [SIP/primarySBC-000067b5]. ANSWERING MACHINE: silenceDuration:2500 initialSilence:2500
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] pbx.c: Executing [8387@default:4] NoOp("SIP/primarySBC-000067b5", "MACHINE") in new stack
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] pbx.c: Executing [8387@default:5] NoOp("SIP/primarySBC-000067b5", "INITIALSILENCE-2500-2500") in new stack
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] pbx.c: Executing [8387@default:6] AGI("SIP/primarySBC-000067b5", "VD_amd.agi,8387") in new stack
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: Launched AGI Script /usr/share/asterisk/agi-bin/VD_amd.agi
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_request: VD_amd.agi
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_channel: SIP/primarySBC-000067b5
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_language: en
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_type: SIP
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_uniqueid: 1614886459.82498
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_version: 13.34.0-vici
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_callerid: +13237458460
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_calleridname: V3041434190000105650
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_callingpres: 0
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_callingani2: 0
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_callington: 0
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_callingtns: 0
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_dnid: unknown
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_rdnis: unknown
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_context: default
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_extension: 8387
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_priority: 6
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_enhanced: 0.0
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_accountcode:
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_threadid: 139749804570368
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_arg_1: 8387
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >>
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Rx << GET VARIABLE AMDSTATUS
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> 200 result=1 (MACHINE)
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Rx << GET VARIABLE AMDCAUSE
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> 200 result=1 (INITIALSILENCE-2500-2500)
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Rx << GET VARIABLE AMDSTATS
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> 200 result=1 (2841-2500-2500-1000-0-0-2000-0-4)
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Rx << STREAM FILE sip-silence ""
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> 200 result=0 endpos=160
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Rx << STREAM FILE sip-silence ""
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> 200 result=0 endpos=160
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Rx << EXEC WaitForSilence 2000,2,10
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: AGI Script Executing Application: (WaitForSilence) Options: (2000,2,10)
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] app_waitforsilence.c: Waiting 2 time(s) for 2000ms of silence with 10s timeout
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> 200 result=0
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Rx << STREAM FILE sip-silence ""
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> 200 result=0 endpos=160
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Rx << HANGUP SIP/primarySBC-000067b5
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> 200 result=1
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Script VD_amd.agi completed, returning 4
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] pbx.c: Spawn extension (default, 8387, 6) exited non-zero on 'SIP/primarySBC-000067b5'
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] pbx.c: Executing [h@default:1] AGI("SIP/primarySBC-000067b5", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16--------------------SIP 200 OK)") in new stack
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: AGI Tx >> agi_network: yes
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: AGI Tx >> agi_network_script: call_log--HVcauses--PRI-----NODEBUG-----16--------------------SIP 200 OK)
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_request: agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16--------------------SIP 200 OK)
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_channel: SIP/primarySBC-000067b5
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_language: en
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_type: SIP
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_uniqueid: 1614886459.82498
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_version: 13.34.0-vici
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_callerid: +13237458460
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_calleridname: V3041434190000105650
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_callingpres: 0
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_callingani2: 0
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_callington: 0
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_callingtns: 0
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_dnid: unknown
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_rdnis: unknown
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_context: default
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_extension: h
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_priority: 1
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_enhanced: 0.0
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_accountcode:
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_threadid: 139749804570368
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >>
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16--------------------SIP 200 OK) completed, returning 0
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> HANGUP
sea2-AST1:/var/log/astguiclient # cat /var/log/asterisk/messages | grep C-0000bd04
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] pbx.c: Executing [813236911763@default:1] AGI("Local/813236911763@default-00006d1a;2", "agi://127.0.0.1:4577/call_log") in new stack
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: AGI Tx >> agi_network: yes
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: AGI Tx >> agi_network_script: call_log
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_request: agi://127.0.0.1:4577/call_log
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_channel: Local/813236911763@default-00006d1a;2
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_language: en
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_type: Local
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_uniqueid: 1614886459.82497
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_version: 13.34.0-vici
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_callerid: 3237458460
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_calleridname: V3041434190000105650
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_callingpres: 0
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_callingani2: 0
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_callington: 0
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_callingtns: 0
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_dnid: unknown
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_rdnis: unknown
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_context: default
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_extension: 813236911763
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_priority: 1
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_enhanced: 0.0
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_accountcode:
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_threadid: 139749839107840
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >>
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Rx << EXEC EXEC Set(_CAMPCUST=OUTSOURC) ""
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: AGI Script Executing Application: (EXEC) Options: (Set(_CAMPCUST=OUTSOURC))
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> 200 result=0
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> HANGUP
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] pbx.c: Executing [813236911763@default:2] Set("Local/813236911763@default-00006d1a;2", "CallerIDString=3237458460") in new stack
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] pbx.c: Executing [813236911763@default:3] Set("Local/813236911763@default-00006d1a;2", "CALLERID(num)=+13237458460") in new stack
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] pbx.c: Executing [813236911763@default:4] NoOp("Local/813236911763@default-00006d1a;2", "CallerID : +13237458460") in new stack
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] pbx.c: Executing [813236911763@default:5] Dial("Local/813236911763@default-00006d1a;2", "SIP/primarySBC/13236911763,,tTo") in new stack
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] netsock2.c: Using SIP RTP CoS mark 5
[Mar  4 14:34:19] VERBOSE[4344][C-0000bd04] app_dial.c: Called SIP/primarySBC/13236911763
[Mar  4 14:34:22] VERBOSE[13687][C-0000bd04] res_rtp_asterisk.c: 0x7f1a400ddf30 -- Strict RTP learning after remote address set to: 172.29.11.10:18496
[Mar  4 14:34:22] VERBOSE[4344][C-0000bd04] app_dial.c: SIP/primarySBC-000067b5 is making progress passing it to Local/813236911763@default-00006d1a;2
[Mar  4 14:34:23] VERBOSE[4344][C-0000bd04] app_dial.c: SIP/primarySBC-000067b5 is ringing
[Mar  4 14:34:23] VERBOSE[4344][C-0000bd04] app_dial.c: SIP/primarySBC-000067b5 is making progress passing it to Local/813236911763@default-00006d1a;2
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] app_dial.c: SIP/primarySBC-000067b5 answered Local/813236911763@default-00006d1a;2
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] bridge_channel.c: Channel SIP/primarySBC-000067b5 joined 'simple_bridge' basic-bridge <b99af038-237e-4f68-a3d5-e7fff52cf4a5>
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] bridge_channel.c: Channel Local/813236911763@default-00006d1a;2 joined 'simple_bridge' basic-bridge <b99af038-237e-4f68-a3d5-e7fff52cf4a5>
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] bridge_channel.c: Channel SIP/primarySBC-000067b5 left 'simple_bridge' basic-bridge <b99af038-237e-4f68-a3d5-e7fff52cf4a5>
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] pbx.c: Executing [8387@default:1] Playback("SIP/primarySBC-000067b5", "sip-silence") in new stack
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] bridge_channel.c: Channel Local/813236911763@default-00006d1a;2 left 'simple_bridge' basic-bridge <b99af038-237e-4f68-a3d5-e7fff52cf4a5>
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] pbx.c: Spawn extension (default, 813236911763, 5) exited non-zero on 'Local/813236911763@default-00006d1a;2'
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] pbx.c: Executing [h@default:1] AGI("Local/813236911763@default-00006d1a;2", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----33-----0-----SIP 200 OK)") in new stack
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: AGI Tx >> agi_network: yes
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: AGI Tx >> agi_network_script: call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----33-----0-----SIP 200 OK)
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_request: agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----33-----0-----SIP 200 OK)
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_channel: Local/813236911763@default-00006d1a;2
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_language: en
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_type: Local
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_uniqueid: 1614886459.82497
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_version: 13.34.0-vici
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] file.c: <SIP/primarySBC-000067b5> Playing 'sip-silence.gsm' (language 'en')
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_callerid: +13237458460
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_calleridname: V3041434190000105650
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_callingpres: 0
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_callingani2: 0
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_callington: 0
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_callingtns: 0
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_dnid: unknown
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_rdnis: unknown
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_context: default
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_extension: h
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_priority: 1
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_enhanced: 0.0
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_accountcode:
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> agi_threadid: 139749839107840
[Mar  4 14:34:53] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >>
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] pbx.c: Executing [8387@default:2] AGI("SIP/primarySBC-000067b5", "agi://127.0.0.1:4577/call_log") in new stack
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: AGI Tx >> agi_network: yes
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: AGI Tx >> agi_network_script: call_log
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_request: agi://127.0.0.1:4577/call_log
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_channel: SIP/primarySBC-000067b5
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_language: en
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_type: SIP
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_uniqueid: 1614886459.82498
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_version: 13.34.0-vici
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_callerid: +13237458460
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_calleridname: V3041434190000105650
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_callingpres: 0
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_callingani2: 0
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_callington: 0
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_callingtns: 0
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_dnid: unknown
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_rdnis: unknown
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_context: default
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_extension: 8387
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_priority: 2
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_enhanced: 0.0
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_accountcode:
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_threadid: 139749804570368
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >>
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Rx << EXEC EXEC Set(_CAMPCUST=OUTSOURC) ""
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: AGI Script Executing Application: (EXEC) Options: (Set(_CAMPCUST=OUTSOURC))
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> 200 result=0
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> HANGUP
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] pbx.c: Executing [8387@default:3] AMD("SIP/primarySBC-000067b5", "2500,2000,1000,5000,120,50,4,256") in new stack
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] app_amd.c: AMD: SIP/primarySBC-000067b5 (N/A) (N/A) (Fmt: slin)
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] app_amd.c: AMD: initialSilence [2500] greeting [2000] afterGreetingSilence [1000] totalAnalysisTime [5000] minimumWordLength [120] betweenWordsSilence [50] maximumNumberOfWords [4] silenceThreshold [256] maximumWordLength [5000]
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_rtp_asterisk.c: 0x7f1a400ddf30 -- Strict RTP switching to RTP target address 172.29.11.10:18496 as source
[Mar  4 14:34:53] VERBOSE[4808][C-0000bd04] res_rtp_asterisk.c: 0x7f1a400ddf30 -- Strict RTP learning complete - Locking on source address 172.29.11.10:18496
[Mar  4 14:34:54] VERBOSE[4808][C-0000bd04] app_amd.c: AMD: Channel [SIP/primarySBC-000067b5]. Changed state to STATE_IN_SILENCE
[Mar  4 14:34:54] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----33-----0-----SIP 200 OK) completed, returning 0
[Mar  4 14:34:54] VERBOSE[4344][C-0000bd04] res_agi.c: <Local/813236911763@default-00006d1a;2>AGI Tx >> HANGUP
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] app_amd.c: AMD: Channel [SIP/primarySBC-000067b5]. ANSWERING MACHINE: silenceDuration:2500 initialSilence:2500
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] pbx.c: Executing [8387@default:4] NoOp("SIP/primarySBC-000067b5", "MACHINE") in new stack
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] pbx.c: Executing [8387@default:5] NoOp("SIP/primarySBC-000067b5", "INITIALSILENCE-2500-2500") in new stack
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] pbx.c: Executing [8387@default:6] AGI("SIP/primarySBC-000067b5", "VD_amd.agi,8387") in new stack
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: Launched AGI Script /usr/share/asterisk/agi-bin/VD_amd.agi
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_request: VD_amd.agi
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_channel: SIP/primarySBC-000067b5
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_language: en
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_type: SIP
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_uniqueid: 1614886459.82498
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_version: 13.34.0-vici
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_callerid: +13237458460
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_calleridname: V3041434190000105650
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_callingpres: 0
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_callingani2: 0
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_callington: 0
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_callingtns: 0
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_dnid: unknown
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_rdnis: unknown
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_context: default
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_extension: 8387
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_priority: 6
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_enhanced: 0.0
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_accountcode:
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_threadid: 139749804570368
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_arg_1: 8387
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >>
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Rx << GET VARIABLE AMDSTATUS
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> 200 result=1 (MACHINE)
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Rx << GET VARIABLE AMDCAUSE
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> 200 result=1 (INITIALSILENCE-2500-2500)
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Rx << GET VARIABLE AMDSTATS
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> 200 result=1 (2841-2500-2500-1000-0-0-2000-0-4)
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Rx << STREAM FILE sip-silence ""
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> 200 result=0 endpos=160
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Rx << STREAM FILE sip-silence ""
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> 200 result=0 endpos=160
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Rx << EXEC WaitForSilence 2000,2,10
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] res_agi.c: AGI Script Executing Application: (WaitForSilence) Options: (2000,2,10)
[Mar  4 14:34:56] VERBOSE[4808][C-0000bd04] app_waitforsilence.c: Waiting 2 time(s) for 2000ms of silence with 10s timeout
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> 200 result=0
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Rx << STREAM FILE sip-silence ""
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> 200 result=0 endpos=160
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Rx << HANGUP SIP/primarySBC-000067b5
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> 200 result=1
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Script VD_amd.agi completed, returning 4
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] pbx.c: Spawn extension (default, 8387, 6) exited non-zero on 'SIP/primarySBC-000067b5'
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] pbx.c: Executing [h@default:1] AGI("SIP/primarySBC-000067b5", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16--------------------SIP 200 OK)") in new stack
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: AGI Tx >> agi_network: yes
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: AGI Tx >> agi_network_script: call_log--HVcauses--PRI-----NODEBUG-----16--------------------SIP 200 OK)
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_request: agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16--------------------SIP 200 OK)
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_channel: SIP/primarySBC-000067b5
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_language: en
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_type: SIP
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_uniqueid: 1614886459.82498
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_version: 13.34.0-vici
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_callerid: +13237458460
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_calleridname: V3041434190000105650
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_callingpres: 0
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_callingani2: 0
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_callington: 0
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_callingtns: 0
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_dnid: unknown
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_rdnis: unknown
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_context: default
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_extension: h
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_priority: 1
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_enhanced: 0.0
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_accountcode:
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> agi_threadid: 139749804570368
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >>
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16--------------------SIP 200 OK) completed, returning 0
[Mar  4 14:35:06] VERBOSE[4808][C-0000bd04] res_agi.c: <SIP/primarySBC-000067b5>AGI Tx >> HANGUP
[/code]

Re: Multiple VD_AMD.AGI running

PostPosted: Fri Mar 05, 2021 1:26 pm
by jessiekidfernando
Dialplan:

exten => 8387,1,Playback(sip-silence) ; test 03052021 for dialplan reload purposes
exten => 8387,n,AGI(agi://127.0.0.1:4577/call_log)
exten => 8387,n,AMD(2000,2000,1000,6000,120,50,4,256)
exten => 8387,n,NoOp(${AMDSTATUS})
exten => 8387,n,NoOp(${AMDCAUSE})
exten => 8387,n,AGI(VD_amd.agi,${EXTEN})
exten => 8387,n,AGI(agi-VDAD_ALL_outbound.agi,NORMAL-----LO)
exten => 8387,n,AGI(agi-VDAD_ALL_outbound.agi,NORMAL-----LO)
exten => 8387,n,Hangup()
All times are UTC - 5 hours
Page 1 of 1
Powered by phpBB® Forum Software © phpBB Group
http://www.phpbb.com/