Some Calls not Connecting to an Agent

[alpaka]

VERSION: 2.14-757a
BUILD: 200619-1643

Version: 2.14b0.5
SVN Version: 3258

We're having an issue where not all calls are being sent to the agents.

Here are the logs we pulled for the various calls. We used grep on the ID of the call shown in the output and pasted everything we found. For calls that go through, we see them hit the right DID.

Sometimes when calls don't come back through they hit the agi-VDAD_local_optimize.agi and then transfer to [138368@default:2]. We don't know the cause of this but it is happening somewhere on the Vici or Asterisk and is likely related to load.

For reference:
Did not go through:
4436149596
7035592753
7857873394

Went through:
7857873394

-----
Start of logs
CID that did not go through:
4436149596

messages grep C-000005c2
[May 12 09:14:33] VERBOSE[27003][C-000005c2] pbx.c: Executing [914436149596@default:1] AGI("Local/914436149596@default-00000359;2", "agi://127.0.0.1:4577/call_log") in new stack
[May 12 09:14:33] VERBOSE[27003][C-000005c2] res_agi.c: AGI Script Executing Application: (EXEC) Options: (Set(_CAMPCUST=TJ_AI_US))
[May 12 09:14:33] VERBOSE[27003][C-000005c2] res_agi.c: <Local/914436149596@default-00000359;2>AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[May 12 09:14:33] VERBOSE[27003][C-000005c2] pbx.c: Executing [914436149596@default:2] Dial("Local/914436149596@default-00000359;2", "SIP/14436149596@ENTP,,To") in new stack
[May 12 09:14:33] VERBOSE[27003][C-000005c2] netsock2.c: Using SIP RTP CoS mark 5
[May 12 09:14:33] VERBOSE[27003][C-000005c2] app_dial.c: Called SIP/14436149596@ENTP
[May 12 09:14:34] VERBOSE[3343][C-000005c2] res_rtp_asterisk.c: 0x7f4b90008460 -- Strict RTP learning after remote address set to: 207.223.77.140:9306
[May 12 09:14:34] VERBOSE[27003][C-000005c2] app_dial.c: SIP/ENTP-0000058f is making progress passing it to Local/914436149596@default-00000359;2
[May 12 09:14:34] VERBOSE[27003][C-000005c2] res_rtp_asterisk.c: 0x7f4b90008460 -- Strict RTP switching to RTP target address 207.223.77.140:9306 as source
[May 12 09:14:38] VERBOSE[27003][C-000005c2] app_dial.c: SIP/ENTP-0000058f answered Local/914436149596@default-00000359;2
[May 12 09:14:38] VERBOSE[27110][C-000005c2] bridge_channel.c: Channel SIP/ENTP-0000058f joined 'simple_bridge' basic-bridge <823256da-942f-412e-8c15-6f91e1f5479d>
[May 12 09:14:38] VERBOSE[27003][C-000005c2] bridge_channel.c: Channel Local/914436149596@default-00000359;2 joined 'simple_bridge' basic-bridge <823256da-942f-412e-8c15-6f91e1f5479d>
[May 12 09:14:39] VERBOSE[27110][C-000005c2] bridge_channel.c: Channel SIP/ENTP-0000058f left 'simple_bridge' basic-bridge <823256da-942f-412e-8c15-6f91e1f5479d>
[May 12 09:14:39] VERBOSE[27003][C-000005c2] bridge_channel.c: Channel Local/914436149596@default-00000359;2 left 'simple_bridge' basic-bridge <823256da-942f-412e-8c15-6f91e1f5479d>
[May 12 09:14:39] VERBOSE[27110][C-000005c2] pbx.c: Executing [8368@default:1] AGI("SIP/ENTP-0000058f", "agi://127.0.0.1:4577/call_log") in new stack
[May 12 09:14:39] VERBOSE[27003][C-000005c2] pbx.c: Spawn extension (default, 914436149596, 2) exited non-zero on 'Local/914436149596@default-00000359;2'
[May 12 09:14:39] VERBOSE[27003][C-000005c2] pbx.c: Executing [h@default:1] AGI("Local/914436149596@default-00000359;2", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----5-----0-----SIP 200 OK)") in new stack
[May 12 09:14:39] VERBOSE[27110][C-000005c2] res_agi.c: AGI Script Executing Application: (EXEC) Options: (Set(_CAMPCUST=TJ_AI_US))
[May 12 09:14:39] VERBOSE[27110][C-000005c2] res_agi.c: <SIP/ENTP-0000058f>AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[May 12 09:14:39] VERBOSE[27110][C-000005c2] pbx.c: Executing [8368@default:2] AGI("SIP/ENTP-0000058f", "agi-VDAD_ALL_outbound.agi,NORMAL-----LB-----V5120914320001035263") in new stack
[May 12 09:14:39] VERBOSE[27110][C-000005c2] res_agi.c: Launched AGI Script /usr/share/asterisk/agi-bin/agi-VDAD_ALL_outbound.agi
[May 12 09:14:39] VERBOSE[27110][C-000005c2] res_agi.c: AGI Script Executing Application: (Monitor) Options: (wav,/var/spool/asterisk/monitor/MIX/TJ_AI_US_20210512-091439_14436149596)
[May 12 09:14:39] VERBOSE[27110][C-000005c2] res_agi.c: <SIP/ENTP-0000058f>AGI Script agi-VDAD_ALL_outbound.agi completed, returning 0
[May 12 09:14:39] VERBOSE[27110][C-000005c2] pbx.c: Executing [038*102*225*096*170101@default:1] Goto("SIP/ENTP-0000058f", "default,170101,1") in new stack
[May 12 09:14:39] VERBOSE[27110][C-000005c2] pbx_builtins.c: Goto (default,170101,1)
[May 12 09:14:39] VERBOSE[27110][C-000005c2] pbx.c: Executing [170101@default:1] Answer("SIP/ENTP-0000058f", "") in new stack
[May 12 09:14:39] VERBOSE[27110][C-000005c2] pbx.c: Executing [170101@default:2] AGI("SIP/ENTP-0000058f", "set_name_by_CID_dynamic.agi,0,0") in new stack
[May 12 09:14:39] VERBOSE[27110][C-000005c2] res_agi.c: Launched AGI Script /usr/share/asterisk/agi-bin/set_name_by_CID_dynamic.agi
[May 12 09:14:39] VERBOSE[27110][C-000005c2] res_agi.c: AGI Script Executing Application: (Set) Options: (CALLERID(name)=dawn)
[May 12 09:14:39] VERBOSE[27110][C-000005c2] res_agi.c: AGI Script Executing Application: (Set) Options: (CALLERID(num)=14436149596)
[May 12 09:14:39] VERBOSE[27110][C-000005c2] res_agi.c: <SIP/ENTP-0000058f>AGI Script set_name_by_CID_dynamic.agi completed, returning 0
[May 12 09:14:39] VERBOSE[27110][C-000005c2] pbx.c: Executing [170101@default:3] Dial("SIP/ENTP-0000058f", "SIP/170102@3.93.224.97") in new stack
[May 12 09:14:39] VERBOSE[27110][C-000005c2] netsock2.c: Using SIP RTP CoS mark 5
[May 12 09:14:39] VERBOSE[27110][C-000005c2] app_dial.c: Called SIP/170102@3.93.224.97
[May 12 09:14:39] VERBOSE[3343][C-000005c2] res_rtp_asterisk.c: 0x7f4a0c03e500 -- Strict RTP learning after remote address set to: 3.91.145.92:15154
[May 12 09:14:39] VERBOSE[27110][C-000005c2] app_dial.c: SIP/3.93.224.97-000005a4 answered SIP/ENTP-0000058f
[May 12 09:14:39] VERBOSE[27145][C-000005c2] bridge_channel.c: Channel SIP/3.93.224.97-000005a4 joined 'simple_bridge' basic-bridge <620f21d1-e720-4fe8-ba97-da2895fd7b48>
[May 12 09:14:39] VERBOSE[27110][C-000005c2] bridge_channel.c: Channel SIP/ENTP-0000058f joined 'simple_bridge' basic-bridge <620f21d1-e720-4fe8-ba97-da2895fd7b48>
[May 12 09:14:39] VERBOSE[27110][C-000005c2] res_rtp_asterisk.c: 0x7f4b90008460 -- Strict RTP learning complete - Locking on source address 207.223.77.140:9306
[May 12 09:14:40] VERBOSE[27003][C-000005c2] res_agi.c: <Local/914436149596@default-00000359;2>AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----5-----0-----SIP 200 OK) completed, returning 0
[May 12 09:14:41] VERBOSE[27145][C-000005c2] res_rtp_asterisk.c: 0x7f4a0c03e500 -- Strict RTP switching to RTP target address 3.91.145.92:15154 as source
[May 12 09:14:45] VERBOSE[27145][C-000005c2] res_rtp_asterisk.c: 0x7f4a0c03e500 -- Strict RTP learning complete - Locking on source address 3.91.145.92:15154
[May 12 09:15:46] VERBOSE[27145][C-000005c2] bridge_channel.c: Channel SIP/3.93.224.97-000005a4 left 'simple_bridge' basic-bridge <620f21d1-e720-4fe8-ba97-da2895fd7b48>
[May 12 09:15:46] VERBOSE[27110][C-000005c2] bridge_channel.c: Channel SIP/ENTP-0000058f left 'simple_bridge' basic-bridge <620f21d1-e720-4fe8-ba97-da2895fd7b48>
[May 12 09:15:46] VERBOSE[27110][C-000005c2] pbx.c: Executing [82002@trunkinbound:1] AGI("SIP/ENTP-0000058f", "agi-DID_route.agi") in new stack
[May 12 09:15:47] VERBOSE[27110][C-000005c2] res_agi.c: Launched AGI Script /usr/share/asterisk/agi-bin/agi-DID_route.agi
[May 12 09:15:47] VERBOSE[27110][C-000005c2] res_agi.c: AGI Script Executing Application: (Monitor) Options: (wav,/var/spool/asterisk/monitor/MIX/20210512091547_82002_14436149596)
[May 12 09:15:47] VERBOSE[27110][C-000005c2] res_agi.c: <SIP/ENTP-0000058f>AGI Script agi-DID_route.agi completed, returning 0
[May 12 09:15:47] VERBOSE[27110][C-000005c2] pbx.c: Executing [99909*297***DID@default:1] Answer("SIP/ENTP-0000058f", "") in new stack
[May 12 09:15:47] VERBOSE[27110][C-000005c2] pbx.c: Executing [99909*297***DID@default:2] AGI("SIP/ENTP-0000058f", "agi-VDAD_ALL_inbound.agi") in new stack
[May 12 09:15:47] VERBOSE[27110][C-000005c2] res_agi.c: Launched AGI Script /usr/share/asterisk/agi-bin/agi-VDAD_ALL_inbound.agi
[May 12 09:15:47] VERBOSE[27110][C-000005c2] res_agi.c: <SIP/ENTP-0000058f> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[May 12 09:15:47] VERBOSE[27110][C-000005c2] res_agi.c: <SIP/ENTP-0000058f> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[May 12 09:15:50] VERBOSE[27110][C-000005c2] res_agi.c: <SIP/ENTP-0000058f> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[May 12 09:15:50] VERBOSE[27110][C-000005c2] res_agi.c: <SIP/ENTP-0000058f> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[May 12 09:15:50] VERBOSE[27110][C-000005c2] res_agi.c: <SIP/ENTP-0000058f> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[May 12 09:15:50] VERBOSE[27110][C-000005c2] res_agi.c: <SIP/ENTP-0000058f> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[May 12 09:15:50] VERBOSE[27110][C-000005c2] res_agi.c: <SIP/ENTP-0000058f> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[May 12 09:15:50] VERBOSE[27110][C-000005c2] res_agi.c: <SIP/ENTP-0000058f> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[May 12 09:15:50] VERBOSE[27110][C-000005c2] res_agi.c: <SIP/ENTP-0000058f>AGI Script agi-VDAD_ALL_inbound.agi completed, returning 0
[May 12 09:15:50] VERBOSE[27110][C-000005c2] pbx.c: Executing [038*102*225*096*8600054@default:1] Goto("SIP/ENTP-0000058f", "default,8600054,1") in new stack
[May 12 09:15:50] VERBOSE[27110][C-000005c2] pbx_builtins.c: Goto (default,8600054,1)
[May 12 09:15:50] VERBOSE[27110][C-000005c2] pbx.c: Executing [8600054@default:1] MeetMe("SIP/ENTP-0000058f", "8600054,F") in new stack
[May 12 09:19:54] VERBOSE[27110][C-000005c2] pbx.c: Spawn extension (default, 8600054, 1) exited non-zero on 'SIP/ENTP-0000058f'
[May 12 09:19:54] WARNING[27110][C-000005c2] func_hangupcause.c: Information type not recognized (SIP/ENTP-0000058f,tech)
[May 12 09:19:54] VERBOSE[27110][C-000005c2] pbx.c: Executing [h@default:1] AGI("SIP/ENTP-0000058f", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER---------------)") in new stack
[May 12 09:19:54] VERBOSE[27110][C-000005c2] res_agi.c: <SIP/ENTP-0000058f>AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER---------------) completed, returning 0


