sip client (1001) <-> hub2 <- dundi/iax2 -> hub1 <-> iax client (1003) Scenario in all cases: 1003 calls 1001, after about 15 seconds 1001 hangs up, debugging kept on until the timeout occurs on 1003 or the hangup is detected. This is debug from using idefisk as iax client: hub1*CLI> iax2 debug IAX2 Debugging Enabled Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: NEW Timestamp: 00003ms SCall: 14402 DCall: 00000 [10.10.180.210:4569] VERSION : 2 CALLING NUMBER : 1003 CALLING NAME : 1003 FORMAT : 2 CAPABILITY : 1550 USERNAME : 1003 CALLED NUMBER : 1001 DNID : 1001 Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: AUTHREQ Timestamp: 00009ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] AUTHMETHODS : 2 CHALLENGE : 181567874 USERNAME : 1003 Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 001 Type: IAX Subclass: AUTHREP Timestamp: 00010ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] MD5 RESULT : a0f1522f210d4ca76737170b96989784 -- Accepting AUTHENTICATED call from 10.10.180.210: > requested format = gsm, > requested prefs = (), > actual format = gsm, > host prefs = (gsm|ulaw|alaw), > priority = mine Tx-Frame Retry[000] -- OSeqno: 001 ISeqno: 002 Type: IAX Subclass: ACCEPT Timestamp: 00013ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] FORMAT : 2 -- Executing ChanIsAvail("IAX2/1003-1", "SIP/1001|sj") in new stack -- Executing ChanIsAvail("IAX2/1003-1", "IAX2/1001|sj") in new stack -- Executing Goto("IAX2/1003-1", "lookupdundi|1001|1") in new stack -- Goto (lookupdundi,1001,1) Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 002 Type: IAX Subclass: ACK Timestamp: 00013ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] -- Called priv:RtACOom7bkOL4yFkmkFNUA@10.10.1.32/1001 Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: NEW Timestamp: 00005ms SCall: 00002 DCall: 00000 [10.10.1.32:4569] VERSION : 2 CALLED NUMBER : 1001 CODEC_PREFS : () CALLING NUMBER : 1003 CALLING PRESNTN : 0 CALLING TYPEOFN : 0 CALLING TRANSIT : 0 CALLING NAME : 1003 LANGUAGE : en USERNAME : priv FORMAT : 2 CAPABILITY : 65283 ADSICPE : 0 DATE TIME : 2006-08-02 10:37:46 Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: AUTHREQ Timestamp: 00005ms SCall: 00001 DCall: 00002 [10.10.1.32:4569] AUTHMETHODS : 3 CHALLENGE : 471481468 USERNAME : priv Tx-Frame Retry[000] -- OSeqno: 001 ISeqno: 001 Type: IAX Subclass: AUTHREP Timestamp: 00008ms SCall: 00002 DCall: 00001 [10.10.1.32:4569] MD5 RESULT : ca0296692b4d2d79bc75cb21d4afee9e Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 002 Type: IAX Subclass: ACCEPT Timestamp: 00007ms SCall: 00001 DCall: 00002 [10.10.1.32:4569] FORMAT : 2 -- Call accepted by 10.10.1.32 (format gsm) -- Format for call is gsm Tx-Frame Retry[-01] -- OSeqno: 002 ISeqno: 002 Type: IAX Subclass: ACK Timestamp: 00007ms SCall: 00002 DCall: 00001 [10.10.1.32:4569] Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 002 Type: CONTROL Subclass: RINGING Timestamp: 00010ms SCall: 00001 DCall: 00002 [10.10.1.32:4569] Tx-Frame Retry[-01] -- OSeqno: 002 ISeqno: 003 Type: IAX Subclass: ACK Timestamp: 00010ms SCall: 00002 DCall: 00001 [10.10.1.32:4569] -- IAX2/10.10.1.32:4569-2 is ringing Tx-Frame Retry[000] -- OSeqno: 002 ISeqno: 002 Type: CONTROL Subclass: RINGING Timestamp: 00016ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 003 Type: IAX Subclass: ACK Timestamp: 00016ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 003 Type: IAX Subclass: PING Timestamp: 02003ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[000] -- OSeqno: 003 ISeqno: 003 Type: IAX Subclass: PONG Timestamp: 02003ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] RR_JITTER : 0 RR_LOSS : 0 RR_PKTS : 1 RR_DELAY : 40 RR_DROPPED : 0 RR_OUTOFORDER : 0 Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 004 Type: IAX Subclass: ACK Timestamp: 02003ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 002 Type: CONTROL Subclass: (255?) Timestamp: 02525ms SCall: 00001 DCall: 00002 [10.10.1.32:4569] Tx-Frame Retry[-01] -- OSeqno: 002 ISeqno: 004 Type: IAX Subclass: ACK Timestamp: 02525ms SCall: 00002 DCall: 00001 [10.10.1.32:4569] Rx-Frame Retry[ No] -- OSeqno: 004 ISeqno: 002 Type: CONTROL Subclass: ANSWER Timestamp: 02528ms SCall: 00001 DCall: 00002 [10.10.1.32:4569] Tx-Frame Retry[-01] -- OSeqno: 002 ISeqno: 005 Type: IAX Subclass: ACK Timestamp: 02528ms SCall: 00002 DCall: 00001 [10.10.1.32:4569] -- IAX2/10.10.1.32:4569-2 stopped sounds -- IAX2/10.10.1.32:4569-2 answered IAX2/1003-1 -- Attempting native bridge of IAX2/1003-1 and IAX2/10.10.1.32:4569-2 Tx-Frame Retry[000] -- OSeqno: 004 ISeqno: 003 Type: CONTROL Subclass: (255?) Timestamp: 02548ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 003 Type: CONTROL Subclass: ANSWER Timestamp: 02551ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Tx-Frame Retry[000] -- OSeqno: 006 ISeqno: 003 Type: IAX Subclass: TXREQ Timestamp: 02554ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] APPARENT ADDRES : IPV4 10.10.1.32:4569 CALL NUMBER : 1 TRANSFER ID : 545934110 Tx-Frame Retry[000] -- OSeqno: 002 ISeqno: 005 Type: IAX Subclass: TXREQ Timestamp: 02529ms SCall: 00002 DCall: 00001 [10.10.1.32:4569] APPARENT ADDRES : IPV4 10.10.180.210:4569 CALL NUMBER : 14402 TRANSFER ID : 545934110 Rx-Frame Retry[ No] -- OSeqno: 005 ISeqno: 003 Type: IAX Subclass: ACK Timestamp: 02529ms SCall: 00001 DCall: 00002 [10.10.1.32:4569] Rx-Frame Retry[ No] -- OSeqno: 005 ISeqno: 003 Type: VOICE Subclass: 2 Timestamp: 02531ms SCall: 00001 DCall: 00002 [10.10.1.32:4569] Tx-Frame Retry[-01] -- OSeqno: 003 ISeqno: 006 Type: IAX Subclass: ACK Timestamp: 02531ms SCall: 00002 DCall: 00001 [10.10.1.32:4569] Tx-Frame Retry[000] -- OSeqno: 007 ISeqno: 003 Type: VOICE Subclass: 2 Timestamp: 02580ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 006 Type: IAX Subclass: ACK Timestamp: 02551ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 006 ISeqno: 003 Type: IAX Subclass: TXREADY Timestamp: 02565ms SCall: 00001 DCall: 00002 [10.10.1.32:4569] CALL NUMBER : 1 -- Channel 'IAX2/10.10.1.32:4569-2' ready to transfer Tx-Frame Retry[-01] -- OSeqno: 003 ISeqno: 007 Type: IAX Subclass: ACK Timestamp: 02565ms SCall: 00002 DCall: 00001 [10.10.1.32:4569] Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 008 Type: IAX Subclass: ACK Timestamp: 02580ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 008 Type: IAX Subclass: TXREADY Timestamp: 02604ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] CALL NUMBER : 14402 -- Channel 'IAX2/1003-1' ready to transfer -- Releasing IAX2/1003-1 and IAX2/10.10.1.32:4569-2 Tx-Frame Retry[000] -- OSeqno: 008 ISeqno: 004 Type: IAX Subclass: TXREL Timestamp: 02623ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] CALL NUMBER : 1 Tx-Frame Retry[000] -- OSeqno: 003 ISeqno: 007 Type: IAX Subclass: TXREL Timestamp: 02586ms SCall: 00002 DCall: 00001 [10.10.1.32:4569] CALL NUMBER : 14402 Rx-Frame Retry[ No] -- OSeqno: 007 ISeqno: 004 Type: IAX Subclass: ACK Timestamp: 02586ms SCall: 00001 DCall: 00002 [10.10.1.32:4569] Rx-Frame Retry[ No] -- OSeqno: 004 ISeqno: 008 Type: VOICE Subclass: 2 Timestamp: 02620ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[-01] -- OSeqno: 008 ISeqno: 005 Type: IAX Subclass: ACK Timestamp: 02620ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 004 ISeqno: 009 Type: IAX Subclass: ACK Timestamp: 1057619968ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] -- Hungup 'IAX2/10.10.1.32:4569-2' -- Hungup 'IAX2/1003-1' Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: REGREQ Timestamp: 00003ms SCall: 14403 DCall: 00000 [10.10.180.210:4569] USERNAME : 1003 REFRESH : 60 Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: REGAUTH Timestamp: 00009ms SCall: 00003 DCall: 14403 [10.10.180.210:4569] AUTHMETHODS : 2 CHALLENGE : 898485208 USERNAME : 1003 Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 001 Type: IAX Subclass: REGREQ Timestamp: 00010ms SCall: 14403 DCall: 00003 [10.10.180.210:4569] USERNAME : 1003 REFRESH : 60 MD5 RESULT : d82d3d5399a6ed188be5d430dbc34aba Tx-Frame Retry[000] -- OSeqno: 001 ISeqno: 002 Type: IAX Subclass: REGACK Timestamp: 00020ms SCall: 00003 DCall: 14403 [10.10.180.210:4569] USERNAME : 1003 DATE TIME : 2006-08-02 10:38:20 REFRESH : 60 APPARENT ADDRES : IPV4 10.10.180.210:4569 Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 002 Type: IAX Subclass: ACK Timestamp: 00020ms SCall: 14403 DCall: 00003 [10.10.180.210:4569] hub1*CLI> iax2 no debug IAX2 Debugging Disabled hub2*CLI> iax2 debug IAX2 Debugging Enabled Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: NEW Timestamp: 00005ms SCall: 00002 DCall: 00000 [10.10.1.31:4569] VERSION : 2 CALLED NUMBER : 1001 CODEC_PREFS : () CALLING NUMBER : 1003 CALLING PRESNTN : 0 CALLING TYPEOFN : 0 CALLING TRANSIT : 0 CALLING NAME : 1003 LANGUAGE : en USERNAME : priv FORMAT : 2 CAPABILITY : 65283 ADSICPE : 0 DATE TIME : 2006-08-02 10:37:46 Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: AUTHREQ Timestamp: 00005ms SCall: 00001 DCall: 00002 [10.10.1.31:4569] AUTHMETHODS : 3 CHALLENGE : 471481468 USERNAME : priv Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 001 Type: IAX Subclass: AUTHREP Timestamp: 00008ms SCall: 00002 DCall: 00001 [10.10.1.31:4569] MD5 RESULT : ca0296692b4d2d79bc75cb21d4afee9e -- Accepting AUTHENTICATED call from 10.10.1.31: > requested format = gsm, > requested prefs = (), > actual format = gsm, > host prefs = (), > priority = mine Tx-Frame Retry[000] -- OSeqno: 001 ISeqno: 002 Type: IAX Subclass: ACCEPT Timestamp: 00007ms SCall: 00001 DCall: 00002 [10.10.1.31:4569] FORMAT : 2 Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 002 Type: IAX Subclass: ACK Timestamp: 00007ms SCall: 00002 DCall: 00001 [10.10.1.31:4569] -- Executing ChanIsAvail("IAX2/10.10.1.31:4569-1", "SIP/1001|sj") in new stack -- Executing Dial("IAX2/10.10.1.31:4569-1", "SIP/1001||") in new stack -- Called 1001 -- SIP/1001-081a3068 is ringing Tx-Frame Retry[000] -- OSeqno: 002 ISeqno: 002 Type: CONTROL Subclass: RINGING Timestamp: 00010ms SCall: 00001 DCall: 00002 [10.10.1.31:4569] Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 003 Type: IAX Subclass: ACK Timestamp: 00010ms SCall: 00002 DCall: 00001 [10.10.1.31:4569] -- SIP/1001-081a3068 answered IAX2/10.10.1.31:4569-1 Tx-Frame Retry[000] -- OSeqno: 003 ISeqno: 002 Type: CONTROL Subclass: (255?) Timestamp: 02525ms SCall: 00001 DCall: 00002 [10.10.1.31:4569] Tx-Frame Retry[000] -- OSeqno: 004 ISeqno: 002 Type: CONTROL Subclass: ANSWER Timestamp: 02528ms SCall: 00001 DCall: 00002 [10.10.1.31:4569] Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 004 Type: IAX Subclass: ACK Timestamp: 02525ms SCall: 00002 DCall: 00001 [10.10.1.31:4569] Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 005 Type: IAX Subclass: ACK Timestamp: 02528ms SCall: 00002 DCall: 00001 [10.10.1.31:4569] Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 005 Type: IAX Subclass: TXREQ Timestamp: 02529ms SCall: 00002 DCall: 00001 [10.10.1.31:4569] APPARENT ADDRES : IPV4 10.10.180.210:4569 CALL NUMBER : 14402 TRANSFER ID : 545934110 Tx-Frame Retry[-01] -- OSeqno: 005 ISeqno: 003 Type: IAX Subclass: ACK Timestamp: 02529ms SCall: 00001 DCall: 00002 [10.10.1.31:4569] Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: TXCNT Timestamp: 02531ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] TRANSFER ID : 545934110 Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 003 Type: VOICE Subclass: 2 Timestamp: 02531ms SCall: 00001 DCall: 00002 [10.10.1.31:4569] Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 006 Type: IAX Subclass: ACK Timestamp: 02531ms SCall: 00002 DCall: 00001 [10.10.1.31:4569] Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: TXCNT Timestamp: 02574ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] TRANSFER ID : 545934110 Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: TXACC Timestamp: 02555ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: TXACC Timestamp: 02584ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] TRANSFER ID : 545934110 Tx-Frame Retry[000] -- OSeqno: 006 ISeqno: 003 Type: IAX Subclass: TXREADY Timestamp: 02565ms SCall: 00001 DCall: 00002 [10.10.1.31:4569] CALL NUMBER : 1 Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 007 Type: IAX Subclass: ACK Timestamp: 02565ms SCall: 00002 DCall: 00001 [10.10.1.31:4569] Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 007 Type: IAX Subclass: TXREL Timestamp: 02586ms SCall: 00002 DCall: 00001 [10.10.1.31:4569] CALL NUMBER : 14402 Tx-Frame Retry[-01] -- OSeqno: 007 ISeqno: 004 Type: IAX Subclass: ACK Timestamp: 02586ms SCall: 00001 DCall: 00002 [10.10.1.31:4569] Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 000 Type: VOICE Subclass: 2 Timestamp: 4294967287ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Tx-Frame Retry[000] -- OSeqno: 001 ISeqno: 000 Type: VOICE Subclass: 2 Timestamp: 00011ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: ACK Timestamp: 4294967287ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 002 Type: IAX Subclass: ACK Timestamp: 00011ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 002 Type: VOICE Subclass: 2 Timestamp: 00020ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[-01] -- OSeqno: 002 ISeqno: 001 Type: IAX Subclass: ACK Timestamp: 00020ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 002 Type: IAX Subclass: PING Timestamp: 09381ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[000] -- OSeqno: 002 ISeqno: 002 Type: IAX Subclass: PONG Timestamp: 09381ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] RR_JITTER : 0 RR_LOSS : 0 RR_PKTS : 1 RR_DELAY : 40 RR_DROPPED : 0 RR_OUTOFORDER : 0 Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 003 Type: IAX Subclass: ACK Timestamp: 09381ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] -- Hungup 'IAX2/10.10.1.31:4569-1' Tx-Frame Retry[000] -- OSeqno: 003 ISeqno: 002 Type: IAX Subclass: HANGUP Timestamp: 16417ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] CAUSE CODE : 16 Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 004 Type: IAX Subclass: ACK Timestamp: 16417ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 004 Type: IAX Subclass: PING Timestamp: 19381ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL Timestamp: 00000ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[Yes] -- OSeqno: 002 ISeqno: 004 Type: IAX Subclass: PING Timestamp: 19381ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL Timestamp: 00000ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[Yes] -- OSeqno: 002 ISeqno: 004 Type: IAX Subclass: PING Timestamp: 19381ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL Timestamp: 00000ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[Yes] -- OSeqno: 002 ISeqno: 004 Type: IAX Subclass: PING Timestamp: 19381ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL Timestamp: 00000ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[Yes] -- OSeqno: 002 ISeqno: 004 Type: IAX Subclass: PING Timestamp: 19381ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL Timestamp: 00000ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[Yes] -- OSeqno: 002 ISeqno: 004 Type: IAX Subclass: PING Timestamp: 19381ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL Timestamp: 00000ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 004 Type: IAX Subclass: PING Timestamp: 29385ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL Timestamp: 00000ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[Yes] -- OSeqno: 003 ISeqno: 004 Type: IAX Subclass: PING Timestamp: 29385ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL Timestamp: 00000ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[Yes] -- OSeqno: 003 ISeqno: 004 Type: IAX Subclass: PING Timestamp: 29385ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL Timestamp: 00000ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[Yes] -- OSeqno: 003 ISeqno: 004 Type: IAX Subclass: PING Timestamp: 29385ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL Timestamp: 00000ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[Yes] -- OSeqno: 002 ISeqno: 004 Type: IAX Subclass: PING Timestamp: 19381ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL Timestamp: 00000ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[Yes] -- OSeqno: 003 ISeqno: 004 Type: IAX Subclass: PING Timestamp: 29385ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL Timestamp: 00000ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[Yes] -- OSeqno: 002 ISeqno: 004 Type: IAX Subclass: PING Timestamp: 19381ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL Timestamp: 00000ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[Yes] -- OSeqno: 003 ISeqno: 004 Type: IAX Subclass: PING Timestamp: 29385ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL Timestamp: 00000ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[Yes] -- OSeqno: 002 ISeqno: 004 Type: IAX Subclass: PING Timestamp: 19381ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL Timestamp: 00000ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 004 ISeqno: 004 Type: IAX Subclass: PING Timestamp: 39391ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL Timestamp: 00000ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[Yes] -- OSeqno: 004 ISeqno: 004 Type: IAX Subclass: PING Timestamp: 39391ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL Timestamp: 00000ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[Yes] -- OSeqno: 004 ISeqno: 004 Type: IAX Subclass: PING Timestamp: 39391ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL Timestamp: 00000ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[Yes] -- OSeqno: 004 ISeqno: 004 Type: IAX Subclass: PING Timestamp: 39391ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL Timestamp: 00000ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[Yes] -- OSeqno: 003 ISeqno: 004 Type: IAX Subclass: PING Timestamp: 29385ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL Timestamp: 00000ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[Yes] -- OSeqno: 004 ISeqno: 004 Type: IAX Subclass: PING Timestamp: 39391ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL Timestamp: 00000ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[Yes] -- OSeqno: 002 ISeqno: 004 Type: IAX Subclass: PING Timestamp: 19381ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL Timestamp: 00000ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[Yes] -- OSeqno: 003 ISeqno: 004 Type: IAX Subclass: PING Timestamp: 29385ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL Timestamp: 00000ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[Yes] -- OSeqno: 004 ISeqno: 004 Type: IAX Subclass: PING Timestamp: 39391ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL Timestamp: 00000ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[Yes] -- OSeqno: 002 ISeqno: 004 Type: IAX Subclass: PING Timestamp: 19381ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL Timestamp: 00000ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[Yes] -- OSeqno: 003 ISeqno: 004 Type: IAX Subclass: PING Timestamp: 29385ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL Timestamp: 00000ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 005 ISeqno: 004 Type: IAX Subclass: PING Timestamp: 49391ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL Timestamp: 00000ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[Yes] -- OSeqno: 005 ISeqno: 004 Type: IAX Subclass: PING Timestamp: 49391ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL Timestamp: 00000ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[Yes] -- OSeqno: 005 ISeqno: 004 Type: IAX Subclass: PING Timestamp: 49391ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL Timestamp: 00000ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[Yes] -- OSeqno: 005 ISeqno: 004 Type: IAX Subclass: PING Timestamp: 49391ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL Timestamp: 00000ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[Yes] -- OSeqno: 004 ISeqno: 004 Type: IAX Subclass: PING Timestamp: 39391ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL Timestamp: 00000ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 006 ISeqno: 004 Type: IAX Subclass: HANGUP Timestamp: 51351ms SCall: 14402 DCall: 00001 [10.10.180.210:4569] CAUSE : Call timed out Tx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL Timestamp: 00000ms SCall: 00001 DCall: 14402 [10.10.180.210:4569] hub2*CLI> iax2 no debug IAX2 Debugging Disabled Now exactly the same but with an iax2 client where it does work ok: hub1*CLI> iax2 debug IAX2 Debugging Enabled Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: NEW Timestamp: 00003ms SCall: 16086 DCall: 00000 [10.10.180.210:4569] VERSION : 2 CALLING NUMBER : 7005551212 CALLING NAME : Not Available FORMAT : 8 CAPABILITY : 1550 USERNAME : 1003 CALLED NUMBER : 1001 DNID : 1001 Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: AUTHREQ Timestamp: 00009ms SCall: 00002 DCall: 16086 [10.10.180.210:4569] AUTHMETHODS : 2 CHALLENGE : 937751395 USERNAME : 1003 Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 001 Type: IAX Subclass: AUTHREP Timestamp: 00020ms SCall: 16086 DCall: 00002 [10.10.180.210:4569] MD5 RESULT : 66b918788218d04976e01e52caf957df -- Accepting AUTHENTICATED call from 10.10.180.210: > requested format = alaw, > requested prefs = (), > actual format = gsm, > host prefs = (gsm|ulaw|alaw), > priority = mine Tx-Frame Retry[000] -- OSeqno: 001 ISeqno: 002 Type: IAX Subclass: ACCEPT Timestamp: 00023ms SCall: 00002 DCall: 16086 [10.10.180.210:4569] FORMAT : 2 -- Executing ChanIsAvail("IAX2/1003-2", "SIP/1001|sj") in new stack -- Executing ChanIsAvail("IAX2/1003-2", "IAX2/1001|sj") in new stack -- Executing Goto("IAX2/1003-2", "lookupdundi|1001|1") in new stack -- Goto (lookupdundi,1001,1) Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 002 Type: IAX Subclass: ACK Timestamp: 00023ms SCall: 16086 DCall: 00002 [10.10.180.210:4569] -- Called priv:RtACOom7bkOL4yFkmkFNUA@10.10.1.32/1001 Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: NEW Timestamp: 00018ms SCall: 00003 DCall: 00000 [10.10.1.32:4569] VERSION : 2 CALLED NUMBER : 1001 CODEC_PREFS : () CALLING NUMBER : 7005551212 CALLING PRESNTN : 0 CALLING TYPEOFN : 0 CALLING TRANSIT : 0 CALLING NAME : Not Available LANGUAGE : en USERNAME : priv FORMAT : 2 CAPABILITY : 65283 ADSICPE : 0 DATE TIME : 2006-08-02 10:47:38 Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: AUTHREQ Timestamp: 00010ms SCall: 00001 DCall: 00003 [10.10.1.32:4569] AUTHMETHODS : 3 CHALLENGE : 155057117 USERNAME : priv Tx-Frame Retry[000] -- OSeqno: 001 ISeqno: 001 Type: IAX Subclass: AUTHREP Timestamp: 00023ms SCall: 00003 DCall: 00001 [10.10.1.32:4569] MD5 RESULT : 3764ccc8d9772e694adfb332500057fc Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 002 Type: IAX Subclass: ACCEPT Timestamp: 00013ms SCall: 00001 DCall: 00003 [10.10.1.32:4569] FORMAT : 2 -- Call accepted by 10.10.1.32 (format gsm) -- Format for call is gsm Tx-Frame Retry[-01] -- OSeqno: 002 ISeqno: 002 Type: IAX Subclass: ACK Timestamp: 00013ms SCall: 00003 DCall: 00001 [10.10.1.32:4569] Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 002 Type: CONTROL Subclass: RINGING Timestamp: 00016ms SCall: 00001 DCall: 00003 [10.10.1.32:4569] Tx-Frame Retry[-01] -- OSeqno: 002 ISeqno: 003 Type: IAX Subclass: ACK Timestamp: 00016ms SCall: 00003 DCall: 00001 [10.10.1.32:4569] -- IAX2/10.10.1.32:4569-3 is ringing Tx-Frame Retry[000] -- OSeqno: 002 ISeqno: 002 Type: CONTROL Subclass: RINGING Timestamp: 00026ms SCall: 00002 DCall: 16086 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 003 Type: IAX Subclass: ACK Timestamp: 00026ms SCall: 16086 DCall: 00002 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 003 Type: VOICE Subclass: 2 Timestamp: 00140ms SCall: 16086 DCall: 00002 [10.10.180.210:4569] Tx-Frame Retry[-01] -- OSeqno: 003 ISeqno: 003 Type: IAX Subclass: ACK Timestamp: 00140ms SCall: 00002 DCall: 16086 [10.10.180.210:4569] Tx-Frame Retry[000] -- OSeqno: 002 ISeqno: 003 Type: VOICE Subclass: 2 Timestamp: 00120ms SCall: 00003 DCall: 00001 [10.10.1.32:4569] Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 003 Type: IAX Subclass: ACK Timestamp: 00120ms SCall: 00001 DCall: 00003 [10.10.1.32:4569] Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 003 Type: CONTROL Subclass: (255?) Timestamp: 01765ms SCall: 00001 DCall: 00003 [10.10.1.32:4569] Tx-Frame Retry[-01] -- OSeqno: 003 ISeqno: 004 Type: IAX Subclass: ACK Timestamp: 01765ms SCall: 00003 DCall: 00001 [10.10.1.32:4569] Rx-Frame Retry[ No] -- OSeqno: 004 ISeqno: 003 Type: CONTROL Subclass: ANSWER Timestamp: 01768ms SCall: 00001 DCall: 00003 [10.10.1.32:4569] Tx-Frame Retry[-01] -- OSeqno: 003 ISeqno: 005 Type: IAX Subclass: ACK Timestamp: 01768ms SCall: 00003 DCall: 00001 [10.10.1.32:4569] -- IAX2/10.10.1.32:4569-3 stopped sounds -- IAX2/10.10.1.32:4569-3 answered IAX2/1003-2 -- Attempting native bridge of IAX2/1003-2 and IAX2/10.10.1.32:4569-3 Tx-Frame Retry[000] -- OSeqno: 003 ISeqno: 003 Type: CONTROL Subclass: (255?) Timestamp: 01798ms SCall: 00002 DCall: 16086 [10.10.180.210:4569] Tx-Frame Retry[000] -- OSeqno: 004 ISeqno: 003 Type: CONTROL Subclass: ANSWER Timestamp: 01801ms SCall: 00002 DCall: 16086 [10.10.180.210:4569] Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 003 Type: IAX Subclass: TXREQ Timestamp: 01804ms SCall: 00002 DCall: 16086 [10.10.180.210:4569] APPARENT ADDRES : IPV4 10.10.1.32:4569 CALL NUMBER : 1 TRANSFER ID : 1524141954 Tx-Frame Retry[000] -- OSeqno: 003 ISeqno: 005 Type: IAX Subclass: TXREQ Timestamp: 01782ms SCall: 00003 DCall: 00001 [10.10.1.32:4569] APPARENT ADDRES : IPV4 10.10.180.210:4569 CALL NUMBER : 16086 TRANSFER ID : 1524141954 Rx-Frame Retry[ No] -- OSeqno: 005 ISeqno: 004 Type: IAX Subclass: ACK Timestamp: 01782ms SCall: 00001 DCall: 00003 [10.10.1.32:4569] Rx-Frame Retry[ No] -- OSeqno: 005 ISeqno: 004 Type: VOICE Subclass: 2 Timestamp: 01771ms SCall: 00001 DCall: 00003 [10.10.1.32:4569] Tx-Frame Retry[-01] -- OSeqno: 004 ISeqno: 006 Type: IAX Subclass: ACK Timestamp: 01771ms SCall: 00003 DCall: 00001 [10.10.1.32:4569] Tx-Frame Retry[000] -- OSeqno: 006 ISeqno: 003 Type: VOICE Subclass: 2 Timestamp: 01820ms SCall: 00002 DCall: 16086 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 005 Type: IAX Subclass: ACK Timestamp: 01801ms SCall: 16086 DCall: 00002 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 006 ISeqno: 004 Type: IAX Subclass: TXREADY Timestamp: 01805ms SCall: 00001 DCall: 00003 [10.10.1.32:4569] CALL NUMBER : 1 -- Channel 'IAX2/10.10.1.32:4569-3' ready to transfer Tx-Frame Retry[-01] -- OSeqno: 004 ISeqno: 007 Type: IAX Subclass: ACK Timestamp: 01805ms SCall: 00003 DCall: 00001 [10.10.1.32:4569] Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 006 Type: VOICE Subclass: 2 Timestamp: 01840ms SCall: 16086 DCall: 00002 [10.10.180.210:4569] Tx-Frame Retry[-01] -- OSeqno: 006 ISeqno: 004 Type: IAX Subclass: ACK Timestamp: 01840ms SCall: 00002 DCall: 16086 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 007 Type: IAX Subclass: ACK Timestamp: 01820ms SCall: 16086 DCall: 00002 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 004 ISeqno: 007 Type: IAX Subclass: TXREADY Timestamp: 01854ms SCall: 16086 DCall: 00002 [10.10.180.210:4569] CALL NUMBER : 16086 -- Channel 'IAX2/1003-2' ready to transfer -- Releasing IAX2/1003-2 and IAX2/10.10.1.32:4569-3 Tx-Frame Retry[000] -- OSeqno: 007 ISeqno: 005 Type: IAX Subclass: TXREL Timestamp: 01863ms SCall: 00002 DCall: 16086 [10.10.180.210:4569] CALL NUMBER : 1 Tx-Frame Retry[000] -- OSeqno: 004 ISeqno: 007 Type: IAX Subclass: TXREL Timestamp: 01840ms SCall: 00003 DCall: 00001 [10.10.1.32:4569] CALL NUMBER : 16086 Rx-Frame Retry[ No] -- OSeqno: 007 ISeqno: 005 Type: IAX Subclass: ACK Timestamp: 01840ms SCall: 00001 DCall: 00003 [10.10.1.32:4569] Rx-Frame Retry[ No] -- OSeqno: 005 ISeqno: 008 Type: IAX Subclass: ACK Timestamp: 1191641088ms SCall: 16086 DCall: 00002 [10.10.180.210:4569] -- Hungup 'IAX2/10.10.1.32:4569-3' -- Hungup 'IAX2/1003-2' Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: REGREQ Timestamp: 00003ms SCall: 16088 DCall: 00000 [10.10.180.210:4569] USERNAME : 1003 REFRESH : 60 Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: REGAUTH Timestamp: 00007ms SCall: 00004 DCall: 16088 [10.10.180.210:4569] AUTHMETHODS : 2 CHALLENGE : 315218489 USERNAME : 1003 Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 001 Type: IAX Subclass: REGREQ Timestamp: 00010ms SCall: 16088 DCall: 00004 [10.10.180.210:4569] USERNAME : 1003 REFRESH : 60 MD5 RESULT : ac08bf35bc701d53ca414a39489c11f7 Tx-Frame Retry[000] -- OSeqno: 001 ISeqno: 002 Type: IAX Subclass: REGACK Timestamp: 00018ms SCall: 00004 DCall: 16088 [10.10.180.210:4569] USERNAME : 1003 DATE TIME : 2006-08-02 10:48:10 REFRESH : 60 APPARENT ADDRES : IPV4 10.10.180.210:4569 Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 002 Type: IAX Subclass: ACK Timestamp: 00018ms SCall: 16088 DCall: 00004 [10.10.180.210:4569] hub1*CLI> iax2 no debug IAX2 Debugging Disabled hub2*CLI> iax2 debug IAX2 Debugging Enabled Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: NEW Timestamp: 00018ms SCall: 00003 DCall: 00000 [10.10.1.31:4569] VERSION : 2 CALLED NUMBER : 1001 CODEC_PREFS : () CALLING NUMBER : 7005551212 CALLING PRESNTN : 0 CALLING TYPEOFN : 0 CALLING TRANSIT : 0 CALLING NAME : Not Available LANGUAGE : en USERNAME : priv FORMAT : 2 CAPABILITY : 65283 ADSICPE : 0 DATE TIME : 2006-08-02 10:47:38 Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: AUTHREQ Timestamp: 00010ms SCall: 00001 DCall: 00003 [10.10.1.31:4569] AUTHMETHODS : 3 CHALLENGE : 155057117 USERNAME : priv Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 001 Type: IAX Subclass: AUTHREP Timestamp: 00023ms SCall: 00003 DCall: 00001 [10.10.1.31:4569] MD5 RESULT : 3764ccc8d9772e694adfb332500057fc -- Accepting AUTHENTICATED call from 10.10.1.31: > requested format = gsm, > requested prefs = (), > actual format = gsm, > host prefs = (), > priority = mine Tx-Frame Retry[000] -- OSeqno: 001 ISeqno: 002 Type: IAX Subclass: ACCEPT Timestamp: 00013ms SCall: 00001 DCall: 00003 [10.10.1.31:4569] FORMAT : 2 -- Executing ChanIsAvail("IAX2/10.10.1.31:4569-1", "SIP/1001|sj") in new stack Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 002 Type: IAX Subclass: ACK Timestamp: 00013ms SCall: 00003 DCall: 00001 [10.10.1.31:4569] -- Executing Dial("IAX2/10.10.1.31:4569-1", "SIP/1001||") in new stack -- Called 1001 -- SIP/1001-0819fd68 is ringing Tx-Frame Retry[000] -- OSeqno: 002 ISeqno: 002 Type: CONTROL Subclass: RINGING Timestamp: 00016ms SCall: 00001 DCall: 00003 [10.10.1.31:4569] Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 003 Type: IAX Subclass: ACK Timestamp: 00016ms SCall: 00003 DCall: 00001 [10.10.1.31:4569] Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 003 Type: VOICE Subclass: 2 Timestamp: 00120ms SCall: 00003 DCall: 00001 [10.10.1.31:4569] Tx-Frame Retry[-01] -- OSeqno: 003 ISeqno: 003 Type: IAX Subclass: ACK Timestamp: 00120ms SCall: 00001 DCall: 00003 [10.10.1.31:4569] -- SIP/1001-0819fd68 answered IAX2/10.10.1.31:4569-1 Tx-Frame Retry[000] -- OSeqno: 003 ISeqno: 003 Type: CONTROL Subclass: (255?) Timestamp: 01765ms SCall: 00001 DCall: 00003 [10.10.1.31:4569] Tx-Frame Retry[000] -- OSeqno: 004 ISeqno: 003 Type: CONTROL Subclass: ANSWER Timestamp: 01768ms SCall: 00001 DCall: 00003 [10.10.1.31:4569] Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 004 Type: IAX Subclass: ACK Timestamp: 01765ms SCall: 00003 DCall: 00001 [10.10.1.31:4569] Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 005 Type: IAX Subclass: ACK Timestamp: 01768ms SCall: 00003 DCall: 00001 [10.10.1.31:4569] Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 005 Type: IAX Subclass: TXREQ Timestamp: 01782ms SCall: 00003 DCall: 00001 [10.10.1.31:4569] APPARENT ADDRES : IPV4 10.10.180.210:4569 CALL NUMBER : 16086 TRANSFER ID : 1524141954 Tx-Frame Retry[-01] -- OSeqno: 005 ISeqno: 004 Type: IAX Subclass: ACK Timestamp: 01782ms SCall: 00001 DCall: 00003 [10.10.1.31:4569] Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: TXCNT Timestamp: 01771ms SCall: 00001 DCall: 16086 [10.10.180.210:4569] TRANSFER ID : 1524141954 Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 004 Type: VOICE Subclass: 2 Timestamp: 01771ms SCall: 00001 DCall: 00003 [10.10.1.31:4569] Rx-Frame Retry[ No] -- OSeqno: 004 ISeqno: 006 Type: IAX Subclass: ACK Timestamp: 01771ms SCall: 00003 DCall: 00001 [10.10.1.31:4569] Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: TXCNT Timestamp: 01824ms SCall: 16086 DCall: 00001 [10.10.180.210:4569] TRANSFER ID : 1524141954 Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: TXACC Timestamp: 01795ms SCall: 00001 DCall: 16086 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: TXACC Timestamp: 01834ms SCall: 16086 DCall: 00001 [10.10.180.210:4569] TRANSFER ID : 1524141954 Tx-Frame Retry[000] -- OSeqno: 006 ISeqno: 004 Type: IAX Subclass: TXREADY Timestamp: 01805ms SCall: 00001 DCall: 00003 [10.10.1.31:4569] CALL NUMBER : 1 Rx-Frame Retry[ No] -- OSeqno: 004 ISeqno: 007 Type: IAX Subclass: ACK Timestamp: 01805ms SCall: 00003 DCall: 00001 [10.10.1.31:4569] Rx-Frame Retry[ No] -- OSeqno: 004 ISeqno: 007 Type: IAX Subclass: TXREL Timestamp: 01840ms SCall: 00003 DCall: 00001 [10.10.1.31:4569] CALL NUMBER : 16086 Tx-Frame Retry[-01] -- OSeqno: 007 ISeqno: 005 Type: IAX Subclass: ACK Timestamp: 01840ms SCall: 00001 DCall: 00003 [10.10.1.31:4569] Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 000 Type: VOICE Subclass: 2 Timestamp: 4294967287ms SCall: 00001 DCall: 16086 [10.10.180.210:4569] Tx-Frame Retry[000] -- OSeqno: 001 ISeqno: 000 Type: VOICE Subclass: 2 Timestamp: 00011ms SCall: 00001 DCall: 16086 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: ACK Timestamp: 4294967287ms SCall: 16086 DCall: 00001 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 002 Type: IAX Subclass: ACK Timestamp: 00011ms SCall: 16086 DCall: 00001 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 002 Type: VOICE Subclass: 2 Timestamp: 00020ms SCall: 16086 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[-01] -- OSeqno: 002 ISeqno: 001 Type: IAX Subclass: ACK Timestamp: 00020ms SCall: 00001 DCall: 16086 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 002 Type: IAX Subclass: PING Timestamp: 00110ms SCall: 16086 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[000] -- OSeqno: 002 ISeqno: 002 Type: IAX Subclass: PONG Timestamp: 00110ms SCall: 00001 DCall: 16086 [10.10.180.210:4569] RR_JITTER : 0 RR_LOSS : 0 RR_PKTS : 1 RR_DELAY : 40 RR_DROPPED : 0 RR_OUTOFORDER : 0 Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 003 Type: IAX Subclass: ACK Timestamp: 00110ms SCall: 16086 DCall: 00001 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 003 Type: CNG Subclass: 10 Timestamp: 00103ms SCall: 16086 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[-01] -- OSeqno: 003 ISeqno: 003 Type: IAX Subclass: ACK Timestamp: 00103ms SCall: 00001 DCall: 16086 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 003 Type: CNG Subclass: 10 Timestamp: 01203ms SCall: 16086 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[-01] -- OSeqno: 003 ISeqno: 004 Type: IAX Subclass: ACK Timestamp: 01203ms SCall: 00001 DCall: 16086 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 004 ISeqno: 003 Type: CNG Subclass: 10 Timestamp: 02103ms SCall: 16086 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[-01] -- OSeqno: 003 ISeqno: 005 Type: IAX Subclass: ACK Timestamp: 02103ms SCall: 00001 DCall: 16086 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 005 ISeqno: 003 Type: CNG Subclass: 10 Timestamp: 02963ms SCall: 16086 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[-01] -- OSeqno: 003 ISeqno: 006 Type: IAX Subclass: ACK Timestamp: 02963ms SCall: 00001 DCall: 16086 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 006 ISeqno: 003 Type: CNG Subclass: 10 Timestamp: 04143ms SCall: 16086 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[-01] -- OSeqno: 003 ISeqno: 007 Type: IAX Subclass: ACK Timestamp: 04143ms SCall: 00001 DCall: 16086 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 007 ISeqno: 003 Type: CNG Subclass: 10 Timestamp: 04343ms SCall: 16086 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[-01] -- OSeqno: 003 ISeqno: 008 Type: IAX Subclass: ACK Timestamp: 04343ms SCall: 00001 DCall: 16086 [10.10.180.210:4569] Rx-Frame Retry[Yes] -- OSeqno: 007 ISeqno: 003 Type: CNG Subclass: 10 Timestamp: 04343ms SCall: 16086 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[-01] -- OSeqno: 003 ISeqno: 008 Type: IAX Subclass: ACK Timestamp: 04343ms SCall: 00001 DCall: 16086 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 008 ISeqno: 003 Type: CNG Subclass: 10 Timestamp: 06403ms SCall: 16086 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[-01] -- OSeqno: 003 ISeqno: 009 Type: IAX Subclass: ACK Timestamp: 06403ms SCall: 00001 DCall: 16086 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 009 ISeqno: 003 Type: CNG Subclass: 10 Timestamp: 06663ms SCall: 16086 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[-01] -- OSeqno: 003 ISeqno: 010 Type: IAX Subclass: ACK Timestamp: 06663ms SCall: 00001 DCall: 16086 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 010 ISeqno: 003 Type: IAX Subclass: PING Timestamp: 10114ms SCall: 16086 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[000] -- OSeqno: 003 ISeqno: 011 Type: IAX Subclass: PONG Timestamp: 10114ms SCall: 00001 DCall: 16086 [10.10.180.210:4569] RR_JITTER : 0 RR_LOSS : 0 RR_PKTS : 1 RR_DELAY : 40 RR_DROPPED : 0 RR_OUTOFORDER : 0 Rx-Frame Retry[ No] -- OSeqno: 011 ISeqno: 004 Type: IAX Subclass: ACK Timestamp: 10114ms SCall: 16086 DCall: 00001 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 011 ISeqno: 004 Type: CNG Subclass: 10 Timestamp: 12183ms SCall: 16086 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[-01] -- OSeqno: 004 ISeqno: 012 Type: IAX Subclass: ACK Timestamp: 12183ms SCall: 00001 DCall: 16086 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 012 ISeqno: 004 Type: CNG Subclass: 10 Timestamp: 12803ms SCall: 16086 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[-01] -- OSeqno: 004 ISeqno: 013 Type: IAX Subclass: ACK Timestamp: 12803ms SCall: 00001 DCall: 16086 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 013 ISeqno: 004 Type: CNG Subclass: 10 Timestamp: 14023ms SCall: 16086 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[-01] -- OSeqno: 004 ISeqno: 014 Type: IAX Subclass: ACK Timestamp: 14023ms SCall: 00001 DCall: 16086 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 014 ISeqno: 004 Type: CNG Subclass: 10 Timestamp: 15823ms SCall: 16086 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[-01] -- OSeqno: 004 ISeqno: 015 Type: IAX Subclass: ACK Timestamp: 15823ms SCall: 00001 DCall: 16086 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 015 ISeqno: 004 Type: CNG Subclass: 10 Timestamp: 16363ms SCall: 16086 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[-01] -- OSeqno: 004 ISeqno: 016 Type: IAX Subclass: ACK Timestamp: 16363ms SCall: 00001 DCall: 16086 [10.10.180.210:4569] Rx-Frame Retry[ No] -- OSeqno: 016 ISeqno: 004 Type: CNG Subclass: 10 Timestamp: 17883ms SCall: 16086 DCall: 00001 [10.10.180.210:4569] Tx-Frame Retry[-01] -- OSeqno: 004 ISeqno: 017 Type: IAX Subclass: ACK Timestamp: 17883ms SCall: 00001 DCall: 16086 [10.10.180.210:4569] -- Hungup 'IAX2/10.10.1.31:4569-1' Tx-Frame Retry[000] -- OSeqno: 004 ISeqno: 017 Type: IAX Subclass: HANGUP Timestamp: 18436ms SCall: 00001 DCall: 16086 [10.10.180.210:4569] CAUSE CODE : 16 Rx-Frame Retry[ No] -- OSeqno: 017 ISeqno: 005 Type: IAX Subclass: ACK Timestamp: 18436ms SCall: 16086 DCall: 00001 [10.10.180.210:4569] hub2*CLI> iax2 no debug IAX2 Debugging Disabled