[Freeswitch-users] Dialing Out Problem via Gateway

Alberto Ceccarelli cyberalby at gmail.com
Sat Jan 17 08:02:24 PST 2009


Hi,
I've the same problem.
I've create the log with only the problem (the log is in attach).
One gateway (messagenet.it) and two internal account (1002 and 1008).
My dialplan:
<include>
  <extension name="messagenet.it">
    <condition field="destination_number" expression="^(5300000)$">
      <action application="set" data="domain_name=$${domain}"/>
      <action application="transfer" data="1008 XML default"/>
    </condition>
  </extension>
</include>

My Sip Profile:
<include>
  <gateway name="messagenet.it">
    <param name="username" value="5300000"/>
    <param name="realm" value="sip.messagenet.it"/>
    <param name="from-domain" value="sip.messagenet.it"/>
    <param name="password" value="password"/>
    <param name="register" value="true"/>
    <param name="retry-seconds" value="30"/>
  </gateway>
</include>

My freeswith is runnig on Windows Server 2003 with 2 NIC (1 interna
192.168.0.15 and 1 external 10.0.3.6 (212.001.001.001))

For privacy I've change my IP and my phone number.

-- 
Alby
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20090117/1e623650/attachment-0002.html 
-------------- next part --------------
2009-01-17 16:09:35 [INFO] switch_core_sqldb.c:487 switch_core_sqldb_start() Opening DB
2009-01-17 16:09:35 [DEBUG] switch_scheduler.c:214 switch_scheduler_add_task() Added task 1 heartbeat (core) to run at 1232204975
2009-01-17 16:09:35 [NOTICE] switch_scheduler.c:166 switch_scheduler_task_thread() Starting task thread
2009-01-17 16:09:35 [CONSOLE] switch_core.c:1270 switch_core_init_and_modload() Bringing up environment.
2009-01-17 16:09:35 [CONSOLE] switch_core.c:1271 switch_core_init_and_modload() Loading Modules.
2009-01-17 16:09:35 [INFO] switch_time.c:656 switch_load_timezones() Timezone loaded 530 definitions
2009-01-17 16:09:35 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [CORE_SOFTTIMER_MODULE]
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:221 switch_loadable_module_process() Adding Timer 'soft'
2009-01-17 16:09:35 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [CORE_PCM_MODULE]
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'PROXY-VID' (PROXY VIDEO PASS-THROUGH) 90000hz 0ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'PROXY' (PROXY PASS-THROUGH) 8000hz 20ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 11025hz 40ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 22050hz 20ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 48000hz 20ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 32000hz 8ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 32000hz 6ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 32000hz 4ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 32000hz 2ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 16000hz 8ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 16000hz 6ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 16000hz 4ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 16000hz 2ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 8000hz 8ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 8000hz 6ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 8000hz 4ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 8000hz 2ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 48000hz 10ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 48000hz 8ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 48000hz 6ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 48000hz 4ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 48000hz 2ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 32000hz 10ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 32000hz 20ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 32000hz 30ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 32000hz 40ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 32000hz 50ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 32000hz 60ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 16000hz 10ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 16000hz 20ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 16000hz 30ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 16000hz 40ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 16000hz 50ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 16000hz 60ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 8000hz 10ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 8000hz 20ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 8000hz 30ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 8000hz 40ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 8000hz 50ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 8000hz 60ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 8000hz 70ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 8000hz 80ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 8000hz 90ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 8000hz 100ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 8000hz 110ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'L16' (RAW Signed Linear (16 bit)) 8000hz 120ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'PCMU' (G.711 ulaw) 8000hz 10ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'PCMU' (G.711 ulaw) 8000hz 20ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'PCMU' (G.711 ulaw) 8000hz 30ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'PCMU' (G.711 ulaw) 8000hz 40ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'PCMU' (G.711 ulaw) 8000hz 50ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'PCMU' (G.711 ulaw) 8000hz 60ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'PCMU' (G.711 ulaw) 8000hz 70ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'PCMU' (G.711 ulaw) 8000hz 80ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'PCMU' (G.711 ulaw) 8000hz 90ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'PCMU' (G.711 ulaw) 8000hz 100ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'PCMU' (G.711 ulaw) 8000hz 110ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'PCMU' (G.711 ulaw) 8000hz 120ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'PCMA' (G.711 alaw) 8000hz 10ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'PCMA' (G.711 alaw) 8000hz 20ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'PCMA' (G.711 alaw) 8000hz 30ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'PCMA' (G.711 alaw) 8000hz 40ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'PCMA' (G.711 alaw) 8000hz 50ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'PCMA' (G.711 alaw) 8000hz 60ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'PCMA' (G.711 alaw) 8000hz 70ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'PCMA' (G.711 alaw) 8000hz 80ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'PCMA' (G.711 alaw) 8000hz 90ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'PCMA' (G.711 alaw) 8000hz 100ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'PCMA' (G.711 alaw) 8000hz 110ms
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'PCMA' (G.711 alaw) 8000hz 120ms
2009-01-17 16:09:35 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [mod_console]
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'console'
2009-01-17 16:09:35 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [mod_logfile]
2009-01-17 16:09:35 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [mod_enum]
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:203 switch_loadable_module_process() Adding Dialplan 'enum'
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'enum'
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'enum'
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'enum_auto'
2009-01-17 16:09:35 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [mod_cdr_csv]
2009-01-17 16:09:35 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [mod_event_socket]
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'socket'
2009-01-17 16:09:35 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'event_sink'
2009-01-17 16:09:35 [NOTICE] sofia_reg.c:1872 sofia_reg_add_gateway() Added gateway 'messagenet.it' to profile 'external'
2009-01-17 16:09:35 [NOTICE] sofia.c:2234 config_sofia() Adding Alias [outbound] for profile [external]
2009-01-17 16:09:35 [NOTICE] sofia.c:2234 config_sofia() Adding Alias [nat] for profile [external]
2009-01-17 16:09:35 [NOTICE] sofia.c:2244 config_sofia() Started Profile external [sofia_reg_external]
2009-01-17 16:09:35 [NOTICE] sofia.c:1181 parse_domain_tag() Adding Alias [192.168.0.74] for profile [internal]
2009-01-17 16:09:35 [NOTICE] sofia.c:2234 config_sofia() Adding Alias [default] for profile [internal]
2009-01-17 16:09:35 [NOTICE] sofia.c:2244 config_sofia() Started Profile internal [sofia_reg_internal]
su_socket_port_init(00DE3B58, 02491E00) called
su_pthread_port_init(00DE3B58, 02491E00) called
su_socket_port_init(0137A468, 02491E00) called
su_pthread_port_init(0137A468, 02491E00) called
soa_create("default", 0137A8D8, 00DD7F90) called
soa_set_params(static::01ADEDC8, ...) called
soa_set_params(static::01ADEDC8, ...) called
nta_agent_create: initialized hash tables
nta_agent_create: initialized transports
nta_agent_create: initialized random identifiers
nta_agent_create: initialized timer
su_socket_port_init(01ADEFF8, 02491E00) called
su_pthread_port_init(01ADEFF8, 02491E00) called
nta_agent_create: initialized resolver
tport_create(): 00DEC198
nta: master transport created
tport(00DEC198) to */10.0.3.6:5080/sip
tport(00DEC198): calling tport_listen for udp
tport(00DEC198): new primary tport 00DD8D20
su_socket_port_init(01AE9DD8, 02491E00) called
su_pthread_port_init(01AE9DD8, 02491E00) called
soa_create("default", 01AE28C0, 01AE5580) called
soa_set_params(static::01AE57C0, ...) called
soa_set_params(static::01AE57C0, ...) called
nta_agent_create: initialized hash tables
nta_agent_create: initialized transports
nta_agent_create: initialized random identifiers
nta_agent_create: initialized timer
nta_agent_create: initialized resolver
tport_create(): 01AE9368
nta: master transport created
tport(01AE9368) to */192.168.0.74:5060/sip
tport(01AE9368): calling tport_listen for udp
tport(01AE9368): new primary tport 01AE9650
tport(00DD8D20): listening at udp/10.0.3.6:5080/sip
tport(00DEC198): calling tport_listen for tcp
tport(00DEC198): new primary tport 01AE1540
tport(01AE9650): listening at udp/192.168.0.74:5060/sip
tport(01AE9368): calling tport_listen for tcp
tport(01AE9368): new primary tport 01AE17F8
tport(01AE17F8): listening at tcp/192.168.0.74:5060/sip
nta: bound to (192.168.0.74:5060;transport=*)
nta: agent_init_via: SIP/2.0/udp 192.168.0.74 (sip)
nta: agent_init_via: SIP/2.0/tcp 192.168.0.74 (sip)
nta: Via fields initialized
nta: Contact header created
nua_register: Adding contact URL '192.168.0.74' to list.
tport_wakeup_pri(01AE9650): events IN
tport_recv_event(01AE9650)
tport(01AE9650) msg 01AE5FB8 from (udp/192.168.0.74:5060) has 4 bytes, veclen = 1
tport(01AE9650): bad msg 01AE5FB8 (0 bytes) from udp/192.168.0.74:5060/sip next=00000000
tport(01AE1540): listening at tcp/10.0.3.6:5080/sip
nta: bound to (212.001.001.001:5080;transport=*;maddr=10.0.3.6)
nta: agent_init_via: SIP/2.0/udp 212.001.001.001:5080 (sip)
nta: agent_init_via: SIP/2.0/tcp 212.001.001.001:5080 (sip)
nta: Via fields initialized
nta: Contact header created
nua_register: Adding contact URL '212.001.001.001' to list.
nua(00000000): sent signal r_set_params
nua(00000000): recv signal r_set_params
soa_set_params(static::01AE57C0, ...) called
nua(00000000): event r_set_params 200 OK
tport_wakeup_pri(00DD8D20): events IN
tport_recv_event(00DD8D20)
tport(00DD8D20) msg 01AF0170 from (udp/10.0.3.6:5080) has 4 bytes, veclen = 1
tport(00DD8D20): bad msg 01AF0170 (0 bytes) from udp/10.0.3.6:5080/sip next=00000000
nua(00000000): sent signal r_set_params
nua(00000000): recv signal r_set_params
soa_set_params(static::01ADEDC8, ...) called
nua(00000000): event r_set_params 200 OK
2009-01-17 16:09:36 [NOTICE] sofia_reg.c:265 sofia_reg_check_gateway() Registering messagenet.it
nua(01AE32E0): sent signal r_register
nua(01AE32E0): recv signal r_register
soa_clone(static::01ADEDC8, 0137A8D8, 01AE32E0) called
soa_set_params(static::01AEC380, ...) called
soa_set_params(static::01AEC380, ...) called
nta_leg_tcreate(01AED9C0)
nua(01AE32E0): adding register usage
nta: selecting scheme sip
nta: for "sip.messagenet.it" query "_sip._udp.sip.messagenet.it" SRV
nta: for "sip.messagenet.it" query "sip.messagenet.it" A
nta: sip.messagenet.it. IN A 212.97.59.76
tport_tsend(00DD8D20) tpn = udp/212.97.59.76:5060
tport_resolve addrinfo = 212.97.59.76:5060
tport(00DD8D20): not found by name udp/212.97.59.76:5060
tport_vsend(00DD8D20): 639 bytes of 639 to udp/212.97.59.76:5060
tport_vsend returned 639
send 639 bytes to udp/[212.97.59.76]:5060 at 15:09:36.803764:
   ------------------------------------------------------------------------
   REGISTER sip:sip.messagenet.it;transport=udp SIP/2.0
   Via: SIP/2.0/UDP 212.001.001.001:5080;rport;branch=z9hG4bKmD9FZQBy2FKXp
   Max-Forwards: 70
   From: <sip:5343504 at sip.messagenet.it;transport=udp>;tag=mypD78F0vQSjc
   To: <sip:5343504 at sip.messagenet.it;transport=udp>
   Call-ID: c66dcbcd-e144-354e-b169-0723760063cf
   CSeq: 109984152 REGISTER
   Contact: <sip:5343504 at 212.001.001.001:5080;transport=udp>
   Expires: 3600
   User-Agent: FreeSWITCH-mod_sofia/1.0.trunk-UNKNOWN
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE, NOTIFY, REFER, UPDATE, REGISTER, INFO
   Supported: timer, precondition, path, replaces
   Content-Length: 0
   
   ------------------------------------------------------------------------
nta: sent REGISTER (109984152) to udp/212.97.59.76:5060
tport_pend(00DD8D20): pending 01AF0170 for udp/10.0.3.6:5080 (already 0)
nta: timer set to 32000 ms
nta: timer shortened to 500 ms
tport_wakeup_pri(00DD8D20): events IN
tport_recv_event(00DD8D20)
tport(00DD8D20) msg 01B5D978 from (udp/10.0.3.6:5080) has 1278 bytes, veclen = 1
recv 564 bytes from udp/[212.97.59.76]:5060 at 15:09:36.803764:
   ------------------------------------------------------------------------
   SIP/2.0 100 Trying
   Via: SIP/2.0/UDP 212.001.001.001:5080;rport=5080;branch=z9hG4bKmD9FZQBy2FKXp
   From: <sip:5343504 at sip.messagenet.it;transport=udp>;tag=mypD78F0vQSjc
   To: <sip:5343504 at sip.messagenet.it;transport=udp>
   Call-ID: c66dcbcd-e144-354e-b169-0723760063cf
   CSeq: 109984152 REGISTER
   Server: OpenSer (1.1.0-notls (i386/linux))
   Content-Length: 0
   Warning: 392 212.97.59.76:5060 "Noisy feedback tells:  pid=15517 req_src_ip=212.001.001.001 req_src_port=5080 in_uri=sip:sip.messagenet.it;transport=udp out_uri=sip:sip.messagenet.it;transport=udp via_cnt==1"
   
   ------------------------------------------------------------------------
tport(00DD8D20): msg 01B5D978 (564 bytes) from udp/212.97.59.76:5080/sip next=00000000
nta: received 100 Trying for REGISTER (109984152)
nta: 100 Trying is going to a transaction
nta_outgoing: RTT is 0 ms
tport(00DD8D20): 01AF0170 by 01AED108 with 01B5D978 (preliminary)
tport_wakeup_pri(00DD8D20): events IN
tport_recv_event(00DD8D20)
tport(00DD8D20) msg 01B5D978 from (udp/10.0.3.6:5080) has 714 bytes, veclen = 1
recv 714 bytes from udp/[212.97.59.76]:5060 at 15:09:36.803764:
   ------------------------------------------------------------------------
   SIP/2.0 401 Unauthorized
   Via: SIP/2.0/UDP 212.001.001.001:5080;rport=5080;branch=z9hG4bKmD9FZQBy2FKXp
   From: <sip:5343504 at sip.messagenet.it;transport=udp>;tag=mypD78F0vQSjc
   To: <sip:5343504 at sip.messagenet.it;transport=udp>;tag=797b035a1d6b0049ed33903c5ef0eddf.062a
   Call-ID: c66dcbcd-e144-354e-b169-0723760063cf
   CSeq: 109984152 REGISTER
   WWW-Authenticate: Digest realm="sip.messagenet.it", nonce="4971f5dfd4d7b34dd71873b0bc184126b45c1700"
   Server: OpenSer (1.1.0-notls (i386/linux))
   Content-Length: 0
   Warning: 392 212.97.59.76:5060 "Noisy feedback tells:  pid=15517 req_src_ip=212.001.001.001 req_src_port=5080 in_uri=sip:sip.messagenet.it;transport=udp out_uri=sip:sip.messagenet.it;transport=udp via_cnt==1"
   
   ------------------------------------------------------------------------
tport(00DD8D20): msg 01B5D978 (714 bytes) from udp/212.97.59.76:5080/sip next=00000000
nta: received 401 Unauthorized for REGISTER (109984152)
nta: 401 Unauthorized is going to a transaction
tport(00DD8D20): 01AF0170 by 01AED108 with 01B5D978
auth_digest_challenge_get(): got 2
nua(01AE32E0): event r_register 401 Unauthorized
nua(01AE32E0): recv signal r_authenticate
auth_digest_a1() has A1 = MD5(5343504:sip.messagenet.it:zanebap) = 7d86e12ae1b9db5b55b0653441352198
A2 = MD5(REGISTER:sip:sip.messagenet.it;transport=udp)
auth_response: 937ac9aceb3126881d30de0ff6c9bcea = MD5(7d86e12ae1b9db5b55b0653441352198:4971f5dfd4d7b34dd71873b0bc184126b45c1700:c7eb2509efe71a9f29aa95f4d4019686) (qop=NONE)
nta: selecting scheme sip
nta: for "sip.messagenet.it" query "_sip._udp.sip.messagenet.it" SRV (cached)
nta: for "sip.messagenet.it" query "sip.messagenet.it" A (cached)
nta: sip.messagenet.it. IN A 212.97.59.76
tport_tsend(00DD8D20) tpn = udp/212.97.59.76:5060
tport_resolve addrinfo = 212.97.59.76:5060
tport(00DD8D20): not found by name udp/212.97.59.76:5060
tport_vsend(00DD8D20): 861 bytes of 861 to udp/212.97.59.76:5060
tport_vsend returned 861
send 861 bytes to udp/[212.97.59.76]:5060 at 15:09:36.803764:
   ------------------------------------------------------------------------
   REGISTER sip:sip.messagenet.it;transport=udp SIP/2.0