-----
messages grep C-000005d4


[May 12 09:14:38] VERBOSE[27002][C-000005d4] pbx.c: Executing [138368@default:1] AGI("Local/914436149596@default-00000359;1", "agi-VDAD_local_optimize.agi,V5120914320001035263") in new stack
[May 12 09:14:38] VERBOSE[27002][C-000005d4] res_agi.c: Launched AGI Script /usr/share/asterisk/agi-bin/agi-VDAD_local_optimize.agi
[May 12 09:14:39] VERBOSE[27002][C-000005d4] res_agi.c: <Local/914436149596@default-00000359;1>AGI Script agi-VDAD_local_optimize.agi completed, returning 0
[May 12 09:14:39] VERBOSE[27002][C-000005d4] pbx.c: Executing [138368@default:2] Wait("Local/914436149596@default-00000359;1", "2") in new stack
[May 12 09:14:40] VERBOSE[27002][C-000005d4] pbx.c: Spawn extension (default, 138368, 2) exited non-zero on 'Local/914436149596@default-00000359;1'
[May 12 09:14:40] WARNING[27002][C-000005d4] func_hangupcause.c: Unable to find information for channel
[May 12 09:14:40] VERBOSE[27002][C-000005d4] pbx.c: Executing [h@default:1] AGI("Local/914436149596@default-00000359;1", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16--------------------)") in new stack
[May 12 09:14:41] VERBOSE[27002][C-000005d4] res_agi.c: <Local/914436149596@default-00000359;1>AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16--------------------) completed, returning 0

