Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: NEW Timestamp: 00007ms SCall: 16389 DCall: 00000 [192.168.5.40:4569] VERSION : 2 CALLED NUMBER : 8897 CODEC_PREFS : (ulaw|alaw|gsm) CALLING NUMBER : CALLING PRESNTN : 0 CALLING TYPEOFN : 0 CALLING TRANSIT : 0 CALLING NAME : LANGUAGE : en CALLED CONTEXT : trusted USERNAME : testlink ENCRYPTION : 32768 FORMAT : 4 CAPABILITY : 1807 ADSICPE : 0 DATE TIME : 2009-10-19 23:18:24 Tx-Frame Retry[-01] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: ACK Timestamp: 00007ms SCall: 09072 DCall: 16389 [192.168.5.40:4569] Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: AUTHREQ Timestamp: 00016ms SCall: 09072 DCall: 16389 [192.168.5.40:4569] AUTHMETHODS : 3 CHALLENGE : \x37\x38\x31\x37\x37\x35\x33\x35\x31 USERNAME : testlink Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 001 Type: IAX Subclass: AUTHREP Timestamp: 00024ms SCall: 16389 DCall: 09072 [192.168.5.40:4569] MD5 RESULT : 88d6f4f50f87b82f5d4e2696c04b8dcd -- Accepting AUTHENTICATED call from 192.168.5.40: > requested format = ulaw, > requested prefs = (ulaw|alaw|gsm), > actual format = alaw, > host prefs = (alaw|ulaw|gsm), > priority = mine -- Executing [8897@trusted:1] NoOp("IAX2/testlink-9072", "") in new stack -- Executing [8897@trusted:2] Answer("IAX2/testlink-9072", "") in new stack Tx-Frame Retry[000] -- OSeqno: 001 ISeqno: 002 Type: IAX Subclass: ACCEPT Timestamp: 00029ms SCall: 09072 DCall: 16389 [192.168.5.40:4569] FORMAT : 8 Tx-Frame Retry[000] -- OSeqno: 002 ISeqno: 002 Type: CONTROL Subclass: ANSWER Timestamp: 00032ms SCall: 09072 DCall: 16389 [192.168.5.40:4569] Tx-Frame Retry[000] -- OSeqno: 003 ISeqno: 002 Type: CONTROL Subclass: (255?) Timestamp: 00035ms SCall: 09072 DCall: 16389 [192.168.5.40:4569] Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 002 Type: IAX Subclass: ACK Timestamp: 00029ms SCall: 16389 DCall: 09072 [192.168.5.40:4569] Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 002 Type: IAX Subclass: VNAK Timestamp: 00041ms SCall: 16389 DCall: 09072 [192.168.5.40:4569] Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 003 Type: IAX Subclass: ACK Timestamp: 00032ms SCall: 16389 DCall: 09072 [192.168.5.40:4569] Tx-Frame Retry[001] -- OSeqno: 002 ISeqno: 002 Type: CONTROL Subclass: ANSWER Timestamp: 00032ms SCall: 09072 DCall: 16389 [192.168.5.40:4569] Tx-Frame Retry[001] -- OSeqno: 003 ISeqno: 002 Type: CONTROL Subclass: (255?) Timestamp: 00035ms SCall: 09072 DCall: 16389 [192.168.5.40:4569] Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 003 Type: CONTROL Subclass: RINGING Timestamp: 00044ms SCall: 16389 DCall: 09072 [192.168.5.40:4569] Tx-Frame Retry[-01] -- OSeqno: 003 ISeqno: 003 Type: IAX Subclass: ACK Timestamp: 00044ms SCall: 09072 DCall: 16389 [192.168.5.40:4569] Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 003 Type: CONTROL Subclass: (20?) Timestamp: 00047ms SCall: 16389 DCall: 09072 [192.168.5.40:4569] Tx-Frame Retry[-01] -- OSeqno: 003 ISeqno: 004 Type: IAX Subclass: ACK Timestamp: 00047ms SCall: 09072 DCall: 16389 [192.168.5.40:4569] Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 003 Type: IAX Subclass: ACK Timestamp: 00032ms SCall: 16389 DCall: 09072 [192.168.5.40:4569] Rx-Frame Retry[ No] -- OSeqno: 004 ISeqno: 004 Type: CONTROL Subclass: (20?) Timestamp: 00050ms SCall: 16389 DCall: 09072 [192.168.5.40:4569] Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 004 Type: IAX Subclass: ACK Timestamp: 00035ms SCall: 16389 DCall: 09072 [192.168.5.40:4569] Tx-Frame Retry[-01] -- OSeqno: 004 ISeqno: 005 Type: IAX Subclass: ACK Timestamp: 00050ms SCall: 09072 DCall: 16389 [192.168.5.40:4569] Rx-Frame Retry[ No] -- OSeqno: 005 ISeqno: 004 Type: CONTROL Subclass: (20?) Timestamp: 00053ms SCall: 16389 DCall: 09072 [192.168.5.40:4569] Tx-Frame Retry[-01] -- OSeqno: 004 ISeqno: 006 Type: IAX Subclass: ACK Timestamp: 00053ms SCall: 09072 DCall: 16389 [192.168.5.40:4569] -- Executing [8897@trusted:3] Playback("IAX2/testlink-9072", "test-tones-follow") in new stack -- Playing 'test-tones-follow.slin' (language 'en') Tx-Frame Retry[000] -- OSeqno: 004 ISeqno: 006 Type: VOICE Subclass: 8 Timestamp: 00540ms SCall: 09072 DCall: 16389 [192.168.5.40:4569] Rx-Frame Retry[ No] -- OSeqno: 006 ISeqno: 005 Type: IAX Subclass: ACK Timestamp: 00540ms SCall: 16389 DCall: 09072 [192.168.5.40:4569] Rx-Frame Retry[ No] -- OSeqno: 006 ISeqno: 005 Type: CONTROL Subclass: (20?) Rx-Frame Retry[ No] -- OSeqno: 007 ISeqno: 005 Type: IAX Subclass: HANGUP Timestamp: 00653ms SCall: 16389 DCall: 09072 [192.168.5.40:4569] Timestamp: 00656ms SCall: 16389 DCall: 09072 [192.168.5.40:4569] CAUSE CODE : 16 Tx-Frame Retry[-01] -- OSeqno: 005 ISeqno: 007 Type: IAX Subclass: ACK Timestamp: 00653ms SCall: 09072 DCall: 16389 [192.168.5.40:4569] Tx-Frame Retry[-01] -- OSeqno: 005 ISeqno: 008 Type: IAX Subclass: ACK Timestamp: 00656ms SCall: 09072 DCall: 16389 [192.168.5.40:4569] == Spawn extension (trusted, 8897, 3) exited non-zero on 'IAX2/testlink-9072' -- Hungup 'IAX2/testlink-9072' Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: NEW Timestamp: 00003ms SCall: 16390 DCall: 00000 [192.168.5.40:4569] VERSION : 2 CALLED NUMBER : 8897 CODEC_PREFS : (ulaw|alaw|gsm) CALLING NUMBER : CALLING PRESNTN : 0 CALLING TYPEOFN : 0 CALLING TRANSIT : 0 CALLING NAME : LANGUAGE : en CALLED CONTEXT : trusted USERNAME : testlink ENCRYPTION : 32768 FORMAT : 4 CAPABILITY : 1807 ADSICPE : 0 DATE TIME : 2009-10-19 23:18:26 Tx-Frame Retry[-01] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: ACK Timestamp: 00003ms SCall: 09503 DCall: 16390 [192.168.5.40:4569] Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: AUTHREQ Timestamp: 00013ms SCall: 09503 DCall: 16390 [192.168.5.40:4569] AUTHMETHODS : 3 CHALLENGE : \x34\x33\x37\x34\x36\x38\x39\x32\x38 USERNAME : testlink Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 001 Type: IAX Subclass: AUTHREP Timestamp: 00020ms SCall: 16390 DCall: 09503 [192.168.5.40:4569] MD5 RESULT : 24cab7e1c16855e80ec0b3f1f2ea3313 -- Accepting AUTHENTICATED call from 192.168.5.40: > requested format = ulaw, > requested prefs = (ulaw|alaw|gsm), > actual format = alaw, > host prefs = (alaw|ulaw|gsm), > priority = mine -- Executing [8897@trusted:1] NoOp("IAX2/testlink-9503", "") in new stack -- Executing [8897@trusted:2] Answer("IAX2/testlink-9503", "") in new stack Tx-Frame Retry[000] -- OSeqno: 001 ISeqno: 002 Type: IAX Subclass: ACCEPT Timestamp: 00025ms SCall: 09503 DCall: 16390 [192.168.5.40:4569] FORMAT : 8 Tx-Frame Retry[000] -- OSeqno: 002 ISeqno: 002 Type: CONTROL Subclass: ANSWER Timestamp: 00028ms SCall: 09503 DCall: 16390 [192.168.5.40:4569] Tx-Frame Retry[000] -- OSeqno: 003 ISeqno: 002 Type: CONTROL Subclass: (255?) Timestamp: 00031ms SCall: 09503 DCall: 16390 [192.168.5.40:4569] Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 002 Type: IAX Subclass: ACK Timestamp: 00025ms SCall: 16390 DCall: 09503 [192.168.5.40:4569] Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 003 Type: IAX Subclass: ACK Timestamp: 00028ms SCall: 16390 DCall: 09503 [192.168.5.40:4569] Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 004 Type: IAX Subclass: ACK Timestamp: 00031ms SCall: 16390 DCall: 09503 [192.168.5.40:4569] Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 004 Type: CONTROL Subclass: RINGING Timestamp: 00023ms SCall: 16390 DCall: 09503 [192.168.5.40:4569] Tx-Frame Retry[-01] -- OSeqno: 004 ISeqno: 003 Type: IAX Subclass: ACK Timestamp: 00023ms SCall: 09503 DCall: 16390 [192.168.5.40:4569] Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 004 Type: CONTROL Subclass: (20?) Timestamp: 00026ms SCall: 16390 DCall: 09503 [192.168.5.40:4569] Tx-Frame Retry[-01] -- OSeqno: 004 ISeqno: 004 Type: IAX Subclass: ACK Timestamp: 00026ms SCall: 09503 DCall: 16390 [192.168.5.40:4569] Rx-Frame Retry[ No] -- OSeqno: 004 ISeqno: 004 Type: CONTROL Subclass: (20?) Timestamp: 00029ms SCall: 16390 DCall: 09503 [192.168.5.40:4569] Tx-Frame Retry[-01] -- OSeqno: 004 ISeqno: 005 Type: IAX Subclass: ACK Timestamp: 00029ms SCall: 09503 DCall: 16390 [192.168.5.40:4569] Rx-Frame Retry[ No] -- OSeqno: 005 ISeqno: 004 Type: CONTROL Subclass: (20?) Timestamp: 00032ms SCall: 16390 DCall: 09503 [192.168.5.40:4569] Tx-Frame Retry[-01] -- OSeqno: 004 ISeqno: 006 Type: IAX Subclass: ACK Timestamp: 00032ms SCall: 09503 DCall: 16390 [192.168.5.40:4569] -- Executing [8897@trusted:3] Playback("IAX2/testlink-9503", "test-tones-follow") in new stack -- Playing 'test-tones-follow.slin' (language 'en') Tx-Frame Retry[000] -- OSeqno: 004 ISeqno: 006 Type: VOICE Subclass: 8 Timestamp: 00540ms SCall: 09503 DCall: 16390 [192.168.5.40:4569] Rx-Frame Retry[ No] -- OSeqno: 006 ISeqno: 005 Type: IAX Subclass: ACK Timestamp: 00540ms SCall: 16390 DCall: 09503 [192.168.5.40:4569] Rx-Frame Retry[ No] -- OSeqno: 006 ISeqno: 005 Type: CONTROL Subclass: (20?) Timestamp: 00692ms SCall: 16390 DCall: 09503 [192.168.5.40:4569] Tx-Frame Retry[-01] -- OSeqno: 005 ISeqno: 007 Type: IAX Subclass: ACK Timestamp: 00692ms SCall: 09503 DCall: 16390 [192.168.5.40:4569] Rx-Frame Retry[ No] -- OSeqno: 007 ISeqno: 005 Type: IAX Subclass: HANGUP Timestamp: 00695ms SCall: 16390 DCall: 09503 [192.168.5.40:4569] CAUSE CODE : 16 Tx-Frame Retry[-01] -- OSeqno: 005 ISeqno: 008 Type: IAX Subclass: ACK Timestamp: 00695ms SCall: 09503 DCall: 16390 [192.168.5.40:4569] == Spawn extension (trusted, 8897, 3) exited non-zero on 'IAX2/testlink-9503' -- Hungup 'IAX2/testlink-9503' Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: NEW Timestamp: 00003ms SCall: 16391 DCall: 00000 [192.168.5.40:4569] VERSION : 2 CALLED NUMBER : 8897 CODEC_PREFS : (ulaw|alaw|gsm) CALLING NUMBER : CALLING PRESNTN : 0 CALLING TYPEOFN : 0 CALLING TRANSIT : 0 CALLING NAME : LANGUAGE : en CALLED CONTEXT : trusted USERNAME : testlink ENCRYPTION : 32768 FORMAT : 4 CAPABILITY : 1807 ADSICPE : 0 DATE TIME : 2009-10-19 23:18:28 Tx-Frame Retry[-01] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: ACK Timestamp: 00003ms SCall: 14544 DCall: 16391 [192.168.5.40:4569] Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: AUTHREQ Timestamp: 00013ms SCall: 14544 DCall: 16391 [192.168.5.40:4569] AUTHMETHODS : 3 CHALLENGE : \x31\x37\x38\x35\x37\x39\x33\x34\x36 USERNAME : testlink Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL Timestamp: 00000ms SCall: 16391 DCall: 14544 [192.168.5.40:4569] Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 001 Type: IAX Subclass: AUTHREP Timestamp: 00020ms SCall: 16391 DCall: 14544 [192.168.5.40:4569] MD5 RESULT : 59ab0910e1e805008ef5983dd64f672a Tx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: INVAL Timestamp: 00000ms SCall: 14544 DCall: 16391 [192.168.5.40:4569] Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: POKE Timestamp: 00007ms SCall: 06041 DCall: 00000 [192.168.5.40:4569] Rx-Frame Retry[Yes] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: PONG Timestamp: 00007ms SCall: 00001 DCall: 06041 [192.168.5.40:4569] Tx-Frame Retry[-01] -- OSeqno: 001 ISeqno: 001 Type: IAX Subclass: ACK Timestamp: 00007ms SCall: 06041 DCall: 00001 [192.168.5.40:4569] auck1*CLI>