rtcachefriends=yes


Server A:

    -- Executing Macro("SIP/304-d4f5", "dialout-IAX2|asterisk2|1|204")
    -- Executing SetCIDName("SIP/304-d4f5", "Alessandro int. 304") in new stack
    -- Executing SetCIDNum("SIP/304-d4f5", "*COMPANY_NUMB*") in new stack
    -- Executing Dial("SIP/304-d4f5", "IAX2/asterisk2/204") in new stack
Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 000 Type: IAX     Subclass: NEW
   Timestamp: 00018ms  SCall: 16384  DCall: 00000 [192.168.0.2:4569]
   VERSION         : 2
   CALLED NUMBER   : 204
   CODEC_PREFS     : (ilbc|gsm|alaw|ulaw)
   CALLING NUMBER  : *COMPANY_NUMB*
   CALLING PRESNTN : 0
   CALLING TYPEOFN : 0
   CALLING TRANSIT : 0
   CALLING NAME    : Alessandro int. 304
   LANGUAGE        : it
   CALLED CONTEXT  : iax2-in
   USERNAME        : asterisk1
   FORMAT          : 1024
   CAPABILITY      : 64526
   ADSICPE         : 2
   DATE TIME       : 180531209

    -- Called asterisk2/204
Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 001 Type: IAX     Subclass: ACK
   Timestamp: 00018ms  SCall: 00001  DCall: 16384 [192.168.0.2:4569]
Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 001 Type: IAX     Subclass: AUTHREQ
   Timestamp: 00017ms  SCall: 00001  DCall: 16384 [192.168.0.2:4569]
   AUTHMETHODS     : 4
   CHALLENGE       : 112063746
   USERNAME        : asterisk1

Tx-Frame Retry[000] -- OSeqno: 001 ISeqno: 001 Type: IAX     Subclass: AUTHREP
   Timestamp: 00111ms  SCall: 16384  DCall: 00001 [192.168.0.2:4569]
   RSA RESULT      : lR6E+vBoNsuGsSzoY90/oxuWEu6709Fi/47P9CCjgqwLBIz2K+5nl1Kt1vnvlJIXBUaVqukYIEULpIhsbElE2qPRcCGY1cW4VuxuFS3rrXDGTzOREFT6npCjdaF0+qvotxCgnC/ME0g5xGkN7MLjiq4S6Be51j0Qf/eqkaPWGGQ

Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 002 Type: IAX     Subclass: ACK
   Timestamp: 00111ms  SCall: 00001  DCall: 16384 [192.168.0.2:4569]
Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 002 Type: IAX     Subclass: ACCEPT
   Timestamp: 00105ms  SCall: 00001  DCall: 16384 [192.168.0.2:4569]
   FORMAT          : 1024

    -- Call accepted by 192.168.0.2 (format ilbc)
    -- Format for call is ilbc
Tx-Frame Retry[-01] -- OSeqno: 002 ISeqno: 002 Type: IAX     Subclass: ACK
   Timestamp: 00105ms  SCall: 16384  DCall: 00001 [192.168.0.2:4569]
Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 002 Type: CONTROL Subclass: ANSWER
   Timestamp: 00108ms  SCall: 00001  DCall: 16384 [192.168.0.2:4569]
Tx-Frame Retry[-01] -- OSeqno: 002 ISeqno: 003 Type: IAX     Subclass: ACK
   Timestamp: 00108ms  SCall: 16384  DCall: 00001 [192.168.0.2:4569]
    -- IAX2/asterisk2-16384 answered SIP/304-d4f5
Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 002 Type: VOICE   Subclass: 138
   Timestamp: 00210ms  SCall: 00001  DCall: 16384 [192.168.0.2:4569]
Tx-Frame Retry[-01] -- OSeqno: 002 ISeqno: 004 Type: IAX     Subclass: ACK
   Timestamp: 00210ms  SCall: 16384  DCall: 00001 [192.168.0.2:4569]
Tx-Frame Retry[000] -- OSeqno: 002 ISeqno: 004 Type: VOICE   Subclass: 138
   Timestamp: 00380ms  SCall: 16384  DCall: 00001 [192.168.0.2:4569]