-----



CID that did not go through:
7035592753

messages grep C-00007565
[May 12 11:25:54] VERBOSE[1098][C-00007565] pbx.c: Executing [917035592753@default:1] AGI("Local/917035592753@default-00004583;2", "agi://127.0.0.1:4577/call_log") in new stack
[May 12 11:25:54] VERBOSE[1098][C-00007565] res_agi.c: AGI Script Executing Application: (EXEC) Options: (Set(_CAMPCUST=TJ_AI_US))
[May 12 11:25:54] VERBOSE[1098][C-00007565] res_agi.c: <Local/917035592753@default-00004583;2>AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[May 12 11:25:54] VERBOSE[1098][C-00007565] pbx.c: Executing [917035592753@default:2] Dial("Local/917035592753@default-00004583;2", "SIP/17035592753@ENTP,,To") in new stack
[May 12 11:25:54] VERBOSE[1098][C-00007565] netsock2.c: Using SIP RTP CoS mark 5
[May 12 11:25:54] VERBOSE[1098][C-00007565] app_dial.c: Called SIP/17035592753@ENTP
[May 12 11:25:55] VERBOSE[3343][C-00007565] res_rtp_asterisk.c: 0x7f4a24032a90 -- Strict RTP learning after remote address set to: 208.93.42.132:47948
[May 12 11:25:55] VERBOSE[1098][C-00007565] app_dial.c: SIP/ENTP-0000722f is making progress passing it to Local/917035592753@default-00004583;2
[May 12 11:25:55] VERBOSE[1098][C-00007565] res_rtp_asterisk.c: 0x7f4a24032a90 -- Strict RTP switching to RTP target address 208.93.42.132:47948 as source
[May 12 11:26:00] VERBOSE[1098][C-00007565] app_dial.c: SIP/ENTP-0000722f answered Local/917035592753@default-00004583;2
[May 12 11:26:00] VERBOSE[1286][C-00007565] bridge_channel.c: Channel SIP/ENTP-0000722f joined 'simple_bridge' basic-bridge <1ac23a2b-c889-4813-a262-613af141e1d9>
[May 12 11:26:00] VERBOSE[1098][C-00007565] bridge_channel.c: Channel Local/917035592753@default-00004583;2 joined 'simple_bridge' basic-bridge <1ac23a2b-c889-4813-a262-613af141e1d9>
[May 12 11:26:00] VERBOSE[1286][C-00007565] res_rtp_asterisk.c: 0x7f4a24032a90 -- Strict RTP learning complete - Locking on source address 208.93.42.132:47948
[May 12 11:26:01] VERBOSE[1286][C-00007565] bridge_channel.c: Channel SIP/ENTP-0000722f left 'simple_bridge' basic-bridge <1ac23a2b-c889-4813-a262-613af141e1d9>
[May 12 11:26:01] VERBOSE[1098][C-00007565] bridge_channel.c: Channel Local/917035592753@default-00004583;2 left 'simple_bridge' basic-bridge <1ac23a2b-c889-4813-a262-613af141e1d9>
[May 12 11:26:01] VERBOSE[1286][C-00007565] pbx.c: Executing [8368@default:1] AGI("SIP/ENTP-0000722f", "agi://127.0.0.1:4577/call_log") in new stack
[May 12 11:26:01] VERBOSE[1098][C-00007565] pbx.c: Spawn extension (default, 917035592753, 2) exited non-zero on 'Local/917035592753@default-00004583;2'
[May 12 11:26:01] VERBOSE[1098][C-00007565] pbx.c: Executing [h@default:1] AGI("Local/917035592753@default-00004583;2", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----7-----0-----SIP 200 OK)") in new stack
[May 12 11:26:01] VERBOSE[1286][C-00007565] res_agi.c: AGI Script Executing Application: (EXEC) Options: (Set(_CAMPCUST=TJ_AI_US))
[May 12 11:26:01] VERBOSE[1286][C-00007565] res_agi.c: <SIP/ENTP-0000722f>AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[May 12 11:26:01] VERBOSE[1286][C-00007565] pbx.c: Executing [8368@default:2] AGI("SIP/ENTP-0000722f", "agi-VDAD_ALL_outbound.agi,NORMAL-----LB-----V5121125420001040726") in new stack
[May 12 11:26:01] VERBOSE[1286][C-00007565] res_agi.c: Launched AGI Script /usr/share/asterisk/agi-bin/agi-VDAD_ALL_outbound.agi
[May 12 11:26:01] VERBOSE[1286][C-00007565] res_agi.c: AGI Script Executing Application: (Monitor) Options: (wav,/var/spool/asterisk/monitor/MIX/TJ_AI_US_20210512-112601_17035592753)
[May 12 11:26:01] VERBOSE[1286][C-00007565] res_agi.c: <SIP/ENTP-0000722f>AGI Script agi-VDAD_ALL_outbound.agi completed, returning 0
[May 12 11:26:01] VERBOSE[1286][C-00007565] pbx.c: Executing [038*102*225*096*170101@default:1] Goto("SIP/ENTP-0000722f", "default,170101,1") in new stack
[May 12 11:26:01] VERBOSE[1286][C-00007565] pbx_builtins.c: Goto (default,170101,1)
[May 12 11:26:01] VERBOSE[1286][C-00007565] pbx.c: Executing [170101@default:1] Answer("SIP/ENTP-0000722f", "") in new stack
[May 12 11:26:01] VERBOSE[1286][C-00007565] pbx.c: Executing [170101@default:2] AGI("SIP/ENTP-0000722f", "set_name_by_CID_dynamic.agi,0,0") in new stack
[May 12 11:26:01] VERBOSE[1286][C-00007565] res_agi.c: Launched AGI Script /usr/share/asterisk/agi-bin/set_name_by_CID_dynamic.agi
[May 12 11:26:01] VERBOSE[1286][C-00007565] res_agi.c: AGI Script Executing Application: (Set) Options: (CALLERID(name)=sally)
[May 12 11:26:01] VERBOSE[1286][C-00007565] res_agi.c: AGI Script Executing Application: (Set) Options: (CALLERID(num)=17035592753)
[May 12 11:26:01] VERBOSE[1286][C-00007565] res_agi.c: <SIP/ENTP-0000722f>AGI Script set_name_by_CID_dynamic.agi completed, returning 0
[May 12 11:26:01] VERBOSE[1286][C-00007565] pbx.c: Executing [170101@default:3] Dial("SIP/ENTP-0000722f", "SIP/170102@3.93.224.97") in new stack
[May 12 11:26:01] VERBOSE[1286][C-00007565] netsock2.c: Using SIP RTP CoS mark 5
[May 12 11:26:01] VERBOSE[1286][C-00007565] app_dial.c: Called SIP/170102@3.93.224.97
[May 12 11:26:01] VERBOSE[3343][C-00007565] res_rtp_asterisk.c: 0x22f6340 -- Strict RTP learning after remote address set to: 54.205.82.96:16796
[May 12 11:26:01] VERBOSE[1286][C-00007565] app_dial.c: SIP/3.93.224.97-00007247 answered SIP/ENTP-0000722f
[May 12 11:26:01] VERBOSE[1338][C-00007565] bridge_channel.c: Channel SIP/3.93.224.97-00007247 joined 'simple_bridge' basic-bridge <a63a1509-7fa8-4b30-a6a7-b337b1e08e24>
[May 12 11:26:01] VERBOSE[1286][C-00007565] bridge_channel.c: Channel SIP/ENTP-0000722f joined 'simple_bridge' basic-bridge <a63a1509-7fa8-4b30-a6a7-b337b1e08e24>
[May 12 11:26:02] VERBOSE[1098][C-00007565] res_agi.c: <Local/917035592753@default-00004583;2>AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----7-----0-----SIP 200 OK) completed, returning 0
[May 12 11:26:04] VERBOSE[1338][C-00007565] res_rtp_asterisk.c: 0x22f6340 -- Strict RTP switching to RTP target address 54.205.82.96:16796 as source
[May 12 11:26:09] VERBOSE[1338][C-00007565] res_rtp_asterisk.c: 0x22f6340 -- Strict RTP learning complete - Locking on source address 54.205.82.96:16796
[May 12 11:26:58] VERBOSE[1338][C-00007565] bridge_channel.c: Channel SIP/3.93.224.97-00007247 left 'simple_bridge' basic-bridge <a63a1509-7fa8-4b30-a6a7-b337b1e08e24>
[May 12 11:26:58] VERBOSE[1286][C-00007565] bridge_channel.c: Channel SIP/ENTP-0000722f left 'simple_bridge' basic-bridge <a63a1509-7fa8-4b30-a6a7-b337b1e08e24>
[May 12 11:26:58] VERBOSE[1286][C-00007565] pbx.c: Spawn extension (default, 170101, 3) exited non-zero on 'SIP/ENTP-0000722f'
[May 12 11:26:58] WARNING[1286][C-00007565] func_hangupcause.c: Information type not recognized (SIP/ENTP-0000722f,tech)
[May 12 11:26:58] VERBOSE[1286][C-00007565] pbx.c: Executing [h@default:1] AGI("SIP/ENTP-0000722f", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----63-----57-----)") in new stack
[May 12 11:26:58] VERBOSE[1286][C-00007565] res_agi.c: <SIP/ENTP-0000722f>AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----63-----57-----) completed, returning 0


