[Jul 15 09:33:01] VERBOSE[2900][C-000109f8] netsock2.c: [Jul 15 09:33:01]   == Using SIP RTP TOS bits 184
[Jul 15 09:33:01] VERBOSE[2900][C-000109f8] netsock2.c: [Jul 15 09:33:01]   == Using SIP RTP CoS mark 5
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [245015804131@context-inbound-default-device-class:1] Set("SIP/944-0002192a", "_CVX_CALLER_CHANNEL=SIP/944-0002192a") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [245015804131@context-inbound-default-device-class:2] Set("SIP/944-0002192a", "CVX_ORIGINATING_CALLER_NUMBER=944") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [245015804131@context-inbound-default-device-class:3] Set("SIP/944-0002192a", "CVX_ORIGINATING_CALLER_NAME=") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [245015804131@context-inbound-default-device-class:4] GotoIf("SIP/944-0002192a", "0?pos5:pos6") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Goto (context-inbound-default-device-class,245015804131,9)
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [245015804131@context-inbound-default-device-class:9] CVX_UDP_SendString("SIP/944-0002192a", "CVX_CID&CVX_DID&CVX_C_CONTEXT&CVX_B_CONTEXT&&&CVX_RECORD_ORIGINATING_CALL&CVX_CLIR_ORIGINATING_CALL,127.0.0.1,8264,6(944)") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [245015804131@context-inbound-default-device-class:10] GotoIf("SIP/944-0002192a", "1?pos9") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Goto (context-inbound-default-device-class,245015804131,12)
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [245015804131@context-inbound-default-device-class:12] GotoIf("SIP/944-0002192a", "1?pos11") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Goto (context-inbound-default-device-class,245015804131,14)
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [245015804131@context-inbound-default-device-class:14] GotoIf("SIP/944-0002192a", "1?pos13") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Goto (context-inbound-default-device-class,245015804131,16)
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [245015804131@context-inbound-default-device-class:16] GotoIf("SIP/944-0002192a", "0?pos14:pos17") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Goto (context-inbound-default-device-class,245015804131,20)
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [245015804131@context-inbound-default-device-class:20] Set("SIP/944-0002192a", "CALLERID(all)=<944>") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [245015804131@context-inbound-default-device-class:21] GotoIf("SIP/944-0002192a", "0?pos20") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [245015804131@context-inbound-default-device-class:22] Set("SIP/944-0002192a", "CALLERID(name)=") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [245015804131@context-inbound-default-device-class:23] Set("SIP/944-0002192a", "__CVX_CALLER_NAME=") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [245015804131@context-inbound-default-device-class:24] Macro("SIP/944-0002192a", "CVX_UNIQUE_CALL_ID") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [s@macro-CVX_UNIQUE_CALL_ID:1] NoOp("SIP/944-0002192a", "CVX_UNIQUE_CALL_ID=, CVX_FORCE_UNIQUE_CALL_ID=, CVX_UCI_Macro=, IAXVAR_UNIQUE_ID=, IAXVAR_FORCE_UNIQUE_ID=") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [s@macro-CVX_UNIQUE_CALL_ID:2] GotoIf("SIP/944-0002192a", "1?pos0") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Goto (macro-CVX_UNIQUE_CALL_ID,s,4)
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [s@macro-CVX_UNIQUE_CALL_ID:4] GotoIf("SIP/944-0002192a", "1?pos1") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Goto (macro-CVX_UNIQUE_CALL_ID,s,8)
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [s@macro-CVX_UNIQUE_CALL_ID:8] GotoIf("SIP/944-0002192a", "0?pos13") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [s@macro-CVX_UNIQUE_CALL_ID:9] Set("SIP/944-0002192a", "__CVX_UCI_Macro=1") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [s@macro-CVX_UNIQUE_CALL_ID:10] GotoIf("SIP/944-0002192a", "1?pos3") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Goto (macro-CVX_UNIQUE_CALL_ID,s,12)
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [s@macro-CVX_UNIQUE_CALL_ID:12] GotoIf("SIP/944-0002192a", "0?pos7") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [s@macro-CVX_UNIQUE_CALL_ID:13] Set("SIP/944-0002192a", "__CVX_SUBJECT=") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [s@macro-CVX_UNIQUE_CALL_ID:14] GotoIf("SIP/944-0002192a", "1?pos7") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Goto (macro-CVX_UNIQUE_CALL_ID,s,17)
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [s@macro-CVX_UNIQUE_CALL_ID:17] GotoIf("SIP/944-0002192a", "0?pos9") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [s@macro-CVX_UNIQUE_CALL_ID:18] Set("SIP/944-0002192a", "__CVX_UNIQUE_CALL_ID=kcippbx2-1468567981.259268") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [s@macro-CVX_UNIQUE_CALL_ID:19] SIPAddHeader("SIP/944-0002192a", "Subject: %01$UUID%05kcippbx2-1468567981.259268%06") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [s@macro-CVX_UNIQUE_CALL_ID:20] Goto("SIP/944-0002192a", "pos13") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Goto (macro-CVX_UNIQUE_CALL_ID,s,23)
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [s@macro-CVX_UNIQUE_CALL_ID:23] Set("SIP/944-0002192a", "IAXVAR(CVX_UNIQUE_CALL_ID)=kcippbx2-1468567981.259268") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [s@macro-CVX_UNIQUE_CALL_ID:24] NoOp("SIP/944-0002192a", "") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [245015804131@context-inbound-default-device-class:25] CVX_UDP_SendString("SIP/944-0002192a", "RESULT,127.0.0.1,8264,76(SIP/944-0002192a&%01$UUID%05kcippbx2-1468567981.259268%06)") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [245015804131@context-inbound-default-device-class:26] Gosub("SIP/944-0002192a", "context-CVX_OriginateCall,245015804131,1(245015804131,context-outbound-class-cde-operators,context-outbound-barring-cde-operaters-out)") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [245015804131@context-CVX_OriginateCall:1] Set("SIP/944-0002192a", "CVX_DESTINATION=245015804131") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [245015804131@context-CVX_OriginateCall:2] Set("SIP/944-0002192a", "CVX_LOCAL_CONTEXT=context-outbound-class-cde-operators") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [245015804131@context-CVX_OriginateCall:3] Set("SIP/944-0002192a", "CVX_ROUTE_CONTEXT=context-outbound-barring-cde-operaters-out") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [245015804131@context-CVX_OriginateCall:4] GotoIf("SIP/944-0002192a", "1?5:7") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Goto (context-CVX_OriginateCall,245015804131,5)
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [245015804131@context-CVX_OriginateCall:5] Gosub("SIP/944-0002192a", "context-outbound-class-cde-operators,245015804131,1") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [245015804131@context-outbound-class-cde-operators:1] Return("SIP/944-0002192a", "") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [245015804131@context-CVX_OriginateCall:6] NoOp("SIP/944-0002192a", "FIRST_RESULT"  "" <944>") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [245015804131@context-CVX_OriginateCall:7] GotoIf("SIP/944-0002192a", "1?8:13") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Goto (context-CVX_OriginateCall,245015804131,8)
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [245015804131@context-CVX_OriginateCall:8] GotoIf("SIP/944-0002192a", "1?9:12") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Goto (context-CVX_OriginateCall,245015804131,9)
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [245015804131@context-CVX_OriginateCall:9] Gosub("SIP/944-0002192a", "context-outbound-barring-cde-operaters-out,245015804131,1") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [245015804131@context-outbound-barring-cde-operaters-out:1] Set("SIP/944-0002192a", "ORIGINAL_CALLERID=944") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [245015804131@context-outbound-barring-cde-operaters-out:2] Gosub("SIP/944-0002192a", "CVX_DialTrunk-Final,015804131,1(SIP/telekom,,90,Telekom,15804000,99,,,,,,0)") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [015804131@CVX_DialTrunk-Final:1] Macro("SIP/944-0002192a", "CVX_AGENT_AUTO_ANSWER_TRUNK") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [s@macro-CVX_AGENT_AUTO_ANSWER_TRUNK:1] NoOp("SIP/944-0002192a", "CVX_AUTO_ANSWER=, CVX_AAA_Macro=, IAXVAR_CVX_AUTO_ANSWER=") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [s@macro-CVX_AGENT_AUTO_ANSWER_TRUNK:2] GotoIf("SIP/944-0002192a", "1?pos10") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Goto (macro-CVX_AGENT_AUTO_ANSWER_TRUNK,s,8)
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [s@macro-CVX_AGENT_AUTO_ANSWER_TRUNK:8] NoOp("SIP/944-0002192a", "NO CVX_AUTO_ANSWER TRUNK DEFINED") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [s@macro-CVX_AGENT_AUTO_ANSWER_TRUNK:9] NoOp("SIP/944-0002192a", "") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [015804131@CVX_DialTrunk-Final:2] Set("SIP/944-0002192a", "CVX_CALLING_PARTY_NUMBER=015804131") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [015804131@CVX_DialTrunk-Final:3] GotoIf("SIP/944-0002192a", "0?4:7") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Goto (CVX_DialTrunk-Final,015804131,7)
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [015804131@CVX_DialTrunk-Final:7] GotoIf("SIP/944-0002192a", "0?8:9") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Goto (CVX_DialTrunk-Final,015804131,9)
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [015804131@CVX_DialTrunk-Final:9] GotoIf("SIP/944-0002192a", "1?10:11") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Goto (CVX_DialTrunk-Final,015804131,10)
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [015804131@CVX_DialTrunk-Final:10] SendText("SIP/944-0002192a", "CVX-TSP: Telekom") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:01]     -- Executing [015804131@CVX_DialTrunk-Final:11] AGI("SIP/944-0002192a", "agi://127.0.0.1:5000/DIAL_TRUNK&SIP/telekom&015804131&&90&944&15804000&99&&&&0&&&2016-07-15 09:33:01&&0&&&kcippbx2-1468567981.259268") in new stack
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] res_agi.c: [Jul 15 09:33:01]     -- AGI Script Executing Application: (DIAL) Options: (SIP/telekom/015804131,90,^^)
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] netsock2.c: [Jul 15 09:33:01]   == Using SIP RTP TOS bits 184
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] netsock2.c: [Jul 15 09:33:01]   == Using SIP RTP CoS mark 5
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] app_dial.c: [Jul 15 09:33:01]     -- Called SIP/telekom/015804131
[Jul 15 09:33:01] VERBOSE[10080][C-000109f8] app_dial.c: [Jul 15 09:33:01]     -- SIP/telekom-0002192b is ringing
[Jul 15 09:33:03] VERBOSE[10080][C-000109f8] app_dial.c: [Jul 15 09:33:03]     -- SIP/telekom-0002192b answered SIP/944-0002192a
[Jul 15 09:33:27] VERBOSE[10080][C-000109f8] res_musiconhold.c: [Jul 15 09:33:27]     -- Started music on hold, class 'default', on SIP/944-0002192a
[Jul 15 09:33:30] VERBOSE[10080][C-000109f8] res_musiconhold.c: [Jul 15 09:33:30]     -- Stopped music on hold on SIP/944-0002192a
[Jul 15 09:33:44] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:44]     -- Executing [h@CVX_DialTrunk-Final:1] Macro("SIP/944-0002192a", "CVX_HangupCall") in new stack
[Jul 15 09:33:44] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:44]     -- Executing [s@macro-CVX_HangupCall:1] NoOp("SIP/944-0002192a", "CVX_USERFIELD: , USERFIELD: ") in new stack
[Jul 15 09:33:44] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:44]     -- Executing [s@macro-CVX_HangupCall:2] Set("SIP/944-0002192a", "CDR(userfield)=,") in new stack
[Jul 15 09:33:44] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:44]     -- Executing [s@macro-CVX_HangupCall:3] ResetCDR("SIP/944-0002192a", "w") in new stack
[Jul 15 09:33:44] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:44]     -- Executing [s@macro-CVX_HangupCall:4] NoCDR("SIP/944-0002192a", "") in new stack
[Jul 15 09:33:44] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:44]     -- Executing [s@macro-CVX_HangupCall:5] Hangup("SIP/944-0002192a", "") in new stack
[Jul 15 09:33:44] VERBOSE[10080][C-000109f8] app_macro.c: [Jul 15 09:33:44]   == Spawn extension (macro-CVX_HangupCall, s, 5) exited non-zero on 'SIP/944-0002192a' in macro 'CVX_HangupCall'
[Jul 15 09:33:44] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:44]   == Spawn extension (CVX_DialTrunk-Final, h, 1) exited non-zero on 'SIP/944-0002192a'
[Jul 15 09:33:44] VERBOSE[10080][C-000109f8] res_agi.c: [Jul 15 09:33:44]     -- <SIP/944-0002192a>AGI Script agi://127.0.0.1:5000/DIAL_TRUNK&SIP/telekom&015804131&&90&944&15804000&99&&&&0&&&2016-07-15 09:33:01&&0&&&kcippbx2-1468567981.259268 completed, returning 4
[Jul 15 09:33:44] VERBOSE[10080][C-000109f8] pbx.c: [Jul 15 09:33:44]   == Spawn extension (CVX_DialTrunk-Final, 015804131, 11) exited non-zero on 'SIP/944-0002192a'