freeswitch@spider> 2007-05-07 17:40:20 [NOTICE] switch_channel.c:372 switch_channel_set_name() New Chan sofia/mydomain.com/4765@192.168.1.206:5060 [efd6f154-fceb-11db-889f-3987eb2a4505]
2007-05-07 17:40:20 [DEBUG] sofia.c:987 sofia_handle_sip_i_state() Channel sofia/mydomain.com/4765@192.168.1.206:5060 entering state [received]
2007-05-07 17:40:20 [DEBUG] sofia.c:991 sofia_handle_sip_i_state() Remote SDP:
v=0
o=- 343918 343918 IN IP4 192.168.1.200
s=-
c=IN IP4 192.168.1.200
t=0 0
m=audio 16468 RTP/AVP 0 2 4 8 18 96 97 98 100 101
a=rtpmap:0 PCMU/8000
a=rtpmap:2 G726-32/8000
a=rtpmap:4 G723/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729a/8000
a=rtpmap:96 G726-40/8000
a=rtpmap:97 G726-24/8000
a=rtpmap:98 G726-16/8000
a=rtpmap:100 NSE/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:30

2007-05-07 17:40:20 [DEBUG] sofia_glue.c:1179 sofia_glue_negotiate_sdp() Audio Codec Compare [PCMU:0]/[PCMU:0]
2007-05-07 17:40:20 [DEBUG] sofia_glue.c:1217 sofia_glue_negotiate_sdp() Substituting codec PCMU@30ms
2007-05-07 17:40:20 [INFO] sofia_glue.c:835 sofia_glue_tech_set_codec() Set Codec sofia/mydomain.com/4765@192.168.1.206:5060 PCMU/8000 30 ms
2007-05-07 17:40:20 [DEBUG] sofia_glue.c:1151 sofia_glue_negotiate_sdp() Set 2833 dtmf payload to 101
2007-05-07 17:40:20 [DEBUG] sofia.c:1092 sofia_handle_sip_i_state() sofia/mydomain.com/4765@192.168.1.206:5060 State Change CS_NEW -> CS_INIT
2007-05-07 17:40:20 [DEBUG] switch_core_state_machine.c:378 switch_core_session_run() (sofia/mydomain.com/4765@192.168.1.206:5060) State INIT
2007-05-07 17:40:20 [DEBUG] mod_sofia.c:88 sofia_on_init() SOFIA INIT
2007-05-07 17:40:20 [DEBUG] mod_sofia.c:102 sofia_on_init() sofia/mydomain.com/4765@192.168.1.206:5060 State Change CS_INIT -> CS_RING
2007-05-07 17:40:20 [DEBUG] switch_core_state_machine.c:413 switch_core_session_run() (sofia/mydomain.com/4765@192.168.1.206:5060) State RING
2007-05-07 17:40:20 [DEBUG] mod_sofia.c:117 sofia_on_ring() SOFIA RING
2007-05-07 17:40:20 [DEBUG] switch_core_state_machine.c:56 switch_core_standard_on_ring() Standard RING sofia/mydomain.com/4765@192.168.1.206:5060
2007-05-07 17:40:20 [DEBUG] mod_enum.c:537 enum_dialplan_hunt() ENUM Lookup on 2003
2007-05-07 17:40:20 [DEBUG] mod_enum.c:202 dnserror() unable to lookup NAPTR record for 3.0.0.2.e164.org: domain name does not exist
2007-05-07 17:40:20 [INFO] mod_dialplan_xml.c:315 dialplan_hunt() Processing 4765->2003!
2007-05-07 17:40:20 [DEBUG] mod_dialplan_xml.c:115 parse_exten() test conditions destination_number(2003) =~ /^556$/
2007-05-07 17:40:20 [DEBUG] mod_dialplan_xml.c:117 parse_exten() Regex mismatch
2007-05-07 17:40:20 [DEBUG] mod_dialplan_xml.c:115 parse_exten() test conditions destination_number(2003) =~ /^(18(0{2}|8{2}|7{2}|6{2})\d{7})$/
2007-05-07 17:40:20 [DEBUG] mod_dialplan_xml.c:117 parse_exten() Regex mismatch
2007-05-07 17:40:20 [DEBUG] mod_dialplan_xml.c:115 parse_exten() test conditions source(mod_sofia) =~ /mod_portaudio/
2007-05-07 17:40:20 [DEBUG] mod_dialplan_xml.c:117 parse_exten() Regex mismatch
2007-05-07 17:40:20 [DEBUG] mod_dialplan_xml.c:115 parse_exten() test conditions destination_number(2003) =~ /^1234$/
2007-05-07 17:40:20 [DEBUG] mod_dialplan_xml.c:117 parse_exten() Regex mismatch
2007-05-07 17:40:20 [DEBUG] mod_dialplan_xml.c:115 parse_exten() test conditions destination_number(2003) =~ /^1000$/
2007-05-07 17:40:20 [DEBUG] mod_dialplan_xml.c:117 parse_exten() Regex mismatch
2007-05-07 17:40:20 [DEBUG] mod_dialplan_xml.c:115 parse_exten() test conditions destination_number(2003) =~ /^2001$/
2007-05-07 17:40:20 [DEBUG] mod_dialplan_xml.c:117 parse_exten() Regex mismatch
2007-05-07 17:40:20 [DEBUG] mod_dialplan_xml.c:115 parse_exten() test conditions destination_number(2003) =~ /^2004$/
2007-05-07 17:40:20 [DEBUG] mod_dialplan_xml.c:117 parse_exten() Regex mismatch
2007-05-07 17:40:20 [DEBUG] mod_dialplan_xml.c:115 parse_exten() test conditions destination_number(2003) =~ /^2002$/
2007-05-07 17:40:20 [DEBUG] mod_dialplan_xml.c:117 parse_exten() Regex mismatch
2007-05-07 17:40:20 [DEBUG] mod_dialplan_xml.c:115 parse_exten() test conditions destination_number(2003) =~ /^2003$/
2007-05-07 17:40:20 [DEBUG] mod_dialplan_xml.c:371 dialplan_hunt() sofia/mydomain.com/4765@192.168.1.206:5060 State Change CS_RING -> CS_EXECUTE
2007-05-07 17:40:20 [DEBUG] switch_core_state_machine.c:448 switch_core_session_run() (sofia/mydomain.com/4765@192.168.1.206:5060) State EXECUTE
2007-05-07 17:40:20 [DEBUG] mod_sofia.c:134 sofia_on_execute() SOFIA EXECUTE
2007-05-07 17:40:20 [DEBUG] switch_core_state_machine.c:114 switch_core_standard_on_execute() Standard EXECUTE
2007-05-07 17:40:20 [NOTICE] switch_core_state_machine.c:124 switch_core_standard_on_execute() Execute python(/usr/src/freeswitch/scripts/py_reload_bug.py)
2007-05-07 17:40:20 [NOTICE] mod_python.c:83 eval_some_python() running /usr/src/freeswitch/scripts/py_reload_bug.py
Traceback (most recent call last):
  File "/usr/lib/python2.4/site-packages/setuptools-0.6c3-py2.4.egg/", line 1, in ?

  File "/usr/lib/python2.4/site-packages/twisted/__init__.py", line 19, in ?
    from zope.interface import Interface
  File "/usr/lib/python2.4/site-packages/zope/interface/__init__.py", line 58, in ?
    _wire()
  File "/usr/lib/python2.4/site-packages/zope/interface/interface.py", line 936, in _wire
    classImplements(Attribute, IAttribute)
  File "/usr/lib/python2.4/site-packages/zope/interface/declarations.py", line 464, in classImplements
    spec = implementedBy(cls)
  File "/usr/lib/python2.4/site-packages/zope/interface/declarations.py", line 330, in implementedByFallback
    if isinstance(spec, Implements):