--

messages grep C-00007578
[May 12 11:26:00] VERBOSE[1097][C-00007578] pbx.c: Executing [138368@default:1] AGI("Local/917035592753@default-00004583;1", "agi-VDAD_local_optimize.agi,V5121125420001040726") in new stack
[May 12 11:26:00] VERBOSE[1097][C-00007578] res_agi.c: Launched AGI Script /usr/share/asterisk/agi-bin/agi-VDAD_local_optimize.agi
[May 12 11:26:01] VERBOSE[1097][C-00007578] res_agi.c: <Local/917035592753@default-00004583;1>AGI Script agi-VDAD_local_optimize.agi completed, returning 0
[May 12 11:26:01] VERBOSE[1097][C-00007578] pbx.c: Executing [138368@default:2] Wait("Local/917035592753@default-00004583;1", "2") in new stack
[May 12 11:26:02] VERBOSE[1097][C-00007578] pbx.c: Spawn extension (default, 138368, 2) exited non-zero on 'Local/917035592753@default-00004583;1'
[May 12 11:26:02] WARNING[1097][C-00007578] func_hangupcause.c: Unable to find information for channel
[May 12 11:26:02] VERBOSE[1097][C-00007578] pbx.c: Executing [h@default:1] AGI("Local/917035592753@default-00004583;1", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16--------------------)") in new stack
[May 12 11:26:03] VERBOSE[1097][C-00007578] res_agi.c: <Local/917035592753@default-00004583;1>AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16--------------------) completed, returning 0

