{rtf1ansiansicpg1252cocoartf949 {fonttblf0fswissfcharset0 Helvetica;} {colortbl;red255green255blue255;} margl1440margr1440vieww21000viewh12340viewkind0 pardtx720tx1440tx2160tx2880tx3600tx4320tx5040tx5760tx6480tx7200tx7920tx8640qlqnaturalpardirnatural f0fs24 cf0 Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: POKE Timestamp: 00013ms SCall: 00002 DCall: 00000 [71.91.234.171:4569] Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: PONG Timestamp: 00013ms SCall: 00001 DCall: 00002 [71.91.234.171:4569] Tx-Frame Retry[-01] -- OSeqno: 001 ISeqno: 001 Type: IAX Subclass: ACK Timestamp: 00013ms SCall: 00002 DCall: 00001 [71.91.234.171:4569] Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: NEW Timestamp: 00002ms SCall: 14973 DCall: 00000 [24.207.177.102:46229] VERSION : 2 CALLED NUMBER : TBD SERVICE IDENT : 0000000003f3 PROVISIONG VER : 0 CALLING NAME : 1305 USERNAME : 1305 FORMAT : 4 CAPABILITY : 36 asterisk1*CLI> Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: AUTHREQ Timestamp: 00001ms SCall: 00006 DCall: 14973 [24.207.177.102:46229] AUTHMETHODS : 3 CHALLENGE : 910317775 USERNAME : 1305 asterisk1*CLI> Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 001 Type: IAX Subclass: AUTHREP Timestamp: 00005ms SCall: 14973 DCall: 00006 [24.207.177.102:46229] MD5 RESULT : 2ce4832f100de70668080ced52dd7e14 SERVICE IDENT : 0000000003f3 PROVISIONG VER : 0 asterisk1*CLI> -- Accepted AUTHENTICATED TBD call from 24.207.177.102 Tx-Frame Retry[000] -- OSeqno: 001 ISeqno: 002 Type: IAX Subclass: ACCEPT Timestamp: 00073ms SCall: 00006 DCall: 14973 [24.207.177.102:46229] FORMAT : 4 Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 002 Type: IAX Subclass: ACK Timestamp: 00073ms SCall: 14973 DCall: 00006 [24.207.177.102:46229] Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 002 Type: IAX Subclass: DPREQ Timestamp: 02265ms SCall: 14973 DCall: 00006 [24.207.177.102:46229] CALLED NUMBER : 6 asterisk1*CLI> Tx-Frame Retry[000] -- OSeqno: 002 ISeqno: 003 Type: IAX Subclass: DPREP Timestamp: 02265ms SCall: 00006 DCall: 14973 [24.207.177.102:46229] CALLED NUMBER : 6 DIALPLAN STATUS : 32769 REFRESH : 600 asterisk1*CLI> Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 003 Type: IAX Subclass: ACK Timestamp: 02265ms SCall: 14973 DCall: 00006 [24.207.177.102:46229] Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 003 Type: IAX Subclass: DPREQ Timestamp: 02574ms SCall: 14973 DCall: 00006 [24.207.177.102:46229] CALLED NUMBER : 67 asterisk1*CLI> Tx-Frame Retry[000] -- OSeqno: 003 ISeqno: 004 Type: IAX Subclass: DPREP Timestamp: 02506ms SCall: 00006 DCall: 14973 [24.207.177.102:46229] CALLED NUMBER : 67 DIALPLAN STATUS : 32769 REFRESH : 600 asterisk1*CLI> Rx-Frame Retry[ No] -- OSeqno: 004 ISeqno: 004 Type: IAX Subclass: ACK Timestamp: 02506ms SCall: 14973 DCall: 00006 [24.207.177.102:46229] Rx-Frame Retry[ No] -- OSeqno: 004 ISeqno: 004 Type: IAX Subclass: DPREQ Timestamp: 02834ms SCall: 14973 DCall: 00006 [24.207.177.102:46229] CALLED NUMBER : 670 asterisk1*CLI> Tx-Frame Retry[000] -- OSeqno: 004 ISeqno: 005 Type: IAX Subclass: DPREP Timestamp: 02766ms SCall: 00006 DCall: 14973 [24.207.177.102:46229] CALLED NUMBER : 670 DIALPLAN STATUS : 32769 REFRESH : 600 asterisk1*CLI> Rx-Frame Retry[ No] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: ACK Timestamp: 02766ms SCall: 14973 DCall: 00006 [24.207.177.102:46229] Rx-Frame Retry[ No] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: DPREQ Timestamp: 03074ms SCall: 14973 DCall: 00006 [24.207.177.102:46229] CALLED NUMBER : 6709 asterisk1*CLI> Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 006 Type: IAX Subclass: DPREP Timestamp: 03005ms SCall: 00006 DCall: 14973 [24.207.177.102:46229] CALLED NUMBER : 6709 DIALPLAN STATUS : 32769 REFRESH : 600 asterisk1*CLI> Rx-Frame Retry[ No] -- OSeqno: 006 ISeqno: 006 Type: IAX Subclass: ACK Timestamp: 03005ms SCall: 14973 DCall: 00006 [24.207.177.102:46229] Rx-Frame Retry[ No] -- OSeqno: 006 ISeqno: 006 Type: IAX Subclass: DPREQ Timestamp: 03314ms SCall: 14973 DCall: 00006 [24.207.177.102:46229] CALLED NUMBER : 67090 asterisk1*CLI> Tx-Frame Retry[000] -- OSeqno: 006 ISeqno: 007 Type: IAX Subclass: DPREP Timestamp: 03248ms SCall: 00006 DCall: 14973 [24.207.177.102:46229] CALLED NUMBER : 67090 DIALPLAN STATUS : 32769 REFRESH : 600 asterisk1*CLI> Rx-Frame Retry[ No] -- OSeqno: 007 ISeqno: 007 Type: IAX Subclass: ACK Timestamp: 03248ms SCall: 14973 DCall: 00006 [24.207.177.102:46229] Rx-Frame Retry[ No] -- OSeqno: 007 ISeqno: 007 Type: IAX Subclass: DPREQ Timestamp: 03594ms SCall: 14973 DCall: 00006 [24.207.177.102:46229] CALLED NUMBER : 670908 asterisk1*CLI> Tx-Frame Retry[000] -- OSeqno: 007 ISeqno: 008 Type: IAX Subclass: DPREP Timestamp: 03526ms SCall: 00006 DCall: 14973 [24.207.177.102:46229] CALLED NUMBER : 670908 DIALPLAN STATUS : 32769 REFRESH : 600 asterisk1*CLI> Rx-Frame Retry[ No] -- OSeqno: 008 ISeqno: 008 Type: IAX Subclass: ACK Timestamp: 03526ms SCall: 14973 DCall: 00006 [24.207.177.102:46229] Rx-Frame Retry[ No] -- OSeqno: 008 ISeqno: 008 Type: IAX Subclass: DPREQ Timestamp: 03909ms SCall: 14973 DCall: 00006 [24.207.177.102:46229] CALLED NUMBER : 6709085 asterisk1*CLI> Tx-Frame Retry[000] -- OSeqno: 008 ISeqno: 009 Type: IAX Subclass: DPREP Timestamp: 03805ms SCall: 00006 DCall: 14973 [24.207.177.102:46229] CALLED NUMBER : 6709085 DIALPLAN STATUS : 32769 REFRESH : 600 Rx-Frame Retry[ No] -- OSeqno: 009 ISeqno: 009 Type: IAX Subclass: ACK Timestamp: 03805ms SCall: 14973 DCall: 00006 [24.207.177.102:46229] Rx-Frame Retry[ No] -- OSeqno: 009 ISeqno: 009 Type: IAX Subclass: PING Timestamp: 05137ms SCall: 14973 DCall: 00006 [24.207.177.102:46229] Tx-Frame Retry[000] -- OSeqno: 009 ISeqno: 010 Type: IAX Subclass: PONG Timestamp: 05137ms SCall: 00006 DCall: 14973 [24.207.177.102:46229] RR_JITTER : 0 RR_LOSS : 0 RR_PKTS : 1 RR_DELAY : 40 RR_DROPPED : 0 RR_OUTOFORDER : 0 asterisk1*CLI> Rx-Frame Retry[ No] -- OSeqno: 010 ISeqno: 010 Type: IAX Subclass: ACK Timestamp: 05137ms SCall: 14973 DCall: 00006 [24.207.177.102:46229] Rx-Frame Retry[ No] -- OSeqno: 010 ISeqno: 010 Type: IAX Subclass: DIAL Timestamp: 07971ms SCall: 14973 DCall: 00006 [24.207.177.102:46229] CALLED NUMBER : 6709085 -- Accepting DIAL from 24.207.177.102, formats = 0x4 Tx-Frame Retry[000] -- OSeqno: 010 ISeqno: 011 Type: CONTROL Subclass: (14?) Timestamp: 07658ms SCall: 00006 DCall: 14973 [24.207.177.102:46229] -- Executing Macro("IAX2/1305-6", "dialout-trunk|2|6709085||") in new stack -- Executing Set("IAX2/1305-6", "DIAL_TRUNK=2") in new stack -- Executing Set("IAX2/1305-6", "DIAL_NUMBER=6709085") in new stack -- Executing Set("IAX2/1305-6", "ROUTE_PASSWD=") in new stack -- Executing GotoIf("IAX2/1305-6", "1?noauth") in new stack -- Goto (macro-dialout-trunk,s,6) -- Executing GotoIf("IAX2/1305-6", "0?disabletrunk|1") in new stack -- Executing Set("IAX2/1305-6", "_NODEST=") in new stack -- Executing Set("IAX2/1305-6", "DIAL_TRUNK_OPTIONS=tr") in new stack -- Executing Set("IAX2/1305-6", "GROUP()=OUT_2") in new stack -- Executing Macro("IAX2/1305-6", "user-callerid|SKIPTTL") in new stack -- Executing NoOp("IAX2/1305-6", "user-callerid: device 1305") in new stack -- Executing Set("IAX2/1305-6", "AMPUSER=1305") in new stack -- Executing GotoIf("IAX2/1305-6", "0?report") in new stack -- Executing GotoIf("IAX2/1305-6", "1?start") in new stack -- Goto (macro-user-callerid,s,6) -- Executing NoOp("IAX2/1305-6", "REALCALLERIDNUM is 1305") in new stack -- Executing Set("IAX2/1305-6", "AMPUSER=1305") in new stack -- Executing Set("IAX2/1305-6", "AMPUSERCIDNAME=Test") in new stack -- Executing GotoIf("IAX2/1305-6", "0?report") in new stack -- Executing Set("IAX2/1305-6", "AMPUSERCID=1305") in new stack -- Executing Set("IAX2/1305-6", "CALLERID(all)="Test" <1305>") in new stack -- Executing Set("IAX2/1305-6", "REALCALLERIDNUM=1305") in new stack -- Executing NoOp("IAX2/1305-6", "TTL: ARG1: SKIPTTL") in new stack -- Executing GotoIf("IAX2/1305-6", "1?continue") in new stack -- Goto (macro-user-callerid,s,23) -- Executing NoOp("IAX2/1305-6", "Using CallerID "Test" <1305>") in new stack -- Executing Macro("IAX2/1305-6", "record-enable|1305|OUT") in new stack -- Executing GotoIf("IAX2/1305-6", "0?2:4") in new stack -- Goto (macro-record-enable,s,4) -- Executing AGI("IAX2/1305-6", "recordingcheck|20071105-093001|1194276601.170") in new stack -- Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck recordingcheck|20071105-093001|1194276601.170: Outbound recording not enabled Rx-Frame Retry[ No] -- OSeqno: 011 ISeqno: 011 Type: IAX Subclass: ACK Timestamp: 07658ms SCall: 14973 DCall: 00006 [24.207.177.102:46229] -- AGI Script recordingcheck completed, returning 0 -- Executing NoOp("IAX2/1305-6", "No recording needed") in new stack -- Executing GotoIf("IAX2/1305-6", "0?skipoutcid") in new stack -- Executing Set("IAX2/1305-6", "DIAL_TRUNK_OPTIONS=") in new stack -- Executing Macro("IAX2/1305-6", "outbound-callerid|2") in new stack -- Executing GotoIf("IAX2/1305-6", "1?start") in new stack -- Goto (macro-outbound-callerid,s,3) -- Executing NoOp("IAX2/1305-6", "REALCALLERIDNUM is 1305") in new stack -- Executing GotoIf("IAX2/1305-6", "1?normcid") in new stack -- Goto (macro-outbound-callerid,s,9) -- Executing Set("IAX2/1305-6", "USEROUTCID=") in new stack -- Executing Set("IAX2/1305-6", "EMERGENCYCID=") in new stack -- Executing Set("IAX2/1305-6", "TRUNKOUTCID="Associated Physicians" <6186288211>") in new stack -- Executing GotoIf("IAX2/1305-6", "1?trunkcid") in new stack -- Goto (macro-outbound-callerid,s,16) -- Executing GotoIf("IAX2/1305-6", "0?usercid") in new stack -- Executing Set("IAX2/1305-6", "CALLERID(all)="Associated Physicians" <6186288211>") in new stack -- Executing GotoIf("IAX2/1305-6", "1?report") in new stack -- Goto (macro-outbound-callerid,s,22) -- Executing NoOp("IAX2/1305-6", "CallerID set to "Associated Physicians" <6186288211>") in new stack -- Executing GotoIf("IAX2/1305-6", "0?nomax") in new stack -- Executing GotoIf("IAX2/1305-6", "0?chanfull") in new stack -- Executing AGI("IAX2/1305-6", "fixlocalprefix") in new stack -- Launched AGI Script /var/lib/asterisk/agi-bin/fixlocalprefix > fixlocalprefix: Using pattern 1618+NXXXXXX == fixlocalprefix: Dialpattern 1618+NXXXXXX matched. 6709085 -> 16186709085 -- AGI Script fixlocalprefix completed, returning 0 -- Executing Set("IAX2/1305-6", "OUTNUM=16186709085") in new stack -- Executing Set("IAX2/1305-6", "custom=SIP/TelaSIP") in new stack -- Executing GotoIf("IAX2/1305-6", "1?gocall") in new stack -- Goto (macro-dialout-trunk,s,24) -- Executing GotoIf("IAX2/1305-6", "0?customtrunk") in new stack -- Executing Dial("IAX2/1305-6", "SIP/TelaSIP/16186709085|300|") in new stack -- Called TelaSIP/16186709085 -- SIP/TelaSIP-08b6a7e8 is making progress passing it to IAX2/1305-6 Tx-Frame Retry[000] -- OSeqno: 011 ISeqno: 011 Type: CONTROL Subclass: (14?) Timestamp: 09475ms SCall: 00006 DCall: 14973 [24.207.177.102:46229] Tx-Frame Retry[000] -- OSeqno: 012 ISeqno: 011 Type: VOICE Subclass: 4 Timestamp: 09484ms SCall: 00006 DCall: 14973 [24.207.177.102:46229] Rx-Frame Retry[ No] -- OSeqno: 011 ISeqno: 012 Type: IAX Subclass: ACK Timestamp: 09475ms SCall: 14973 DCall: 00006 [24.207.177.102:46229] Rx-Frame Retry[ No] -- OSeqno: 011 ISeqno: 013 Type: IAX Subclass: ACK Timestamp: 09484ms SCall: 14973 DCall: 00006 [24.207.177.102:46229] Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: POKE Timestamp: 00011ms SCall: 00003 DCall: 00000 [71.91.234.171:4569] Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: PONG Timestamp: 00011ms SCall: 00007 DCall: 00003 [71.91.234.171:4569] Tx-Frame Retry[000] -- OSeqno: 013 ISeqno: 011 Type: IAX Subclass: LAGRQ Timestamp: 10001ms SCall: 00006 DCall: 14973 [24.207.177.102:46229] Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 001 Type: IAX Subclass: ACK Timestamp: 00011ms SCall: 00003 DCall: 00007 [71.91.234.171:4569] Rx-Frame Retry[ No] -- OSeqno: 011 ISeqno: 014 Type: IAX Subclass: LAGRP Timestamp: 10001ms SCall: 14973 DCall: 00006 [24.207.177.102:46229] Tx-Frame Retry[-01] -- OSeqno: 014 ISeqno: 012 Type: IAX Subclass: ACK Timestamp: 10001ms SCall: 00006 DCall: 14973 [24.207.177.102:46229] Rx-Frame Retry[ No] -- OSeqno: 012 ISeqno: 014 Type: IAX Subclass: HANGUP Timestamp: 16488ms SCall: 14973 DCall: 00006 [24.207.177.102:46229] Tx-Frame Retry[-01] -- OSeqno: 014 ISeqno: 013 Type: IAX Subclass: ACK Timestamp: 16488ms SCall: 00006 DCall: 14973 [24.207.177.102:46229] == Spawn extension (macro-dialout-trunk, s, 25) exited non-zero on 'IAX2/1305-6' in macro 'dialout-trunk' == Spawn extension (macro-dialout-trunk, s, 25) exited non-zero on 'IAX2/1305-6' -- Executing Macro("IAX2/1305-6", "hangupcall") in new stack -- Executing ResetCDR("IAX2/1305-6", "w") in new stack -- Executing NoCDR("IAX2/1305-6", "") in new stack -- Executing GotoIf("IAX2/1305-6", "1?skiprg") in new stack -- Goto (macro-hangupcall,s,6) -- Executing GotoIf("IAX2/1305-6", "1?skipblkvm") in new stack -- Goto (macro-hangupcall,s,9) -- Executing GotoIf("IAX2/1305-6", "1?theend") in new stack -- Goto (macro-hangupcall,s,11) -- Executing Hangup("IAX2/1305-6", "") in new stack == Spawn extension (macro-hangupcall, s, 11) exited non-zero on 'IAX2/1305-6' in macro 'hangupcall' == Spawn extension (macro-hangupcall, s, 11) exited non-zero on 'IAX2/1305-6' -- Hungup 'IAX2/1305-6' }