asterisk*CLI> iax2 debug IAX2 Debugging Enabled Tx-Frame Retry[000] -- OSeqno: 032 ISeqno: 035 Type: VOICE Subclass: 4 Timestamp: 917532ms SCall: 00006 DCall: 00199 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 035 ISeqno: 033 Type: IAX Subclass: ACK Timestamp: 917532ms SCall: 00199 DCall: 00006 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 035 ISeqno: 033 Type: VOICE Subclass: 4 Timestamp: 917518ms SCall: 00199 DCall: 00006 [64.34.45.100:4569] Tx-Frame Retry[-01] -- OSeqno: 033 ISeqno: 036 Type: IAX Subclass: ACK Timestamp: 917518ms SCall: 00006 DCall: 00199 [64.34.45.100:4569] Tx-Frame Retry[000] -- OSeqno: 033 ISeqno: 036 Type: IAX Subclass: PING Timestamp: 920025ms SCall: 00006 DCall: 00199 [64.34.45.100:4569] Tx-Frame Retry[000] -- OSeqno: 034 ISeqno: 036 Type: IAX Subclass: LAGRQ Timestamp: 920028ms SCall: 00006 DCall: 00199 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 036 ISeqno: 034 Type: IAX Subclass: PONG Timestamp: 920025ms SCall: 00199 DCall: 00006 [64.34.45.100:4569] Tx-Frame Retry[-01] -- OSeqno: 034 ISeqno: 037 Type: IAX Subclass: ACK Timestamp: 920025ms SCall: 00006 DCall: 00199 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 037 ISeqno: 035 Type: IAX Subclass: LAGRP Timestamp: 920028ms SCall: 00199 DCall: 00006 [64.34.45.100:4569] Tx-Frame Retry[-01] -- OSeqno: 035 ISeqno: 038 Type: IAX Subclass: ACK Timestamp: 920028ms SCall: 00006 DCall: 00199 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 038 ISeqno: 035 Type: IAX Subclass: PING Timestamp: 920003ms SCall: 00199 DCall: 00006 [64.34.45.100:4569] Tx-Frame Retry[000] -- OSeqno: 035 ISeqno: 039 Type: IAX Subclass: PONG Timestamp: 920003ms SCall: 00006 DCall: 00199 [64.34.45.100:4569] RR_JITTER : 0 RR_LOSS : 0 RR_PKTS : 1 RR_DELAY : 40 RR_DROPPED : 0 RR_OUTOFORDER : 0 Rx-Frame Retry[ No] -- OSeqno: 039 ISeqno: 035 Type: IAX Subclass: LAGRQ Timestamp: 920006ms SCall: 00199 DCall: 00006 [64.34.45.100:4569] Tx-Frame Retry[000] -- OSeqno: 036 ISeqno: 040 Type: IAX Subclass: LAGRP Timestamp: 920006ms SCall: 00006 DCall: 00199 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 039 ISeqno: 036 Type: IAX Subclass: ACK Timestamp: 920003ms SCall: 00199 DCall: 00006 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 040 ISeqno: 037 Type: IAX Subclass: ACK Timestamp: 920006ms SCall: 00199 DCall: 00006 [64.34.45.100:4569] Tx-Frame Retry[000] -- OSeqno: 037 ISeqno: 040 Type: IAX Subclass: LAGRQ Timestamp: 930015ms SCall: 00006 DCall: 00199 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 040 ISeqno: 038 Type: IAX Subclass: LAGRP Timestamp: 930015ms SCall: 00199 DCall: 00006 [64.34.45.100:4569] Tx-Frame Retry[-01] -- OSeqno: 038 ISeqno: 041 Type: IAX Subclass: ACK Timestamp: 930015ms SCall: 00006 DCall: 00199 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 041 ISeqno: 038 Type: IAX Subclass: LAGRQ Timestamp: 930003ms SCall: 00199 DCall: 00006 [64.34.45.100:4569] Tx-Frame Retry[000] -- OSeqno: 038 ISeqno: 042 Type: IAX Subclass: LAGRP Timestamp: 930003ms SCall: 00006 DCall: 00199 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 042 ISeqno: 039 Type: IAX Subclass: ACK Timestamp: 930003ms SCall: 00199 DCall: 00006 [64.34.45.100:4569] -- Executing Macro("SIP/sipura1_1-fe27", "sddial-defid|1212787XXXX") in new stack -- Executing Set("SIP/sipura1_1-fe27", "CALLEDNUMBER=212787XXXX") in new stack -- Executing NoOp("SIP/sipura1_1-fe27", "TIME=26Jun2006-16:16:15") in new stack -- Executing Macro("SIP/sipura1_1-fe27", "setdefcallid") in new stack -- Executing Set("SIP/sipura1_1-fe27", "CALLERID(number)=212787XXXX|a") in new stack -- Executing Set("SIP/sipura1_1-fe27", "CALLERID(name)=user Group|a") in new stack -- Executing Dial("SIP/sipura1_1-fe27", "IAX2/2372@voipjet-out/1212787XXXX|90|T") in new stack Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: NEW Timestamp: 00005ms SCall: 00004 DCall: 00000 [64.34.45.100:4569] VERSION : 2 CALLED NUMBER : 1212787XXXX CODEC_PREFS : (ulaw) CALLING NUMBER : 212787XXXX CALLING PRESNTN : 0 CALLING TYPEOFN : 0 CALLING TRANSIT : 0 CALLING NAME : user Group LANGUAGE : en USERNAME : 2372 FORMAT : 4 CAPABILITY : 63492 ADSICPE : 2 DATE TIME : 2006-06-26 16:16:14 -- Called 2372@voipjet-out/1212787XXXX Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: ACK Timestamp: 00005ms SCall: 00310 DCall: 00004 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: AUTHREQ Timestamp: 00016ms SCall: 00310 DCall: 00004 [64.34.45.100:4569] AUTHMETHODS : 3 CHALLENGE : 140331206 USERNAME : 2372 Tx-Frame Retry[000] -- OSeqno: 001 ISeqno: 001 Type: IAX Subclass: AUTHREP Timestamp: 00026ms SCall: 00004 DCall: 00310 [64.34.45.100:4569] MD5 RESULT : aa1166615cee267f58e1a648e5a7f098 Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 002 Type: IAX Subclass: ACK Timestamp: 00026ms SCall: 00310 DCall: 00004 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 002 Type: IAX Subclass: ACCEPT Timestamp: 00032ms SCall: 00310 DCall: 00004 [64.34.45.100:4569] FORMAT : 4 -- Call accepted by 64.34.45.100 (format ulaw) -- Format for call is ulaw Tx-Frame Retry[-01] -- OSeqno: 002 ISeqno: 002 Type: IAX Subclass: ACK Timestamp: 00032ms SCall: 00004 DCall: 00310 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 002 Type: CONTROL Subclass: (14?) Timestamp: 00035ms SCall: 00310 DCall: 00004 [64.34.45.100:4569] Tx-Frame Retry[-01] -- OSeqno: 002 ISeqno: 003 Type: IAX Subclass: ACK Timestamp: 00035ms SCall: 00004 DCall: 00310 [64.34.45.100:4569] -- IAX2/voipjet-out-4 is making progress passing it to SIP/sipura1_1-fe27 Tx-Frame Retry[000] -- OSeqno: 002 ISeqno: 003 Type: VOICE Subclass: 4 Timestamp: 00627ms SCall: 00004 DCall: 00310 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 003 Type: IAX Subclass: ACK Timestamp: 00627ms SCall: 00310 DCall: 00004 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 003 Type: VOICE Subclass: 4 Timestamp: 00704ms SCall: 00310 DCall: 00004 [64.34.45.100:4569] Tx-Frame Retry[-01] -- OSeqno: 003 ISeqno: 004 Type: IAX Subclass: ACK Timestamp: 00704ms SCall: 00004 DCall: 00310 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: NEW Timestamp: 00013ms SCall: 00142 DCall: 00000 [66.227.100.30:4569] VERSION : 2 CALLED NUMBER : CODEC_PREFS : (ulaw|alaw|gsm|g726|g729|g723) CALLING NUMBER : CALLING PRESNTN : 0 CALLING TYPEOFN : 0 CALLING TRANSIT : 0 CALLING NAME : LANGUAGE : en USERNAME : FORMAT : 4 CAPABILITY : 63775 ADSICPE : 2 DATE TIME : 2006-06-26 16:16:18 Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: AUTHREQ Timestamp: 00002ms SCall: 00001 DCall: 00142 [66.227.100.30:4569] AUTHMETHODS : 4 CHALLENGE : USERNAME : Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 001 Type: IAX Subclass: AUTHREP Timestamp: 00033ms SCall: 00142 DCall: 00001 [66.227.100.30:4569] RSA RESULT : -- Accepting AUTHENTICATED call from 66.227.100.30: > requested format = ulaw, > requested prefs = (ulaw|alaw|gsm|g726|g729|g723), > actual format = ulaw, > host prefs = (ulaw|alaw|gsm), > priority = mine Tx-Frame Retry[000] -- OSeqno: 001 ISeqno: 002 Type: IAX Subclass: ACCEPT Timestamp: 00022ms SCall: 00001 DCall: 00142 [66.227.100.30:4569] FORMAT : 4 -- Executing Macro("IAX2/66.227.100.30:4569-1", "setstamp|212787XXXX|junction-in4") in new stack -- Executing Set("IAX2/66.227.100.30:4569-1", "CDR(accountcode)=212787XXXX") in new stack -- Executing NoOp("IAX2/66.227.100.30:4569-1", "junction-in4| 20060626-161618| ") in new stack -- Executing NoOp("IAX2/66.227.100.30:4569-1", "Caller Name: 212787XXXX| Number: 1212787XXXX") in new stack -- Executing SetGlobalVar("IAX2/66.227.100.30:4569-1", "INLINE=212787XXXX") in new stack == Setting global variable 'INLINE' to '212787XXXX' -- Executing Goto("IAX2/66.227.100.30:4569-1", "default|s|1") in new stack -- Goto (default,s,1) -- Executing NoOp("IAX2/66.227.100.30:4569-1", "route-calls") in new stack -- Executing SetMusicOnHold("IAX2/66.227.100.30:4569-1", "regular") in new stack -- Executing Set("IAX2/66.227.100.30:4569-1", "MOHVAL=regular") in new stack -- Executing Answer("IAX2/66.227.100.30:4569-1", "") in new stack Tx-Frame Retry[000] -- OSeqno: 002 ISeqno: 002 Type: CONTROL Subclass: ANSWER Timestamp: 00025ms SCall: 00001 DCall: 00142 [66.227.100.30:4569] -- Executing Goto("IAX2/66.227.100.30:4569-1", "mainmenu|s|1") in new stack -- Goto (mainmenu,s,1) -- Executing Set("IAX2/66.227.100.30:4569-1", "TIMEOUT(digit)=5") in new stack -- Digit timeout set to 5 -- Executing Set("IAX2/66.227.100.30:4569-1", "TIMEOUT(response)=10") in new stack -- Response timeout set to 10 -- Executing Set("IAX2/66.227.100.30:4569-1", "PressCount=0") in new stack -- Executing NoOp("IAX2/66.227.100.30:4569-1", "TIME=26Jun2006-16:16:18") in new stack -- Executing Wait("IAX2/66.227.100.30:4569-1", "1.5") in new stack Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 002 Type: IAX Subclass: ACK Timestamp: 00022ms SCall: 00142 DCall: 00001 [66.227.100.30:4569] Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 003 Type: IAX Subclass: ACK Timestamp: 00025ms SCall: 00142 DCall: 00001 [66.227.100.30:4569] Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 003 Type: IAX Subclass: TXREQ Timestamp: 00045ms SCall: 00142 DCall: 00001 [66.227.100.30:4569] APPARENT ADDRES : IPV4 66.227.100.34:4569 CALL NUMBER : 11 TRANSFER ID : 1350874374 Tx-Frame Retry[-01] -- OSeqno: 003 ISeqno: 003 Type: IAX Subclass: ACK Timestamp: 00045ms SCall: 00001 DCall: 00142 [66.227.100.30:4569] Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: TXCNT Timestamp: 00032ms SCall: 00001 DCall: 00011 [66.227.100.34:4569] TRANSFER ID : 1350874374 Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: TXCNT Timestamp: 00045ms SCall: 00011 DCall: 00001 [66.227.100.34:4569] TRANSFER ID : 1350874374 Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: TXACC Timestamp: 00033ms SCall: 00001 DCall: 00011 [66.227.100.34:4569] Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: TXACC Timestamp: 00053ms SCall: 00011 DCall: 00001 [66.227.100.34:4569] Tx-Frame Retry[000] -- OSeqno: 003 ISeqno: 003 Type: IAX Subclass: TXREADY Timestamp: 00040ms SCall: 00001 DCall: 00142 [66.227.100.30:4569] CALL NUMBER : 1 Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 003 Type: VOICE Subclass: 4 Timestamp: 00080ms SCall: 00142 DCall: 00001 [66.227.100.30:4569] Tx-Frame Retry[-01] -- OSeqno: 003 ISeqno: 004 Type: IAX Subclass: ACK Timestamp: 00080ms SCall: 00001 DCall: 00142 [66.227.100.30:4569] Rx-Frame Retry[ No] -- OSeqno: 004 ISeqno: 004 Type: IAX Subclass: TXREL Timestamp: 00083ms SCall: 00142 DCall: 00001 [66.227.100.30:4569] CALL NUMBER : 11 Tx-Frame Retry[-01] -- OSeqno: 004 ISeqno: 005 Type: IAX Subclass: ACK Timestamp: 00083ms SCall: 00001 DCall: 00142 [66.227.100.30:4569] Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: VOICE Subclass: 4 Timestamp: 00000ms SCall: 00011 DCall: 00001 [66.227.100.34:4569] Tx-Frame Retry[-01] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: ACK Timestamp: 00009ms SCall: 00001 DCall: 00011 [66.227.100.34:4569] Rx-Frame Retry[ No] -- OSeqno: 004 ISeqno: 003 Type: CONTROL Subclass: ANSWER Timestamp: 03533ms SCall: 00310 DCall: 00004 [64.34.45.100:4569] Tx-Frame Retry[-01] -- OSeqno: 003 ISeqno: 005 Type: IAX Subclass: ACK Timestamp: 03533ms SCall: 00004 DCall: 00310 [64.34.45.100:4569] -- IAX2/voipjet-out-4 answered SIP/sipura1_1-fe27 -- Executing BackGround("IAX2/66.227.100.30:4569-1", "welcome") in new stack Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 001 Type: VOICE Subclass: 4 Timestamp: 01480ms SCall: 00001 DCall: 00011 [66.227.100.34:4569] -- Playing 'welcome' (language 'en') Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 001 Type: IAX Subclass: ACK Timestamp: 01480ms SCall: 00011 DCall: 00001 [66.227.100.34:4569] -- Executing BackGround("IAX2/66.227.100.30:4569-1", "if-u-know-ext-dial") in new stack -- Playing 'if-u-know-ext-dial' (language 'en') Tx-Frame Retry[000] -- OSeqno: 039 ISeqno: 042 Type: IAX Subclass: PING Timestamp: 940035ms SCall: 00006 DCall: 00199 [64.34.45.100:4569] Tx-Frame Retry[000] -- OSeqno: 040 ISeqno: 042 Type: IAX Subclass: LAGRQ Timestamp: 940038ms SCall: 00006 DCall: 00199 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 042 ISeqno: 040 Type: IAX Subclass: PONG Timestamp: 940035ms SCall: 00199 DCall: 00006 [64.34.45.100:4569] Tx-Frame Retry[-01] -- OSeqno: 040 ISeqno: 043 Type: IAX Subclass: ACK Timestamp: 940035ms SCall: 00006 DCall: 00199 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 043 ISeqno: 041 Type: IAX Subclass: LAGRP Timestamp: 940038ms SCall: 00199 DCall: 00006 [64.34.45.100:4569] Tx-Frame Retry[-01] -- OSeqno: 041 ISeqno: 044 Type: IAX Subclass: ACK Timestamp: 940038ms SCall: 00006 DCall: 00199 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 044 ISeqno: 041 Type: IAX Subclass: PING Timestamp: 940003ms SCall: 00199 DCall: 00006 [64.34.45.100:4569] Tx-Frame Retry[000] -- OSeqno: 041 ISeqno: 045 Type: IAX Subclass: PONG Timestamp: 940003ms SCall: 00006 DCall: 00199 [64.34.45.100:4569] RR_JITTER : 0 RR_LOSS : 0 RR_PKTS : 1 RR_DELAY : 40 RR_DROPPED : 0 RR_OUTOFORDER : 0 Rx-Frame Retry[ No] -- OSeqno: 045 ISeqno: 041 Type: IAX Subclass: LAGRQ Timestamp: 940006ms SCall: 00199 DCall: 00006 [64.34.45.100:4569] Tx-Frame Retry[000] -- OSeqno: 042 ISeqno: 046 Type: IAX Subclass: LAGRP Timestamp: 940006ms SCall: 00006 DCall: 00199 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 045 ISeqno: 042 Type: IAX Subclass: ACK Timestamp: 940003ms SCall: 00199 DCall: 00006 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 046 ISeqno: 043 Type: IAX Subclass: ACK Timestamp: 940006ms SCall: 00199 DCall: 00006 [64.34.45.100:4569] -- Executing BackGround("IAX2/66.227.100.30:4569-1", "to-dial-by-name-press&digits/3") in new stack -- Playing 'to-dial-by-name-press' (language 'en') Tx-Frame Retry[000] -- OSeqno: 003 ISeqno: 005 Type: DTMF Subclass: 6 Timestamp: 08550ms SCall: 00004 DCall: 00310 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 005 ISeqno: 004 Type: IAX Subclass: ACK Timestamp: 08550ms SCall: 00310 DCall: 00004 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 001 Type: DTMF Subclass: 6 Timestamp: 06503ms SCall: 00011 DCall: 00001 [66.227.100.34:4569] Tx-Frame Retry[-01] -- OSeqno: 001 ISeqno: 002 Type: IAX Subclass: ACK Timestamp: 06503ms SCall: 00001 DCall: 00011 [66.227.100.34:4569] Tx-Frame Retry[000] -- OSeqno: 004 ISeqno: 005 Type: DTMF Subclass: 6 Timestamp: 09000ms SCall: 00004 DCall: 00310 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: ACK Timestamp: 09000ms SCall: 00310 DCall: 00004 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 001 Type: DTMF Subclass: 6 Timestamp: 06963ms SCall: 00011 DCall: 00001 [66.227.100.34:4569] Tx-Frame Retry[-01] -- OSeqno: 001 ISeqno: 003 Type: IAX Subclass: ACK Timestamp: 06963ms SCall: 00001 DCall: 00011 [66.227.100.34:4569] Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: LAGRQ Timestamp: 10005ms SCall: 00004 DCall: 00310 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 005 ISeqno: 005 Type: IAX Subclass: LAGRQ Timestamp: 10015ms SCall: 00310 DCall: 00004 [64.34.45.100:4569] Tx-Frame Retry[000] -- OSeqno: 006 ISeqno: 006 Type: IAX Subclass: LAGRP Timestamp: 10015ms SCall: 00004 DCall: 00310 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 006 ISeqno: 006 Type: IAX Subclass: LAGRP Timestamp: 10005ms SCall: 00310 DCall: 00004 [64.34.45.100:4569] Tx-Frame Retry[-01] -- OSeqno: 006 ISeqno: 007 Type: IAX Subclass: ACK Timestamp: 10005ms SCall: 00004 DCall: 00310 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 006 ISeqno: 007 Type: IAX Subclass: ACK Timestamp: 10015ms SCall: 00310 DCall: 00004 [64.34.45.100:4569] -- Playing 'digits/3' (language 'en') -- Executing BackGround("IAX2/66.227.100.30:4569-1", "otherwise") in new stack -- Playing 'otherwise' (language 'en') -- Executing Set("IAX2/66.227.100.30:4569-1", "PressCount=1") in new stack -- Executing BackGround("IAX2/66.227.100.30:4569-1", "press-1") in new stack -- Playing 'press-1' (language 'en') -- Executing GotoIf("IAX2/66.227.100.30:4569-1", "1?silence") in new stack -- Goto (mainmenu,s,14) -- Executing BackGround("IAX2/66.227.100.30:4569-1", "silence/4") in new stack -- Playing 'silence/4' (language 'en') Tx-Frame Retry[000] -- OSeqno: 007 ISeqno: 007 Type: DTMF Subclass: 6 Timestamp: 12930ms SCall: 00004 DCall: 00310 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 007 ISeqno: 008 Type: IAX Subclass: ACK Timestamp: 12930ms SCall: 00310 DCall: 00004 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 001 Type: DTMF Subclass: 6 Timestamp: 10903ms SCall: 00011 DCall: 00001 [66.227.100.34:4569] Tx-Frame Retry[-01] -- OSeqno: 001 ISeqno: 004 Type: IAX Subclass: ACK Timestamp: 10903ms SCall: 00001 DCall: 00011 [66.227.100.34:4569] Tx-Frame Retry[000] -- OSeqno: 008 ISeqno: 007 Type: DTMF Subclass: 6 Timestamp: 13560ms SCall: 00004 DCall: 00310 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 007 ISeqno: 009 Type: IAX Subclass: ACK Timestamp: 13560ms SCall: 00310 DCall: 00004 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 004 ISeqno: 001 Type: DTMF Subclass: 6 Timestamp: 11523ms SCall: 00011 DCall: 00001 [66.227.100.34:4569] Tx-Frame Retry[-01] -- OSeqno: 001 ISeqno: 005 Type: IAX Subclass: ACK Timestamp: 11523ms SCall: 00001 DCall: 00011 [66.227.100.34:4569] Tx-Frame Retry[000] -- OSeqno: 043 ISeqno: 046 Type: IAX Subclass: LAGRQ Timestamp: 950025ms SCall: 00006 DCall: 00199 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 046 ISeqno: 044 Type: IAX Subclass: LAGRP Timestamp: 950025ms SCall: 00199 DCall: 00006 [64.34.45.100:4569] Tx-Frame Retry[-01] -- OSeqno: 044 ISeqno: 047 Type: IAX Subclass: ACK Timestamp: 950025ms SCall: 00006 DCall: 00199 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 047 ISeqno: 044 Type: IAX Subclass: LAGRQ Timestamp: 950003ms SCall: 00199 DCall: 00006 [64.34.45.100:4569] Tx-Frame Retry[000] -- OSeqno: 044 ISeqno: 048 Type: IAX Subclass: LAGRP Timestamp: 950003ms SCall: 00006 DCall: 00199 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 048 ISeqno: 045 Type: IAX Subclass: ACK Timestamp: 950003ms SCall: 00199 DCall: 00006 [64.34.45.100:4569] -- Executing GotoIf("IAX2/66.227.100.30:4569-1", "0?voice-operator|s|vmail:press") in new stack -- Goto (mainmenu,s,10) -- Executing Set("IAX2/66.227.100.30:4569-1", "PressCount=2") in new stack -- Executing BackGround("IAX2/66.227.100.30:4569-1", "press-1") in new stack -- Playing 'press-1' (language 'en') Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: REGREQ Timestamp: 00003ms SCall: 00005 DCall: 00000 [66.227.100.30:4569] USERNAME : user REFRESH : 60 Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: REGAUTH Timestamp: 00004ms SCall: 00084 DCall: 00005 [66.227.100.30:4569] AUTHMETHODS : 3 CHALLENGE : USERNAME : user Tx-Frame Retry[000] -- OSeqno: 001 ISeqno: 001 Type: IAX Subclass: REGREQ Timestamp: 00012ms SCall: 00005 DCall: 00084 [66.227.100.30:4569] USERNAME : user REFRESH : 60 MD5 RESULT : Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 002 Type: IAX Subclass: REGACK Timestamp: 00017ms SCall: 00084 DCall: 00005 [66.227.100.30:4569] USERNAME : user DATE TIME : 2006-06-26 16:16:32 REFRESH : 60 APPARENT ADDRES : IPV4 66.134.254.178:4569 Tx-Frame Retry[-01] -- OSeqno: 002 ISeqno: 002 Type: IAX Subclass: ACK Timestamp: 00017ms SCall: 00005 DCall: 00084 [66.227.100.30:4569] -- Executing GotoIf("IAX2/66.227.100.30:4569-1", "0?silence") in new stack -- Executing BackGround("IAX2/66.227.100.30:4569-1", "now") in new stack -- Playing 'now' (language 'en') -- Executing BackGround("IAX2/66.227.100.30:4569-1", "silence/4") in new stack -- Playing 'silence/4' (language 'en') Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: REGREQ Timestamp: 00015ms SCall: 00007 DCall: 00000 [207.174.202.3:4569] USERNAME : REFRESH : 60 Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: REGAUTH Timestamp: 00018ms SCall: 00505 DCall: 00007 [207.174.202.3:4569] AUTHMETHODS : 2 CHALLENGE : 12030484 USERNAME : Tx-Frame Retry[000] -- OSeqno: 001 ISeqno: 001 Type: IAX Subclass: REGREQ Timestamp: 00118ms SCall: 00007 DCall: 00505 [207.174.202.3:4569] USERNAME : user REFRESH : 60 MD5 RESULT : Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 002 Type: IAX Subclass: REGACK Timestamp: 00109ms SCall: 00505 DCall: 00007 [207.174.202.3:4569] USERNAME : user DATE TIME : 2006-06-26 14:18:04 REFRESH : 60 APPARENT ADDRES : IPV4 66.134.254.178:4569 CALLING NUMBER : CALLING NAME : user Group Tx-Frame Retry[-01] -- OSeqno: 002 ISeqno: 002 Type: IAX Subclass: ACK Timestamp: 00109ms SCall: 00007 DCall: 00505 [207.174.202.3:4569] Tx-Frame Retry[000] -- OSeqno: 009 ISeqno: 007 Type: IAX Subclass: PING Timestamp: 20005ms SCall: 00004 DCall: 00310 [64.34.45.100:4569] Tx-Frame Retry[000] -- OSeqno: 010 ISeqno: 007 Type: IAX Subclass: LAGRQ Timestamp: 20006ms SCall: 00004 DCall: 00310 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 007 ISeqno: 010 Type: IAX Subclass: PONG Timestamp: 20005ms SCall: 00310 DCall: 00004 [64.34.45.100:4569] Tx-Frame Retry[-01] -- OSeqno: 010 ISeqno: 008 Type: IAX Subclass: ACK Timestamp: 20005ms SCall: 00004 DCall: 00310 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 008 ISeqno: 011 Type: IAX Subclass: LAGRP Timestamp: 20006ms SCall: 00310 DCall: 00004 [64.34.45.100:4569] Tx-Frame Retry[-01] -- OSeqno: 011 ISeqno: 009 Type: IAX Subclass: ACK Timestamp: 20006ms SCall: 00004 DCall: 00310 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 009 ISeqno: 011 Type: IAX Subclass: PING Timestamp: 20012ms SCall: 00310 DCall: 00004 [64.34.45.100:4569] Tx-Frame Retry[000] -- OSeqno: 011 ISeqno: 010 Type: IAX Subclass: PONG Timestamp: 20012ms SCall: 00004 DCall: 00310 [64.34.45.100:4569] RR_JITTER : 0 RR_LOSS : 0 RR_PKTS : 1 RR_DELAY : 40 RR_DROPPED : 0 RR_OUTOFORDER : 0 Rx-Frame Retry[ No] -- OSeqno: 010 ISeqno: 011 Type: IAX Subclass: LAGRQ Timestamp: 20015ms SCall: 00310 DCall: 00004 [64.34.45.100:4569] Tx-Frame Retry[000] -- OSeqno: 012 ISeqno: 011 Type: IAX Subclass: LAGRP Timestamp: 20015ms SCall: 00004 DCall: 00310 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 010 ISeqno: 012 Type: IAX Subclass: ACK Timestamp: 20012ms SCall: 00310 DCall: 00004 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 011 ISeqno: 013 Type: IAX Subclass: ACK Timestamp: 20015ms SCall: 00310 DCall: 00004 [64.34.45.100:4569] -- Hungup 'IAX2/voipjet-out-4' == Spawn extension (macro-sddial-defid, s, 4) exited non-zero on 'SIP/sipura1_1-fe27' in macro 'sddial-defid' == Spawn extension (macro-sddial-defid, s, 4) exited non-zero on 'SIP/sipura1_1-fe27' -- Executing Macro("SIP/sipura1_1-fe27", "rhangup") in new stack -- Executing NoOp("SIP/sipura1_1-fe27", "DIALSTATUS=ANSWER") in new stack -- Executing NoOp("SIP/sipura1_1-fe27", "TIME=26Jun2006-16:16:36") in new stack -- Executing Hangup("SIP/sipura1_1-fe27", "") in new stack == Spawn extension (macro-rhangup, s, 3) exited non-zero on 'SIP/sipura1_1-fe27' in macro 'rhangup' == Spawn extension (macro-rhangup, s, 3) exited non-zero on 'SIP/sipura1_1-fe27' Tx-Frame Retry[000] -- OSeqno: 013 ISeqno: 011 Type: IAX Subclass: HANGUP Timestamp: 20250ms SCall: 00004 DCall: 00310 [64.34.45.100:4569] CAUSE CODE : 16 Rx-Frame Retry[ No] -- OSeqno: 011 ISeqno: 014 Type: IAX Subclass: ACK Timestamp: 20250ms SCall: 00310 DCall: 00004 [64.34.45.100:4569] Rx-Frame Retry[ No] -- OSeqno: 005 ISeqno: 001 Type: IAX Subclass: HANGUP Timestamp: 18881ms SCall: 00011 DCall: 00001 [66.227.100.34:4569] CAUSE CODE : 16 Tx-Frame Retry[-01] -- OSeqno: 001 ISeqno: 006 Type: IAX Subclass: ACK Timestamp: 18881ms SCall: 00001 DCall: 00011 [66.227.100.34:4569] == Spawn extension (mainmenu, s, 14) exited non-zero on 'IAX2/66.227.100.30:4569-1' -- Executing Macro("IAX2/66.227.100.30:4569-1", "rhangup") in new stack -- Executing NoOp("IAX2/66.227.100.30:4569-1", "DIALSTATUS=") in new stack -- Executing NoOp("IAX2/66.227.100.30:4569-1", "TIME=26Jun2006-16:16:37") in new stack -- Executing Hangup("IAX2/66.227.100.30:4569-1", "") in new stack == Spawn extension (macro-rhangup, s, 3) exited non-zero on 'IAX2/66.227.100.30:4569-1' in macro 'rhangup' == Spawn extension (macro-rhangup, s, 3) exited non-zero on 'IAX2/66.227.100.30:4569-1' -- Hungup 'IAX2/66.227.100.30:4569-1' asterisk*CLI> iax2 no debug IAX2 Debugging Disabled asterisk*CLI>