--


went through:
7857873394
Channels:
C-0000352f

[May 12 10:13:08] VERBOSE[9477][C-0000352f] pbx.c: Executing [138368@default:1] AGI("Local/917857873394@default-00001f36;1", "agi-VDAD_local_optimize.agi,V5121012270001033065") in new stack
[May 12 10:13:08] VERBOSE[9477][C-0000352f] res_agi.c: Launched AGI Script /usr/share/asterisk/agi-bin/agi-VDAD_local_optimize.agi
[May 12 10:13:08] VERBOSE[9477][C-0000352f] res_agi.c: <Local/917857873394@default-00001f36;1>AGI Script agi-VDAD_local_optimize.agi completed, returning 0
[May 12 10:13:08] VERBOSE[9477][C-0000352f] pbx.c: Executing [138368@default:2] Wait("Local/917857873394@default-00001f36;1", "2") in new stack
[May 12 10:13:09] VERBOSE[9477][C-0000352f] pbx.c: Spawn extension (default, 138368, 2) exited non-zero on 'Local/917857873394@default-00001f36;1'
[May 12 10:13:09] WARNING[9477][C-0000352f] func_hangupcause.c: Unable to find information for channel
[May 12 10:13:09] VERBOSE[9477][C-0000352f] pbx.c: Executing [h@default:1] AGI("Local/917857873394@default-00001f36;1", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16--------------------)") in new stack
[May 12 10:13:10] VERBOSE[9477][C-0000352f] res_agi.c: <Local/917857873394@default-00001f36;1>AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16--------------------) completed, returning 0


C-000034bf

