Asterisk Ready.
*CLI> Jun 30 23:10:28 DEBUG[14372]: chan_iax2.c:7150 socket_read: We don't do requested format ulaw, falling back to peer capability 4
    -- Accepting AUTHENTICATED call from 10.0.0.1:
       > requested format = ulaw,
       > requested prefs = (),
       > actual format = ulaw,
       > host prefs = (),
       > priority = mine
    -- Executing Macro("IAX2/simon-2", "outGlobotech|IAX2/Globotech|15") in new stack
    -- Executing Dial("IAX2/simon-2", "IAX2/Globotech/16138682446|15|t") in new stack
Jun 30 23:10:28 NOTICE[14372]: app_dial.c:1109 dial_exec_full: Unable to create channel of type 'IAX2' (cause 3 - No route to destination)
  == Everyone is busy/congested at this time (1:0/0/1)
Jun 30 23:10:28 DEBUG[14372]: app_dial.c:1673 dial_exec_full: Exiting with DIALSTATUS=CHANUNAVAIL.
Jun 30 23:10:28 DEBUG[14372]: chan_iax2.c:6568 socket_read: Ooh, voice format changed to 4
Jun 30 23:10:38 WARNING[14372]: pbx.c:2420 __ast_pbx_run: Timeout, but no rule 't' in context 'NN_accounts'
Jun 30 23:10:38 DEBUG[14372]: cdr_addon_mysql.c:206 mysql_log: cdr_mysql: inserting a CDR record.
Jun 30 23:10:38 DEBUG[14372]: cdr_addon_mysql.c:222 mysql_log: cdr_mysql: SQL command as follows: INSERT INTO cdr (calldate,clid,src,dst,dcontext,channel,dstchannel,lastapp,lastdata,duration,billsec,disposition,amaflags,accountcode,userfield) VALUES ('2006-06-30 23:10:28','simon','','16138682464','NN_accounts', 'IAX2/simon-2','','Dial','IAX2/Globotech/16138682446|15|t',10,0,'BUSY',3,'','')
Jun 30 23:10:38 DEBUG[14372]: pbx.c:1527 pbx_substitute_variables_helper_full: Function result is 'simon'
Jun 30 23:10:38 DEBUG[14372]: pbx.c:1527 pbx_substitute_variables_helper_full: Function result is '(null)'
Jun 30 23:10:38 DEBUG[14372]: pbx.c:1527 pbx_substitute_variables_helper_full: Function result is '16138682464'
Jun 30 23:10:38 DEBUG[14372]: pbx.c:1527 pbx_substitute_variables_helper_full: Function result is 'NN_accounts'
Jun 30 23:10:38 DEBUG[14372]: pbx.c:1527 pbx_substitute_variables_helper_full: Function result is 'IAX2/simon-2'
Jun 30 23:10:38 DEBUG[14372]: pbx.c:1527 pbx_substitute_variables_helper_full: Function result is '(null)'
Jun 30 23:10:38 DEBUG[14372]: pbx.c:1527 pbx_substitute_variables_helper_full: Function result is 'Dial'
Jun 30 23:10:38 DEBUG[14372]: pbx.c:1527 pbx_substitute_variables_helper_full: Function result is 'IAX2/Globotech/16138682446|15|t'
Jun 30 23:10:38 DEBUG[14372]: pbx.c:1527 pbx_substitute_variables_helper_full: Function result is '2006-06-30 23:10:28'
Jun 30 23:10:38 DEBUG[14372]: pbx.c:1527 pbx_substitute_variables_helper_full: Function result is '(null)'
Jun 30 23:10:38 DEBUG[14372]: pbx.c:1527 pbx_substitute_variables_helper_full: Function result is '2006-06-30 23:10:38'
Jun 30 23:10:38 DEBUG[14372]: pbx.c:1527 pbx_substitute_variables_helper_full: Function result is '10'
Jun 30 23:10:38 DEBUG[14372]: pbx.c:1527 pbx_substitute_variables_helper_full: Function result is '0'
Jun 30 23:10:38 DEBUG[14372]: pbx.c:1527 pbx_substitute_variables_helper_full: Function result is 'BUSY'
Jun 30 23:10:38 DEBUG[14372]: pbx.c:1527 pbx_substitute_variables_helper_full: Function result is 'DOCUMENTATION'
Jun 30 23:10:38 DEBUG[14372]: pbx.c:1527 pbx_substitute_variables_helper_full: Function result is '(null)'
Jun 30 23:10:38 DEBUG[14372]: pbx.c:1527 pbx_substitute_variables_helper_full: Function result is '1151709028.0'
Jun 30 23:10:38 DEBUG[14372]: pbx.c:1527 pbx_substitute_variables_helper_full: Function result is '(null)'
Jun 30 23:10:38 DEBUG[14372]: chan_iax2.c:2983 iax2_hangup: We're hanging up IAX2/simon-2 now...
    -- Hungup 'IAX2/simon-2'