rendered paste body
Jun 3 17:13:57 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:13:57.764218 [DEBUG] switch_rtp.c:3302 RTP RECV DTMF 9:800
Jun 3 17:13:57 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:13:57.764218 [DEBUG] mod_erlang_event.c:149 Sending event DTMF to attached session ba128689636793b8
Jun 3 17:13:57 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(undefined): <<"DTMF">>. Sendable: true
Jun 3 17:13:58 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:13:58.031806 [DEBUG] switch_rtp.c:3302 RTP RECV DTMF 0:800
Jun 3 17:13:58 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:13:58.031806 [DEBUG] mod_erlang_event.c:149 Sending event DTMF to attached session ba128689636793b8
Jun 3 17:13:58 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(undefined): <<"DTMF">>. Sendable: true
Jun 3 17:13:58 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:13:58.298145 [DEBUG] switch_rtp.c:3302 RTP RECV DTMF 5:640
Jun 3 17:13:58 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:13:58.298145 [DEBUG] mod_erlang_event.c:149 Sending event DTMF to attached session ba128689636793b8
Jun 3 17:13:58 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(undefined): <<"DTMF">>. Sendable: true
Jun 3 17:13:58 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:13:58.483561 [DEBUG] switch_rtp.c:3302 RTP RECV DTMF 5:880
Jun 3 17:13:58 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:13:58.483561 [DEBUG] mod_erlang_event.c:149 Sending event DTMF to attached session ba128689636793b8
Jun 3 17:13:58 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(undefined): <<"DTMF">>. Sendable: true
Jun 3 17:13:58 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:13:58.749712 [DEBUG] switch_rtp.c:3302 RTP RECV DTMF #:1040
Jun 3 17:13:58 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:13:58.749712 [DEBUG] switch_ivr_play_say.c:1992 Test Regex [9055][\d+]
Jun 3 17:13:58 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:13:58.749712 [DEBUG] mod_erlang_event.c:149 Sending event DTMF to attached session ba128689636793b8
Jun 3 17:13:58 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:13:58.749712 [DEBUG] mod_erlang_event.c:149 Sending event CHANNEL_EXECUTE_COMPLETE to attached session ba128689636793b8
Jun 3 17:13:58 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(undefined): <<"DTMF">>. Sendable: true
Jun 3 17:13:58 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(<<"play_and_get_digits">>): <<"CHANNEL_EXECUTE_COMPLETE">>. Sendable: true
Jun 3 17:13:58 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: CONTROL(<0.17662.0>): Command <<"play_and_get_digits">> execution complete, advance call-id <<"ba128689636793b8">> running <<"play_and_collect_digits">>
Jun 3 17:13:58 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: CONTROL(<0.17662.0>): Recv App queue, insert-at: tail
Jun 3 17:13:58 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: CONTROL.queue: insert Cmd: <<"play">>
Jun 3 17:13:58 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: CONTROL.queue: insert Cmd: <<"say">>
Jun 3 17:13:58 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: CONTROL.queue: insert Cmd: <<"play">>
Jun 3 17:13:58 whistle1 last message repeated 2 times
Jun 3 17:13:58 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: CONTROL.queue: insert Cmd: <<"say">>
Jun 3 17:13:58 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: CONTROL.queue: insert Cmd: <<"play">>
Jun 3 17:13:58 whistle1 last message repeated 3 times
Jun 3 17:13:58 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: CONTROL.queue: insert Cmd: <<"say">>
Jun 3 17:13:58 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: CONTROL.queue: insert Cmd: <<"play">>
Jun 3 17:13:58 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: CONTROL.queue: insert Cmd: <<"play">>
Jun 3 17:13:58 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: CONTROL.queue: insert Cmd: <<"say">>
Jun 3 17:13:58 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: CONTROL.queue: insert Cmd: <<"play">>
Jun 3 17:13:58 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: CONTROL.queue: insert Cmd: <<"play">>
Jun 3 17:13:58 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: CONTROL.queue: insert Cmd: <<"say">>
Jun 3 17:13:58 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: CONTROL.queue: insert Cmd: <<"play">>
Jun 3 17:13:58 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: CONTROL.queue: insert Cmd: <<"play">>
Jun 3 17:13:58 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: CONTROL.queue: insert Cmd: <<"say">>
Jun 3 17:13:58 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: ECALL_MEDREG(<0.131.0>): {lookup_local, <<"/system_media/vm-you_have">>, <<"ba128689636793b8">>}
Jun 3 17:13:58 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: WORKER-F(<0.111.0>): Working for <0.17662.0> and sent {"Stream-Type":"new","Media-Name":"/system_media/vm-you_have","App-Version":"0.7.2","App-Name":"ecallmgr","Event-Name":"media_req","Event-Category":"media","Server-ID":"amq.gen-iRkUU6tlZfKmKqx8jM/xOg=="}
Jun 3 17:13:58 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: MEDIA_SRV(<0.269.0>): Recv JSON: <<"{\"Stream-Type\":\"new\",\"Media-Name\":\"/system_media/vm-you_have\",\"App-Version\":\"0.7.2\",\"App-Name\":\"ecallmgr\",\"Event-Name\":\"media_req\",\"Event-Category\":\"media\",\"Server-ID\":\"amq.gen-iRkUU6tlZfKmKqx8jM/xOg==\"}">>
Jun 3 17:13:58 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: MEDIA_SRV(<0.25783.14>): Starting stream
Jun 3 17:13:58 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: Starting up SHOUT on #Port<0.14864> for Media <<"/system_media/vm-you_have">> of type single
Jun 3 17:13:58 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: MEDIA_SRV(<0.25783.14>): Req handled
Jun 3 17:13:58 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT(<0.25785.14>): Send <<"http://whistle1.vinixtech.com:58221/stream.wav">> to [<<"amq.gen-iRkUU6tlZfKmKqx8jM/xOg==">>]
Jun 3 17:13:58 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT.accept(<0.25788.14>): Stream Acceptor started
Jun 3 17:13:58 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT(<0.25785.14>): Sending {"Stream-URL":"http://whistle1.vinixtech.com:58221/stream.wav","Media-Name":"/system_media/vm-you_have","App-Version":"0.2.0","App-Name":"media_srv","Event-Name":"media_resp","Event-Category":"media","Server-ID":""} to <<"amq.gen-iRkUU6tlZfKmKqx8jM/xOg==">>
Jun 3 17:13:58 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: MEDIA_SHOUT(<0.25785.14>): Recv info {'EXIT',<0.25787.14>,normal}
Jun 3 17:13:58 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: WORKER-B(<0.111.0>): Recv payload response (12 ms)
Jun 3 17:13:58 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: CONTROL(<0.17662.0>): SendMsg -> Node: 'freeswitch@whistle1.vinixtech.com' UUID: <<"ba128689636793b8">> App: "set" Args: "playback_terminators=123456789*0#"
Jun 3 17:13:58 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:13:58.903202 [DEBUG] switch_core_session.c:956 Send signal sofia/sipinterface_1/neurooffice@whistle1.vinixtech.com:5060 [BREAK]
Jun 3 17:13:58 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: CONTROL(<0.17662.0>): SendMsg -> Node: 'freeswitch@whistle1.vinixtech.com' UUID: <<"ba128689636793b8">> App: "playback" Args: "shell_stream:///usr/local/bin/fetch_remote_audio.sh http://whistle1.vinixtech.com:58221/stream.wav"
Jun 3 17:13:58 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:13:58.903202 [DEBUG] switch_core_session.c:956 Send signal sofia/sipinterface_1/neurooffice@whistle1.vinixtech.com:5060 [BREAK]
Jun 3 17:13:58 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:13:58.934490 [DEBUG] switch_ivr.c:567 sofia/sipinterface_1/neurooffice@whistle1.vinixtech.com:5060 Command Execute set(playback_terminators=123456789*0#)
Jun 3 17:13:58 whistle1 freeswitch[12883]: ba128689636793b8 EXECUTE sofia/sipinterface_1/neurooffice@whistle1.vinixtech.com:5060 set(playback_terminators=123456789*0#)
Jun 3 17:13:58 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:13:58.934490 [DEBUG] mod_dptools.c:1063 sofia/sipinterface_1/neurooffice@whistle1.vinixtech.com:5060 SET [playback_terminators]=[123456789*0#]
Jun 3 17:13:58 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:13:58.934490 [DEBUG] mod_erlang_event.c:149 Sending event CHANNEL_EXECUTE to attached session ba128689636793b8
Jun 3 17:13:58 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:13:58.934490 [DEBUG] switch_ivr.c:567 sofia/sipinterface_1/neurooffice@whistle1.vinixtech.com:5060 Command Execute playback(shell_stream:///usr/local/bin/fetch_remote_audio.sh http://whistle1.vinixtech.com:58221/stream.wav)
Jun 3 17:13:58 whistle1 freeswitch[12883]: ba128689636793b8 EXECUTE sofia/sipinterface_1/neurooffice@whistle1.vinixtech.com:5060 playback(shell_stream:///usr/local/bin/fetch_remote_audio.sh http://whistle1.vinixtech.com:58221/stream.wav)
Jun 3 17:13:58 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:13:58.934490 [DEBUG] mod_erlang_event.c:149 Sending event CHANNEL_EXECUTE_COMPLETE to attached session ba128689636793b8
Jun 3 17:13:58 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:13:58.955851 [DEBUG] mod_erlang_event.c:149 Sending event CHANNEL_EXECUTE to attached session ba128689636793b8
Jun 3 17:13:58 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT.accept(<0.25792.14>): Stream Acceptor started
Jun 3 17:13:59 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT.accept(<0.25788.14>): Listening on #Port<0.14931>: Req: "GET /stream.wav HTTP/1.1\r\nUser-Agent: curl/7.20.1 (x86_64-unknown-linux-gnu) libcurl/7.20.1 OpenSSL/0.9.8b zlib/1.2.3\r\nHost: whistle1.vinixtech.com:58221\r\nAccept: */*"
Jun 3 17:13:59 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT.mloop(<0.25791.14>): Adding first socket: #Port<0.14931> Sending Resp Headers: ["HTTP/1.1 200 OK\r\n", "Server: ", <<"media_srv">>, "/", <<"0.2.0">>, "\r\n", "Content-Type: ", "audio/x-wav", "\r\n",
Jun 3 17:13:59 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT.mloop(<0.25791.14>): Playing from 0 (8988)
Jun 3 17:13:59 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT.mloop(<0.25791.14>): done playing, bye!
Jun 3 17:13:59 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT(<0.25785.14>): MediaLoop <0.25791.14> went down normal, stopping
Jun 3 17:13:59 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT(<0.25785.14>): Closing socket and shutting down: normal
Jun 3 17:13:59 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(<<"set">>): <<"CHANNEL_EXECUTE">>. Sendable: true
Jun 3 17:13:59 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:13:59.007668 [DEBUG] switch_ivr_play_say.c:1279 Codec Activated L16@8000hz 1 channels 30ms
Jun 3 17:13:59 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:13:59.007668 [DEBUG] mod_erlang_event.c:149 Sending event PLAYBACK_START to attached session ba128689636793b8
Jun 3 17:13:59 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(<<"set">>): <<"CHANNEL_EXECUTE_COMPLETE">>. Sendable: true
Jun 3 17:13:59 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(<<"playback">>): <<"CHANNEL_EXECUTE">>. Sendable: true
Jun 3 17:13:59 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(undefined): <<"PLAYBACK_START">>. Sendable: true
Jun 3 17:13:59 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17793.0>): Skipped event <<"PLAYBACK_START">>
Jun 3 17:13:59 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:13:59.558385 [DEBUG] switch_ivr_play_say.c:1649 done playing file
Jun 3 17:13:59 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:13:59.558385 [DEBUG] mod_erlang_event.c:149 Sending event PLAYBACK_STOP to attached session ba128689636793b8
Jun 3 17:13:59 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:13:59.558385 [DEBUG] mod_erlang_event.c:149 Sending event CHANNEL_EXECUTE_COMPLETE to attached session ba128689636793b8
Jun 3 17:13:59 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(undefined): <<"PLAYBACK_STOP">>. Sendable: true
Jun 3 17:13:59 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17794.0>): Skipped event <<"PLAYBACK_STOP">>
Jun 3 17:13:59 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(<<"playback">>): <<"CHANNEL_EXECUTE_COMPLETE">>. Sendable: true
Jun 3 17:13:59 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: CONTROL(<0.17662.0>): Command <<"playback">> execution complete, advance call-id <<"ba128689636793b8">> running <<"play">>
Jun 3 17:13:59 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: BUILT COMMAND: conference <<"en name_spelled pronounced 0">>
Jun 3 17:13:59 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: CONTROL(<0.17662.0>): SendMsg -> Node: 'freeswitch@whistle1.vinixtech.com' UUID: <<"ba128689636793b8">> App: "say" Args: "en name_spelled pronounced 0"
Jun 3 17:13:59 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:13:59.702432 [DEBUG] switch_core_session.c:956 Send signal sofia/sipinterface_1/neurooffice@whistle1.vinixtech.com:5060 [BREAK]
Jun 3 17:13:59 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:13:59.713272 [DEBUG] switch_ivr.c:567 sofia/sipinterface_1/neurooffice@whistle1.vinixtech.com:5060 Command Execute say(en name_spelled pronounced 0)
Jun 3 17:13:59 whistle1 freeswitch[12883]: ba128689636793b8 EXECUTE sofia/sipinterface_1/neurooffice@whistle1.vinixtech.com:5060 say(en name_spelled pronounced 0)
Jun 3 17:13:59 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:13:59.713272 [DEBUG] mod_erlang_event.c:149 Sending event CHANNEL_EXECUTE to attached session ba128689636793b8
Jun 3 17:13:59 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:13:59.713272 [DEBUG] switch_ivr_play_say.c:1279 Codec Activated L16@8000hz 1 channels 30ms
Jun 3 17:13:59 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:13:59.713272 [DEBUG] mod_erlang_event.c:149 Sending event PLAYBACK_START to attached session ba128689636793b8
Jun 3 17:13:59 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(<<"say">>): <<"CHANNEL_EXECUTE">>. Sendable: true
Jun 3 17:13:59 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(undefined): <<"PLAYBACK_START">>. Sendable: true
Jun 3 17:13:59 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17801.0>): Skipped event <<"PLAYBACK_START">>
Jun 3 17:14:00 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:00.489976 [DEBUG] switch_ivr_play_say.c:1649 done playing file
Jun 3 17:14:00 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:00.489976 [DEBUG] mod_erlang_event.c:149 Sending event PLAYBACK_STOP to attached session ba128689636793b8
Jun 3 17:14:00 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:00.489976 [DEBUG] mod_erlang_event.c:149 Sending event CHANNEL_EXECUTE_COMPLETE to attached session ba128689636793b8
Jun 3 17:14:00 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(undefined): <<"PLAYBACK_STOP">>. Sendable: true
Jun 3 17:14:00 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17802.0>): Skipped event <<"PLAYBACK_STOP">>
Jun 3 17:14:00 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(<<"say">>): <<"CHANNEL_EXECUTE_COMPLETE">>. Sendable: true
Jun 3 17:14:00 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: CONTROL(<0.17662.0>): Command <<"say">> execution complete, advance call-id <<"ba128689636793b8">> running <<"say">>
Jun 3 17:14:00 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: ECALL_MEDREG(<0.131.0>): {lookup_local, <<"/system_media/vm-new">>, <<"ba128689636793b8">>}
Jun 3 17:14:00 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: WORKER-F(<0.106.0>): Working for <0.17662.0> and sent {"Stream-Type":"new","Media-Name":"/system_media/vm-new","App-Version":"0.7.2","App-Name":"ecallmgr","Event-Name":"media_req","Event-Category":"media","Server-ID":"amq.gen-w8PCZAobnYXjh+dJiHi66g=="}
Jun 3 17:14:00 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: MEDIA_SRV(<0.269.0>): Recv JSON: <<"{\"Stream-Type\":\"new\",\"Media-Name\":\"/system_media/vm-new\",\"App-Version\":\"0.7.2\",\"App-Name\":\"ecallmgr\",\"Event-Name\":\"media_req\",\"Event-Category\":\"media\",\"Server-ID\":\"amq.gen-w8PCZAobnYXjh+dJiHi66g==\"}">>
Jun 3 17:14:00 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: MEDIA_SRV(<0.25809.14>): Starting stream
Jun 3 17:14:00 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: Starting up SHOUT on #Port<0.14908> for Media <<"/system_media/vm-new">> of type single
Jun 3 17:14:00 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: MEDIA_SRV(<0.25809.14>): Req handled
Jun 3 17:14:00 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT(<0.25811.14>): Send <<"http://whistle1.vinixtech.com:59297/stream.wav">> to [<<"amq.gen-w8PCZAobnYXjh+dJiHi66g==">>]
Jun 3 17:14:00 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT.accept(<0.25814.14>): Stream Acceptor started
Jun 3 17:14:00 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT(<0.25811.14>): Sending {"Stream-URL":"http://whistle1.vinixtech.com:59297/stream.wav","Media-Name":"/system_media/vm-new","App-Version":"0.2.0","App-Name":"media_srv","Event-Name":"media_resp","Event-Category":"media","Server-ID":""} to <<"amq.gen-w8PCZAobnYXjh+dJiHi66g==">>
Jun 3 17:14:00 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: MEDIA_SHOUT(<0.25811.14>): Recv info {'EXIT',<0.25813.14>,normal}
Jun 3 17:14:00 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: WORKER-B(<0.106.0>): Recv payload response (12 ms)
Jun 3 17:14:00 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: CONTROL(<0.17662.0>): SendMsg -> Node: 'freeswitch@whistle1.vinixtech.com' UUID: <<"ba128689636793b8">> App: "set" Args: "playback_terminators=123456789*0#"
Jun 3 17:14:00 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:00.624713 [DEBUG] switch_core_session.c:956 Send signal sofia/sipinterface_1/neurooffice@whistle1.vinixtech.com:5060 [BREAK]
Jun 3 17:14:00 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: CONTROL(<0.17662.0>): SendMsg -> Node: 'freeswitch@whistle1.vinixtech.com' UUID: <<"ba128689636793b8">> App: "playback" Args: "shell_stream:///usr/local/bin/fetch_remote_audio.sh http://whistle1.vinixtech.com:59297/stream.wav"
Jun 3 17:14:00 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:00.624713 [DEBUG] switch_core_session.c:956 Send signal sofia/sipinterface_1/neurooffice@whistle1.vinixtech.com:5060 [BREAK]
Jun 3 17:14:00 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:00.634814 [DEBUG] switch_ivr.c:567 sofia/sipinterface_1/neurooffice@whistle1.vinixtech.com:5060 Command Execute set(playback_terminators=123456789*0#)
Jun 3 17:14:00 whistle1 freeswitch[12883]: ba128689636793b8 EXECUTE sofia/sipinterface_1/neurooffice@whistle1.vinixtech.com:5060 set(playback_terminators=123456789*0#)
Jun 3 17:14:00 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:00.634814 [DEBUG] mod_dptools.c:1063 sofia/sipinterface_1/neurooffice@whistle1.vinixtech.com:5060 SET [playback_terminators]=[123456789*0#]
Jun 3 17:14:00 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:00.634814 [DEBUG] mod_erlang_event.c:149 Sending event CHANNEL_EXECUTE to attached session ba128689636793b8
Jun 3 17:14:00 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:00.634814 [DEBUG] mod_erlang_event.c:149 Sending event CHANNEL_EXECUTE_COMPLETE to attached session ba128689636793b8
Jun 3 17:14:00 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:00.634814 [DEBUG] switch_ivr.c:567 sofia/sipinterface_1/neurooffice@whistle1.vinixtech.com:5060 Command Execute playback(shell_stream:///usr/local/bin/fetch_remote_audio.sh http://whistle1.vinixtech.com:59297/stream.wav)
Jun 3 17:14:00 whistle1 freeswitch[12883]: ba128689636793b8 EXECUTE sofia/sipinterface_1/neurooffice@whistle1.vinixtech.com:5060 playback(shell_stream:///usr/local/bin/fetch_remote_audio.sh http://whistle1.vinixtech.com:59297/stream.wav)
Jun 3 17:14:00 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:00.634814 [DEBUG] mod_erlang_event.c:149 Sending event CHANNEL_EXECUTE to attached session ba128689636793b8
Jun 3 17:14:00 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT.accept(<0.25818.14>): Stream Acceptor started
Jun 3 17:14:00 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT.accept(<0.25814.14>): Listening on #Port<0.14935>: Req: "GET /stream.wav HTTP/1.1\r\nUser-Agent: curl/7.20.1 (x86_64-unknown-linux-gnu) libcurl/7.20.1 OpenSSL/0.9.8b zlib/1.2.3\r\nHost: whistle1.vinixtech.com:59297\r\nAccept: */*"
Jun 3 17:14:00 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT.mloop(<0.25817.14>): Adding first socket: #Port<0.14935> Sending Resp Headers: ["HTTP/1.1 200 OK\r\n", "Server: ", <<"media_srv">>, "/", <<"0.2.0">>, "\r\n", "Content-Type: ", "audio/x-wav", "\r\n",
Jun 3 17:14:00 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT.mloop(<0.25817.14>): Playing from 0 (5480)
Jun 3 17:14:00 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT.mloop(<0.25817.14>): done playing, bye!
Jun 3 17:14:00 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT(<0.25811.14>): MediaLoop <0.25817.14> went down normal, stopping
Jun 3 17:14:00 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT(<0.25811.14>): Closing socket and shutting down: normal
Jun 3 17:14:00 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:00.719004 [DEBUG] switch_ivr_play_say.c:1279 Codec Activated L16@8000hz 1 channels 30ms
Jun 3 17:14:00 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:00.719004 [DEBUG] mod_erlang_event.c:149 Sending event PLAYBACK_START to attached session ba128689636793b8
Jun 3 17:14:00 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(<<"set">>): <<"CHANNEL_EXECUTE">>. Sendable: true
Jun 3 17:14:00 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(<<"set">>): <<"CHANNEL_EXECUTE_COMPLETE">>. Sendable: true
Jun 3 17:14:00 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(<<"playback">>): <<"CHANNEL_EXECUTE">>. Sendable: true
Jun 3 17:14:01 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(undefined): <<"PLAYBACK_START">>. Sendable: true
Jun 3 17:14:01 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17818.0>): Skipped event <<"PLAYBACK_START">>
Jun 3 17:14:01 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:01.064431 [DEBUG] switch_ivr_play_say.c:1649 done playing file
Jun 3 17:14:01 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:01.064431 [DEBUG] mod_erlang_event.c:149 Sending event PLAYBACK_STOP to attached session ba128689636793b8
Jun 3 17:14:01 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:01.064431 [DEBUG] mod_erlang_event.c:149 Sending event CHANNEL_EXECUTE_COMPLETE to attached session ba128689636793b8
Jun 3 17:14:01 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(undefined): <<"PLAYBACK_STOP">>. Sendable: true
Jun 3 17:14:01 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17819.0>): Skipped event <<"PLAYBACK_STOP">>
Jun 3 17:14:01 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(<<"playback">>): <<"CHANNEL_EXECUTE_COMPLETE">>. Sendable: true
Jun 3 17:14:01 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: CONTROL(<0.17662.0>): Command <<"playback">> execution complete, advance call-id <<"ba128689636793b8">> running <<"play">>
Jun 3 17:14:01 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: ECALL_MEDREG(<0.131.0>): {lookup_local, <<"/system_media/vm-messages">>, <<"ba128689636793b8">>}
Jun 3 17:14:01 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: MEDIA_SRV(<0.269.0>): Recv JSON: <<"{\"Stream-Type\":\"new\",\"Media-Name\":\"/system_media/vm-messages\",\"App-Version\":\"0.7.2\",\"App-Name\":\"ecallmgr\",\"Event-Name\":\"media_req\",\"Event-Category\":\"media\",\"Server-ID\":\"amq.gen-kABY8iRiSHHDBcFdF4AkFQ==\"}">>
Jun 3 17:14:01 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: WORKER-F(<0.109.0>): Working for <0.17662.0> and sent {"Stream-Type":"new","Media-Name":"/system_media/vm-messages","App-Version":"0.7.2","App-Name":"ecallmgr","Event-Name":"media_req","Event-Category":"media","Server-ID":"amq.gen-kABY8iRiSHHDBcFdF4AkFQ=="}
Jun 3 17:14:01 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: MEDIA_SRV(<0.25820.14>): Starting stream
Jun 3 17:14:01 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: Starting up SHOUT on #Port<0.14909> for Media <<"/system_media/vm-messages">> of type single
Jun 3 17:14:01 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: MEDIA_SRV(<0.25820.14>): Req handled
Jun 3 17:14:01 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT(<0.25822.14>): Send <<"http://whistle1.vinixtech.com:58095/stream.wav">> to [<<"amq.gen-kABY8iRiSHHDBcFdF4AkFQ==">>]
Jun 3 17:14:01 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT.accept(<0.25825.14>): Stream Acceptor started
Jun 3 17:14:01 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT(<0.25822.14>): Sending {"Stream-URL":"http://whistle1.vinixtech.com:58095/stream.wav","Media-Name":"/system_media/vm-messages","App-Version":"0.2.0","App-Name":"media_srv","Event-Name":"media_resp","Event-Category":"media","Server-ID":""} to <<"amq.gen-kABY8iRiSHHDBcFdF4AkFQ==">>
Jun 3 17:14:01 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: MEDIA_SHOUT(<0.25822.14>): Recv info {'EXIT',<0.25824.14>,normal}
Jun 3 17:14:01 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: WORKER-B(<0.109.0>): Recv payload response (9 ms)
Jun 3 17:14:01 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: CONTROL(<0.17662.0>): SendMsg -> Node: 'freeswitch@whistle1.vinixtech.com' UUID: <<"ba128689636793b8">> App: "set" Args: "playback_terminators=123456789*0#"
Jun 3 17:14:01 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:01.247691 [DEBUG] switch_core_session.c:956 Send signal sofia/sipinterface_1/neurooffice@whistle1.vinixtech.com:5060 [BREAK]
Jun 3 17:14:01 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: CONTROL(<0.17662.0>): SendMsg -> Node: 'freeswitch@whistle1.vinixtech.com' UUID: <<"ba128689636793b8">> App: "playback" Args: "shell_stream:///usr/local/bin/fetch_remote_audio.sh http://whistle1.vinixtech.com:58095/stream.wav"
Jun 3 17:14:01 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:01.247691 [DEBUG] switch_core_session.c:956 Send signal sofia/sipinterface_1/neurooffice@whistle1.vinixtech.com:5060 [BREAK]
Jun 3 17:14:01 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:01.267907 [DEBUG] switch_ivr.c:567 sofia/sipinterface_1/neurooffice@whistle1.vinixtech.com:5060 Command Execute set(playback_terminators=123456789*0#)
Jun 3 17:14:01 whistle1 freeswitch[12883]: ba128689636793b8 EXECUTE sofia/sipinterface_1/neurooffice@whistle1.vinixtech.com:5060 set(playback_terminators=123456789*0#)
Jun 3 17:14:01 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:01.267907 [DEBUG] mod_dptools.c:1063 sofia/sipinterface_1/neurooffice@whistle1.vinixtech.com:5060 SET [playback_terminators]=[123456789*0#]
Jun 3 17:14:01 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:01.267907 [DEBUG] mod_erlang_event.c:149 Sending event CHANNEL_EXECUTE to attached session ba128689636793b8
Jun 3 17:14:01 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:01.267907 [DEBUG] switch_ivr.c:567 sofia/sipinterface_1/neurooffice@whistle1.vinixtech.com:5060 Command Execute playback(shell_stream:///usr/local/bin/fetch_remote_audio.sh http://whistle1.vinixtech.com:58095/stream.wav)
Jun 3 17:14:01 whistle1 freeswitch[12883]: ba128689636793b8 EXECUTE sofia/sipinterface_1/neurooffice@whistle1.vinixtech.com:5060 playback(shell_stream:///usr/local/bin/fetch_remote_audio.sh http://whistle1.vinixtech.com:58095/stream.wav)
Jun 3 17:14:01 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:01.267907 [DEBUG] mod_erlang_event.c:149 Sending event CHANNEL_EXECUTE_COMPLETE to attached session ba128689636793b8
Jun 3 17:14:01 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:01.267907 [DEBUG] mod_erlang_event.c:149 Sending event CHANNEL_EXECUTE to attached session ba128689636793b8
Jun 3 17:14:01 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT.accept(<0.25829.14>): Stream Acceptor started
Jun 3 17:14:01 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT.accept(<0.25825.14>): Listening on #Port<0.14939>: Req: "GET /stream.wav HTTP/1.1\r\nUser-Agent: curl/7.20.1 (x86_64-unknown-linux-gnu) libcurl/7.20.1 OpenSSL/0.9.8b zlib/1.2.3\r\nHost: whistle1.vinixtech.com:58095\r\nAccept: */*"
Jun 3 17:14:01 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT.mloop(<0.25828.14>): Adding first socket: #Port<0.14939> Sending Resp Headers: ["HTTP/1.1 200 OK\r\n", "Server: ", <<"media_srv">>, "/", <<"0.2.0">>, "\r\n", "Content-Type: ", "audio/x-wav", "\r\n",
Jun 3 17:14:01 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT.mloop(<0.25828.14>): Playing from 0 (10572)
Jun 3 17:14:01 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT.mloop(<0.25828.14>): done playing, bye!
Jun 3 17:14:01 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT(<0.25822.14>): MediaLoop <0.25828.14> went down normal, stopping
Jun 3 17:14:01 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT(<0.25822.14>): Closing socket and shutting down: normal
Jun 3 17:14:01 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:01.351153 [DEBUG] switch_ivr_play_say.c:1279 Codec Activated L16@8000hz 1 channels 30ms
Jun 3 17:14:01 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:01.351153 [DEBUG] mod_erlang_event.c:149 Sending event PLAYBACK_START to attached session ba128689636793b8
Jun 3 17:14:01 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(<<"set">>): <<"CHANNEL_EXECUTE">>. Sendable: true
Jun 3 17:14:01 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(<<"set">>): <<"CHANNEL_EXECUTE_COMPLETE">>. Sendable: true
Jun 3 17:14:01 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(<<"playback">>): <<"CHANNEL_EXECUTE">>. Sendable: true
Jun 3 17:14:01 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(undefined): <<"PLAYBACK_START">>. Sendable: true
Jun 3 17:14:01 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17835.0>): Skipped event <<"PLAYBACK_START">>
Jun 3 17:14:01 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:01.994311 [DEBUG] switch_ivr_play_say.c:1649 done playing file
Jun 3 17:14:01 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:01.994311 [DEBUG] mod_erlang_event.c:149 Sending event PLAYBACK_STOP to attached session ba128689636793b8
Jun 3 17:14:01 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:01.994311 [DEBUG] mod_erlang_event.c:149 Sending event CHANNEL_EXECUTE_COMPLETE to attached session ba128689636793b8
Jun 3 17:14:02 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(undefined): <<"PLAYBACK_STOP">>. Sendable: true
Jun 3 17:14:02 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17836.0>): Skipped event <<"PLAYBACK_STOP">>
Jun 3 17:14:02 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(<<"playback">>): <<"CHANNEL_EXECUTE_COMPLETE">>. Sendable: true
Jun 3 17:14:02 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: CONTROL(<0.17662.0>): Command <<"playback">> execution complete, advance call-id <<"ba128689636793b8">> running <<"play">>
Jun 3 17:14:02 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: ECALL_MEDREG(<0.131.0>): {lookup_local, <<"/system_media/vm-you_have">>, <<"ba128689636793b8">>}
Jun 3 17:14:02 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: MEDIA_SRV(<0.269.0>): Recv JSON: <<"{\"Stream-Type\":\"new\",\"Media-Name\":\"/system_media/vm-you_have\",\"App-Version\":\"0.7.2\",\"App-Name\":\"ecallmgr\",\"Event-Name\":\"media_req\",\"Event-Category\":\"media\",\"Server-ID\":\"amq.gen-9dpPJJV6ZCZ50LKB4vLRaQ==\"}">>
Jun 3 17:14:02 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: WORKER-F(<0.112.0>): Working for <0.17662.0> and sent {"Stream-Type":"new","Media-Name":"/system_media/vm-you_have","App-Version":"0.7.2","App-Name":"ecallmgr","Event-Name":"media_req","Event-Category":"media","Server-ID":"amq.gen-9dpPJJV6ZCZ50LKB4vLRaQ=="}
Jun 3 17:14:02 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: MEDIA_SRV(<0.25831.14>): Starting stream
Jun 3 17:14:02 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: Starting up SHOUT on #Port<0.14910> for Media <<"/system_media/vm-you_have">> of type single
Jun 3 17:14:02 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: MEDIA_SRV(<0.25831.14>): Req handled
Jun 3 17:14:02 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT(<0.25833.14>): Send <<"http://whistle1.vinixtech.com:51070/stream.wav">> to [<<"amq.gen-9dpPJJV6ZCZ50LKB4vLRaQ==">>]
Jun 3 17:14:02 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT.accept(<0.25836.14>): Stream Acceptor started
Jun 3 17:14:02 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT(<0.25833.14>): Sending {"Stream-URL":"http://whistle1.vinixtech.com:51070/stream.wav","Media-Name":"/system_media/vm-you_have","App-Version":"0.2.0","App-Name":"media_srv","Event-Name":"media_resp","Event-Category":"media","Server-ID":""} to <<"amq.gen-9dpPJJV6ZCZ50LKB4vLRaQ==">>
Jun 3 17:14:02 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: MEDIA_SHOUT(<0.25833.14>): Recv info {'EXIT',<0.25835.14>,normal}
Jun 3 17:14:02 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: WORKER-B(<0.112.0>): Recv payload response (5 ms)
Jun 3 17:14:02 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: CONTROL(<0.17662.0>): SendMsg -> Node: 'freeswitch@whistle1.vinixtech.com' UUID: <<"ba128689636793b8">> App: "set" Args: "playback_terminators=123456789*0#"
Jun 3 17:14:02 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:02.168670 [DEBUG] switch_core_session.c:956 Send signal sofia/sipinterface_1/neurooffice@whistle1.vinixtech.com:5060 [BREAK]
Jun 3 17:14:02 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: CONTROL(<0.17662.0>): SendMsg -> Node: 'freeswitch@whistle1.vinixtech.com' UUID: <<"ba128689636793b8">> App: "playback" Args: "shell_stream:///usr/local/bin/fetch_remote_audio.sh http://whistle1.vinixtech.com:51070/stream.wav"
Jun 3 17:14:02 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:02.168670 [DEBUG] switch_core_session.c:956 Send signal sofia/sipinterface_1/neurooffice@whistle1.vinixtech.com:5060 [BREAK]
Jun 3 17:14:02 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:02.199011 [DEBUG] switch_ivr.c:567 sofia/sipinterface_1/neurooffice@whistle1.vinixtech.com:5060 Command Execute set(playback_terminators=123456789*0#)
Jun 3 17:14:02 whistle1 freeswitch[12883]: ba128689636793b8 EXECUTE sofia/sipinterface_1/neurooffice@whistle1.vinixtech.com:5060 set(playback_terminators=123456789*0#)
Jun 3 17:14:02 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:02.199011 [DEBUG] mod_dptools.c:1063 sofia/sipinterface_1/neurooffice@whistle1.vinixtech.com:5060 SET [playback_terminators]=[123456789*0#]
Jun 3 17:14:02 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:02.199011 [DEBUG] mod_erlang_event.c:149 Sending event CHANNEL_EXECUTE to attached session ba128689636793b8
Jun 3 17:14:02 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:02.199011 [DEBUG] mod_erlang_event.c:149 Sending event CHANNEL_EXECUTE_COMPLETE to attached session ba128689636793b8
Jun 3 17:14:02 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:02.199011 [DEBUG] switch_ivr.c:567 sofia/sipinterface_1/neurooffice@whistle1.vinixtech.com:5060 Command Execute playback(shell_stream:///usr/local/bin/fetch_remote_audio.sh http://whistle1.vinixtech.com:51070/stream.wav)
Jun 3 17:14:02 whistle1 freeswitch[12883]: ba128689636793b8 EXECUTE sofia/sipinterface_1/neurooffice@whistle1.vinixtech.com:5060 playback(shell_stream:///usr/local/bin/fetch_remote_audio.sh http://whistle1.vinixtech.com:51070/stream.wav)
Jun 3 17:14:02 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:02.199011 [DEBUG] mod_erlang_event.c:149 Sending event CHANNEL_EXECUTE to attached session ba128689636793b8
Jun 3 17:14:02 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT.accept(<0.25840.14>): Stream Acceptor started
Jun 3 17:14:02 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT.accept(<0.25836.14>): Listening on #Port<0.14943>: Req: "GET /stream.wav HTTP/1.1\r\nUser-Agent: curl/7.20.1 (x86_64-unknown-linux-gnu) libcurl/7.20.1 OpenSSL/0.9.8b zlib/1.2.3\r\nHost: whistle1.vinixtech.com:51070\r\nAccept: */*"
Jun 3 17:14:02 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT.mloop(<0.25839.14>): Adding first socket: #Port<0.14943> Sending Resp Headers: ["HTTP/1.1 200 OK\r\n", "Server: ", <<"media_srv">>, "/", <<"0.2.0">>, "\r\n", "Content-Type: ", "audio/x-wav", "\r\n",
Jun 3 17:14:02 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT.mloop(<0.25839.14>): Playing from 0 (8988)
Jun 3 17:14:02 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT.mloop(<0.25839.14>): done playing, bye!
Jun 3 17:14:02 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT(<0.25833.14>): MediaLoop <0.25839.14> went down normal, stopping
Jun 3 17:14:02 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: SHOUT(<0.25833.14>): Closing socket and shutting down: normal
Jun 3 17:14:02 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(<<"set">>): <<"CHANNEL_EXECUTE">>. Sendable: true
Jun 3 17:14:02 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:02.281949 [DEBUG] switch_ivr_play_say.c:1279 Codec Activated L16@8000hz 1 channels 30ms
Jun 3 17:14:02 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:02.281949 [DEBUG] mod_erlang_event.c:149 Sending event PLAYBACK_START to attached session ba128689636793b8
Jun 3 17:14:02 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(<<"set">>): <<"CHANNEL_EXECUTE_COMPLETE">>. Sendable: true
Jun 3 17:14:02 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(<<"playback">>): <<"CHANNEL_EXECUTE">>. Sendable: true
Jun 3 17:14:02 whistle1 whistle_apps@whistle1.vinixtech.com[13356]: REG_SRV(<0.155.0>): Time to clean old registrations
Jun 3 17:14:02 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(undefined): <<"PLAYBACK_START">>. Sendable: true
Jun 3 17:14:02 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17852.0>): Skipped event <<"PLAYBACK_START">>
Jun 3 17:14:02 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:02.832207 [DEBUG] switch_ivr_play_say.c:1649 done playing file
Jun 3 17:14:02 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:02.832207 [DEBUG] mod_erlang_event.c:149 Sending event PLAYBACK_STOP to attached session ba128689636793b8
Jun 3 17:14:02 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:02.832207 [DEBUG] mod_erlang_event.c:149 Sending event CHANNEL_EXECUTE_COMPLETE to attached session ba128689636793b8
Jun 3 17:14:02 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(undefined): <<"PLAYBACK_STOP">>. Sendable: true
Jun 3 17:14:02 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17853.0>): Skipped event <<"PLAYBACK_STOP">>
Jun 3 17:14:02 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(<<"playback">>): <<"CHANNEL_EXECUTE_COMPLETE">>. Sendable: true
Jun 3 17:14:02 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: CONTROL(<0.17662.0>): Command <<"playback">> execution complete, advance call-id <<"ba128689636793b8">> running <<"play">>
Jun 3 17:14:02 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: BUILT COMMAND: conference <<"en name_spelled pronounced 0">>
Jun 3 17:14:02 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: CONTROL(<0.17662.0>): SendMsg -> Node: 'freeswitch@whistle1.vinixtech.com' UUID: <<"ba128689636793b8">> App: "say" Args: "en name_spelled pronounced 0"
Jun 3 17:14:02 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:02.984688 [DEBUG] switch_core_session.c:956 Send signal sofia/sipinterface_1/neurooffice@whistle1.vinixtech.com:5060 [BREAK]
Jun 3 17:14:03 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:03.005500 [DEBUG] switch_ivr.c:567 sofia/sipinterface_1/neurooffice@whistle1.vinixtech.com:5060 Command Execute say(en name_spelled pronounced 0)
Jun 3 17:14:03 whistle1 freeswitch[12883]: ba128689636793b8 EXECUTE sofia/sipinterface_1/neurooffice@whistle1.vinixtech.com:5060 say(en name_spelled pronounced 0)
Jun 3 17:14:03 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:03.005500 [DEBUG] mod_erlang_event.c:149 Sending event CHANNEL_EXECUTE to attached session ba128689636793b8
Jun 3 17:14:03 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:03.005500 [DEBUG] switch_ivr_play_say.c:1279 Codec Activated L16@8000hz 1 channels 30ms
Jun 3 17:14:03 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:03.005500 [DEBUG] mod_erlang_event.c:149 Sending event PLAYBACK_START to attached session ba128689636793b8
Jun 3 17:14:03 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(<<"say">>): <<"CHANNEL_EXECUTE">>. Sendable: true
Jun 3 17:14:03 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17664.0>): {Call_Event, {Event}} for <<"ba128689636793b8">>(undefined): <<"PLAYBACK_START">>. Sendable: true
Jun 3 17:14:03 whistle1 ecallmgr@whistle1.vinixtech.com[13232]: EVT(<0.17860.0>): Skipped event <<"PLAYBACK_START">>
Jun 3 17:14:03 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:03.790386 [DEBUG] switch_ivr_play_say.c:1649 done playing file
Jun 3 17:14:03 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:03.790386 [DEBUG] mod_erlang_event.c:149 Sending event PLAYBACK_STOP to attached session ba128689636793b8
Jun 3 17:14:03 whistle1 freeswitch[12883]: ba128689636793b8 2011-06-03 17:14:03.790386 [DEBUG] mod_erlang_event.c:149 Sending event CHANNEL_EXECUTE_COMPLETE to attached session ba128689636793b8
Jun 3 17:14:03 whistle1 ecallmgr@whistle1.vini