[May 12 10:12:41] VERBOSE[9478][C-000034bf] pbx.c: Executing [917857873394@default:1] AGI("Local/917857873394@default-00001f36;2", "agi://127.0.0.1:4577/call_log") in new stack
[May 12 10:12:41] VERBOSE[9478][C-000034bf] res_agi.c: AGI Script Executing Application: (EXEC) Options: (Set(_CAMPCUST=TJ_AI_US))
[May 12 10:12:41] VERBOSE[9478][C-000034bf] res_agi.c: <Local/917857873394@default-00001f36;2>AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[May 12 10:12:41] VERBOSE[9478][C-000034bf] pbx.c: Executing [917857873394@default:2] Dial("Local/917857873394@default-00001f36;2", "SIP/17857873394@ENTP,,To") in new stack
[May 12 10:12:41] VERBOSE[9478][C-000034bf] netsock2.c: Using SIP RTP CoS mark 5
[May 12 10:12:41] VERBOSE[9478][C-000034bf] app_dial.c: Called SIP/17857873394@ENTP
[May 12 10:12:43] VERBOSE[3343][C-000034bf] res_rtp_asterisk.c: 0x7f4ba0009190 -- Strict RTP learning after remote address set to: 4.55.7.2:13070
[May 12 10:12:43] VERBOSE[9478][C-000034bf] app_dial.c: SIP/ENTP-0000335b is making progress passing it to Local/917857873394@default-00001f36;2
[May 12 10:12:43] VERBOSE[9478][C-000034bf] res_rtp_asterisk.c: 0x7f4ba0009190 -- Strict RTP switching to RTP target address 4.55.7.2:13070 as source
[May 12 10:12:48] VERBOSE[9478][C-000034bf] res_rtp_asterisk.c: 0x7f4ba0009190 -- Strict RTP learning complete - Locking on source address 4.55.7.2:13070
[May 12 10:13:08] VERBOSE[9478][C-000034bf] app_dial.c: SIP/ENTP-0000335b answered Local/917857873394@default-00001f36;2
[May 12 10:13:08] VERBOSE[10733][C-000034bf] bridge_channel.c: Channel SIP/ENTP-0000335b joined 'simple_bridge' basic-bridge <18346f36-7d7a-48d2-a6be-251ba0e1055b>
[May 12 10:13:08] VERBOSE[9478][C-000034bf] bridge_channel.c: Channel Local/917857873394@default-00001f36;2 joined 'simple_bridge' basic-bridge <18346f36-7d7a-48d2-a6be-251ba0e1055b>
[May 12 10:13:08] VERBOSE[10733][C-000034bf] bridge_channel.c: Channel SIP/ENTP-0000335b left 'simple_bridge' basic-bridge <18346f36-7d7a-48d2-a6be-251ba0e1055b>
[May 12 10:13:08] VERBOSE[9478][C-000034bf] bridge_channel.c: Channel Local/917857873394@default-00001f36;2 left 'simple_bridge' basic-bridge <18346f36-7d7a-48d2-a6be-251ba0e1055b>
[May 12 10:13:08] VERBOSE[10733][C-000034bf] pbx.c: Executing [8368@default:1] AGI("SIP/ENTP-0000335b", "agi://127.0.0.1:4577/call_log") in new stack
[May 12 10:13:08] VERBOSE[9478][C-000034bf] pbx.c: Spawn extension (default, 917857873394, 2) exited non-zero on 'Local/917857873394@default-00001f36;2'
[May 12 10:13:08] VERBOSE[9478][C-000034bf] pbx.c: Executing [h@default:1] AGI("Local/917857873394@default-00001f36;2", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----27-----0-----SIP 200 OK)") in new stack
[May 12 10:13:08] VERBOSE[10733][C-000034bf] res_agi.c: AGI Script Executing Application: (EXEC) Options: (Set(_CAMPCUST=TJ_AI_US))
[May 12 10:13:08] VERBOSE[10733][C-000034bf] res_agi.c: <SIP/ENTP-0000335b>AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[May 12 10:13:08] VERBOSE[10733][C-000034bf] pbx.c: Executing [8368@default:2] AGI("SIP/ENTP-0000335b", "agi-VDAD_ALL_outbound.agi,NORMAL-----LB-----V5121012270001033065") in new stack
[May 12 10:13:08] VERBOSE[10733][C-000034bf] res_agi.c: Launched AGI Script /usr/share/asterisk/agi-bin/agi-VDAD_ALL_outbound.agi
[May 12 10:13:09] VERBOSE[10733][C-000034bf] res_agi.c: AGI Script Executing Application: (Monitor) Options: (wav,/var/spool/asterisk/monitor/MIX/TJ_AI_US_20210512-101309_17857873394)
[May 12 10:13:09] VERBOSE[10733][C-000034bf] res_agi.c: <SIP/ENTP-0000335b>AGI Script agi-VDAD_ALL_outbound.agi completed, returning 0
[May 12 10:13:09] VERBOSE[10733][C-000034bf] pbx.c: Executing [038*102*225*096*170101@default:1] Goto("SIP/ENTP-0000335b", "default,170101,1") in new stack
[May 12 10:13:09] VERBOSE[10733][C-000034bf] pbx_builtins.c: Goto (default,170101,1)
[May 12 10:13:09] VERBOSE[10733][C-000034bf] pbx.c: Executing [170101@default:1] Answer("SIP/ENTP-0000335b", "") in new stack
[May 12 10:13:09] VERBOSE[10733][C-000034bf] pbx.c: Executing [170101@default:2] AGI("SIP/ENTP-0000335b", "set_name_by_CID_dynamic.agi,0,0") in new stack
[May 12 10:13:09] VERBOSE[10733][C-000034bf] res_agi.c: Launched AGI Script /usr/share/asterisk/agi-bin/set_name_by_CID_dynamic.agi
[May 12 10:13:09] VERBOSE[10733][C-000034bf] res_agi.c: AGI Script Executing Application: (Set) Options: (CALLERID(name)=julie)
[May 12 10:13:09] VERBOSE[10733][C-000034bf] res_agi.c: AGI Script Executing Application: (Set) Options: (CALLERID(num)=17857873394)
[May 12 10:13:09] VERBOSE[10733][C-000034bf] res_agi.c: <SIP/ENTP-0000335b>AGI Script set_name_by_CID_dynamic.agi completed, returning 0
[May 12 10:13:09] VERBOSE[10733][C-000034bf] pbx.c: Executing [170101@default:3] Dial("SIP/ENTP-0000335b", "SIP/170102@3.93.224.97") in new stack
[May 12 10:13:09] VERBOSE[10733][C-000034bf] netsock2.c: Using SIP RTP CoS mark 5
[May 12 10:13:09] VERBOSE[10733][C-000034bf] app_dial.c: Called SIP/170102@3.93.224.97
[May 12 10:13:09] VERBOSE[3343][C-000034bf] res_rtp_asterisk.c: 0x7f49d0041ef0 -- Strict RTP learning after remote address set to: 52.87.236.21:18604
[May 12 10:13:09] VERBOSE[10733][C-000034bf] app_dial.c: SIP/3.93.224.97-000033c3 answered SIP/ENTP-0000335b
[May 12 10:13:09] VERBOSE[10794][C-000034bf] bridge_channel.c: Channel SIP/3.93.224.97-000033c3 joined 'simple_bridge' basic-bridge <fddbdba3-a077-435b-a60a-1371a67c7d00>
[May 12 10:13:09] VERBOSE[10733][C-000034bf] bridge_channel.c: Channel SIP/ENTP-0000335b joined 'simple_bridge' basic-bridge <fddbdba3-a077-435b-a60a-1371a67c7d00>
[May 12 10:13:09] VERBOSE[9478][C-000034bf] res_agi.c: <Local/917857873394@default-00001f36;2>AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----27-----0-----SIP 200 OK) completed, returning 0
[May 12 10:13:13] VERBOSE[10794][C-000034bf] res_rtp_asterisk.c: 0x7f49d0041ef0 -- Strict RTP switching to RTP target address 52.87.236.21:18604 as source
[May 12 10:13:14] VERBOSE[10794][C-000034bf] res_rtp_asterisk.c: 0x7f49d0041ef0 -- Strict RTP learning complete - Locking on source address 52.87.236.21:18604
[May 12 10:14:14] VERBOSE[10794][C-000034bf] bridge_channel.c: Channel SIP/3.93.224.97-000033c3 left 'simple_bridge' basic-bridge <fddbdba3-a077-435b-a60a-1371a67c7d00>
[May 12 10:14:14] VERBOSE[10733][C-000034bf] bridge_channel.c: Channel SIP/ENTP-0000335b left 'simple_bridge' basic-bridge <fddbdba3-a077-435b-a60a-1371a67c7d00>
[May 12 10:14:14] VERBOSE[10733][C-000034bf] pbx.c: Executing [82002@trunkinbound:1] AGI("SIP/ENTP-0000335b", "agi-DID_route.agi") in new stack
[May 12 10:14:14] VERBOSE[10733][C-000034bf] res_agi.c: Launched AGI Script /usr/share/asterisk/agi-bin/agi-DID_route.agi
[May 12 10:14:14] VERBOSE[10733][C-000034bf] res_agi.c: AGI Script Executing Application: (Monitor) Options: (wav,/var/spool/asterisk/monitor/MIX/20210512101414_82002_17857873394)
[May 12 10:14:14] VERBOSE[10733][C-000034bf] res_agi.c: <SIP/ENTP-0000335b>AGI Script agi-DID_route.agi completed, returning 0
[May 12 10:14:14] VERBOSE[10733][C-000034bf] pbx.c: Executing [99909*297***DID@default:1] Answer("SIP/ENTP-0000335b", "") in new stack
[May 12 10:14:14] VERBOSE[10733][C-000034bf] pbx.c: Executing [99909*297***DID@default:2] AGI("SIP/ENTP-0000335b", "agi-VDAD_ALL_inbound.agi") in new stack
[May 12 10:14:14] VERBOSE[10733][C-000034bf] res_agi.c: Launched AGI Script /usr/share/asterisk/agi-bin/agi-VDAD_ALL_inbound.agi
[May 12 10:14:14] VERBOSE[10733][C-000034bf] res_agi.c: <SIP/ENTP-0000335b> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[May 12 10:14:14] VERBOSE[10733][C-000034bf] res_agi.c: <SIP/ENTP-0000335b> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[May 12 10:14:15] VERBOSE[10733][C-000034bf] res_agi.c: <SIP/ENTP-0000335b> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[May 12 10:14:15] VERBOSE[10733][C-000034bf] res_agi.c: <SIP/ENTP-0000335b> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[May 12 10:14:16] VERBOSE[10733][C-000034bf] res_agi.c: <SIP/ENTP-0000335b> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[May 12 10:14:16] VERBOSE[10733][C-000034bf] res_agi.c: <SIP/ENTP-0000335b> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[May 12 10:14:16] VERBOSE[10733][C-000034bf] res_agi.c: <SIP/ENTP-0000335b> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[May 12 10:14:16] VERBOSE[10733][C-000034bf] res_agi.c: <SIP/ENTP-0000335b> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[May 12 10:14:16] VERBOSE[10733][C-000034bf] res_agi.c: <SIP/ENTP-0000335b>AGI Script agi-VDAD_ALL_inbound.agi completed, returning 0
[May 12 10:14:16] VERBOSE[10733][C-000034bf] pbx.c: Executing [038*102*225*096*8600060@default:1] Goto("SIP/ENTP-0000335b", "default,8600060,1") in new stack
[May 12 10:14:16] VERBOSE[10733][C-000034bf] pbx_builtins.c: Goto (default,8600060,1)
[May 12 10:14:16] VERBOSE[10733][C-000034bf] pbx.c: Executing [8600060@default:1] MeetMe("SIP/ENTP-0000335b", "8600060,F") in new stack
[May 12 10:14:48] VERBOSE[10733][C-000034bf] pbx.c: Spawn extension (default, 8600060, 1) exited non-zero on 'SIP/ENTP-0000335b'
[May 12 10:14:48] WARNING[10733][C-000034bf] func_hangupcause.c: Information type not recognized (SIP/3.93.224.97-000033c3,tech)
[May 12 10:14:48] VERBOSE[10733][C-000034bf] pbx.c: Executing [h@default:1] AGI("SIP/ENTP-0000335b", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER---------------)") in new stack
[May 12 10:14:48] VERBOSE[10733][C-000034bf] res_agi.c: <SIP/ENTP-0000335b>AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER---------------) completed, returning 0


