2008-03-04 19:51:29 [NOTICE] switch_channel.c:1343 switch_channel_perform_mark_pre_answered() Ring-Ready sofia/192.168.1.101/nobody@192.168.1.101:6087!
2008-03-04 19:51:29 [NOTICE] mod_sofia.c:1017 sofia_receive_message() Pre-Answer sofia/192.168.1.101/nobody@192.168.1.101:6087!
2008-03-04 19:51:29 [DEBUG] sofia.c:221 sofia_event_callback() event [nua_i_state] status [183][Session Progress] session: sofia/192.168.1.101/nobody@192.168.1.101:6087
2008-03-04 19:51:29 [DEBUG] sofia.c:1450 sofia_handle_sip_i_state() Channel sofia/192.168.1.101/nobody@192.168.1.101:6087 entering state [early]
2008-03-04 19:51:29 [DEBUG] switch_core_session.c:354 switch_core_session_receive_message() Kill sofia/192.168.1.101/nobody@192.168.1.101:6087 [BREAK]
2008-03-04 19:51:29 [NOTICE] mod_python.c:86 eval_some_python() Invoking py module: wikipbx.ivr.voicemail
2008-03-04 19:51:29 [DEBUG] mod_python.c:147 eval_some_python() Call python scri
pt 
2008-03-04 19:51:29 [INFO] switch_cpp.cpp:477 console_log() Voicemail recorder starting ..
2008-03-04 19:51:29 [DEBUG] freeswitch_python.cpp:225 begin_allow_threads() PySession::begin_allow_threads() called
2008-03-04 19:51:29 [DEBUG] freeswitch_python.cpp:240 begin_allow_threads() Threadstate swap-out!
2008-03-04 19:51:29 [DEBUG] freeswitch_python.cpp:242 begin_allow_threads() swapin_tstate: 0x88d41f8
2008-03-04 19:51:29 [DEBUG] mod_sndfile.c:170 sndfile_file_open() Opening File [/tmp/wikipbx/tts/0f8bd56fa7a8e76c1323d3dacc591754-william.wav] rate 8000hz
2008-03-04 19:51:29 [DEBUG] switch_ivr_play_say.c:814 switch_ivr_play_file() Codec Activated L16@8000hz 1 channels 20ms
2008-03-04 19:51:32 [DEBUG] switch_ivr_play_say.c:1062 switch_ivr_play_file() done playing file
2008-03-04 19:51:32 [DEBUG] freeswitch_python.cpp:259 end_allow_threads() PySession::end_allow_threads() called
2008-03-04 19:51:32 [DEBUG] freeswitch_python.cpp:274 end_allow_threads() Threadstate swap-in!
2008-03-04 19:51:32 [DEBUG] freeswitch_python.cpp:275 end_allow_threads() swapin_tstate: 0x88d41f8