Thanks for the reply. This is strange - I can't seem to find anything wrong in the logs - it looks like any other call does. Which is leading me to believe that it's our CO provider, and not a system-related issue. For grins, here's the applicable text from the log - could you take a quick scan through and see if you notice anything? FYI - Names and last four digits of trunk replaced with X's:
[pre]
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-user-callerid:11] Set("UCX/222@222-0", "CALLERID(all)="xxx (PO)" <222>") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-user-callerid:12] GotoIf("UCX/222@222-0", "0?limit") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-user-callerid:13] ExecIf("UCX/222@222-0", "1?Set(GROUP(concurrency_limit)=222)") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-user-callerid:14] ExecIf("UCX/222@222-0", "0?Set(CHANNEL(language)=)") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-user-callerid:15] GotoIf("UCX/222@222-0", "1?continue") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Goto (macro-user-callerid,s,28)
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-user-callerid:28] Set("UCX/222@222-0", "CALLERID(number)=222") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-user-callerid:29] Set("UCX/222@222-0", "CALLERID(name)=xxx (PO)") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-user-callerid:30] Set("UCX/222@222-0", "CDR(cnum)=222") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-user-callerid:31] Set("UCX/222@222-0", "CDR(cnam)=xxx (PO)") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-user-callerid:32] Set("UCX/222@222-0", "CHANNEL(language)=en") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [911@from-internal:2] Set("UCX/222@222-0", "ROUTE_ID=17") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [911@from-internal:3] Set("UCX/222@222-0", "MOHCLASS=default") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [911@from-internal:4] Set("UCX/222@222-0", "_NODEST=") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [911@from-internal:5] Gosub("UCX/222@222-0", "sub-record-check,s,1(out,911,)") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@sub-record-check:1] Set("UCX/222@222-0", "REC_POLICY_MODE_SAVE=") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@sub-record-check:2] GotoIf("UCX/222@222-0", "1?check") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Goto (sub-record-check,s,7)
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@sub-record-check:7] Set("UCX/222@222-0", "__MON_FMT=WAV") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@sub-record-check:8] GotoIf("UCX/222@222-0", "1?next") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Goto (sub-record-check,s,11)
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@sub-record-check:11] ExecIf("UCX/222@222-0", "0?Return()") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@sub-record-check:12] ExecIf("UCX/222@222-0", "0?Set(__REC_POLICY_MODE=)") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@sub-record-check:13] GotoIf("UCX/222@222-0", "0?out,1") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@sub-record-check:14] Set("UCX/222@222-0", "__REC_STATUS=INITIALIZED") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@sub-record-check:15] Set("UCX/222@222-0", "NOW=1428952555") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@sub-record-check:16] Set("UCX/222@222-0", "__DAY=13") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@sub-record-check:17] Set("UCX/222@222-0", "__MONTH=04") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@sub-record-check:18] Set("UCX/222@222-0", "__YEAR=2015") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@sub-record-check:19] Set("UCX/222@222-0", "__TIMESTR=20150413-141555") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@sub-record-check:20] Set("UCX/222@222-0", "__FROMEXTEN=222") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@sub-record-check:21] Set("UCX/222@222-0", "__CALLFILENAME=out-911-222-20150413-141555-1428952555.10721") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@sub-record-check:22] Goto("UCX/222@222-0", "out,1") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Goto (sub-record-check,out,1)
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [out@sub-record-check:1] ExecIf("UCX/222@222-0", "1?Set(__REC_POLICY_MODE=dontcare)") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [out@sub-record-check:2] GosubIf("UCX/222@222-0", "0?record,1(exten,911,222)") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [out@sub-record-check:3] Return("UCX/222@222-0", "") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [911@from-internal:6] Macro("UCX/222@222-0", "dialout-trunk,3,911,,off") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-dialout-trunk:1] Set("UCX/222@222-0", "DIAL_TRUNK=3") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-dialout-trunk:2] GosubIf("UCX/222@222-0", "0?sub-pincheck,s,1()") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-dialout-trunk:3] GotoIf("UCX/222@222-0", "0?disabletrunk,1") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-dialout-trunk:4] Set("UCX/222@222-0", "DIAL_NUMBER=911") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-dialout-trunk:5] Set("UCX/222@222-0", "DIAL_TRUNK_OPTIONS=tTr") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-dialout-trunk:6] Set("UCX/222@222-0", "OUTBOUND_GROUP=OUT_3") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-dialout-trunk:7] Set("UCX/222@222-0", "SCA_TAG=SCGUser") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-dialout-trunk:8] GotoIf("UCX/222@222-0", "1?nomax") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Goto (macro-dialout-trunk,s,10)
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-dialout-trunk:10] GotoIf("UCX/222@222-0", "0?skipoutcid") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-dialout-trunk:11] Set("UCX/222@222-0", "DIAL_TRUNK_OPTIONS=tT") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-dialout-trunk:12] Macro("UCX/222@222-0", "outbound-callerid,3") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-outbound-callerid:1] ExecIf("UCX/222@222-0", "0?Set(CALLERPRES()=)") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-outbound-callerid:2] ExecIf("UCX/222@222-0", "0?Set(REALCALLERIDNUM=222)") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-outbound-callerid:3] GotoIf("UCX/222@222-0", "1?normcid") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Goto (macro-outbound-callerid,s,6)
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-outbound-callerid:6] Set("UCX/222@222-0", "USEROUTCID=") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-outbound-callerid:7] Set("UCX/222@222-0", "EMERGENCYCID=") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-outbound-callerid:8] Set("UCX/222@222-0", "TRUNKOUTCID=1608249xxxx") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-outbound-callerid:9] GotoIf("UCX/222@222-0", "1?trunkcid") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Goto (macro-outbound-callerid,s,14)
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-outbound-callerid:14] ExecIf("UCX/222@222-0", "1?Set(CALLERID(all)=1608249xxxx)") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-outbound-callerid:15] ExecIf("UCX/222@222-0", "0?Set(CALLERID(all)=)") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-outbound-callerid:16] ExecIf("UCX/222@222-0", "0?Set(CALLERID(all)=)") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-outbound-callerid:17] ExecIf("UCX/222@222-0", "0?Set(CALLERPRES()=prohib_passed_screen)") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-outbound-callerid:18] Set("UCX/222@222-0", "CDR(outbound_cnum)=1608249xxxx") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-outbound-callerid:19] Set("UCX/222@222-0", "CDR(outbound_cnam)=") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-dialout-trunk:13] GosubIf("UCX/222@222-0", "0?sub-flp-3,s,1()") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-dialout-trunk:14] Set("UCX/222@222-0", "OUTNUM=911") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-dialout-trunk:15] Set("UCX/222@222-0", "custom=SIP/LINE2-608249xxxx") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-dialout-trunk:16] ExecIf("UCX/222@222-0", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default)tT)") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-dialout-trunk:17] ExecIf("UCX/222@222-0", "0?Set(DIAL_TRUNK_OPTIONS=tTM(confirm))") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-dialout-trunk:18] Macro("UCX/222@222-0", "dialout-trunk-predial-hook,") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("UCX/222@222-0", "") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-dialout-trunk:19] GotoIf("UCX/222@222-0", "0?bypass,1") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-dialout-trunk:20] ExecIf("UCX/222@222-0", "1?Set(CONNECTEDLINE(num,i)=911)") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-dialout-trunk:21] GotoIf("UCX/222@222-0", "0?customtrunk") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-dialout-trunk:22] Dial("UCX/222@222-0", "SIP/LINE2-608249xxxx/911,300,tT") in new stack
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] netsock2.c: == Using SIP RTP TOS bits 184
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] netsock2.c: == Using SIP RTP CoS mark 5
[2015-04-13 14:15:55] VERBOSE[11882][C-00000b40] app_dial.c: -- Called SIP/LINE2-608249xxxx/911
[2015-04-13 14:15:56] VERBOSE[11882][C-00000b40] app_dial.c: -- SIP/LINE2-608249xxxx-0000070b is ringing
[2015-04-13 14:16:12] VERBOSE[11882][C-00000b40] app_dial.c: -- SIP/LINE2-608249xxxx-0000070b answered UCX/222@222-0
[2015-04-13 14:16:12] VERBOSE[11883][C-00000b41] pbx.c: -- Executing [s@from-internal:1] Macro("UCX/222@222-26", "hangupcall") in new stack
[2015-04-13 14:16:12] VERBOSE[11883][C-00000b41] pbx.c: -- Executing [s@macro-hangupcall:1] GotoIf("UCX/222@222-0<ZOMBIE>", "1?theend") in new stack
[2015-04-13 14:16:12] VERBOSE[11883][C-00000b41] pbx.c: -- Goto (macro-hangupcall,s,3)
[2015-04-13 14:16:12] VERBOSE[11883][C-00000b41] pbx.c: -- Executing [h@from-internal:1] Hangup("UCX/222@222-0<ZOMBIE>", "") in new stack
[2015-04-13 14:16:12] VERBOSE[11883][C-00000b41] pbx.c: == Spawn extension (from-internal, h, 1) exited non-zero on 'UCX/222@222-0<ZOMBIE>'
[2015-04-13 14:16:30] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [h@macro-dialout-trunk:1] Macro("UCX/222@222-26", "hangupcall,") in new stack
[2015-04-13 14:16:30] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-hangupcall:1] GotoIf("UCX/222@222-26", "1?theend") in new stack
[2015-04-13 14:16:30] VERBOSE[11882][C-00000b40] pbx.c: -- Goto (macro-hangupcall,s,3)
[2015-04-13 14:16:30] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-hangupcall:3] ExecIf("UCX/222@222-26", "0?Set(CDR(recordingfile)=)") in new stack
[2015-04-13 14:16:30] VERBOSE[11882][C-00000b40] pbx.c: -- Executing [s@macro-hangupcall:4] Hangup("UCX/222@222-26", "") in new stack
[2015-04-13 14:16:30] VERBOSE[11882][C-00000b40] app_macro.c: == Spawn extension (macro-hangupcall, s, 4) exited non-zero on 'UCX/222@222-26' in macro 'hangupcall'
[2015-04-13 14:16:30] VERBOSE[11882][C-00000b40] pbx.c: == Spawn extension (macro-dialout-trunk, h, 1) exited non-zero on 'UCX/222@222-26'
[2015-04-13 14:16:30] VERBOSE[11882][C-00000b40] app_macro.c: == Spawn extension (macro-dialout-trunk, s, 22) exited non-zero on 'UCX/222@222-26' in macro 'dialout-trunk'
[2015-04-13 14:16:30] VERBOSE[11882][C-00000b40] pbx.c: == Spawn extension (from-internal, 911, 6) exited non-zero on 'UCX/222@222-26'
[/pre]