TypeError: 'NoneType' object is not callable
2007-05-07 17:40:21 [NOTICE] switch_core_state_machine.c:178 switch_core_standard_on_execute() Hangup sofia/mydomain.com/4765@192.168.1.206:5060 [CS_EXECUTE] [NORMAL_CLEARING]
2007-05-07 17:40:21 [INFO] switch_channel.c:1055 switch_channel_perform_hangup() Kill sofia/mydomain.com/4765@192.168.1.206:5060 [KILL]
2007-05-07 17:40:21 [DEBUG] switch_core_state_machine.c:342 switch_core_session_run() (sofia/mydomain.com/4765@192.168.1.206:5060) State HANGUP
2007-05-07 17:40:21 [DEBUG] mod_sofia.c:214 sofia_on_hangup() Channel sofia/mydomain.com/4765@192.168.1.206:5060 hanging up, cause: NORMAL_CLEARING
2007-05-07 17:40:21 [DEBUG] mod_sofia.c:234 sofia_on_hangup() Responding to INVITE with: 480
2007-05-07 17:40:21 [DEBUG] sofia.c:74 sofia_event_callback() event [nua_i_state] status [480][Call state] session: sofia/mydomain.com/4765@192.168.1.206:5060
2007-05-07 17:40:21 [DEBUG] sofia.c:987 sofia_handle_sip_i_state() Channel sofia/mydomain.com/4765@192.168.1.206:5060 entering state [terminated]
2007-05-07 17:40:21 [DEBUG] switch_core_state_machine.c:45 switch_core_standard_on_hangup() Standard HANGUP sofia/mydomain.com/4765@192.168.1.206:5060, cause: NORMAL_CLEARING
2007-05-07 17:40:21 [DEBUG] switch_core_session.c:696 switch_core_session_thread() Session 2 (sofia/mydomain.com/4765@192.168.1.206:5060) Locked, Waiting on external entities
2007-05-07 17:40:21 [INFO] switch_core_session.c:702 switch_core_session_thread() Session 2 (sofia/mydomain.com/4765@192.168.1.206:5060) Ended
2007-05-07 17:40:21 [NOTICE] switch_core_session.c:654 switch_core_session_destroy() Close Channel sofia/mydomain.com/4765@192.168.1.206:5060