nua(01AE32E0): sent signal r_authenticate
   Via: SIP/2.0/UDP 212.001.001.001:5080;rport;branch=z9hG4bKNp280jv1Zr9Fj
   Max-Forwards: 70
   From: <sip:5343504 at sip.messagenet.it;transport=udp>;tag=mypD78F0vQSjc
   To: <sip:5343504 at sip.messagenet.it;transport=udp>
   Call-ID: c66dcbcd-e144-354e-b169-0723760063cf
   CSeq: 109984153 REGISTER
   Contact: <sip:5343504 at 212.001.001.001:5080;transport=udp>
   Expires: 3600
   User-Agent: FreeSWITCH-mod_sofia/1.0.trunk-UNKNOWN
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE, NOTIFY, REFER, UPDATE, REGISTER, INFO
   Supported: timer, precondition, path, replaces
   Authorization: Digest username="5343504", realm="sip.messagenet.it", nonce="4971f5dfd4d7b34dd71873b0bc184126b45c1700", algorithm=MD5, uri="sip:sip.messagenet.it;transport=udp", response="937ac9aceb3126881d30de0ff6c9bcea"
   Content-Length: 0
   
   ------------------------------------------------------------------------
nta: sent REGISTER (109984153) to udp/212.97.59.76:5060
tport_pend(00DD8D20): pending 01B58858 for udp/10.0.3.6:5080 (already 0)
tport_wakeup_pri(00DD8D20): events IN
tport_recv_event(00DD8D20)
tport(00DD8D20) msg 01B59988 from (udp/10.0.3.6:5080) has 564 bytes, veclen = 1
recv 564 bytes from udp/[212.97.59.76]:5060 at 15:09:36.819385:
   ------------------------------------------------------------------------
   SIP/2.0 100 Trying
   Via: SIP/2.0/UDP 212.001.001.001:5080;rport=5080;branch=z9hG4bKNp280jv1Zr9Fj
   From: <sip:5343504 at sip.messagenet.it;transport=udp>;tag=mypD78F0vQSjc
   To: <sip:5343504 at sip.messagenet.it;transport=udp>
   Call-ID: c66dcbcd-e144-354e-b169-0723760063cf
   CSeq: 109984153 REGISTER
   Server: OpenSer (1.1.0-notls (i386/linux))
   Content-Length: 0
   Warning: 392 212.97.59.76:5060 "Noisy feedback tells:  pid=15519 req_src_ip=212.001.001.001 req_src_port=5080 in_uri=sip:sip.messagenet.it;transport=udp out_uri=sip:sip.messagenet.it;transport=udp via_cnt==1"
   
   ------------------------------------------------------------------------
tport(00DD8D20): msg 01B59988 (564 bytes) from udp/212.97.59.76:5080/sip next=00000000
nta: received 100 Trying for REGISTER (109984153)
nta: 100 Trying is going to a transaction
nta_outgoing: RTT is 15.621 ms
tport(00DD8D20): 01B58858 by 01B5C388 with 01B59988 (preliminary)
tport_wakeup_pri(00DD8D20): events IN
tport_recv_event(00DD8D20)
tport(00DD8D20) msg 01B59988 from (udp/10.0.3.6:5080) has 715 bytes, veclen = 1
recv 715 bytes from udp/[212.97.59.76]:5060 at 15:09:36.819385:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP 212.001.001.001:5080;rport=5080;branch=z9hG4bKNp280jv1Zr9Fj
   From: <sip:5343504 at sip.messagenet.it;transport=udp>;tag=mypD78F0vQSjc
   To: <sip:5343504 at sip.messagenet.it;transport=udp>;tag=797b035a1d6b0049ed33903c5ef0eddf.bdba
   Call-ID: c66dcbcd-e144-354e-b169-0723760063cf
   CSeq: 109984153 REGISTER
   Date: Sat, 17 Jan 2009 15:09:39 GMT
   Contact: <sip:5343504 at 212.001.001.001:5080;transport=udp>;q=0.5;expires=3600
   Server: OpenSer (1.1.0-notls (i386/linux))
   Content-Length: 0
   Warning: 392 212.97.59.76:5060 "Noisy feedback tells:  pid=15519 req_src_ip=212.001.001.001 req_src_port=5080 in_uri=sip:sip.messagenet.it;transport=udp out_uri=sip:sip.messagenet.it;transport=udp via_cnt==1"
   
   ------------------------------------------------------------------------
tport(00DD8D20): msg 01B59988 (715 bytes) from udp/212.97.59.76:5080/sip next=00000000
nta: received 200 OK for REGISTER (109984153)
nta: 200 OK is going to a transaction
tport(00DD8D20): 01B58858 by 01B5C388 with 01B59988
nua(): refresh register after 2568 seconds (in [900..2700])
nua(): refresh register after 2568 seconds
nua(01AE32E0): event r_register 200 OK
2009-01-17 16:09:37 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [mod_sofia]
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:141 switch_loadable_module_process() Adding Endpoint 'sofia'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'sofia'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'sofia_contact'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:354 switch_loadable_module_process() Adding Chat interface 'sip'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:394 switch_loadable_module_process() Adding Management interface 'mod_sofia' OID[.1.3.6.1.4.1.27880.1]
2009-01-17 16:09:37 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [mod_loopback]
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:141 switch_loadable_module_process() Adding Endpoint 'loopback'
2009-01-17 16:09:37 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [mod_commands]
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'group_call'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'in_group'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'uuid_flush_dtmf'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'md5'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'hupall'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'strftime_tz'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'originate'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'tone_detect'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'uuid_kill'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'uuid_park'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'reloadacl'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'reloadxml'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'unload'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'reload'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'load'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'uuid_transfer'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'pause'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'break'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'show'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'complete'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'alias'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'status'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'uuid_session_heartbeat'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'uuid_bridge'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'uuid_setvar'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'uuid_setvar_multi'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'uuid_getvar'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'uuid_dump'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'global_setvar'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'global_getvar'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'uuid_displace'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'uuid_record'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'uuid_broadcast'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'uuid_hold'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'uuid_display'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'uuid_media'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'fsctl'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'help'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'version'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'sched_hangup'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'sched_broadcast'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'sched_transfer'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'create_uuid'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'sched_api'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'unsched_api'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'bgapi'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'sched_del'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'xml_wrap'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'is_lan_addr'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'cond'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'regex'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'acl'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'uuid_chat'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'uuid_deflect'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'find_user_xml'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'user_exists'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'xml_locate'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'user_data'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'url_encode'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'url_decode'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'module_exists'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'domain_exists'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'uuid_send_dtmf'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'eval'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'system'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'time_test'
2009-01-17 16:09:37 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [mod_conference]
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'conference'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'conference_set_auto_outcall'
2009-01-17 16:09:37 [CONSOLE] sofia_presence.c:621 sofia_presence_event_thread_run() Event Thread Started
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'conference'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:354 switch_loadable_module_process() Adding Chat interface 'conf'
2009-01-17 16:09:37 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [mod_dptools]
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:141 switch_loadable_module_process() Adding Endpoint 'error'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:141 switch_loadable_module_process() Adding Endpoint 'group'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:141 switch_loadable_module_process() Adding Endpoint 'user'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:203 switch_loadable_module_process() Adding Dialplan 'inline'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'privacy'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'flush_dtmf'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'hold'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'unhold'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'transfer'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'check_acl'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'verbose_events'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'sleep'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'delay_echo'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'strftime'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'phrase'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'eval'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'pre_answer'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'answer'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'hangup'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'set_name'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'presence'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'log'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'info'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'event'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'export'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'set'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'set_global'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'set_profile_var'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'unset'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'ring_ready'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'remove_bugs'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'break'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'detect_speech'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'ivr'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'redirect'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'send_display'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'respond'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'deflect'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'queue_dtmf'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'send_dtmf'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'sched_hangup'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'sched_broadcast'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'sched_transfer'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'execute_extension'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'mkdir'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'soft_hold'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'bind_meta_app'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'unbind_meta_app'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'intercept'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'eavesdrop'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'three_way'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'set_user'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'stop_dtmf'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'start_dtmf'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'stop_dtmf_generate'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'start_dtmf_generate'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'stop_tone_detect'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'fax_detect'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'tone_detect'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'echo'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'park'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'park_state'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'gentones'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'playback'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'att_xfer'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'read'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'stop_record_session'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'record_session'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'record'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'stop_displace_session'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'displace_session'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'speak'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'clear_speech_cache'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'bridge'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'system'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'say'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'wait_for_silence'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'strepoch'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'chat'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'strftime'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'presence'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:354 switch_loadable_module_process() Adding Chat interface 'event'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:354 switch_loadable_module_process() Adding Chat interface 'api'
2009-01-17 16:09:37 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [mod_expr]
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'expr'
2009-01-17 16:09:37 [INFO] mod_fifo.c:1811 load_config() cool_fifo at 192.168.0.74 configured
2009-01-17 16:09:37 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [mod_fifo]
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'fifo'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'fifo'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'fifo_member'
2009-01-17 16:09:37 [INFO] mod_voicemail.c:765 load_config() Added Profile default
2009-01-17 16:09:37 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [mod_voicemail]
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'voicemail'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'voicemail'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'voicemail_inject'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'vm_boxcount'
2009-01-17 16:09:37 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [mod_limit]
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'limit'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'limit_hash'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'db'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'hash'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'group'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'limit_hash_usage'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'limit_usage'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'db'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'hash'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'group'
2009-01-17 16:09:37 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [mod_esf]
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'esf_page_group'
2009-01-17 16:09:37 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [mod_fsv]
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'play_fsv'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'record_fsv'
2009-01-17 16:09:37 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [mod_dialplan_xml]
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:203 switch_loadable_module_process() Adding Dialplan 'XML'
nta: timer set next to 4485 ms
2009-01-17 16:09:37 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [mod_dialplan_asterisk]
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:141 switch_loadable_module_process() Adding Endpoint 'SIP'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:141 switch_loadable_module_process() Adding Endpoint 'IAX2'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:203 switch_loadable_module_process() Adding Dialplan 'asterisk'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'Dial'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'Goto'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'AvoidingDeadlock'
2009-01-17 16:09:37 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [mod_voipcodecs]
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'DVI4' (ADPCM (IMA)) 16000hz 10ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'DVI4' (ADPCM (IMA)) 16000hz 20ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'DVI4' (ADPCM (IMA)) 16000hz 30ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'DVI4' (ADPCM (IMA)) 16000hz 40ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'DVI4' (ADPCM (IMA)) 16000hz 50ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'DVI4' (ADPCM (IMA)) 16000hz 60ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'DVI4' (ADPCM (IMA)) 8000hz 10ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'DVI4' (ADPCM (IMA)) 8000hz 20ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'DVI4' (ADPCM (IMA)) 8000hz 30ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'DVI4' (ADPCM (IMA)) 8000hz 40ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'DVI4' (ADPCM (IMA)) 8000hz 50ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'DVI4' (ADPCM (IMA)) 8000hz 60ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'DVI4' (ADPCM (IMA)) 8000hz 70ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'DVI4' (ADPCM (IMA)) 8000hz 80ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'DVI4' (ADPCM (IMA)) 8000hz 90ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'DVI4' (ADPCM (IMA)) 8000hz 100ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'DVI4' (ADPCM (IMA)) 8000hz 110ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'DVI4' (ADPCM (IMA)) 8000hz 120ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-16' (G.726 16k (AAL2)) 8000hz 10ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-16' (G.726 16k (AAL2)) 8000hz 20ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-16' (G.726 16k (AAL2)) 8000hz 30ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-16' (G.726 16k (AAL2)) 8000hz 40ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-16' (G.726 16k (AAL2)) 8000hz 50ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-16' (G.726 16k (AAL2)) 8000hz 60ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-16' (G.726 16k (AAL2)) 8000hz 70ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-16' (G.726 16k (AAL2)) 8000hz 80ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-16' (G.726 16k (AAL2)) 8000hz 90ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-16' (G.726 16k (AAL2)) 8000hz 100ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-16' (G.726 16k (AAL2)) 8000hz 110ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-16' (G.726 16k (AAL2)) 8000hz 120ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-16' (G.726 16k) 8000hz 10ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-16' (G.726 16k) 8000hz 20ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-16' (G.726 16k) 8000hz 30ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-16' (G.726 16k) 8000hz 40ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-16' (G.726 16k) 8000hz 50ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-16' (G.726 16k) 8000hz 60ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-16' (G.726 16k) 8000hz 70ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-16' (G.726 16k) 8000hz 80ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-16' (G.726 16k) 8000hz 90ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-16' (G.726 16k) 8000hz 100ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-16' (G.726 16k) 8000hz 110ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-16' (G.726 16k) 8000hz 120ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-24' (G.726 24k (AAL2)) 8000hz 10ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-24' (G.726 24k (AAL2)) 8000hz 20ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-24' (G.726 24k (AAL2)) 8000hz 30ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-24' (G.726 24k (AAL2)) 8000hz 40ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-24' (G.726 24k (AAL2)) 8000hz 50ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-24' (G.726 24k (AAL2)) 8000hz 60ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-24' (G.726 24k (AAL2)) 8000hz 70ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-24' (G.726 24k (AAL2)) 8000hz 80ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-24' (G.726 24k (AAL2)) 8000hz 90ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-24' (G.726 24k (AAL2)) 8000hz 100ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-24' (G.726 24k (AAL2)) 8000hz 110ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-24' (G.726 24k (AAL2)) 8000hz 120ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-32' (G.726 32k (AAL2)) 8000hz 10ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-32' (G.726 32k (AAL2)) 8000hz 20ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-32' (G.726 32k (AAL2)) 8000hz 30ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-32' (G.726 32k (AAL2)) 8000hz 40ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-32' (G.726 32k (AAL2)) 8000hz 50ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-32' (G.726 32k (AAL2)) 8000hz 60ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-32' (G.726 32k (AAL2)) 8000hz 70ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-32' (G.726 32k (AAL2)) 8000hz 80ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-32' (G.726 32k (AAL2)) 8000hz 90ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-32' (G.726 32k (AAL2)) 8000hz 100ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-32' (G.726 32k (AAL2)) 8000hz 110ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-32' (G.726 32k (AAL2)) 8000hz 120ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-32' (G.726 32k) 8000hz 10ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-32' (G.726 32k) 8000hz 20ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-32' (G.726 32k) 8000hz 30ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-32' (G.726 32k) 8000hz 40ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-32' (G.726 32k) 8000hz 50ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-32' (G.726 32k) 8000hz 60ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-32' (G.726 32k) 8000hz 70ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-32' (G.726 32k) 8000hz 80ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-32' (G.726 32k) 8000hz 90ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-32' (G.726 32k) 8000hz 100ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-32' (G.726 32k) 8000hz 110ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-32' (G.726 32k) 8000hz 120ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-40' (G.726 40k (AAL2)) 8000hz 10ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-40' (G.726 40k (AAL2)) 8000hz 20ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-40' (G.726 40k (AAL2)) 8000hz 30ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-40' (G.726 40k (AAL2)) 8000hz 40ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-40' (G.726 40k (AAL2)) 8000hz 50ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-40' (G.726 40k (AAL2)) 8000hz 60ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-40' (G.726 40k (AAL2)) 8000hz 70ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-40' (G.726 40k (AAL2)) 8000hz 80ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-40' (G.726 40k (AAL2)) 8000hz 90ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-40' (G.726 40k (AAL2)) 8000hz 100ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-40' (G.726 40k (AAL2)) 8000hz 110ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AAL2-G726-40' (G.726 40k (AAL2)) 8000hz 120ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-40' (G.726 40k) 8000hz 10ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-40' (G.726 40k) 8000hz 20ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-40' (G.726 40k) 8000hz 30ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-40' (G.726 40k) 8000hz 40ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-40' (G.726 40k) 8000hz 50ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-40' (G.726 40k) 8000hz 60ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-40' (G.726 40k) 8000hz 70ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-40' (G.726 40k) 8000hz 80ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-40' (G.726 40k) 8000hz 90ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-40' (G.726 40k) 8000hz 100ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-40' (G.726 40k) 8000hz 110ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G726-40' (G.726 40k) 8000hz 120ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G722' (G.722) 16000hz 10ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G722' (G.722) 16000hz 20ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G722' (G.722) 16000hz 30ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G722' (G.722) 16000hz 40ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G722' (G.722) 16000hz 50ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G722' (G.722) 16000hz 60ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'GSM' (GSM) 8000hz 20ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'GSM' (GSM) 8000hz 40ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'GSM' (GSM) 8000hz 60ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'GSM' (GSM) 8000hz 80ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'GSM' (GSM) 8000hz 100ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'GSM' (GSM) 8000hz 120ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'LPC' (LPC-10) 8000hz 90ms
2009-01-17 16:09:37 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [mod_g723_1]
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G723' (G.723.1 6.3k) 8000hz 30ms
2009-01-17 16:09:37 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [mod_g729]
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G729' (G.729) 8000hz 10ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G729' (G.729) 8000hz 20ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G729' (G.729) 8000hz 30ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G729' (G.729) 8000hz 40ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G729' (G.729) 8000hz 50ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G729' (G.729) 8000hz 60ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G729' (G.729) 8000hz 70ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G729' (G.729) 8000hz 80ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G729' (G.729) 8000hz 90ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G729' (G.729) 8000hz 100ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G729' (G.729) 8000hz 110ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'G729' (G.729) 8000hz 120ms
2009-01-17 16:09:37 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [mod_amr]
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'AMR' (AMR) 8000hz 20ms
2009-01-17 16:09:37 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [mod_ilbc]
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'iLBC' (iLBC) 8000hz 30ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'iLBC' (iLBC) 8000hz 30ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'iLBC20ms' (iLBC) 8000hz 20ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'iLBC102' (iLBC) 8000hz 20ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'iLBC' (iLBC) 8000hz 20ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'iLBC' (iLBC) 8000hz 20ms
2009-01-17 16:09:37 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [mod_speex]
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'SPEEX' (Speex) 32000hz 20ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'SPEEX' (Speex) 16000hz 20ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'SPEEX' (Speex) 8000hz 20ms
2009-01-17 16:09:37 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [mod_h26x]
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'H264' (H.264 Video (passthru)) 90000hz 0ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'H263' (H.263 Video (passthru)) 90000hz 0ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'H263-1998' (H.263+ Video (passthru)) 90000hz 0ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'H263-2000' (H.263++ Video (passthru)) 90000hz 0ms
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:179 switch_loadable_module_process() Adding Codec 'H261' (H.261 Video (passthru)) 90000hz 0ms
2009-01-17 16:09:37 [INFO] mod_sndfile.c:308 setup_formats() 
LibSndFile Version : libsndfile-1.0.12 Supported Formats
================================================================================
AIFF (Apple/SGI)  (extension "aiff")
AU (Sun/NeXT)  (extension "au")
AVR (Audio Visual Research)  (extension "avr")
CAF (Apple Core Audio File)  (extension "caf")
HTK (HMM Tool Kit)  (extension "htk")
IFF (Amiga IFF/SVX8/SV16)  (extension "iff")
MAT4 (GNU Octave 2.0 / Matlab 4.2)  (extension "mat")
MAT5 (GNU Octave 2.1 / Matlab 5.0)  (extension "mat")
PAF (Ensoniq PARIS)  (extension "paf")
PVF (Portable Voice Format)  (extension "pvf")
RAW (header-less)  (extension "raw")
SD2 (Sound Designer II)  (extension "sd2")
SDS (Midi Sample Dump Standard)  (extension "sds")
SF (Berkeley/IRCAM/CARL)  (extension "sf")
VOC (Creative Labs)  (extension "voc")
W64 (SoundFoundry WAVE 64)  (extension "w64")
WAV (Microsoft)  (extension "wav")
WAV (NIST Sphere)  (extension "wav")
WAVEX (Microsoft)  (extension "wav")
XI (FastTracker 2)  (extension "xi")
================================================================================
2009-01-17 16:09:37 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [mod_sndfile]
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'aiff'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'au'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'avr'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'caf'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'htk'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'iff'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'mat'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'mat'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'paf'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'pvf'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'raw'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'sd2'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'sds'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'sf'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'voc'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'w64'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'wav'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'wav'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'wav'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'xi'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'r8'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'r16'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'r24'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'r32'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'gsm'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'ul'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'al'
2009-01-17 16:09:37 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [mod_native_file]
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'H263'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'iLBC20ms'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'AMR'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'H263-1998'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'SPEEX'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'G729'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'G723'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'G726-16'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'H261'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'AAL2-G726-16'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'DVI4'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'PCMA'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'PCMU'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'L16'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'iLBC20ms'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'PROXY'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'PROXY-VID'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'AAL2-G726-24'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'AAL2-G726-32'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'H263-2000'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'H264'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'G726-32'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'iLBC20ms'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'G722'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'AAL2-G726-40'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'G726-40'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'GSM'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'LPC'
2009-01-17 16:09:37 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [mod_local_stream]
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'stop_local_stream'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'start_local_stream'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'local_stream'
2009-01-17 16:09:37 [CONSOLE] mod_local_stream.c:142 read_stream_thread() Can't open directory: C:\Program Files\FreeSwitch/sounds/music/16000
2009-01-17 16:09:37 [CONSOLE] mod_local_stream.c:142 read_stream_thread() Can't open directory: C:\Program Files\FreeSwitch/sounds/music/32000
2009-01-17 16:09:37 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [mod_tone_stream]
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'tone_stream'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:281 switch_loadable_module_process() Adding File Format 'silence_stream'
2009-01-17 16:09:37 [CONSOLE] mod_spidermonkey.c:948 sm_load_file() Successfully Loaded [C:\Program Files\FreeSwitch\mod\mod_spidermonkey_teletone.dll]
2009-01-17 16:09:37 [CONSOLE] mod_spidermonkey.c:948 sm_load_file() Successfully Loaded [C:\Program Files\FreeSwitch\mod\mod_spidermonkey_core_db.dll]
2009-01-17 16:09:37 [CONSOLE] mod_spidermonkey.c:948 sm_load_file() Successfully Loaded [C:\Program Files\FreeSwitch\mod\mod_spidermonkey_socket.dll]
2009-01-17 16:09:37 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [mod_spidermonkey]
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'javascript'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'jsrun'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'jsapi'
2009-01-17 16:09:37 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [mod_lua]
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:239 switch_loadable_module_process() Adding Application 'lua'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'luarun'
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:259 switch_loadable_module_process() Adding API Function 'lua'
2009-01-17 16:09:37 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [mod_say_en]
2009-01-17 16:09:37 [NOTICE] switch_loadable_module.c:372 switch_loadable_module_process() Adding Say interface 'en'
2009-01-17 16:09:37 [CONSOLE] switch_loadable_module.c:119 switch_loadable_module_runtime() Starting runtime thread for CORE_SOFTTIMER_MODULE
2009-01-17 16:09:37 [CONSOLE] switch_loadable_module.c:119 switch_loadable_module_runtime() Starting runtime thread for mod_event_socket
2009-01-17 16:09:37 [CONSOLE] switch_core.c:865 switch_load_network_lists() Created ip list dl-candidates default (allow)
2009-01-17 16:09:37 [NOTICE] switch_core.c:948 switch_load_network_lists() Adding 10.0.0.0/8 (deny) to list dl-candidates
2009-01-17 16:09:37 [NOTICE] switch_core.c:948 switch_load_network_lists() Adding 172.16.0.0/12 (deny) to list dl-candidates
2009-01-17 16:09:37 [NOTICE] switch_core.c:948 switch_load_network_lists() Adding 192.168.0.0/16 (deny) to list dl-candidates
2009-01-17 16:09:37 [CONSOLE] switch_core.c:865 switch_load_network_lists() Created ip list rfc1918 default (deny)
2009-01-17 16:09:37 [NOTICE] switch_core.c:948 switch_load_network_lists() Adding 10.0.0.0/8 (allow) to list rfc1918
2009-01-17 16:09:37 [NOTICE] switch_core.c:948 switch_load_network_lists() Adding 172.16.0.0/12 (allow) to list rfc1918
2009-01-17 16:09:37 [NOTICE] switch_core.c:948 switch_load_network_lists() Adding 192.168.0.0/16 (allow) to list rfc1918
2009-01-17 16:09:37 [CONSOLE] switch_core.c:865 switch_load_network_lists() Created ip list lan default (allow)
2009-01-17 16:09:37 [NOTICE] switch_core.c:948 switch_load_network_lists() Adding 192.168.42.0/24 (deny) to list lan
2009-01-17 16:09:37 [NOTICE] switch_core.c:948 switch_load_network_lists() Adding 192.168.42.42/32 (allow) to list lan
2009-01-17 16:09:37 [CONSOLE] switch_core.c:865 switch_load_network_lists() Created ip list strict default (deny)
2009-01-17 16:09:37 [NOTICE] switch_core.c:948 switch_load_network_lists() Adding 208.102.123.124/32 (allow) to list strict
2009-01-17 16:09:37 [CONSOLE] switch_core.c:865 switch_load_network_lists() Created ip list domains default (deny)
2009-01-17 16:09:37 [CONSOLE] switch_core.c:1287 switch_core_init_and_modload() 
FreeSWITCH Version 1.0.trunk (UNKNOWN) Started.
Crash Protection [Disabled]
Max Sessions[1000]
Session Rate[30]
SQL [Enabled]