Caller ID did not go through:
12314082128

Channels:
C-00000604
C-000005da
[May 12 09:14:51] VERBOSE[27153][C-00000604] pbx.c: Executing [138368@default:1] AGI("Local/912314082128@default-0000036a;1", "agi-VDAD_local_optimize.agi,V5120914320001000136") in new stack
[May 12 09:14:51] VERBOSE[27153][C-00000604] res_agi.c: Launched AGI Script /usr/share/asterisk/agi-bin/agi-VDAD_local_optimize.agi
[May 12 09:14:51] VERBOSE[27153][C-00000604] res_agi.c: <Local/912314082128@default-0000036a;1>AGI Script agi-VDAD_local_optimize.agi completed, returning 0
[May 12 09:14:51] VERBOSE[27153][C-00000604] pbx.c: Executing [138368@default:2] Wait("Local/912314082128@default-0000036a;1", "2") in new stack
[May 12 09:14:52] VERBOSE[27153][C-00000604] pbx.c: Spawn extension (default, 138368, 2) exited non-zero on 'Local/912314082128@default-0000036a;1'
[May 12 09:14:52] WARNING[27153][C-00000604] func_hangupcause.c: Unable to find information for channel
[May 12 09:14:52] VERBOSE[27153][C-00000604] pbx.c: Executing [h@default:1] AGI("Local/912314082128@default-0000036a;1", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16--------------------)") in new stack
[May 12 09:14:54] VERBOSE[27153][C-00000604] res_agi.c: <Local/912314082128@default-0000036a;1>AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16--------------------) completed, returning 0
[May 12 09:14:40] VERBOSE[27154][C-000005da] pbx.c: Executing [912314082128@default:1] AGI("Local/912314082128@default-0000036a;2", "agi://127.0.0.1:4577/call_log") in new stack
[May 12 09:14:40] VERBOSE[27154][C-000005da] res_agi.c: AGI Script Executing Application: (EXEC) Options: (Set(_CAMPCUST=TJ_AI_US))
[May 12 09:14:40] VERBOSE[27154][C-000005da] res_agi.c: <Local/912314082128@default-0000036a;2>AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[May 12 09:14:40] VERBOSE[27154][C-000005da] pbx.c: Executing [912314082128@default:2] Dial("Local/912314082128@default-0000036a;2", "SIP/12314082128@ENTP,,To") in new stack
[May 12 09:14:40] VERBOSE[27154][C-000005da] netsock2.c: Using SIP RTP CoS mark 5
[May 12 09:14:40] VERBOSE[27154][C-000005da] app_dial.c: Called SIP/12314082128@ENTP
[May 12 09:14:42] VERBOSE[3343][C-000005da] res_rtp_asterisk.c: 0x7f4970008eb0 -- Strict RTP learning after remote address set to: 207.223.77.140:57484
[May 12 09:14:42] VERBOSE[27154][C-000005da] app_dial.c: SIP/ENTP-000005a5 is making progress passing it to Local/912314082128@default-0000036a;2
[May 12 09:14:42] VERBOSE[27154][C-000005da] res_rtp_asterisk.c: 0x7f4970008eb0 -- Strict RTP switching to RTP target address 207.223.77.140:57484 as source
[May 12 09:14:47] VERBOSE[27154][C-000005da] res_rtp_asterisk.c: 0x7f4970008eb0 -- Strict RTP learning complete - Locking on source address 207.223.77.140:57484
[May 12 09:14:51] VERBOSE[27154][C-000005da] app_dial.c: SIP/ENTP-000005a5 answered Local/912314082128@default-0000036a;2
[May 12 09:14:51] VERBOSE[27428][C-000005da] bridge_channel.c: Channel SIP/ENTP-000005a5 joined 'simple_bridge' basic-bridge <1ea2c847-2872-4bcf-9aaa-09867235af01>
[May 12 09:14:51] VERBOSE[27154][C-000005da] bridge_channel.c: Channel Local/912314082128@default-0000036a;2 joined 'simple_bridge' basic-bridge <1ea2c847-2872-4bcf-9aaa-09867235af01>
[May 12 09:14:51] VERBOSE[27428][C-000005da] bridge_channel.c: Channel SIP/ENTP-000005a5 left 'simple_bridge' basic-bridge <1ea2c847-2872-4bcf-9aaa-09867235af01>
[May 12 09:14:51] VERBOSE[27154][C-000005da] bridge_channel.c: Channel Local/912314082128@default-0000036a;2 left 'simple_bridge' basic-bridge <1ea2c847-2872-4bcf-9aaa-09867235af01>
[May 12 09:14:51] VERBOSE[27428][C-000005da] pbx.c: Executing [8368@default:1] AGI("SIP/ENTP-000005a5", "agi://127.0.0.1:4577/call_log") in new stack
[May 12 09:14:51] VERBOSE[27154][C-000005da] pbx.c: Spawn extension (default, 912314082128, 2) exited non-zero on 'Local/912314082128@default-0000036a;2'
[May 12 09:14:51] VERBOSE[27154][C-000005da] pbx.c: Executing [h@default:1] AGI("Local/912314082128@default-0000036a;2", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----11-----0-----SIP 200 OK)") in new stack
[May 12 09:14:51] VERBOSE[27428][C-000005da] res_agi.c: AGI Script Executing Application: (EXEC) Options: (Set(_CAMPCUST=TJ_AI_US))
[May 12 09:14:51] VERBOSE[27428][C-000005da] res_agi.c: <SIP/ENTP-000005a5>AGI Script agi://127.0.0.1:4577/call_log completed, returning 0
[May 12 09:14:51] VERBOSE[27428][C-000005da] pbx.c: Executing [8368@default:2] AGI("SIP/ENTP-000005a5", "agi-VDAD_ALL_outbound.agi,NORMAL-----LB-----V5120914320001000136") in new stack
[May 12 09:14:52] VERBOSE[27428][C-000005da] res_agi.c: Launched AGI Script /usr/share/asterisk/agi-bin/agi-VDAD_ALL_outbound.agi
[May 12 09:14:52] VERBOSE[27428][C-000005da] res_agi.c: AGI Script Executing Application: (Monitor) Options: (wav,/var/spool/asterisk/monitor/MIX/TJ_AI_US_20210512-091452_12314082128)
[May 12 09:14:52] VERBOSE[27428][C-000005da] res_agi.c: <SIP/ENTP-000005a5>AGI Script agi-VDAD_ALL_outbound.agi completed, returning 0
[May 12 09:14:52] VERBOSE[27428][C-000005da] pbx.c: Executing [038*102*225*096*170101@default:1] Goto("SIP/ENTP-000005a5", "default,170101,1") in new stack
[May 12 09:14:52] VERBOSE[27428][C-000005da] pbx_builtins.c: Goto (default,170101,1)
[May 12 09:14:52] VERBOSE[27428][C-000005da] pbx.c: Executing [170101@default:1] Answer("SIP/ENTP-000005a5", "") in new stack
[May 12 09:14:52] VERBOSE[27428][C-000005da] pbx.c: Executing [170101@default:2] AGI("SIP/ENTP-000005a5", "set_name_by_CID_dynamic.agi,0,0") in new stack
[May 12 09:14:52] VERBOSE[27428][C-000005da] res_agi.c: Launched AGI Script /usr/share/asterisk/agi-bin/set_name_by_CID_dynamic.agi
[May 12 09:14:52] VERBOSE[27428][C-000005da] res_agi.c: AGI Script Executing Application: (Set) Options: (CALLERID(name)=julie)
[May 12 09:14:52] VERBOSE[27428][C-000005da] res_agi.c: AGI Script Executing Application: (Set) Options: (CALLERID(num)=12314082128)
[May 12 09:14:52] VERBOSE[27428][C-000005da] res_agi.c: <SIP/ENTP-000005a5>AGI Script set_name_by_CID_dynamic.agi completed, returning 0
[May 12 09:14:52] VERBOSE[27428][C-000005da] pbx.c: Executing [170101@default:3] Dial("SIP/ENTP-000005a5", "SIP/170102@3.93.224.97") in new stack
[May 12 09:14:52] VERBOSE[27428][C-000005da] netsock2.c: Using SIP RTP CoS mark 5
[May 12 09:14:52] VERBOSE[27428][C-000005da] app_dial.c: Called SIP/170102@3.93.224.97
[May 12 09:14:52] VERBOSE[3343][C-000005da] res_rtp_asterisk.c: 0x7f4c00033ef0 -- Strict RTP learning after remote address set to: 54.163.83.94:15440
[May 12 09:14:52] VERBOSE[27428][C-000005da] app_dial.c: SIP/3.93.224.97-000005d5 answered SIP/ENTP-000005a5
[May 12 09:14:52] VERBOSE[27476][C-000005da] bridge_channel.c: Channel SIP/3.93.224.97-000005d5 joined 'simple_bridge' basic-bridge <ec3f7db6-1027-453e-98ab-2ae3877a4544>
[May 12 09:14:52] VERBOSE[27428][C-000005da] bridge_channel.c: Channel SIP/ENTP-000005a5 joined 'simple_bridge' basic-bridge <ec3f7db6-1027-453e-98ab-2ae3877a4544>
[May 12 09:14:52] VERBOSE[27154][C-000005da] res_agi.c: <Local/912314082128@default-0000036a;2>AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----11-----0-----SIP 200 OK) completed, returning 0
[May 12 09:14:55] VERBOSE[27476][C-000005da] res_rtp_asterisk.c: 0x7f4c00033ef0 -- Strict RTP switching to RTP target address 54.163.83.94:15440 as source
[May 12 09:15:07] VERBOSE[27476][C-000005da] res_rtp_asterisk.c: 0x7f4c00033ef0 -- Strict RTP learning complete - Locking on source address 54.163.83.94:15440
[May 12 09:15:54] VERBOSE[27476][C-000005da] bridge_channel.c: Channel SIP/3.93.224.97-000005d5 left 'simple_bridge' basic-bridge <ec3f7db6-1027-453e-98ab-2ae3877a4544>
[May 12 09:15:54] VERBOSE[27428][C-000005da] bridge_channel.c: Channel SIP/ENTP-000005a5 left 'simple_bridge' basic-bridge <ec3f7db6-1027-453e-98ab-2ae3877a4544>
[May 12 09:15:54] VERBOSE[27428][C-000005da] pbx.c: Spawn extension (default, 170101, 3) exited non-zero on 'SIP/ENTP-000005a5'
[May 12 09:15:54] WARNING[27428][C-000005da] func_hangupcause.c: Information type not recognized (SIP/3.93.224.97-000005d5,tech)
[May 12 09:15:54] VERBOSE[27428][C-000005da] pbx.c: Executing [h@default:1] AGI("SIP/ENTP-000005a5", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----74-----62-----)") in new stack
[May 12 09:15:54] VERBOSE[27428][C-000005da] res_agi.c: <SIP/ENTP-000005a5>AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----74-----62-----) completed, returning 0


I would really appreciate any help anyone's input on this. Thank you!

[carpenox]

remove your Ip's from this post and future posts for security reasons. The only difference I notice is the IP's that it submits from, perhaps some are not added to your carrier allow list? is this a cluster?