Rx-Frame Retry[ No] -- OSeqno: 004 ISeqno: 003 Type: IAX     Subclass: ACK
   Timestamp: 00380ms  SCall: 00001  DCall: 16384 [192.168.0.2:4569]
    -- Hungup 'IAX2/asterisk2-16384'
  == Spawn extension (macro-dialout-IAX2, s, 3) exited non-zero on 'SIP/304-d4f5' in macro 'dialout-IAX2'
  == Spawn extension (sip-in, 1*204, 1) exited non-zero on 'SIP/304-d4f5'
Tx-Frame Retry[000] -- OSeqno: 003 ISeqno: 004 Type: IAX     Subclass: HANGUP
   Timestamp: 01616ms  SCall: 16384  DCall: 00001 [192.168.0.2:4569]
   CAUSE CODE      : 16

Rx-Frame Retry[ No] -- OSeqno: 004 ISeqno: 004 Type: IAX     Subclass: ACK
   Timestamp: 01616ms  SCall: 00001  DCall: 16384 [192.168.0.2:4569]
    -- Executing Hangup("SIP/304-d4f5", "") in new stack
  == Spawn extension (sip-in, h, 1) exited non-zero on 'SIP/304-d4f5'


Server B:

Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX     Subclass: NEW
   Timestamp: 00018ms  SCall: 16384  DCall: 00000 [192.168.0.1:4569]
   VERSION         : 2
   CALLED NUMBER   : 204
   CODEC_PREFS     : (ilbc|gsm|alaw|ulaw)
   CALLING NUMBER  : *COMPANY_NUMB*
   CALLING PRESNTN : 0
   CALLING TYPEOFN : 0
   CALLING TRANSIT : 0
   CALLING NAME    : Alessandro int. 304
   LANGUAGE        : it
   CALLED CONTEXT  : iax2-in
   USERNAME        : asterisk1
   FORMAT          : 1024
   CAPABILITY      : 64526
   ADSICPE         : 2
   DATE TIME       : 180531209

Tx-Frame Retry[-01] -- OSeqno: 000 ISeqno: 001 Type: IAX     Subclass: ACK
   Timestamp: 00018ms  SCall: 00001  DCall: 16384 [192.168.0.1:4569]
Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 001 Type: IAX     Subclass: AUTHREQ
   Timestamp: 00017ms  SCall: 00001  DCall: 16384 [192.168.0.1:4569]
   AUTHMETHODS     : 4
   CHALLENGE       : 112063746
   USERNAME        : asterisk1

Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 001 Type: IAX     Subclass: AUTHREP
   Timestamp: 00111ms  SCall: 16384  DCall: 00001 [192.168.0.1:4569]
   RSA RESULT      : lR6E+vBoNsuGsSzoY90/oxuWEu6709Fi/47P9CCjgqwLBIz2K+5nl1Kt1vnvlJIXBUaVqukYIEULpIhsbElE2qPRcCGY1cW4VuxuFS3rrXDGTzOREFT6npCjdaF0+qvotxCgnC/ME0g5xGkN7MLjiq4S6Be51j0Qf/eqkaPWGGQ

Tx-Frame Retry[-01] -- OSeqno: 001 ISeqno: 002 Type: IAX     Subclass: ACK
   Timestamp: 00111ms  SCall: 00001  DCall: 16384 [192.168.0.1:4569]
    -- Accepting AUTHENTICATED call from 192.168.0.1:
       > requested format = ilbc,
       > requested prefs = (),
       > actual format = ilbc,
       > host prefs = (ilbc|gsm|alaw|ulaw),
       > priority = mine
Tx-Frame Retry[000] -- OSeqno: 001 ISeqno: 002 Type: IAX     Subclass: ACCEPT
   Timestamp: 00105ms  SCall: 00001  DCall: 16384 [192.168.0.1:4569]
   FORMAT          : 1024

Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 002 Type: IAX     Subclass: ACK
   Timestamp: 00105ms  SCall: 16384  DCall: 00001 [192.168.0.1:4569]
    -- Executing Macro("IAX2/asterisk1@192.168.0.1:4569-1", "stdexten|204|SIP/204")
    -- Executing DBget("IAX2/asterisk1@192.168.0.1:4569-1", "temp=DND/204") in new stack
    -- DBget: varname=temp, family=DND, key=204
    -- DBget: Value not found in database.
    -- Executing Goto("IAX2/asterisk1@192.168.0.1:4569-1", "s|3") in new stack
    -- Goto (macro-stdexten,s,3)
    -- Executing DBget("IAX2/asterisk1@192.168.0.1:4569-1", "temp=CFU/204") in new stack
    -- DBget: varname=temp, family=CFU, key=204
    -- DBget: Value not found in database.
    -- Executing Goto("IAX2/asterisk1@192.168.0.1:4569-1", "s|5") in new stack
    -- Goto (macro-stdexten,s,5)
    -- Executing Dial("IAX2/asterisk1@192.168.0.1:4569-1", "SIP/204|20|rtTwW") in new stack