freeswitch at inetmail2> nta: timer K fired, terminate REGISTER (109984152)
outgoing_reclaim_all(00000000, 00000000, 027FFEC0)
nta_outgoing_timer: 0/0 resent, 0/0 tout, 1/2 term, 1/2 free
nta: timer set next to 1 ms
nta: timer K fired, terminate REGISTER (109984153)
outgoing_reclaim_all(00000000, 00000000, 027FFEC0)
nta_outgoing_timer: 0/0 resent, 0/0 tout, 1/1 term, 1/1 free
nta: timer not set
tport_wakeup_pri(01AE9650): events IN
tport_recv_event(01AE9650)
tport(01AE9650) msg 01B59988 from (udp/192.168.0.74:5060) has 543 bytes, veclen = 1
recv 543 bytes from udp/[192.168.0.52]:63214 at 15:09:57.844578:
   ------------------------------------------------------------------------
   REGISTER sip:192.168.0.74 SIP/2.0
   Via: SIP/2.0/UDP 192.168.0.52:63214;branch=z9hG4bK-d8754z-10626c213e281d27-1---d8754z-;rport
   Max-Forwards: 70
   Contact: <sip:1008 at 192.168.0.52:63214;rinstance=a8691dfbc11775d5>
   To: "Alberto"<sip:1008 at 192.168.0.74>
   From: "Alberto"<sip:1008 at 192.168.0.74>;tag=544adf7f
   Call-ID: ZjNlNGY5ZGE5OGI5MjFkNTc3Y2RjMzhhMDc4MmM1NDc.
   CSeq: 1 REGISTER
   Expires: 3600
   Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO
   User-Agent: X-Lite release 1100l stamp 47546
   Content-Length: 0
   
   ------------------------------------------------------------------------
tport(01AE9650): msg 01B59988 (543 bytes) from udp/192.168.0.52:5060/sip next=00000000
nta: received REGISTER sip:192.168.0.74 SIP/2.0 (CSeq 1)
nta: canonizing sip:192.168.0.74 with contact
nta: REGISTER (1) going to a default leg
soa_clone(static::01AE57C0, 01AE28C0, 01B6FBD8) called
soa_set_params(static::01B5EF70, ...) called
nua(01B6FBD8): event i_register 100 Trying
nua(01B6FBD8): sent signal r_respond
nua(01B6FBD8): recv signal r_respond 401 Unauthorized
soa_set_params(static::01B5EF70, ...) called
nua(01B6FBD8): sent signal r_destroy
tport_tsend(01AE9650) tpn = UDP/192.168.0.52:63214
tport_resolve addrinfo = 192.168.0.52:63214
tport(01AE9650): not found by name UDP/192.168.0.52:63214
tport_vsend(01AE9650): 667 bytes of 667 to udp/192.168.0.52:63214
tport_vsend returned 667
send 667 bytes to udp/[192.168.0.52]:63214 at 15:09:57.844578:
   ------------------------------------------------------------------------
   SIP/2.0 401 Unauthorized
   Via: SIP/2.0/UDP 192.168.0.52:63214;branch=z9hG4bK-d8754z-10626c213e281d27-1---d8754z-;rport=63214
   From: "Alberto"<sip:1008 at 192.168.0.74>;tag=544adf7f
   To: "Alberto" <sip:1008 at 192.168.0.74>;tag=mypD78F0vQSjc
   Call-ID: ZjNlNGY5ZGE5OGI5MjFkNTc3Y2RjMzhhMDc4MmM1NDc.
   CSeq: 1 REGISTER
   User-Agent: FreeSWITCH-mod_sofia/1.0.trunk-UNKNOWN
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE, NOTIFY, REFER, UPDATE, REGISTER, INFO, PUBLISH
   Supported: timer, precondition, path, replaces
   WWW-Authenticate: Digest realm="192.168.0.74", nonce="8d55768a-5992-1c4d-912e-92961f1f4e5e", algorithm=MD5, qop="auth"
   Content-Length: 0
   
   ------------------------------------------------------------------------
nta: sent 401 Unauthorized for REGISTER (1)
nta: timer set to 32000 ms
nua(01B6FBD8): recv signal r_destroy
nta_leg_destroy(00000000)
soa_destroy(static::01B5EF70) called
tport_wakeup_pri(01AE9650): events IN
tport_recv_event(01AE9650)
tport(01AE9650) msg 01B5D978 from (udp/192.168.0.74:5060) has 792 bytes, veclen = 1
recv 792 bytes from udp/[192.168.0.52]:63214 at 15:09:58.047644:
   ------------------------------------------------------------------------
   REGISTER sip:192.168.0.74 SIP/2.0
   Via: SIP/2.0/UDP 192.168.0.52:63214;branch=z9hG4bK-d8754z-53075b0a800fd422-1---d8754z-;rport
   Max-Forwards: 70
   Contact: <sip:1008 at 192.168.0.52:63214;rinstance=a8691dfbc11775d5>
   To: "Alberto"<sip:1008 at 192.168.0.74>
   From: "Alberto"<sip:1008 at 192.168.0.74>;tag=544adf7f
   Call-ID: ZjNlNGY5ZGE5OGI5MjFkNTc3Y2RjMzhhMDc4MmM1NDc.
   CSeq: 2 REGISTER
   Expires: 3600
   Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO
   User-Agent: X-Lite release 1100l stamp 47546
   Authorization: Digest username="1008",realm="192.168.0.74",nonce="8d55768a-5992-1c4d-912e-92961f1f4e5e",uri="sip:192.168.0.74",response="55d0982a97d14c1b35e41e9617710f4f",cnonce="d4204f159a249cc80d1ea728bac88ad2",nc=00000001,qop=auth,algorithm=MD5
   Content-Length: 0
   
   ------------------------------------------------------------------------
tport(01AE9650): msg 01B5D978 (792 bytes) from udp/192.168.0.52:5060/sip next=00000000
nta: received REGISTER sip:192.168.0.74 SIP/2.0 (CSeq 2)
nta: canonizing sip:192.168.0.74 with contact
nta: REGISTER (2) going to a default leg
soa_clone(static::01AE57C0, 01AE28C0, 01B6FBD8) called
soa_set_params(static::01B75A20, ...) called
nua(01B6FBD8): event i_register 100 Trying
nua(01B6FBD8): sent signal r_respond
nua(01B6FBD8): recv signal r_respond 200 OK
soa_set_params(static::01B75A20, ...) called
tport_tsend(01AE9650) tpn = UDP/192.168.0.52:63214
tport_resolve addrinfo = 192.168.0.52:63214
tport(01AE9650): not found by name UDP/192.168.0.52:63214
tport_vsend(01AE9650): 654 bytes of 654 to udp/192.168.0.52:63214
tport_vsend returned 654
nua(01B6FBD8): sent signal r_destroy
send 654 bytes to udp/[192.168.0.52]:63214 at 15:09:58.047644:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP 192.168.0.52:63214;branch=z9hG4bK-d8754z-53075b0a800fd422-1---d8754z-;rport=63214
   From: "Alberto"<sip:1008 at 192.168.0.74>;tag=544adf7f
   To: "Alberto" <sip:1008 at 192.168.0.74>;tag=N7F68303S0F5Q
   Call-ID: ZjNlNGY5ZGE5OGI5MjFkNTc3Y2RjMzhhMDc4MmM1NDc.
   CSeq: 2 REGISTER
   Contact: <sip:1008 at 192.168.0.52:63214;rinstance=a8691dfbc11775d5>;expires=3600
   Date: Sat, 17 Jan 2009 15:09:58 GMT
   User-Agent: FreeSWITCH-mod_sofia/1.0.trunk-UNKNOWN
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE, NOTIFY, REFER, UPDATE, REGISTER, INFO, PUBLISH
   Supported: timer, precondition, path, replaces
   Content-Length: 0
   
   ------------------------------------------------------------------------
nta: sent 200 OK for REGISTER (2)
nua(01B6FBD8): recv signal r_destroy
nta_leg_destroy(00000000)
soa_destroy(static::01B75A20) called
nua(01B6FBD8): sent signal r_notify
nua(01B6FBD8): recv signal r_notify
soa_clone(static::01AE57C0, 01AE28C0, 01B6FBD8) called
soa_set_params(static::01B75A20, ...) called
soa_set_params(static::01B75A20, ...) called
nta_leg_tcreate(00DD7010)
nua(01B6FBD8): adding notify usage with event message-summary
nta: selecting scheme sip
tport_tsend(01AE9650) tpn = */192.168.0.52:63214
tport_resolve addrinfo = 192.168.0.52:63214
tport(01AE9650): not found by name */192.168.0.52:63214
tport_vsend(01AE9650): 887 bytes of 887 to udp/192.168.0.52:63214
tport_vsend returned 887
send 887 bytes to udp/[192.168.0.52]:63214 at 15:09:58.141367:
   ------------------------------------------------------------------------
   NOTIFY sip:1008 at 192.168.0.52:63214;rinstance=a8691dfbc11775d5 SIP/2.0
   Via: SIP/2.0/UDP 192.168.0.74;rport;branch=z9hG4bKmD9FZQBy2FKXp
   Max-Forwards: 70
   From: <sip:1008 at 192.168.0.74>;tag=pg9yaZH7p95QK
   To: <sip:1008 at 192.168.0.74>
   Call-ID: beeb792e-5f4b-122c-2780-39a48cb53b8d
   CSeq: 109984163 NOTIFY
   Contact: <sip:mod_sofia at 192.168.0.74:5060>
   User-Agent: FreeSWITCH-mod_sofia/1.0.trunk-UNKNOWN
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE, NOTIFY, REFER, UPDATE, REGISTER, INFO, PUBLISH
   Supported: timer, precondition, path, replaces
   Event: message-summary
   Allow-Events: talk, presence, dialog, call-info, sla, include-session-description, presence.winfo, message-summary, refer
   Subscription-State: terminated;timeout
   Content-Type: application/simple-message-summary
   Content-Length: 64
   
   Messages-Waiting: no
   Message-Account: sip:1008 at 192.168.0.74
   
   ------------------------------------------------------------------------
nta: sent NOTIFY (109984163) to */192.168.0.52:63214
tport_pend(01AE9650): pending 01B72C38 for udp/192.168.0.74:5060 (already 0)
nta: timer shortened to 500 ms
tport_wakeup_pri(01AE9650): events IN
tport_recv_event(01AE9650)
tport(01AE9650) msg 02F2FC50 from (udp/192.168.0.74:5060) has 546 bytes, veclen = 1
recv 546 bytes from udp/[192.168.0.52]:63214 at 15:09:58.141367:
   ------------------------------------------------------------------------
   SUBSCRIBE sip:1008 at 192.168.0.74 SIP/2.0
   Via: SIP/2.0/UDP 192.168.0.52:63214;branch=z9hG4bK-d8754z-f3490746570af404-1---d8754z-;rport
   Max-Forwards: 70
   Contact: <sip:1008 at 192.168.0.52:63214>
   To: "Alberto"<sip:1008 at 192.168.0.74>
   From: "Alberto"<sip:1008 at 192.168.0.74>;tag=d11f6f44
   Call-ID: ZDY2ZWMwN2M0MTkwZDA1NDJkOGNhZmNmYTg5NDgyNGY.
   CSeq: 1 SUBSCRIBE
   Expires: 300
   Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO
   User-Agent: X-Lite release 1100l stamp 47546
   Event: message-summary
   Content-Length: 0
   
   ------------------------------------------------------------------------
tport(01AE9650): msg 02F2FC50 (546 bytes) from udp/192.168.0.52:5060/sip next=00000000
nta: received SUBSCRIBE sip:1008 at 192.168.0.74 SIP/2.0 (CSeq 1)
nta: canonizing sip:1008 at 192.168.0.74 with contact
nta: SUBSCRIBE (1) going to a default leg
soa_clone(static::01AE57C0, 01AE28C0, 01B72720) called
soa_set_params(static::01B5EF70, ...) called
nta_leg_tcreate(01B6F530)
nua(01B72720): adding notify usage with event message-summary
nua(01B72720): event i_subscribe 100 Trying
nua(): refresh notify after 600 seconds (in [600..600])
nua(): refresh notify after 600 seconds
nua(01B72720): recv signal r_respond 202 Accepted
soa_set_params(static::01B5EF70, ...) called
tport_tsend(01AE9650) tpn = UDP/192.168.0.52:63214
tport_resolve addrinfo = 192.168.0.52:63214
tport(01AE9650): not found by name UDP/192.168.0.52:63214
tport_vsend(01AE9650): 771 bytes of 771 to udp/192.168.0.52:63214
tport_vsend returned 771
send 771 bytes to udp/[192.168.0.52]:63214 at 15:09:58.141367:
   ------------------------------------------------------------------------
   SIP/2.0 202 Accepted
   Via: SIP/2.0/UDP 192.168.0.52:63214;branch=z9hG4bK-d8754z-f3490746570af404-1---d8754z-;rport=63214
   From: "Alberto"<sip:1008 at 192.168.0.74>;tag=d11f6f44
   To: "Alberto" <sip:1008 at 192.168.0.74>;tag=QS2Qct2amjvaF
   Call-ID: ZDY2ZWMwN2M0MTkwZDA1NDJkOGNhZmNmYTg5NDgyNGY.nua(01B72720): sent signal r_respond

   CSeq: 1 SUBSCRIBE
   Contact: "Alberto" <sip:1008 at 192.168.0.52:63214>
   Expires: 300
   User-Agent: FreeSWITCH-mod_sofia/1.0.trunk-UNKNOWN
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE, NOTIFY, REFER, UPDATE, REGISTER, INFO, PUBLISH
   Supported: timer, precondition, path, replaces
   Allow-Events: talk, presence, dialog, call-info, sla, include-session-description, presence.winfo, message-summary, refer
   Subscription-State: active;expires=300
   Content-Length: 0
   
   ------------------------------------------------------------------------
nta: sent 202 Accepted for SUBSCRIBE (1)
tport_wakeup_pri(01AE9650): events IN
tport_recv_event(01AE9650)
tport(01AE9650) msg 01D71768 from (udp/192.168.0.74:5060) has 350 bytes, veclen = 1
recv 350 bytes from udp/[192.168.0.52]:63214 at 15:09:58.141367:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP 192.168.0.74;rport=5060;branch=z9hG4bKmD9FZQBy2FKXp
   Contact: <sip:192.168.0.52:63214>
   To: <sip:1008 at 192.168.0.74>;tag=321bea76
   From: <sip:1008 at 192.168.0.74>;tag=pg9yaZH7p95QK
   Call-ID: beeb792e-5f4b-122c-2780-39a48cb53b8d
   CSeq: 109984163 NOTIFY
   User-Agent: X-Lite release 1100l stamp 47546
   Content-Length: 0
   
   ------------------------------------------------------------------------
tport(01AE9650): msg 01D71768 (350 bytes) from udp/192.168.0.52:5060/sip next=00000000
nta: received 200 OK for NOTIFY (109984163)
nta: 200 OK is going to a transaction
nta_outgoing: RTT is 15.621 ms
tport(01AE9650): 01B72C38 by 01AED108 with 01D71768
nua(01B6FBD8): event r_notify 200 OK
nua(01B6FBD8): removing notify usage with event message-summary
nta_leg_destroy(00DD7010)
nua(01B6FBD8): sent signal r_destroy
nua(01B6FBD8): recv signal r_destroy
nta_leg_destroy(00000000)
soa_destroy(static::01B75A20) called
nta: timer set next to 4484 ms
tport_wakeup_pri(01AE9650): events IN
tport_recv_event(01AE9650)
tport(01AE9650) msg 02F4BC48 from (udp/192.168.0.74:5060) has 4 bytes, veclen = 1
tport(01AE9650): bad msg 02F4BC48 (4 bytes) from udp/192.168.0.38:5060/sip next=00000000
nta: timer K fired, terminate NOTIFY (109984163)
outgoing_reclaim_all(00000000, 00000000, 028FFEC0)
nta_outgoing_timer: 0/0 resent, 0/0 tout, 1/1 term, 1/1 free
nta: timer set next to 26689 ms
tport_wakeup_pri(00DD8D20): events IN
tport_recv_event(00DD8D20)
tport(00DD8D20) msg 01D71768 from (udp/10.0.3.6:5080) has 1168 bytes, veclen = 1
recv 1168 bytes from udp/[212.97.59.76]:5060 at 15:10:08.076005:
   ------------------------------------------------------------------------
   INVITE sip:5343504 at 212.001.001.001:5080;transport=udp SIP/2.0
   Record-Route: <sip:212.97.59.76;r2=on;lr=on;ftag=as302aa103>
   Record-Route: <sip:212.97.59.76:5061;r2=on;lr=on;ftag=as302aa103>
   Via: SIP/2.0/UDP 212.97.59.76;branch=z9hG4bKe61f.f220cd02.0
   Via: SIP/2.0/UDP 212.97.59.87:5060;branch=z9hG4bK57267a99;rport=5060
   From: "+39020000000" <sip:+39020000000 at sip.messagenet.it>;tag=as302aa103
   To: <sip:0200000002 at 212.97.59.76:5061>
   Contact: <sip:+39020000000 at 212.97.59.87>
   Call-ID: 0991575e53c716557b287c0f4e34a842 at sip.messagenet.it
   CSeq: 102 INVITE
   User-Agent: alpha
   Max-Forwards: 69
   Date: Sat, 17 Jan 2009 15:10:11 GMT
   Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
   Supported: replaces
   Content-Type: application/sdp
   Content-Length: 395
   
   v=0
   o=root 3859 3859 IN IP4 212.97.59.87
   s=session
   c=IN IP4 212.97.59.91
   t=0 0
   m=audio 38196 RTP/AVP 18 3 97 8 0 101
   a=rtpmap:18 G729/8000
   a=fmtp:18 annexb=no
   a=rtpmap:3 GSM/8000
   a=rtpmap:97 iLBC/8000
   a=fmtp:97 mode=30
   a=rtpmap:8 PCMA/8000
   a=rtpmap:0 PCMU/8000
   a=rtpmap:101 telephone-event/8000
   a=fmtp:101 0-16
   a=silenceSupp:off - - - -
   a=ptime:20
   a=sendrecv
   a=nortpproxy:yes
   ------------------------------------------------------------------------
tport(00DD8D20): msg 01D71768 (1168 bytes) from udp/212.97.59.76:5080/sip next=00000000
nta: received INVITE sip:5343504 at 212.001.001.001:5080;transport=udp SIP/2.0 (CSeq 102)
nta: canonizing sip:5343504 at 212.001.001.001:5080 with contact
nta: INVITE (102) going to a default leg
nta: timer set to 200 ms
soa_clone(static::01ADEDC8, 0137A8D8, 02EDF6E0) called
soa_set_params(static::01B75A20, ...) called
nta_leg_tcreate(02F004E0)
soa_init_offer_answer(static::01B75A20) called
soa_set_remote_sdp(static::01B75A20, 00000000, 02F47CAD, 395) called
nua(02EDF6E0): adding session usage
tport_tsend(00DD8D20) tpn = UDP/212.97.59.76:5060
tport_resolve addrinfo = 212.97.59.76:5060
tport(00DD8D20): not found by name UDP/212.97.59.76:5060
tport_vsend(00DD8D20): 546 bytes of 546 to udp/212.97.59.76:5060
tport_vsend returned 546
send 546 bytes to udp/[212.97.59.76]:5060 at 15:10:08.076005:
   ------------------------------------------------------------------------
   SIP/2.0 100 Trying
   Via: SIP/2.0/UDP 212.97.59.76;branch=z9hG4bKe61f.f220cd02.0
   Via: SIP/2.0/UDP 212.97.59.87:5060;branch=z9hG4bK57267a99;rport=5060
   Record-Route: <sip:212.97.59.76;r2=on;lr=on;ftag=as302aa103>
   Record-Route: <sip:212.97.59.76:5061;r2=on;lr=on;ftag=as302aa103>
   From: "+39020000000" <sip:+39020000000 at sip.messagenet.it>;tag=as302aa103
   To: <sip:0200000002 at 212.97.59.76:5061>
   Call-ID: 0991575e53c716557b287c0f4e34a842 at sip.messagenet.it
   CSeq: 102 INVITE
   User-Agent: FreeSWITCH-mod_sofia/1.0.trunk-UNKNOWN
   Content-Length: 0
   
   ------------------------------------------------------------------------
nta: sent 100 Trying for INVITE (102)
nua(02EDF6E0): event i_invite 100 Trying
nua(02EDF6E0): call state changed: init -> received, received offer
soa_get_remote_sdp(static::01B75A20, [027FFC14], [027FFC10], [00000000]) called
nua(02EDF6E0): event i_state 100 Trying
2009-01-17 16:10:08 [NOTICE] switch_channel.c:565 switch_channel_set_name() New Channel sofia/external/+39020000000 at sip.messagenet.it [711a2124-077d-f442-ae20-e63b2273f326]
2009-01-17 16:10:08 [INFO] mod_dialplan_xml.c:233 dialplan_hunt() Processing +39020000000->5343504 in context public
2009-01-17 16:10:08 [NOTICE] switch_ivr.c:1255 switch_ivr_session_transfer() Transfer sofia/external/+39020000000 at sip.messagenet.it to XML[1008 at default]
2009-01-17 16:10:08 [INFO] mod_dialplan_xml.c:233 dialplan_hunt() Processing +39020000000->1008 in context default
2009-01-17 16:10:08 [ERR] switch_regex.c:94 switch_regex_perform() COMPILE ERROR: 1 [nothing to repeat][^+39020000000$]
2009-01-17 16:10:08 [INFO] switch_ivr_async.c:1644 switch_ivr_bind_dtmf_meta_session() Bound B-Leg: 1 execute_extension::dx XML features
2009-01-17 16:10:08 [INFO] switch_ivr_async.c:1644 switch_ivr_bind_dtmf_meta_session() Bound B-Leg: 2 record_session::C:Program FilesFreeSwitch/recordings/+39020000000.2009-01-17-16-10-08.wav
2009-01-17 16:10:08 [INFO] switch_ivr_async.c:1644 switch_ivr_bind_dtmf_meta_session() Bound B-Leg: 3 execute_extension::cf XML features
2009-01-17 16:10:08 [NOTICE] switch_channel.c:565 switch_channel_set_name() New Channel sofia/internal/sip:1008 at 192.168.0.52:63214;rinstance=a8691dfbc11775d5 [698623ef-686c-9c4d-93c7-3cc6db803902]
nua(02EDF468): sent signal r_invite
nua(02EDF468): recv signal r_invite
soa_clone(static::01AE57C0, 01AE28C0, 02EDF468) called
soa_set_params(static::01D7FE78, ...) called
soa_set_params(static::01D7FE78, ...) called
soa_set_user_sdp(static::01D7FE78, 00000000, 012733C2, -1) called
soa_set_capability_sdp(static::01D7FE78, 00000000, 012733C2, -1) called
nta_leg_tcreate(02F47280)
nua(02EDF468): adding session usage
soa_init_offer_answer(static::01D7FE78) called
soa_generate_offer(static::01D7FE78, 0) called
soa_static_offer_answer_action(01D7FE78, soa_generate_offer): called
soa_static(01D7FE78, soa_generate_offer): generating local description
soa_static(01D7FE78, soa_generate_offer): upgrade with local description
soa_sdp_mode_set(028FDCAC, 00000000, ""): called
soa_static(01D7FE78, soa_generate_offer): storing local description
soa_get_local_sdp(static::01D7FE78, [00000000], [028FFDC4], [028FFDC0]) called
nta: selecting scheme sip
tport_tsend(01AE9650) tpn = */192.168.0.52:63214
tport_resolve addrinfo = 192.168.0.52:63214
tport(01AE9650): not found by name */192.168.0.52:63214
tport_vsend(01AE9650): 1261 bytes of 1261 to udp/192.168.0.52:63214
tport_vsend returned 1261
send 1261 bytes to udp/[192.168.0.52]:63214 at 15:10:08.216590:
   ------------------------------------------------------------------------
   INVITE sip:1008 at 192.168.0.52:63214;rinstance=a8691dfbc11775d5 SIP/2.0
   Via: SIP/2.0/UDP 192.168.0.74;rport;branch=z9hG4bKNp280jv1Zr9Fj
   Max-Forwards: 67
   From: "+39020000000" <sip:+39020000000 at 192.168.0.74>;tag=r2UgeNKeHUjXa
   To: <sip:1008 at 192.168.0.52:63214;rinstance=a8691dfbc11775d5>
   Call-ID: c4ecd490-5f4b-122c-2780-39a48cb53b8d
   CSeq: 109984168 INVITE
   Contact: <sip:mod_sofia at 192.168.0.74:5060>
   User-Agent: FreeSWITCH-mod_sofia/1.0.trunk-UNKNOWN
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE, NOTIFY, REFER, UPDATE, REGISTER, INFO, PUBLISH
   Supported: timer, precondition, path, replaces
   Allow-Events: talk, presence, dialog, call-info, sla, include-session-description, presence.winfo, message-summary, refer
   Min-SE: 120
   Content-Type: application/sdp
   Content-Disposition: session
   Content-Length: 333
   Remote-Party-ID: "+39020000000" <sip:+39020000000 at 192.168.0.74>;screen=yes;privacy=off
   
   v=0
   o=FreeSWITCH 6699757194367626025 7696645903169343292 IN IP4 192.168.0.74
   s=FreeSWITCH
   c=IN IP4 192.168.0.74
   t=0 0
   m=audio 29688 RTP/AVP 3 9 0 8 101 13
   a=rtpmap:3 GSM/8000
   a=rtpmap:9 G722/8000
   a=rtpmap:0 PCMU/8000
   a=rtpmap:8 PCMA/8000
   a=rtpmap:101 telephone-event/8000
   a=fmtp:101 0-16
   a=rtpmap:13 CN/8000
   a=ptime:20
   ------------------------------------------------------------------------