Jun  2 22:00:18 NOTICE[7963]: app_dial.c:969 dial_exec_full: Unable to create channel of type 'SIP' (cause 3)
  == Everyone is busy/congested at this time (1:0/1/0)
    -- Executing Goto("IAX2/asterisk1@192.168.0.1:4569-1", "s-CONGESTION|1") in new stack
    -- Goto (macro-stdexten,s-CONGESTION,1)
    -- Executing Goto("IAX2/asterisk1@192.168.0.1:4569-1", "s-NOANSWER|1") in new stack
    -- Goto (macro-stdexten,s-NOANSWER,1)
    -- Executing DBget("IAX2/asterisk1@192.168.0.1:4569-1", "temp=CFNR/204") in new stack
    -- DBget: varname=temp, family=CFNR, key=204
    -- DBget: Value not found in database.
    -- Executing Goto("IAX2/asterisk1@192.168.0.1:4569-1", "s-NOANSWER|3") in new stack
    -- Goto (macro-stdexten,s-NOANSWER,3)
    -- Executing DBget("IAX2/asterisk1@192.168.0.1:4569-1", "temp=VM/204") in new stack
    -- DBget: varname=temp, family=VM, key=204
    -- DBget: Value not found in database.
    -- Executing Goto("IAX2/asterisk1@192.168.0.1:4569-1", "s-NOANSWER|5") in new stack
    -- Goto (macro-stdexten,s-NOANSWER,5)
    -- Executing VoiceMail("IAX2/asterisk1@192.168.0.1:4569-1", "u204") in new stack
Tx-Frame Retry[000] -- OSeqno: 002 ISeqno: 002 Type: CONTROL Subclass: ANSWER
   Timestamp: 00108ms  SCall: 00001  DCall: 16384 [192.168.0.1:4569]
Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 003 Type: IAX     Subclass: ACK
   Timestamp: 00108ms  SCall: 16384  DCall: 00001 [192.168.0.1:4569]
uniqueid => 10
customer_id => 0
context => default
mailbox => 204
password => ****
fullname => Alessandro
email => ******
attach => yes
saycid => yes
hidefromdir => no
stamp => 2005-04-19 11:25:48
    -- Playing 'vm-theperson' (language 'it')
Tx-Frame Retry[000] -- OSeqno: 003 ISeqno: 002 Type: VOICE   Subclass: 138
   Timestamp: 00210ms  SCall: 00001  DCall: 16384 [192.168.0.1:4569]
Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 004 Type: IAX     Subclass: ACK
   Timestamp: 00210ms  SCall: 16384  DCall: 00001 [192.168.0.1:4569]
Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 004 Type: VOICE   Subclass: 138
   Timestamp: 00380ms  SCall: 16384  DCall: 00001 [192.168.0.1:4569]
Tx-Frame Retry[-01] -- OSeqno: 004 ISeqno: 003 Type: IAX     Subclass: ACK
   Timestamp: 00380ms  SCall: 00001  DCall: 16384 [192.168.0.1:4569]
VGvvGvvvvvvvvvvvGvvvlLvvvvvvvvvvvvvvvvvvvRx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 004 Type: IAX     Subclass: HANGUP
   Timestamp: 01616ms  SCall: 16384  DCall: 00001 [192.168.0.1:4569]
   CAUSE CODE      : 16

Tx-Frame Retry[-01] -- OSeqno: 004 ISeqno: 004 Type: IAX     Subclass: ACK
   Timestamp: 01616ms  SCall: 00001  DCall: 16384 [192.168.0.1:4569]
Jun  2 22:00:19 NOTICE[7963]: chan_iax2.c:1576 iax2_destroy: Avoiding IAX destroy deadlock
  == Spawn extension (macro-stdexten, s-NOANSWER, 5) exited non-zero on 'IAX2/asterisk1@192.168.0.1:4569-1' in macro 'stdexten'
  == Spawn extension (iax2-in, 204, 1) exited non-zero on 'IAX2/asterisk1@192.168.0.1:4569-1'
    -- Hungup 'IAX2/asterisk1@192.168.0.1:4569-1'