nta: sent INVITE (109984168) to */192.168.0.52:63214
tport_pend(01AE9650): pending 02FC1940 for udp/192.168.0.74:5060 (already 0)
nta: timer shortened to 500 ms
nua(02EDF468): call state changed: init -> calling, sent offer
soa_get_local_sdp(static::01D7FE78, [028FFDC4], [028FFDC0], [00000000]) called
nua(02EDF468): event i_state INVITE sent
nta: timer not set
2009-01-17 16:10:08 [INFO] mod_sofia.c:1294 sofia_receive_message() Asked to send early media by sofia/external/+39020000000 at sip.messagenet.it
2009-01-17 16:10:08 [INFO] mod_sofia.c:1335 sofia_receive_message() Ring SDP:
v=0
o=FreeSWITCH 1232175320 1232175321 IN IP4 212.001.001.001
s=FreeSWITCH
c=IN IP4 212.001.001.001
t=0 0
m=audio 29688 RTP/AVP 3 101
a=rtpmap:3 GSM/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv

2009-01-17 16:10:08 [NOTICE] mod_sofia.c:1338 sofia_receive_message() Ring-Ready sofia/external/+39020000000 at sip.messagenet.it!
2009-01-17 16:10:08 [NOTICE] mod_sofia.c:1338 sofia_receive_message() Pre-Answer sofia/external/+39020000000 at sip.messagenet.it!
nua(02EDF6E0): sent signal r_respond
nua(02EDF6E0): recv signal r_respond 183 Session Progress
soa_set_params(static::01B75A20, ...) called
soa_set_user_sdp(static::01B75A20, 00000000, 00DECA53, -1) called
soa_set_capability_sdp(static::01B75A20, 00000000, 00DECA53, -1) called
soa_generate_answer(static::01B75A20) called
soa_static_offer_answer_action(01B75A20, soa_generate_answer): called
soa_static(01B75A20, soa_generate_answer): generating local description
soa_static(01B75A20, soa_generate_answer): upgrade with remote description
soa_sdp_mode_set(027FDCF8, 01274870, ""): called
soa_static(01B75A20, soa_generate_answer): storing local description
soa_activate(static::01B75A20, (nil)) called
soa_get_local_sdp(static::01B75A20, [00000000], [027FFE0C], [027FFE08]) called
tport_tsend(00DD8D20) tpn = UDP/212.97.59.76:5060
tport_resolve addrinfo = 212.97.59.76:5060
tport(00DD8D20): not found by name UDP/212.97.59.76:5060
tport_vsend(00DD8D20): 1170 bytes of 1170 to udp/212.97.59.76:5060
tport_vsend returned 1170
send 1170 bytes to udp/[212.97.59.76]:5060 at 15:10:08.310313:
   ------------------------------------------------------------------------
   SIP/2.0 183 Session Progress
   Via: SIP/2.0/UDP 212.97.59.76;branch=z9hG4bKe61f.f220cd02.0
   Via: SIP/2.0/UDP 212.97.59.87:5060;branch=z9hG4bK57267a99;rport=5060
   Record-Route: <sip:212.97.59.76;r2=on;lr=on;ftag=as302aa103>
   Record-Route: <sip:212.97.59.76:5061;r2=on;lr=on;ftag=as302aa103>
   From: "+39020000000" <sip:+39020000000 at sip.messagenet.it>;tag=as302aa103
   To: <sip:0200000002 at 212.97.59.76:5061>;tag=N7F68303S0F5Q
   Call-ID: 0991575e53c716557b287c0f4e34a842 at sip.messagenet.it
   CSeq: 102 INVITE
   Contact: <sip:mod_sofia at 212.001.001.001:5080;transport=udp>
   User-Agent: FreeSWITCH-mod_sofia/1.0.trunk-UNKNOWN
   Accept: application/sdp
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE, NOTIFY, REFER, UPDATE, REGISTER, INFO
   Supported: timer, precondition, path, replaces
   Allow-Events: talk, refer
   Content-Type: application/sdp
   Content-Disposition: session
   Content-Length: 266
   
   v=0
   o=FreeSWITCH 1110445663877587962 6324161778166975444 IN IP4 212.001.001.001
   s=FreeSWITCH
   c=IN IP4 212.001.001.001
   t=0 0
   m=audio 29688 RTP/AVP 3 101
   a=rtpmap:3 GSM/8000
   a=rtpmap:101 telephone-event/8000
   a=fmtp:101 0-16
   a=silenceSupp:off - - - -
   a=ptime:20
   ------------------------------------------------------------------------
nta: sent 183 Session Progress for INVITE (102)
nta: timer set to 60000 ms
nua(02EDF6E0): call state changed: received -> early, sent answer
soa_get_local_sdp(static::01B75A20, [027FFE48], [027FFE44], [00000000]) called
soa_get_params(static::01B75A20, ...) called
nua(02EDF6E0): event i_state 183 Session Progress
tport_wakeup_pri(01AE9650): events IN
tport_recv_event(01AE9650)
tport(01AE9650) msg 02F4BC48 from (udp/192.168.0.74:5060) has 316 bytes, veclen = 1
recv 316 bytes from udp/[192.168.0.52]:63214 at 15:10:08.325933:
   ------------------------------------------------------------------------
   SIP/2.0 100 Trying
   Via: SIP/2.0/UDP 192.168.0.74;rport=5060;branch=z9hG4bKNp280jv1Zr9Fj
   To: <sip:1008 at 192.168.0.52:63214;rinstance=a8691dfbc11775d5>
   From: "+39020000000" <sip:+39020000000 at 192.168.0.74>;tag=r2UgeNKeHUjXa
   Call-ID: c4ecd490-5f4b-122c-2780-39a48cb53b8d
   CSeq: 109984168 INVITE
   Content-Length: 0
   
   ------------------------------------------------------------------------
tport(01AE9650): msg 02F4BC48 (316 bytes) from udp/192.168.0.52:5060/sip next=00000000
nta: received 100 Trying for INVITE (109984168)
nta: 100 Trying is going to a transaction
nta_outgoing: RTT is 109.343 ms
tport(01AE9650): 02FC1940 by 02F30CF8 with 02F4BC48 (preliminary)
tport_wakeup_pri(01AE9650): events IN
tport_recv_event(01AE9650)
tport(01AE9650) msg 02F4BC48 from (udp/192.168.0.74:5060) has 442 bytes, veclen = 1
recv 442 bytes from udp/[192.168.0.52]:63214 at 15:10:08.638343:
   ------------------------------------------------------------------------
   SIP/2.0 180 Ringing
   Via: SIP/2.0/UDP 192.168.0.74;rport=5060;branch=z9hG4bKNp280jv1Zr9Fj
   Contact: <sip:1008 at 192.168.0.52:63214;rinstance=a8691dfbc11775d5>
   To: <sip:1008 at 192.168.0.52:63214;rinstance=a8691dfbc11775d5>;tag=8b08c857
   From: "+39020000000"<sip:+39020000000 at 192.168.0.74>;tag=r2UgeNKeHUjXa
   Call-ID: c4ecd490-5f4b-122c-2780-39a48cb53b8d
   CSeq: 109984168 INVITE
   User-Agent: X-Lite release 1100l stamp 47546
   Content-Length: 0
   
   ------------------------------------------------------------------------
tport(01AE9650): msg 02F4BC48 (442 bytes) from udp/192.168.0.52:5060/sip next=00000000
nta: received 180 Ringing for INVITE (109984168)
nta: 180 Ringing is going to a transaction
tport(01AE9650): 02FC1940 by 02F30CF8 with 02F4BC48 (preliminary)
nua(02EDF468): event r_invite 180 Ringing
nua(02EDF468): call state changed: calling -> proceeding
nua(02EDF468): event i_state 180 Ringing
2009-01-17 16:10:08 [NOTICE] sofia.c:2627 sofia_handle_sip_i_state() Ring-Ready sofia/internal/sip:1008 at 192.168.0.52:63214;rinstance=a8691dfbc11775d5!
nta: timer set next to 21113 ms
tport_wakeup_pri(01AE9650): events IN
tport_recv_event(01AE9650)
tport(01AE9650) msg 02F51A68 from (udp/192.168.0.74:5060) has 740 bytes, veclen = 1
recv 740 bytes from udp/[192.168.0.52]:63214 at 15:10:12.059233:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP 192.168.0.74;rport=5060;branch=z9hG4bKNp280jv1Zr9Fj
   Contact: <sip:1008 at 192.168.0.52:63214;rinstance=a8691dfbc11775d5>
   To: <sip:1008 at 192.168.0.52:63214;rinstance=a8691dfbc11775d5>;tag=8b08c857
   From: "+39020000000"<sip:+39020000000 at 192.168.0.74>;tag=r2UgeNKeHUjXa
   Call-ID: c4ecd490-5f4b-122c-2780-39a48cb53b8d
   CSeq: 109984168 INVITE
   Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO
   Content-Type: application/sdp
   User-Agent: X-Lite release 1100l stamp 47546
   Content-Length: 187
   
   v=0
   o=- 6 2 IN IP4 192.168.0.52
   s=CounterPath X-Lite 3.0
   c=IN IP4 192.168.0.52
   t=0 0
   m=audio 28768 RTP/AVP 3 0 8 101
   a=fmtp:101 0-15
   a=rtpmap:101 telephone-event/8000
   a=sendrecv
   ------------------------------------------------------------------------
tport(01AE9650): msg 02F51A68 (740 bytes) from udp/192.168.0.52:5060/sip next=00000000
nta: received 200 OK for INVITE (109984168)
nta: 200 OK is going to a transaction
tport(01AE9650): 02FC1940 by 02F30CF8 with 02F51A68
soa_set_remote_sdp(static::01D7FE78, 00000000, 02FD0601, 187) called
soa_process_answer(static::01D7FE78) called
soa_static_offer_answer_action(01D7FE78, soa_process_answer): called
soa_sdp_mode_set(02FC27A0, 03007728, ""): called
soa_static(01D7FE78, soa_process_answer): upgrade codecs with remote description
soa_static(01D7FE78, soa_process_answer): storing local description
soa_activate(static::01D7FE78, (nil)) called
nua(02EDF468): INVITE: processed SDP answer in 200 OK
nua(02EDF468): event r_invite 200 OK
soa_activate(static::01D7FE78, (nil)) called
nta: selecting scheme sip
tport_tsend(01AE9650) tpn = */192.168.0.52:63214
tport_resolve addrinfo = 192.168.0.52:63214
tport(01AE9650): not found by name */192.168.0.52:63214
tport_vsend(01AE9650): 431 bytes of 431 to udp/192.168.0.52:63214
tport_vsend returned 431
send 431 bytes to udp/[192.168.0.52]:63214 at 15:10:12.059233:
   ------------------------------------------------------------------------
   ACK sip:1008 at 192.168.0.52:63214;rinstance=a8691dfbc11775d5 SIP/2.0
   Via: SIP/2.0/UDP 192.168.0.74;rport;branch=z9hG4bKpZU12DD5v1Z2D
   Max-Forwards: 70
   From: "+39020000000" <sip:+39020000000 at 192.168.0.74>;tag=r2UgeNKeHUjXa
   To: <sip:1008 at 192.168.0.52:63214;rinstance=a8691dfbc11775d5>;tag=8b08c857
   Call-ID: c4ecd490-5f4b-122c-2780-39a48cb53b8d
   CSeq: 109984168 ACK
   Contact: <sip:mod_sofia at 192.168.0.74:5060>
   Content-Length: 0
   
   ------------------------------------------------------------------------
nta: sent ACK (109984168) to */192.168.0.52:63214
nua(02EDF468): call state changed: proceeding -> ready, received answer
soa_get_remote_sdp(static::01D7FE78, [028FFC2C], [028FFC28], [00000000]) called
soa_get_params(static::01D7FE78, ...) called
nua(02EDF468): event i_state 200 OK
nua(02EDF468): event i_active 200 Call active
nua(02EDF6E0): recv signal r_respond 200 OK
soa_set_params(static::01B75A20, ...) called
soa_set_user_sdp(static::01B75A20, 00000000, 0127FA5D, -1) called
soa_get_local_sdp(static::01B75A20, [00000000], [027FFE0C], [027FFE08]) called
tport_tsend(00DD8D20) tpn = UDP/212.97.59.76:5060
2009-01-17 16:10:12 [NOTICE] sofia.c:3065 sofia_handle_sip_i_state() Channel [sofia/internal/sip:1008 at 192.168.0.52:63214;rinstance=a8691dfbc11775d5] has been answered
tport_resolve addrinfo = 212.97.59.76:5060
tport(00DD8D20): not found by name UDP/212.97.59.76:5060
tport_vsend(00DD8D20): 1144 bytes of 1144 to udp/212.97.59.76:5060
tport_vsend returned 1144
send 1144 bytes to udp/[212.97.59.76]:5060 at 15:10:12.074853:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP 212.97.59.76;branch=z9hG4bKe61f.f220cd02.0
   Via: SIP/2.0/UDP 212.97.59.87:5060;branch=z9hG4bK57267a99;rport=5060
   Record-Route: <sip:212.97.59.76;r2=on;lr=on;ftag=as302aa103>
   Record-Route: <sip:212.97.59.76:5061;r2=on;lr=on;ftag=as302aa103>
   From: "+39020000000" <sip:+39020000000 at sip.messagenet.it>;tag=as302aa103
   To: <sip:0200000002 at 212.97.59.76:5061>;tag=N7F68303S0F5Q
   Call-ID: 0991575e53c716557b287c0f4e34a842 at sip.messagenet.it
   CSeq: 102 INVITE
   Contact: <sip:mod_sofia at 212.001.001.001:5080;transport=udp>
   User-Agent: FreeSWITCH-mod_sofia/1.0.trunk-UNKNOWN
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE, NOTIFY, REFER, UPDATE, REGISTER, INFO
   Supported: timer, precondition, path, replaces
   Allow-Events: talk, refer
   Min-SE: 120
   Content-Type: application/sdp
   Content-Disposition: session
   Content-Length: 266
   
   v=0
   o=FreeSWITCH 1110445663877587962 6324161778166975444 IN IP4 212.001.001.001
   s=FreeSWITCH
   c=IN IP4 212.001.001.001
   t=0 0
   m=audio 29688 RTP/AVP 3 101
   a=rtpmap:3 GSM/8000
   a=rtpmap:101 telephone-event/8000
   a=fmtp:101 0-16
   a=silenceSupp:off - - - -
   a=ptime:20
   ------------------------------------------------------------------------
nta: sent 200 OK for INVITE (102)
nta: timer shortened to 500 ms
nua(02EDF6E0): call state changed: early -> completed, sent answer
soa_get_local_sdp(static::01B75A20, [027FFE48], [027FFE44], [00000000]) called
soa_get_params(static::01B75A20, ...) called
nua(02EDF6E0): event i_state 200 OK
nua(02EDF6E0): sent signal r_respond
2009-01-17 16:10:12 [NOTICE] switch_ivr_originate.c:1597 switch_ivr_originate() Channel [sofia/external/+39020000000 at sip.messagenet.it] has been answered
tport_wakeup_pri(00DD8D20): events IN
tport_recv_event(00DD8D20)
tport(00DD8D20) msg 02F87F58 from (udp/10.0.3.6:5080) has 628 bytes, veclen = 1
recv 628 bytes from udp/[212.97.59.76]:5060 at 15:10:12.106094:
   ------------------------------------------------------------------------
   ACK sip:mod_sofia at 212.001.001.001:5080;transport=udp SIP/2.0
   Record-Route: <sip:212.97.59.76;r2=on;lr=on;ftag=as302aa103>
   Record-Route: <sip:212.97.59.76:5061;r2=on;lr=on;ftag=as302aa103>
   Via: SIP/2.0/UDP 212.97.59.76;branch=z9hG4bKe61f.f220cd02.2
   Via: SIP/2.0/UDP 212.97.59.87:5060;branch=z9hG4bK0498006e;rport=5060
   From: "+39020000000" <sip:+39020000000 at sip.messagenet.it>;tag=as302aa103
   To: <sip:0200000002 at 212.97.59.76:5061>;tag=N7F68303S0F5Q
   Contact: <sip:+39020000000 at 212.97.59.87>
   Call-ID: 0991575e53c716557b287c0f4e34a842 at sip.messagenet.it
   CSeq: 102 ACK
   User-Agent: alpha
   Max-Forwards: 69
   Content-Length: 0
   
   ------------------------------------------------------------------------
tport(00DD8D20): msg 02F87F58 (628 bytes) from udp/212.97.59.76:5080/sip next=00000000
nta: received ACK sip:mod_sofia at 212.001.001.001:5080;transport=udp SIP/2.0 (CSeq 102)
nta: ACK (102) is going to INVITE (102)
soa_clear_remote_sdp(static::01B75A20) called
nua(02EDF6E0): event i_ack 200 OK
nua(02EDF6E0): call state changed: completed -> ready
nua(02EDF6E0): event i_state 200 OK
nua(02EDF6E0): event i_active 200 Call active
tport_wakeup_pri(01AE9650): events IN
tport_recv_event(01AE9650)
tport(01AE9650) msg 02F87F58 from (udp/192.168.0.74:5060) has 574 bytes, veclen = 1
recv 574 bytes from udp/[192.168.0.38]:51091 at 15:10:12.527848:
   ------------------------------------------------------------------------
   SUBSCRIBE sip:1002 at 192.168.0.74 SIP/2.0
   Via: SIP/2.0/UDP 192.168.0.38:51091;branch=z9hG4bK-d8754z-08453f6c6e106020-1---d8754z-;rport
   Max-Forwards: 70
   Contact: <sip:1002 at 192.168.0.38:51091>
   To: "Alessandro Ceccarelli"<sip:1002 at 192.168.0.74>
   From: "Alessandro Ceccarelli"<sip:1002 at 192.168.0.74>;tag=333d701e
   Call-ID: NTU2NDA2N2VjMzZlZTY4ODJlYmUwN2Y1MDc3NmFiOGY.
   CSeq: 1 SUBSCRIBE
   Expires: 300
   Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO
   User-Agent: X-Lite release 1100l stamp 47546
   Event: message-summary
   Content-Length: 0
   
   ------------------------------------------------------------------------
tport(01AE9650): msg 02F87F58 (574 bytes) from udp/192.168.0.38:5060/sip next=00000000
nta: received SUBSCRIBE sip:1002 at 192.168.0.74 SIP/2.0 (CSeq 1)
nta: canonizing sip:1002 at 192.168.0.74 with contact
nta: SUBSCRIBE (1) going to a default leg
soa_clone(static::01AE57C0, 01AE28C0, 02F49AA0) called
soa_set_params(static::02F88ED0, ...) called
nta_leg_tcreate(02F039B0)
nua(02F49AA0): adding notify usage with event message-summary
nua(02F49AA0): event i_subscribe 100 Trying
nua(): refresh notify after 600 seconds (in [600..600])
nua(): refresh notify after 600 seconds
nua(02F49AA0): sent signal r_respond
nua(02F49AA0): recv signal r_respond 202 Accepted
soa_set_params(static::02F88ED0, ...) called
tport_tsend(01AE9650) tpn = UDP/192.168.0.38:51091
tport_resolve addrinfo = 192.168.0.38:51091
tport(01AE9650): not found by name UDP/192.168.0.38:51091
tport_vsend(01AE9650): 813 bytes of 813 to udp/192.168.0.38:51091
tport_vsend returned 813
send 813 bytes to udp/[192.168.0.38]:51091 at 15:10:12.527848:
   ------------------------------------------------------------------------
   SIP/2.0 202 Accepted
   Via: SIP/2.0/UDP 192.168.0.38:51091;branch=z9hG4bK-d8754z-08453f6c6e106020-1---d8754z-;rport=51091
   From: "Alessandro Ceccarelli"<sip:1002 at 192.168.0.74>;tag=333d701e
   To: "Alessandro Ceccarelli" <sip:1002 at 192.168.0.74>;tag=SBN9Fg4He48Fp
   Call-ID: NTU2NDA2N2VjMzZlZTY4ODJlYmUwN2Y1MDc3NmFiOGY.
   CSeq: 1 SUBSCRIBE
   Contact: "Alessandro Ceccarelli" <sip:1002 at 192.168.0.38:51091>
   Expires: 300
   User-Agent: FreeSWITCH-mod_sofia/1.0.trunk-UNKNOWN
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE, NOTIFY, REFER, UPDATE, REGISTER, INFO, PUBLISH
   Supported: timer, precondition, path, replaces
   Allow-Events: talk, presence, dialog, call-info, sla, include-session-description, presence.winfo, message-summary, refer
   Subscription-State: active;expires=300
   Content-Length: 0
   
   ------------------------------------------------------------------------
nta: sent 202 Accepted for SUBSCRIBE (1)
nta: timer set next to 4453 ms
nta: timer I fired, terminate 200 response
incoming_reclaim_all(00000000, 00000000, 027FFEBC)
nta_incoming_timer: 0/0 resent, 0/0 tout, 1/1 term, 1/1 free
nta: timer not set
tport_wakeup_pri(01AE9650): events IN
tport_recv_event(01AE9650)
tport(01AE9650) msg 01D71768 from (udp/192.168.0.74:5060) has 801 bytes, veclen = 1
recv 801 bytes from udp/[192.168.0.52]:63214 at 15:10:19.104078:
   ------------------------------------------------------------------------
   INVITE sip:mod_sofia at 192.168.0.74:5060 SIP/2.0
   Via: SIP/2.0/UDP 192.168.0.52:63214;branch=z9hG4bK-d8754z-4e76a82c441aae66-1---d8754z-;rport
   Max-Forwards: 70
   Contact: <sip:1008 at 192.168.0.52:63214;rinstance=a8691dfbc11775d5>
   To: "+39020000000"<sip:+39020000000 at 192.168.0.74>;tag=r2UgeNKeHUjXa
   From: <sip:1008 at 192.168.0.52:63214;rinstance=a8691dfbc11775d5>;tag=8b08c857
   Call-ID: c4ecd490-5f4b-122c-2780-39a48cb53b8d
   CSeq: 2 INVITE
   Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO
   Content-Type: application/sdp
   User-Agent: X-Lite release 1100l stamp 47546
   Content-Length: 182
   
   v=0
   o=- 6 3 IN IP4 192.168.0.52
   s=CounterPath X-Lite 3.0
   c=IN IP4 0.0.0.0
   t=0 0
   m=audio 28768 RTP/AVP 3 0 8 101
   a=fmtp:101 0-15
   a=rtpmap:101 telephone-event/8000
   a=sendonly
   ------------------------------------------------------------------------
tport(01AE9650): msg 01D71768 (801 bytes) from udp/192.168.0.52:5060/sip next=00000000
nta: received INVITE sip:mod_sofia at 192.168.0.74:5060 SIP/2.0 (CSeq 2)
nta: canonizing sip:mod_sofia at 192.168.0.74:5060 with contact
nta: INVITE (2) going to existing leg
nta: timer shortened to 200 ms
soa_init_offer_answer(static::01D7FE78) called
soa_set_remote_sdp(static::01D7FE78, 00000000, 01279F8B, 182) called
tport_tsend(01AE9650) tpn = UDP/192.168.0.52:63214
tport_resolve addrinfo = 192.168.0.52:63214
tport(01AE9650): not found by name UDP/192.168.0.52:63214
tport_vsend(01AE9650): 402 bytes of 402 to udp/192.168.0.52:63214
tport_vsend returned 402
send 402 bytes to udp/[192.168.0.52]:63214 at 15:10:19.119699:
   ------------------------------------------------------------------------
   SIP/2.0 100 Trying
   Via: SIP/2.0/UDP 192.168.0.52:63214;branch=z9hG4bK-d8754z-4e76a82c441aae66-1---d8754z-;rport=63214
   From: <sip:1008 at 192.168.0.52:63214;rinstance=a8691dfbc11775d5>;tag=8b08c857
   To: "+39020000000"<sip:+39020000000 at 192.168.0.74>;tag=r2UgeNKeHUjXa
   Call-ID: c4ecd490-5f4b-122c-2780-39a48cb53b8d
   CSeq: 2 INVITE
   User-Agent: FreeSWITCH-mod_sofia/1.0.trunk-UNKNOWN
   Content-Length: 0
   
   ------------------------------------------------------------------------
nta: sent 100 Trying for INVITE (2)
nua(02EDF468): event i_invite 100 Trying
nua(02EDF468): ready call updated: received received offer
soa_get_remote_sdp(static::01D7FE78, [028FFC14], [028FFC10], [00000000]) called
nua(02EDF468): event i_state 100 Trying
nta: timer set next to 10538 ms
nua(02EDF468): sent signal r_respond
nua(02EDF468): recv signal r_respond 200 OK
soa_set_params(static::01D7FE78, ...) called
soa_set_user_sdp(static::01D7FE78, 00000000, 01B8170C, -1) called
soa_generate_answer(static::01D7FE78) called
soa_static_offer_answer_action(01D7FE78, soa_generate_answer): called
soa_static(01D7FE78, soa_generate_answer): upgrade with remote description
soa_static(01D7FE78, soa_generate_answer): marking rejected media
soa_sdp_mode_set(028FDCF8, 01D705C8, ""): called
soa_sdp_mode_set(028FDCF8, 01D705C8, ""): called
soa_static(01D7FE78, soa_generate_answer): storing local description
soa_activate(static::01D7FE78, (nil)) called
soa_get_local_sdp(static::01D7FE78, [00000000], [028FFE0C], [028FFE08]) called
tport_tsend(01AE9650) tpn = UDP/192.168.0.52:63214
tport_resolve addrinfo = 192.168.0.52:63214
tport(01AE9650): not found by name UDP/192.168.0.52:63214
tport_vsend(01AE9650): 984 bytes of 984 to udp/192.168.0.52:63214
tport_vsend returned 984
send 984 bytes to udp/[192.168.0.52]:63214 at 15:10:19.369627:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP 192.168.0.52:63214;branch=z9hG4bK-d8754z-4e76a82c441aae66-1---d8754z-;rport=63214
   From: <sip:1008 at 192.168.0.52:63214;rinstance=a8691dfbc11775d5>;tag=8b08c857
   To: "+39020000000"<sip:+39020000000 at 192.168.0.74>;tag=r2UgeNKeHUjXa
   Call-ID: c4ecd490-5f4b-122c-2780-39a48cb53b8d
   CSeq: 2 INVITE
   Contact: <sip:mod_sofia at 192.168.0.74:5060>
   User-Agent: FreeSWITCH-mod_sofia/1.0.trunk-UNKNOWN
   Accept: application/sdp
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE, NOTIFY, REFER, UPDATE, REGISTER, INFO, PUBLISH
   Supported: timer, precondition, path, replaces
   Min-SE: 120
   Content-Type: application/sdp
   Content-Disposition: session
   Content-Length: 276
   
   v=0
   o=FreeSWITCH 6699757194367626025 7696645903169343293 IN IP4 192.168.0.74
   s=FreeSWITCH
   c=IN IP4 192.168.0.74
   t=0 0
   m=audio 29688 RTP/AVP 3 101
   a=rtpmap:3 GSM/8000
   a=rtpmap:101 telephone-event/8000
   a=fmtp:101 0-16
   a=recvonly
   a=silenceSupp:off - - - -
   a=ptime:20
   ------------------------------------------------------------------------
nta: sent 200 OK for INVITE (2)
nta: timer shortened to 500 ms
nua(02EDF468): ready call updated: completed sent answer
soa_get_local_sdp(static::01D7FE78, [028FFE48], [028FFE44], [00000000]) called
soa_get_params(static::01D7FE78, ...) called
nua(02EDF468): event i_state 200 OK
tport_wakeup_pri(01AE9650): events IN
tport_recv_event(01AE9650)
tport(01AE9650) msg 02F4BC48 from (udp/192.168.0.74:5060) has 497 bytes, veclen = 1
recv 497 bytes from udp/[192.168.0.52]:63214 at 15:10:19.478970:
   ------------------------------------------------------------------------
   ACK sip:mod_sofia at 192.168.0.74:5060 SIP/2.0
   Via: SIP/2.0/UDP 192.168.0.52:63214;branch=z9hG4bK-d8754z-0a230c1b27666c30-1---d8754z-;rport
   Max-Forwards: 70
   Contact: <sip:1008 at 192.168.0.52:63214;rinstance=a8691dfbc11775d5>
   To: "+39020000000"<sip:+39020000000 at 192.168.0.74>;tag=r2UgeNKeHUjXa
   From: <sip:1008 at 192.168.0.52:63214;rinstance=a8691dfbc11775d5>;tag=8b08c857
   Call-ID: c4ecd490-5f4b-122c-2780-39a48cb53b8d
   CSeq: 2 ACK
   User-Agent: X-Lite release 1100l stamp 47546
   Content-Length: 0
   
   ------------------------------------------------------------------------
tport(01AE9650): msg 02F4BC48 (497 bytes) from udp/192.168.0.52:5060/sip next=00000000
nta: received ACK sip:mod_sofia at 192.168.0.74:5060 SIP/2.0 (CSeq 2)
nta: ACK (2) is going to INVITE (2)
soa_clear_remote_sdp(static::01D7FE78) called
nua(02EDF468): event i_ack 200 OK
nua(02EDF468): ready call updated: ready
nua(02EDF468): event i_state 200 OK
nua(02EDF468): event i_active 200 Call active
nta: timer set next to 4594 ms
nta: timer I fired, terminate 200 response
incoming_reclaim_all(00000000, 00000000, 028FFEBC)
nta_incoming_timer: 0/0 resent, 0/0 tout, 1/5 term, 1/5 free
nta: timer set next to 5352 ms
tport_wakeup_pri(01AE9650): events IN
tport_recv_event(01AE9650)
tport(01AE9650) msg 01D71768 from (udp/192.168.0.74:5060) has 4 bytes, veclen = 1
tport(01AE9650): bad msg 01D71768 (4 bytes) from udp/192.168.0.52:5060/sip next=00000000
nta: timer J fired, terminate 401 response
incoming_reclaim_all(00000000, 00000000, 028FFEBC)
nta_incoming_timer: 0/0 resent, 0/0 tout, 1/4 term, 1/4 free
nta: timer set next to 197 ms
nta: timer J fired, terminate 200 response
incoming_reclaim_all(00000000, 00000000, 028FFEBC)
nta_incoming_timer: 0/0 resent, 0/0 tout, 1/3 term, 1/3 free
nta: timer set next to 87 ms
nta: timer J fired, terminate 202 response
incoming_reclaim_all(00000000, 00000000, 028FFEBC)
nta_incoming_timer: 0/0 resent, 0/0 tout, 1/2 term, 1/2 free
nta: timer set next to 13911 ms
tport_wakeup_pri(01AE9650): events IN
tport_recv_event(01AE9650)
tport(01AE9650) msg 01D71768 from (udp/192.168.0.74:5060) has 4 bytes, veclen = 1
tport(01AE9650): bad msg 01D71768 (4 bytes) from udp/192.168.0.38:5060/sip next=00000000
tport_wakeup_pri(01AE9650): events IN
tport_recv_event(01AE9650)
tport(01AE9650) msg 01D71768 from (udp/192.168.0.74:5060) has 802 bytes, veclen = 1
recv 802 bytes from udp/[192.168.0.52]:63214 at 15:10:39.504451:
   ------------------------------------------------------------------------
   INVITE sip:mod_sofia at 192.168.0.74:5060 SIP/2.0
   Via: SIP/2.0/UDP 192.168.0.52:63214;branch=z9hG4bK-d8754z-4b5f9a669369bb1f-1---d8754z-;rport
   Max-Forwards: 70
   Contact: <sip:1008 at 192.168.0.52:63214;rinstance=a8691dfbc11775d5>
   To: "+39020000000"<sip:+39020000000 at 192.168.0.74>;tag=r2UgeNKeHUjXa
   From: <sip:1008 at 192.168.0.52:63214;rinstance=a8691dfbc11775d5>;tag=8b08c857
   Call-ID: c4ecd490-5f4b-122c-2780-39a48cb53b8d
   CSeq: 3 INVITE
   Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO
   Content-Type: application/sdp
   User-Agent: X-Lite release 1100l stamp 47546
   Content-Length: 183
   
   v=0
   o=- 6 4 IN IP4 192.168.0.52
   s=CounterPath X-Lite 3.0
   c=IN IP4 192.168.0.52
   t=0 0
   m=audio 28768 RTP/AVP 3 101
   a=fmtp:101 0-15
   a=rtpmap:101 telephone-event/8000
   a=sendrecv
   ------------------------------------------------------------------------
tport(01AE9650): msg 01D71768 (802 bytes) from udp/192.168.0.52:5060/sip next=00000000
nta: received INVITE sip:mod_sofia at 192.168.0.74:5060 SIP/2.0 (CSeq 3)
nta: canonizing sip:mod_sofia at 192.168.0.74:5060 with contact
nta: INVITE (3) going to existing leg
nta: timer shortened to 200 ms
soa_init_offer_answer(static::01D7FE78) called
soa_set_remote_sdp(static::01D7FE78, 00000000, 01279F8B, 183) called
tport_tsend(01AE9650) tpn = UDP/192.168.0.52:63214
tport_resolve addrinfo = 192.168.0.52:63214
tport(01AE9650): not found by name UDP/192.168.0.52:63214
tport_vsend(01AE9650): 402 bytes of 402 to udp/192.168.0.52:63214
tport_vsend returned 402
send 402 bytes to udp/[192.168.0.52]:63214 at 15:10:39.504451:
   ------------------------------------------------------------------------
   SIP/2.0 100 Trying
   Via: SIP/2.0/UDP 192.168.0.52:63214;branch=z9hG4bK-d8754z-4b5f9a669369bb1f-1---d8754z-;rport=63214
   From: <sip:1008 at 192.168.0.52:63214;rinstance=a8691dfbc11775d5>;tag=8b08c857
   To: "+39020000000"<sip:+39020000000 at 192.168.0.74>;tag=r2UgeNKeHUjXa
   Call-ID: c4ecd490-5f4b-122c-2780-39a48cb53b8d
   CSeq: 3 INVITE
   User-Agent: FreeSWITCH-mod_sofia/1.0.trunk-UNKNOWN
   Content-Length: 0
   
   ------------------------------------------------------------------------
nta: sent 100 Trying for INVITE (3)
nua(02EDF468): event i_invite 100 Trying
nua(02EDF468): ready call updated: received received offer
soa_get_remote_sdp(static::01D7FE78, [028FFC14], [028FFC10], [00000000]) called
nua(02EDF468): event i_state 100 Trying
nta: timer set next to 4351 ms
nua(02EDF468): sent signal r_respond
nua(02EDF468): recv signal r_respond 200 OK
soa_set_params(static::01D7FE78, ...) called
soa_set_user_sdp(static::01D7FE78, 00000000, 01B8170C, -1) called
soa_generate_answer(static::01D7FE78) called
soa_static_offer_answer_action(01D7FE78, soa_generate_answer): called
soa_static(01D7FE78, soa_generate_answer): upgrade with remote description
soa_sdp_mode_set(028FDCF8, 00DE0118, ""): called
soa_static(01D7FE78, soa_generate_answer): storing local description
soa_activate(static::01D7FE78, (nil)) called
soa_get_local_sdp(static::01D7FE78, [00000000], [028FFE0C], [028FFE08]) called
tport_tsend(01AE9650) tpn = UDP/192.168.0.52:63214
tport_resolve addrinfo = 192.168.0.52:63214
tport(01AE9650): not found by name UDP/192.168.0.52:63214
tport_vsend(01AE9650): 972 bytes of 972 to udp/192.168.0.52:63214
tport_vsend returned 972
send 972 bytes to udp/[192.168.0.52]:63214 at 15:10:39.785620:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP 192.168.0.52:63214;branch=z9hG4bK-d8754z-4b5f9a669369bb1f-1---d8754z-;rport=63214
   From: <sip:1008 at 192.168.0.52:63214;rinstance=a8691dfbc11775d5>;tag=8b08c857
   To: "+39020000000"<sip:+39020000000 at 192.168.0.74>;tag=r2UgeNKeHUjXa
   Call-ID: c4ecd490-5f4b-122c-2780-39a48cb53b8d
   CSeq: 3 INVITE
   Contact: <sip:mod_sofia at 192.168.0.74:5060>
   User-Agent: FreeSWITCH-mod_sofia/1.0.trunk-UNKNOWN
   Accept: application/sdp
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE, NOTIFY, REFER, UPDATE, REGISTER, INFO, PUBLISH
   Supported: timer, precondition, path, replaces
   Min-SE: 120
   Content-Type: application/sdp
   Content-Disposition: session
   Content-Length: 264
   
   v=0
   o=FreeSWITCH 6699757194367626025 7696645903169343294 IN IP4 192.168.0.74
   s=FreeSWITCH
   c=IN IP4 192.168.0.74
   t=0 0
   m=audio 29688 RTP/AVP 3 101
   a=rtpmap:3 GSM/8000
   a=rtpmap:101 telephone-event/8000
   a=fmtp:101 0-16
   a=silenceSupp:off - - - -
   a=ptime:20
   ------------------------------------------------------------------------
nta: sent 200 OK for INVITE (3)
nta: timer shortened to 500 ms
nua(02EDF468): ready call updated: completed sent answer
soa_get_local_sdp(static::01D7FE78, [028FFE48], [028FFE44], [00000000]) called
soa_get_params(static::01D7FE78, ...) called
nua(02EDF468): event i_state 200 OK
tport_wakeup_pri(01AE9650): events IN
tport_recv_event(01AE9650)
tport(01AE9650) msg 02F04E20 from (udp/192.168.0.74:5060) has 497 bytes, veclen = 1
recv 497 bytes from udp/[192.168.0.52]:63214 at 15:10:39.894964:
   ------------------------------------------------------------------------
   ACK sip:mod_sofia at 192.168.0.74:5060 SIP/2.0
   Via: SIP/2.0/UDP 192.168.0.52:63214;branch=z9hG4bK-d8754z-b131c97e6c16e653-1---d8754z-;rport
   Max-Forwards: 70
   Contact: <sip:1008 at 192.168.0.52:63214;rinstance=a8691dfbc11775d5>
   To: "+39020000000"<sip:+39020000000 at 192.168.0.74>;tag=r2UgeNKeHUjXa
   From: <sip:1008 at 192.168.0.52:63214;rinstance=a8691dfbc11775d5>;tag=8b08c857
   Call-ID: c4ecd490-5f4b-122c-2780-39a48cb53b8d
   CSeq: 3 ACK
   User-Agent: X-Lite release 1100l stamp 47546
   Content-Length: 0
   
   ------------------------------------------------------------------------
tport(01AE9650): msg 02F04E20 (497 bytes) from udp/192.168.0.52:5060/sip next=00000000
nta: received ACK sip:mod_sofia at 192.168.0.74:5060 SIP/2.0 (CSeq 3)
nta: ACK (3) is going to INVITE (3)
soa_clear_remote_sdp(static::01D7FE78) called
nua(02EDF468): event i_ack 200 OK
nua(02EDF468): ready call updated: ready
nua(02EDF468): event i_state 200 OK
nua(02EDF468): event i_active 200 Call active
nta: timer set next to 3758 ms
tport_wakeup_pri(01AE9650): events IN
tport_recv_event(01AE9650)
tport(01AE9650) msg 02F04E20 from (udp/192.168.0.74:5060) has 537 bytes, veclen = 1
recv 537 bytes from udp/[192.168.0.52]:63214 at 15:10:42.316141:
   ------------------------------------------------------------------------
   BYE sip:mod_sofia at 192.168.0.74:5060 SIP/2.0
   Via: SIP/2.0/UDP 192.168.0.52:63214;branch=z9hG4bK-d8754z-5f47b655ea7fe925-1---d8754z-;rport
   Max-Forwards: 70
   Contact: <sip:1008 at 192.168.0.52:63214;rinstance=a8691dfbc11775d5>
   To: "+39020000000"<sip:+39020000000 at 192.168.0.74>;tag=r2UgeNKeHUjXa
   From: <sip:1008 at 192.168.0.52:63214;rinstance=a8691dfbc11775d5>;tag=8b08c857
   Call-ID: c4ecd490-5f4b-122c-2780-39a48cb53b8d
   CSeq: 4 BYE
   User-Agent: X-Lite release 1100l stamp 47546
   Reason: SIP;description="User Hung Up"
   Content-Length: 0
   
   ------------------------------------------------------------------------
tport(01AE9650): msg 02F04E20 (537 bytes) from udp/192.168.0.52:5060/sip next=00000000
nta: received BYE sip:mod_sofia at 192.168.0.74:5060 SIP/2.0 (CSeq 4)
nta: canonizing sip:mod_sofia at 192.168.0.74:5060 with contact
nta: BYE (4) going to existing leg
tport_tsend(01AE9650) tpn = UDP/192.168.0.52:63214
tport_resolve addrinfo = 192.168.0.52:63214
tport(01AE9650): not found by name UDP/192.168.0.52:63214
tport_vsend(01AE9650): 560 bytes of 560 to udp/192.168.0.52:63214
tport_vsend returned 560
send 560 bytes to udp/[192.168.0.52]:63214 at 15:10:42.316141:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP 192.168.0.52:63214;branch=z9hG4bK-d8754z-5f47b655ea7fe925-1---d8754z-;rport=63214
   From: <sip:1008 at 192.168.0.52:63214;rinstance=a8691dfbc11775d5>;tag=8b08c857
   To: "+39020000000"<sip:+39020000000 at 192.168.0.74>;tag=r2UgeNKeHUjXa
   Call-ID: c4ecd490-5f4b-122c-2780-39a48cb53b8d
   CSeq: 4 BYE
   User-Agent: FreeSWITCH-mod_sofia/1.0.trunk-UNKNOWN
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE, NOTIFY, REFER, UPDATE, REGISTER, INFO, PUBLISH
   Supported: timer, precondition, path, replaces
   Content-Length: 0
   
   ------------------------------------------------------------------------
nta: sent 200 OK for BYE (4)
nua(02EDF468): event i_bye 200 Session Terminated
nua(02EDF468): removing session usage
nua(02EDF468): call state changed: ready -> terminated
nua(02EDF468): event i_state 200 Session Terminated
nua(02EDF468): event i_terminated 200 Session Terminated
soa_destroy(static::01D7FE78) called
nta_leg_destroy(02F47280)
2009-01-17 16:10:42 [NOTICE] sofia.c:3124 sofia_handle_sip_i_state() Hangup sofia/internal/sip:1008 at 192.168.0.52:63214;rinstance=a8691dfbc11775d5 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
nua(02EDF468): sent signal r_destroy
nua(02EDF468): event i_terminated dropped
nua(02EDF468): recv signal r_destroy
nta_leg_destroy(00000000)
2009-01-17 16:10:42 [NOTICE] switch_ivr_bridge.c:955 switch_ivr_multi_threaded_bridge() Hangup sofia/external/+39020000000 at sip.messagenet.it [CS_EXECUTE] [NORMAL_CLEARING]
2009-01-17 16:10:42 [NOTICE] switch_core_session.c:960 switch_core_session_thread() Session 2 (sofia/internal/sip:1008 at 192.168.0.52:63214;rinstance=a8691dfbc11775d5) Ended
2009-01-17 16:10:42 [NOTICE] switch_core_session.c:962 switch_core_session_thread() Close Channel sofia/internal/sip:1008 at 192.168.0.52:63214;rinstance=a8691dfbc11775d5 [CS_HANGUP]
nua(02EDF6E0): recv signal r_bye
soa_set_params(static::01B75A20, ...) called
soa_terminate(static::01B75A20) called
soa_init_offer_answer(static::01B75A20) called
nta: selecting scheme sip
tport_tsend(00DD8D20) tpn = */212.97.59.76:5060
nua(02EDF6E0): sent signal r_bye
tport_resolve addrinfo = 212.97.59.76:5060
tport(00DD8D20): not found by name */212.97.59.76:5060
tport_vsend(00DD8D20): 796 bytes of 796 to udp/212.97.59.76:5060
tport_vsend returned 796
send 796 bytes to udp/[212.97.59.76]:5060 at 15:10:42.331762:
   ------------------------------------------------------------------------
   BYE sip:+39020000000 at 212.97.59.87 SIP/2.0
   Via: SIP/2.0/UDP 212.001.001.001:5080;rport;branch=z9hG4bKpZU12DD5v1Z2D
   Route: <sip:212.97.59.76;r2=on;lr=on;ftag=as302aa103>
   Route: <sip:212.97.59.76:5061;r2=on;lr=on;ftag=as302aa103>
   Max-Forwards: 70
   From: <sip:0200000002 at 212.97.59.76:5061>;tag=N7F68303S0F5Q
   To: "+39020000000" <sip:+39020000000 at sip.messagenet.it>;tag=as302aa103
   Call-ID: 0991575e53c716557b287c0f4e34a842 at sip.messagenet.it
   CSeq: 109984185 BYE
   Contact: <sip:mod_sofia at 212.001.001.001:5080;transport=udp>
   User-Agent: FreeSWITCH-mod_sofia/1.0.trunk-UNKNOWN
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE, NOTIFY, REFER, UPDATE, REGISTER, INFO
   Supported: timer, precondition, path, replaces
   Reason: Q.850;cause=16;text="NORMAL_CLEARING"
   Content-Length: 0
   
   ------------------------------------------------------------------------
nta: sent BYE (109984185) to */212.97.59.76:5060
tport_pend(00DD8D20): pending 02F4B840 for udp/10.0.3.6:5080 (already 0)
nta: timer set to 32000 ms
nta: timer shortened to 500 ms
2009-01-17 16:10:42 [NOTICE] switch_core_session.c:960 switch_core_session_thread() Session 1 (sofia/external/+39020000000 at sip.messagenet.it) Ended
2009-01-17 16:10:42 [NOTICE] switch_core_session.c:962 switch_core_session_thread() Close Channel sofia/external/+39020000000 at sip.messagenet.it [CS_HANGUP]
tport_wakeup_pri(00DD8D20): events IN
tport_recv_event(00DD8D20)
tport(00DD8D20) msg 02F8AAA8 from (udp/10.0.3.6:5080) has 612 bytes, veclen = 1
recv 612 bytes from udp/[212.97.59.76]:5060 at 15:10:42.347382:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP 212.001.001.001:5080;rport=5080;branch=z9hG4bKpZU12DD5v1Z2D
   Record-Route: <sip:212.97.59.76:5061;r2=on;lr=on;ftag=N7F68303S0F5Q>
   Record-Route: <sip:212.97.59.76;r2=on;lr=on;ftag=N7F68303S0F5Q>
   From: <sip:0200000002 at 212.97.59.76:5061>;tag=N7F68303S0F5Q
   To: "+39020000000" <sip:+39020000000 at sip.messagenet.it>;tag=as302aa103
   Call-ID: 0991575e53c716557b287c0f4e34a842 at sip.messagenet.it
   CSeq: 109984185 BYE
   User-Agent: alpha
   Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
   Supported: replaces
   Contact: <sip:+39020000000 at 212.97.59.87>
   Content-Length: 0
   
   ------------------------------------------------------------------------
tport(00DD8D20): msg 02F8AAA8 (612 bytes) from udp/212.97.59.76:5080/sip next=00000000
nta: received 200 OK for BYE (109984185)
nta: 200 OK is going to a transaction
nta_outgoing: RTT is 31.241 ms
tport(00DD8D20): 02F4B840 by 01B70810 with 02F8AAA8
nua(02EDF6E0): event r_bye 200 OK
nua(02EDF6E0): call state changed: terminating -> terminated
nua(02EDF6E0): event i_state 200 to BYE
nua(02EDF6E0): event i_terminated 200 to BYE
nua(02EDF6E0): removing session usage
soa_destroy(static::01B75A20) called
nta_leg_destroy(02F004E0)
nua: terminated session 02EDF6E0
nua(02EDF6E0): recv signal r_destroy
nta_leg_destroy(00000000)
nua(02EDF6E0): sent signal r_destroy
nta: timer set next to 4500 ms
nta: timer D fired, terminate INVITE (109984168)
nta: timer F fired, terminating ACK (109984168)
outgoing_reclaim_all(00000000, 00000000, 028FFEC0)
nta_outgoing_timer: 0/0 resent, 1/1 tout, 1/1 term, 2/2 free
nta: timer set next to 477 ms
nta: timer J fired, terminate 202 response
incoming_reclaim_all(00000000, 00000000, 028FFEBC)
nta_incoming_timer: 0/0 resent, 0/0 tout, 1/3 term, 1/3 free
nta: timer set next to 345 ms
nta: timer I fired, terminate 200 response
incoming_reclaim_all(00000000, 00000000, 028FFEBC)
nta_incoming_timer: 0/0 resent, 0/0 tout, 1/2 term, 1/2 free
nta: timer set next to 29407 ms
nta: timer K fired, terminate BYE (109984185)
outgoing_reclaim_all(00000000, 00000000, 027FFEC0)
nta_outgoing_timer: 0/0 resent, 0/0 tout, 1/1 term, 1/1 free
nta: timer not set
2009-01-17 16:10:57 [CONSOLE] switch_console.c:229 switch_console_process() Bye!
2009-01-17 16:10:57 [CONSOLE] switch_core.c:1459 switch_core_destroy() End existing sessions
2009-01-17 16:10:57 [CONSOLE] switch_core.c:1461 switch_core_destroy() Clean up modules.
2009-01-17 16:10:57 [CONSOLE] switch_core_memory.c:443 switch_core_memory_stop() Stopping memory pool queue.
2009-01-17 16:10:57 [CONSOLE] switch_core_memory.c:374 switch_core_memory_reclaim() Returning 3 recycled memory pool(s)
2009-01-17 16:10:57 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'lua'
2009-01-17 16:10:57 [NOTICE] switch_loadable_module.c:536 switch_loadable_module_unprocess() Deleting API Function 'luarun'
2009-01-17 16:10:57 [NOTICE] switch_loadable_module.c:536 switch_loadable_module_unprocess() Deleting API Function 'lua'
2009-01-17 16:10:57 [CONSOLE] switch_loadable_module.c:1231 do_shutdown() Stopping: mod_lua
2009-01-17 16:10:57 [NOTICE] switch_event.c:1189 switch_event_unbind() Event Binding deleted for mod_lua:MESSAGE_QUERY
2009-01-17 16:10:57 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'limit'
2009-01-17 16:10:57 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'limit_hash'
2009-01-17 16:10:57 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'db'
2009-01-17 16:10:57 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'hash'
2009-01-17 16:10:57 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'group'
2009-01-17 16:10:57 [NOTICE] switch_loadable_module.c:536 switch_loadable_module_unprocess() Deleting API Function 'limit_hash_usage'
2009-01-17 16:10:57 [NOTICE] switch_loadable_module.c:536 switch_loadable_module_unprocess() Deleting API Function 'limit_usage'
2009-01-17 16:10:57 [NOTICE] switch_loadable_module.c:536 switch_loadable_module_unprocess() Deleting API Function 'db'
2009-01-17 16:10:57 [NOTICE] switch_loadable_module.c:536 switch_loadable_module_unprocess() Deleting API Function 'hash'
2009-01-17 16:10:57 [NOTICE] switch_loadable_module.c:536 switch_loadable_module_unprocess() Deleting API Function 'group'
2009-01-17 16:10:57 [CONSOLE] switch_loadable_module.c:1234 do_shutdown() mod_limit has no shutdown routine
2009-01-17 16:10:57 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'fifo'
2009-01-17 16:10:57 [NOTICE] switch_loadable_module.c:536 switch_loadable_module_unprocess() Deleting API Function 'fifo'
2009-01-17 16:10:57 [NOTICE] switch_loadable_module.c:536 switch_loadable_module_unprocess() Deleting API Function 'fifo_member'
2009-01-17 16:10:57 [CONSOLE] switch_loadable_module.c:1231 do_shutdown() Stopping: mod_fifo
2009-01-17 16:10:57 [NOTICE] switch_event.c:1189 switch_event_unbind() Event Binding deleted for mod_fifo:PRESENCE_PROBE
2009-01-17 16:10:57 [NOTICE] switch_event.c:374 switch_event_free_subclass_detailed() Subclass reservation deleted for .\mod_fifo.c:fifo::info
tport_wakeup_pri(01AE9650): events IN
tport_recv_event(01AE9650)
tport(01AE9650) msg 02F053A0 from (udp/192.168.0.74:5060) has 4 bytes, veclen = 1
tport(01AE9650): bad msg 02F053A0 (4 bytes) from udp/192.168.0.52:5060/sip next=00000000
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:536 switch_loadable_module_unprocess() Deleting API Function 'expr'
2009-01-17 16:10:58 [CONSOLE] switch_loadable_module.c:1234 do_shutdown() mod_expr has no shutdown routine
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:575 switch_loadable_module_unprocess() Deleting File Format 'aiff'
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:575 switch_loadable_module_unprocess() Deleting File Format 'au'
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:575 switch_loadable_module_unprocess() Deleting File Format 'avr'
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:575 switch_loadable_module_unprocess() Deleting File Format 'caf'
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:575 switch_loadable_module_unprocess() Deleting File Format 'htk'
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:575 switch_loadable_module_unprocess() Deleting File Format 'iff'
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:575 switch_loadable_module_unprocess() Deleting File Format 'mat'
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:575 switch_loadable_module_unprocess() Deleting File Format 'mat'
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:575 switch_loadable_module_unprocess() Deleting File Format 'paf'
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:575 switch_loadable_module_unprocess() Deleting File Format 'pvf'
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:575 switch_loadable_module_unprocess() Deleting File Format 'raw'
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:575 switch_loadable_module_unprocess() Deleting File Format 'sd2'
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:575 switch_loadable_module_unprocess() Deleting File Format 'sds'
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:575 switch_loadable_module_unprocess() Deleting File Format 'sf'
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:575 switch_loadable_module_unprocess() Deleting File Format 'voc'
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:575 switch_loadable_module_unprocess() Deleting File Format 'w64'
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:575 switch_loadable_module_unprocess() Deleting File Format 'wav'
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:575 switch_loadable_module_unprocess() Deleting File Format 'wav'
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:575 switch_loadable_module_unprocess() Deleting File Format 'wav'
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:575 switch_loadable_module_unprocess() Deleting File Format 'xi'
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:575 switch_loadable_module_unprocess() Deleting File Format 'r8'
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:575 switch_loadable_module_unprocess() Deleting File Format 'r16'
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:575 switch_loadable_module_unprocess() Deleting File Format 'r24'
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:575 switch_loadable_module_unprocess() Deleting File Format 'r32'
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:575 switch_loadable_module_unprocess() Deleting File Format 'gsm'
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:575 switch_loadable_module_unprocess() Deleting File Format 'ul'
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:575 switch_loadable_module_unprocess() Deleting File Format 'al'
2009-01-17 16:10:58 [CONSOLE] switch_loadable_module.c:1231 do_shutdown() Stopping: mod_sndfile
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:700 switch_loadable_module_unprocess() Deleting Say interface 'en'
2009-01-17 16:10:58 [CONSOLE] switch_loadable_module.c:1234 do_shutdown() mod_say_en has no shutdown routine
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:434 switch_loadable_module_unprocess() Deleting Endpoint 'loopback'
2009-01-17 16:10:58 [CONSOLE] switch_loadable_module.c:1231 do_shutdown() Stopping: mod_loopback
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'conference'
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'conference_set_auto_outcall'
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:536 switch_loadable_module_unprocess() Deleting API Function 'conference'
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:677 switch_loadable_module_unprocess() Deleting Chat interface 'conf'
2009-01-17 16:10:58 [CONSOLE] switch_loadable_module.c:1231 do_shutdown() Stopping: mod_conference
2009-01-17 16:10:58 [NOTICE] switch_event.c:1189 switch_event_unbind() Event Binding deleted for mod_conference:PRESENCE_PROBE
2009-01-17 16:10:58 [NOTICE] switch_event.c:374 switch_event_free_subclass_detailed() Subclass reservation deleted for .\mod_conference.c:conference::maintenance
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'PROXY-VID' (PROXY VIDEO PASS-THROUGH) 90000hz 0ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'PROXY' (PROXY PASS-THROUGH) 8000hz 20ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 11025hz 40ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 22050hz 20ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 48000hz 20ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 32000hz 8ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 32000hz 6ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 32000hz 4ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 32000hz 2ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 16000hz 8ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 16000hz 6ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 16000hz 4ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 16000hz 2ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 8000hz 8ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 8000hz 6ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 8000hz 4ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 8000hz 2ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 48000hz 10ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 48000hz 8ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 48000hz 6ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 48000hz 4ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 48000hz 2ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 32000hz 10ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 32000hz 20ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 32000hz 30ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 32000hz 40ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 32000hz 50ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 32000hz 60ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 16000hz 10ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 16000hz 20ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 16000hz 30ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 16000hz 40ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 16000hz 50ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 16000hz 60ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 8000hz 10ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 8000hz 20ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 8000hz 30ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 8000hz 40ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 8000hz 50ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 8000hz 60ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 8000hz 70ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 8000hz 80ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 8000hz 90ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 8000hz 100ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 8000hz 110ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'L16' (RAW Signed Linear (16 bit)) 8000hz 120ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'PCMU' (G.711 ulaw) 8000hz 10ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'PCMU' (G.711 ulaw) 8000hz 20ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'PCMU' (G.711 ulaw) 8000hz 30ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'PCMU' (G.711 ulaw) 8000hz 40ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'PCMU' (G.711 ulaw) 8000hz 50ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'PCMU' (G.711 ulaw) 8000hz 60ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'PCMU' (G.711 ulaw) 8000hz 70ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'PCMU' (G.711 ulaw) 8000hz 80ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'PCMU' (G.711 ulaw) 8000hz 90ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'PCMU' (G.711 ulaw) 8000hz 100ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'PCMU' (G.711 ulaw) 8000hz 110ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'PCMU' (G.711 ulaw) 8000hz 120ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'PCMA' (G.711 alaw) 8000hz 10ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'PCMA' (G.711 alaw) 8000hz 20ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'PCMA' (G.711 alaw) 8000hz 30ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'PCMA' (G.711 alaw) 8000hz 40ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'PCMA' (G.711 alaw) 8000hz 50ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'PCMA' (G.711 alaw) 8000hz 60ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'PCMA' (G.711 alaw) 8000hz 70ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'PCMA' (G.711 alaw) 8000hz 80ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'PCMA' (G.711 alaw) 8000hz 90ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'PCMA' (G.711 alaw) 8000hz 100ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'PCMA' (G.711 alaw) 8000hz 110ms
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'PCMA' (G.711 alaw) 8000hz 120ms
2009-01-17 16:10:58 [CONSOLE] switch_loadable_module.c:1231 do_shutdown() Stopping: CORE_PCM_MODULE
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'socket'
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:536 switch_loadable_module_unprocess() Deleting API Function 'event_sink'
2009-01-17 16:10:58 [CONSOLE] switch_loadable_module.c:1231 do_shutdown() Stopping: mod_event_socket
2009-01-17 16:10:58 [NOTICE] switch_event.c:1189 switch_event_unbind() Event Binding deleted for mod_event_socket:ALL
2009-01-17 16:10:58 [NOTICE] mod_event_socket.c:2079 mod_event_socket_runtime() Shutting Down
2009-01-17 16:10:58 [NOTICE] switch_loadable_module.c:95 switch_loadable_module_exec() Thread ended for mod_event_socket
2009-01-17 16:10:59 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'AMR' (AMR) 8000hz 20ms
2009-01-17 16:10:59 [CONSOLE] switch_loadable_module.c:1234 do_shutdown() mod_amr has no shutdown routine
2009-01-17 16:10:59 [NOTICE] switch_loadable_module.c:434 switch_loadable_module_unprocess() Deleting Endpoint 'error'
2009-01-17 16:10:59 [NOTICE] switch_loadable_module.c:434 switch_loadable_module_unprocess() Deleting Endpoint 'group'
2009-01-17 16:10:59 [NOTICE] switch_loadable_module.c:434 switch_loadable_module_unprocess() Deleting Endpoint 'user'
2009-01-17 16:10:59 [NOTICE] switch_loadable_module.c:479 switch_loadable_module_unprocess() Deleting Dialplan 'inline'
2009-01-17 16:10:59 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'privacy'
2009-01-17 16:10:59 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'flush_dtmf'
2009-01-17 16:10:59 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'hold'
2009-01-17 16:10:59 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'unhold'
2009-01-17 16:10:59 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'transfer'
tport_wakeup_pri(01AE9650): events IN
tport_recv_event(01AE9650)
tport(01AE9650) msg 02F053A0 from (udp/192.168.0.74:5060) has 4 bytes, veclen = 1
tport(01AE9650): bad msg 02F053A0 (4 bytes) from udp/192.168.0.38:5060/sip next=00000000
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'check_acl'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'verbose_events'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'sleep'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'delay_echo'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'strftime'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'phrase'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'eval'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'pre_answer'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'answer'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'hangup'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'set_name'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'presence'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'log'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'info'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'event'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'export'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'set'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'set_global'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'set_profile_var'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'unset'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'ring_ready'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'remove_bugs'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'break'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'detect_speech'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'ivr'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'redirect'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'send_display'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'respond'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'deflect'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'queue_dtmf'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'send_dtmf'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'sched_hangup'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'sched_broadcast'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'sched_transfer'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'execute_extension'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'mkdir'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'soft_hold'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'bind_meta_app'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'unbind_meta_app'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'intercept'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'eavesdrop'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'three_way'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'set_user'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'stop_dtmf'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'start_dtmf'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'stop_dtmf_generate'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'start_dtmf_generate'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'stop_tone_detect'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'fax_detect'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'tone_detect'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'echo'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'park'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'park_state'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'gentones'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'playback'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'att_xfer'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'read'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'stop_record_session'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'record_session'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'record'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'stop_displace_session'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'displace_session'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'speak'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'clear_speech_cache'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'bridge'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'system'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'say'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:510 switch_loadable_module_unprocess() Deleting Application 'wait_for_silence'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:536 switch_loadable_module_unprocess() Deleting API Function 'strepoch'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:536 switch_loadable_module_unprocess() Deleting API Function 'chat'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:536 switch_loadable_module_unprocess() Deleting API Function 'strftime'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:536 switch_loadable_module_unprocess() Deleting API Function 'presence'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:677 switch_loadable_module_unprocess() Deleting Chat interface 'event'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:677 switch_loadable_module_unprocess() Deleting Chat interface 'api'
2009-01-17 16:11:03 [CONSOLE] switch_loadable_module.c:1234 do_shutdown() mod_dptools has no shutdown routine
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:455 switch_loadable_module_unprocess() Deleting Codec 'G723' (G.723.1 6.3k) 8000hz 30ms
2009-01-17 16:11:03 [CONSOLE] switch_loadable_module.c:1234 do_shutdown() mod_g723_1 has no shutdown routine
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:536 switch_loadable_module_unprocess() Deleting API Function 'console'
2009-01-17 16:11:03 [CONSOLE] switch_loadable_module.c:1231 do_shutdown() Stopping: mod_logfile
2009-01-17 16:11:03 [NOTICE] switch_event.c:1189 switch_event_unbind() Event Binding deleted for mod_logfile:TRAP
2009-01-17 16:11:03 [INFO] mod_logfile.c:391 mod_logfile_shutdown() Closing C:\Program Files\FreeSwitch\log\freeswitch.log
2009-01-17 16:11:03 [DEBUG] switch_loadable_module.c:427 switch_loadable_module_unprocess() Write lock interface 'sofia' to wait for existing references.
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:434 switch_loadable_module_unprocess() Deleting Endpoint 'sofia'
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:536 switch_loadable_module_unprocess() Deleting API Function 'sofia'
2009-01-17 16:11:03 [DEBUG] switch_loadable_module.c:538 switch_loadable_module_unprocess() Write lock interface 'sofia' to wait for existing references.
2009-01-17 16:11:03 [NOTICE] switch_loadable_module.c:536 switch_loadable_module_unprocess() Deleting API Function 'sofia_contact'
2009-01-17 16:11:03 [DEBUG] switch_loadable_module.c:538 switch_loadable_module_unprocess() Write lock interface 'sofia_contact' to wait for existing references.
2009-01-17 16:11:03 [DEBUG] switch_loadable_module.c:669 switch_loadable_module_unprocess() Write lock interface 'sip' to wait for existing referen
-------------- next part --------------
A non-text attachment was scrubbed...
Name: freeswitch.log
Type: application/octet-stream
Size: 148830 bytes
Desc: not available
Url : http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20090117/1e623650/attachment-0004.obj 
-------------- next part --------------
A non-text attachment was scrubbed...
Name: tport_sip.log
Type: application/octet-stream
Size: 21119 bytes
Desc: not available
Url : http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20090117/1e623650/attachment-0005.obj 


More information about the FreeSWITCH-users mailing list