Skip to content

Instantly share code, notes, and snippets.

@benlangfeld

benlangfeld/freeswitch.log Secret

Created August 6, 2012 18:42
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save benlangfeld/477e53db58318125cc2c to your computer and use it in GitHub Desktop.
Save benlangfeld/477e53db58318125cc2c to your computer and use it in GitHub Desktop.
Download ZIP
Raw
freeswitch.log
2012-08-06 11:41:09.240843 [INFO] mod_unimrcp.c:1571 speech_handle: name = unimrcp, rate = 8000, speed = 0, samples = 240, voice = , engine = unimrcp, param = (null)
2012-08-06 11:41:09.240843 [INFO] mod_unimrcp.c:1574 voice = english-female4, rate = 8000
2012-08-06 11:41:09.240843 [NOTICE] mrcp_application.c:95 () Create MRCP Handle 0x92f3bf8 [voxeo-prism]
2012-08-06 11:41:09.240843 [INFO] mrcp_client_session.c:124 (TTS-3) Create Channel 0x92f3bf8 <new>
2012-08-06 11:41:09.240843 [INFO] mrcp_client_session.c:392 (TTS-3) Receive App Request 0x92f3bf8 <new> [2]
2012-08-06 11:41:09.240843 [NOTICE] rtsp_client.c:278 () Create RTSP Handle 0xb6c020c8
2012-08-06 11:41:09.240843 [INFO] mrcp_client.c:586 () Add MRCP Handle 0x92f3bf8 <new>
2012-08-06 11:41:09.240843 [NOTICE] mrcp_client_session.c:721 (TTS-3) Add Control Channel 0x92f3bf8 <new@speechsynth>
2012-08-06 11:41:09.251067 [INFO] mrcp_client_session.c:416 (TTS-3) Send Offer 0x92f3bf8 <new> [c:0 a:1 v:0] to 192.168.82.1:10074
2012-08-06 11:41:09.251067 [NOTICE] rtsp_client.c:354 () Established RTSP Connection 192.168.82.134:35886 <-> 192.168.82.1:10074
2012-08-06 11:41:09.251067 [INFO] rtsp_client.c:560 () Add RTSP Handle 0xb6c020c8
2012-08-06 11:41:09.251067 [INFO] rtsp_client.c:831 () Send RTSP Stream 192.168.82.134:35886 <-> 192.168.82.1:10074 [346 bytes]
SETUP rtsp://192.168.82.1:10074/synthesizer RTSP/1.0
CSeq: 1
Transport: RTP/AVP;unicast;client_port=4006-4007
Content-Type: application/sdp
Content-Length: 179
v=0
o=FreeSWITCH 0 0 IN IP4 127.0.1.1
s=-
c=IN IP4 127.0.1.1
t=0 0
m=audio 4006 RTP/AVP 0 8 96
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:96 L16/8000
a=recvonly
2012-08-06 11:41:09.251067 [INFO] rtsp_client.c:513 () Push RTSP Request to In-Progress Queue 0xb6c020c8 <new> CSeq:1
2012-08-06 11:41:09.251067 [INFO] rtsp_client.c:929 () Receive RTSP Stream 192.168.82.134:35886 <-> 192.168.82.1:10074 [347 bytes]
RTSP/1.0 200 OK
Session: 4248672905-a93df90-01b528d0-00000004
Transport: RTP/AVP;unicast;client_port=4006-4007;server_port=65535-65536
CSeq: 1
Content-Type: application/sdp
Content-Length: 146
v=0
o=- 996545 996545 IN IP4 109.148.202.60
s=voxeo
c=IN IP4 109.148.202.60
t=0 0
m=audio 20006 RTP/AVP 0
a=rtpmap:0 PCMU/8000
a=ptime:20
2012-08-06 11:41:09.251067 [INFO] rtsp_client.c:538 () Pop In-Progress RTSP Request 0xb6c020c8 CSeq:1
2012-08-06 11:41:09.251067 [INFO] rtsp_client.c:675 () Add RTSP Session 0xb6c020c8 <4248672905-a93df90-01b528d0-00000004>
2012-08-06 11:41:09.251067 [INFO] mrcp_client_session.c:142 (TTS-3) Receive Answer 0x92f3bf8 <4248672905-a93df90-01b528d0-00000004> [c:0 a:1 v:0]
2012-08-06 11:41:09.260812 [INFO] mpf_rtp_stream.c:302 () Enable RTP Session 127.0.1.1:4006
2012-08-06 11:41:09.260812 [INFO] mpf_rtp_stream.c:467 () Open RTP Receiver 127.0.1.1:4006 <- 109.148.202.60:20006 playout [50 ms]
2012-08-06 11:41:09.260812 [INFO] mpf_bridge.c:93 () Media Path 0x92f3bf8 Source->[PCMU/8000/1]->Decoder->[LPCM/8000/1]->Bridge->[LPCM/8000/1]->Sink
2012-08-06 11:41:09.260812 [INFO] mrcp_client_session.c:457 (TTS-3) Raise App Response 0x92f3bf8 <4248672905-a93df90-01b528d0-00000004> [2] SUCCESS [0]
2012-08-06 11:41:09.260812 [INFO] mrcp_client_session.c:397 (TTS-3) Receive App MRCP Request 0x92f3bf8 <4248672905-a93df90-01b528d0-00000004>
2012-08-06 11:41:09.260812 [INFO] mrcp_client_session.c:624 (TTS-3) Send MRCP Request 0x92f3bf8 <4248672905-a93df90-01b528d0-00000004@speechsynth> [1]
2012-08-06 11:41:09.260812 [INFO] rtsp_client.c:831 () Send RTSP Stream 192.168.82.134:35886 <-> 192.168.82.1:10074 [368 bytes]
ANNOUNCE rtsp://192.168.82.1:10074/synthesizer RTSP/1.0
CSeq: 2
Session: 4248672905-a93df90-01b528d0-00000004
Content-Type: application/mrcp
Content-Length: 200
SPEAK 1 MRCP/1.0
Content-Type: application/ssml+xml
Voice-Name: english-female4
Content-Length: 95
<speak xmlns="http://www.w3.org/2001/10/synthesis" version="1.0" xml:lang="en-US">Hello</speak>
2012-08-06 11:41:09.260812 [INFO] rtsp_client.c:513 () Push RTSP Request to In-Progress Queue 0xb6c020c8 <4248672905-a93df90-01b528d0-00000004> CSeq:2
2012-08-06 11:41:09.260812 [INFO] rtsp_client.c:929 () Receive RTSP Stream 192.168.82.134:35886 <-> 192.168.82.1:10074 [154 bytes]
RTSP/1.0 200 OK
Session: 4248672905-a93df90-01b528d0-00000004
CSeq: 2
Content-Type: application/mrcp
Content-Length: 27
MRCP/1.0 1 407 COMPLETE
2012-08-06 11:41:09.260812 [INFO] rtsp_client.c:538 () Pop In-Progress RTSP Request 0xb6c020c8 CSeq:2
2012-08-06 11:41:09.260812 [INFO] mrcp_client_session.c:502 (TTS-3) Raise App MRCP Response 0x92f3bf8 <4248672905-a93df90-01b528d0-00000004>
2012-08-06 11:41:09.871016 [INFO] mrcp_client_session.c:392 (TTS-3) Receive App Request 0x92f3bf8 <4248672905-a93df90-01b528d0-00000004> [1]
2012-08-06 11:41:09.871016 [INFO] mrcp_client_session.c:832 (TTS-3) Terminate Session 0x92f3bf8 <4248672905-a93df90-01b528d0-00000004>
2012-08-06 11:41:09.871016 [INFO] rtsp_client.c:831 () Send RTSP Stream 192.168.82.134:35886 <-> 192.168.82.1:10074 [115 bytes]
TEARDOWN rtsp://192.168.82.1:10074/synthesizer RTSP/1.0
CSeq: 3
Session: 4248672905-a93df90-01b528d0-00000004
2012-08-06 11:41:09.871016 [INFO] rtsp_client.c:513 () Push RTSP Request to In-Progress Queue 0xb6c020c8 <4248672905-a93df90-01b528d0-00000004> CSeq:3
2012-08-06 11:41:09.871016 [INFO] rtsp_client.c:929 () Receive RTSP Stream 192.168.82.134:35886 <-> 192.168.82.1:10074 [75 bytes]
RTSP/1.0 200 OK
Session: 4248672905-a93df90-01b528d0-00000004
CSeq: 3
2012-08-06 11:41:09.871016 [INFO] rtsp_client.c:538 () Pop In-Progress RTSP Request 0xb6c020c8 CSeq:3
2012-08-06 11:41:09.871016 [INFO] rtsp_client.c:693 () Remove RTSP Session 0xb6c020c8 <4248672905-a93df90-01b528d0-00000004>
2012-08-06 11:41:09.871016 [INFO] rtsp_client.c:429 () Remove RTSP Handle 0xb6c020c8
2012-08-06 11:41:09.871016 [NOTICE] rtsp_client.c:285 () Destroy RTSP Handle 0xb6c020c8
2012-08-06 11:41:09.871016 [INFO] rtsp_client.c:362 () Close RTSP Connection 192.168.82.134:35886 <-> 192.168.82.1:10074
2012-08-06 11:41:09.871016 [NOTICE] rtsp_client.c:415 () Destroy RTSP Connection 192.168.82.134:35886 <-> 192.168.82.1:10074
2012-08-06 11:41:09.871016 [INFO] mrcp_client_session.c:194 (TTS-3) Session Terminated 0x92f3bf8 <4248672905-a93df90-01b528d0-00000004>
2012-08-06 11:41:09.880776 [INFO] mpf_rtp_stream.c:495 () Close RTP Receiver 127.0.1.1:4006 <- 109.148.202.60:20006 [r:0 l:0 j:0 d:0 i:0]
2012-08-06 11:41:09.880776 [INFO] mpf_rtp_stream.c:376 () Remove RTP Session 127.0.1.1:4006
2012-08-06 11:41:09.880776 [INFO] mrcp_client.c:596 () Remove MRCP Handle 0x92f3bf8 <4248672905-a93df90-01b528d0-00000004>
2012-08-06 11:41:09.880776 [INFO] mrcp_client_session.c:457 (TTS-3) Raise App Response 0x92f3bf8 <4248672905-a93df90-01b528d0-00000004> [1] SUCCESS [0]
2012-08-06 11:41:09.880776 [NOTICE] mrcp_application.c:171 () Destroy MRCP Handle 0x92f3bf8
2012-08-06 11:41:09.930790 [NOTICE] switch_ivr.c:695 Hangup sofia/internal/1000@192.168.82.134 [CS_EXECUTE] [NORMAL_CLEARING]
2012-08-06 11:41:09.930790 [NOTICE] switch_core_session.c:1447 Session 6 (sofia/internal/1000@192.168.82.134) Ended
2012-08-06 11:41:09.930790 [NOTICE] switch_core_session.c:1449 Close Channel sofia/internal/1000@192.168.82.134 [CS_DESTROY]
Raw
vcs.log
MRS0170549760/blmbp.home/2012.08.06.19.41.09.256/0:00000000000000000000000000000000:FFFFFFFF:1/00000010/Event::TCP/ TCP session accept socket=11
MRS0170549760/blmbp.home/2012.08.06.19.41.09.257/0:00000000000000000000000000000000:FFFFFFFF:1/00000010/Event::TCP/TCPSession: Accept() successful (client=192.168.82.134:35886).
MRS0028649680/blmbp.home/2012.08.06.19.41.09.257/0:4248672905-a93df90-01b528d0-00000004:00000000:1/0000001d/MRCPServerAPP/Session 4248672905-a93df90-01b528d0-00000004 has been associated with the queue 176232608, id=4
MRS0028649680/blmbp.home/2012.08.06.19.41.09.258/0:00000000000000000000000000000000:FFFFFFFF:1/0000001f/MRCPServerAPP/MRCP session is created, count=1
MRS0028649680/blmbp.home/2012.08.06.19.41.09.258/0:4248672905-a93df90-01b528d0-00000004:00000000:1/0000003f/MRCP::RTSP/RTSP Message(i):\r\nSETUP rtsp:\s\s192.168.82.1:10074\ssynthesizer RTSP\s1.0\r\nContent-Length: 179\r\nContent-Type: application\ssdp\r\nCSeq: 1\r\nTransport: RTP\sAVP;unicast;client_port=4006-4007\r\n\r\nv=0\r\no=FreeSWITCH 0 0 IN IP4 127.0.1.1\r\ns=-\r\nc=IN IP4 127.0.1.1\r\nt=0 0\r\nm=audio 4006 RTP\sAVP 0 8 96\r\na=rtpmap:0 PCMU\s8000\r\na=rtpmap:8 PCMA\s8000\r\na=rtpmap:96 L16\s8000\r\na=recvonly\r\n
MRS0176232608/blmbp.home/2012.08.06.19.41.09.259/0:4248672905-a93df90-01b528d0-00000004:00000000:1/0000003f/RTP5/RTP session (20006) on thread 29479936 was modified successfully.
MRS0176232608/blmbp.home/2012.08.06.19.41.09.259/0:4248672905-a93df90-01b528d0-00000004:00000000:1/0000001f/MRCPServerAPP/MRCP endpoints: local=109.148.202.60:20006; remote=127.0.1.1:4006
MRS0176232608/blmbp.home/2012.08.06.19.41.09.259/0:4248672905-a93df90-01b528d0-00000004:00000000:1/0000003f/MRCP::RTSP/RTSP message(o):\r\nRTSP\s1.0 200 OK\r\nSession: 4248672905-a93df90-01b528d0-00000004\r\nTransport: RTP\sAVP;unicast;client_port=4006-4007;server_port=65535-65536\r\nCSeq: 1\r\nContent-Type: application\ssdp\r\nContent-Length: 146\r\n\r\nv=0\r\no=- 996545 996545 IN IP4 109.148.202.60\r\ns=voxeo\r\nc=IN IP4 109.148.202.60\r\nt=0 0\r\nm=audio 20006 RTP\sAVP 0\r\na=rtpmap:0 PCMU\s8000\r\na=ptime:20\r\n
MRS0028649680/blmbp.home/2012.08.06.19.41.09.262/0:4248672905-a93df90-01b528d0-00000004:00000000:1/4000003f/MRCP::RTSP/RTSP Message(i):\r\nANNOUNCE rtsp:\s\s192.168.82.1:10074\ssynthesizer RTSP\s1.0\r\nContent-Length: 200\r\nContent-Type: application\smrcp\r\nCSeq: 2\r\nSession: 4248672905-a93df90-01b528d0-00000004\r\n\r\nSPEAK 1 MRCP\s1.0\r\nContent-Type: application\sssml+xml\r\nVoice-Name: english-female4\r\nContent-Length: 95\r\n\r\n<speak xmlns="http:\s\swww.w3.org\s2001\s10\ssynthesis" version="1.0" xml:lang="en-US">Hello<\sspeak>
MRS0176232608/blmbp.home/2012.08.06.19.41.09.262/0:4248672905-a93df90-01b528d0-00000004:00000000:1/0000009d/MRCPServerAPP/Unknown Content-Type in SPEAK: application\sssml+xml
MRS0176232608/blmbp.home/2012.08.06.19.41.09.262/0:4248672905-a93df90-01b528d0-00000004:00000000:1/0000003f/MRCP::RTSP/RTSP message(o):\r\nRTSP\s1.0 200 OK\r\nSession: 4248672905-a93df90-01b528d0-00000004\r\nCSeq: 2\r\nContent-Type: application\smrcp\r\nContent-Length: 27\r\n\r\nMRCP\s1.0 1 407 COMPLETE\r\n\r\n
MRS0028649680/blmbp.home/2012.08.06.19.41.09.875/0:4248672905-a93df90-01b528d0-00000004:00000000:1/0000003f/MRCP::RTSP/RTSP Message(i):\r\nTEARDOWN rtsp:\s\s192.168.82.1:10074\ssynthesizer RTSP\s1.0\r\nCSeq: 3\r\nSession: 4248672905-a93df90-01b528d0-00000004\r\n\r\n
MRS0176232608/blmbp.home/2012.08.06.19.41.09.878/0:4248672905-a93df90-01b528d0-00000004:00000000:1/0000003f/RTP5/RTP session (20006) on thread 29479936 was stopped.\nRTPSTAT:Duration=0000619;TX=000031|000;RX=000000|000|000000|0000;BR=000000|000000|000000|0000;TM=00000|0000|000;CONF=0000000|0000000|0000000|0000000;ERR=000|000|000|000|000|000|000|000;127.0.1.1:4006;
MRS0176232608/blmbp.home/2012.08.06.19.41.09.878/0:4248672905-a93df90-01b528d0-00000004:00000000:1/0000003f/MRCP::RTSP/RTSP message(o):\r\nRTSP\s1.0 200 OK\r\nSession: 4248672905-a93df90-01b528d0-00000004\r\nCSeq: 3\r\n\r\n
MRS0028649680/blmbp.home/2012.08.06.19.41.09.879/0:4248672905-a93df90-01b528d0-00000004:00000000:1/00000010/Event::TCP/Dropping connection (client=192.168.82.134:35886).
MRS0028649680/blmbp.home/2012.08.06.19.41.09.879/0:00000000000000000000000000000000:FFFFFFFF:1/00000010/Event::TCP/TCPSession: connection (client=192.168.82.134:35886) is already dropped.
MRS0176232608/blmbp.home/2012.08.06.19.41.09.879/0:00000000000000000000000000000000:FFFFFFFF:1/00000010/Event::TCP/TCPSession: connection (client=192.168.82.134:35886) is already dropped.
MRS0176232608/blmbp.home/2012.08.06.19.41.09.879/0:00000000000000000000000000000000:FFFFFFFF:1/0000001f/MRCPServerAPP/MRCP session is released, count=0
MRS0176232608/blmbp.home/2012.08.06.19.41.12.880/0:00000000000000000000000000000000:FFFFFFFF:1/00000010/Event::TCP/TCPSession: connection (client=192.168.82.134:35886) is already dropped.
CXV0058855280/blmbp.home/2012.08.06.19.41.38.540/:00000000000000000000000000000000:-1:1/00000010/Diagnose/Diagnosis: begin ---------------------------
CXV0058855280/blmbp.home/2012.08.06.19.41.38.540/:00000000000000000000000000000000:-1:1/00000010/Diagnose/================ DIAGNOSIS ================\n\n-------- Romeo Status --------\nGROUP1 "ccxml.dlg.application\sxml+vxml"\n\tTARGET1 "127.0.0.1:5066", available: yes\nGROUP2 "ccxml.dlg.application\sxml+scxml"\n\tTARGET1 "127.0.0.1:5066", available: yes\nGROUP3 "ccxml.dlg.application\sx-callxml"\n\tTARGET1 "127.0.0.1:5061", available: yes\n-------- MRCP Server Status --------\nMRCP Server: total of 20 message queues are handling 0 client sessions (0)\n\n\n\n-------- Session Manager Status --------\n Messages in queue: 0\n CallXML Sessions : 0 of unlimited\n
CXV0058855280/blmbp.home/2012.08.06.19.41.38.540/:00000000000000000000000000000000:-1:1/00000014/SessionManager/event EVENT_AREYOUALIVE added to queue (count=1, state=0)
CXV0176311808/blmbp.home/2012.08.06.19.41.38.540/:00000000000000000000000000000000:-1:1/00000010/SessionManager/done with EVENT_AREYOUALIVE(0ms), now processing EVENT_AREYOUALIVE(0ms), Q=1,G=0,F=0,C=0,R=0,S=0,A=0,SS=0
CXV0058855280/blmbp.home/2012.08.06.19.41.38.540/:00000000000000000000000000000000:-1:1/00000010/Diagnose/system check succeeded
CXV0058855280/blmbp.home/2012.08.06.19.41.38.540/:00000000000000000000000000000000:-1:1/00000010/Diagnose/Diagnosis: end -----------------------------
VCS0028555712/blmbp.home/2012.08.06.19.41.38.839/0:00000000000000000000000000000000:FFFFFFFF:1/0000001d/RTPMessageQueue/RTPSTAT: RTP2: Messages=10839t|00000h|00000m|00000q;Avg times=000|000;Max times=0001t|0001m|00000q;Delays=5811|0001avg|0001max(0011)
VCS0029479936/blmbp.home/2012.08.06.19.41.38.884/0:00000000000000000000000000000000:FFFFFFFF:1/0000001d/RTPMessageQueue/RTPSTAT: RTP1: Messages=10834t|00002h|00002m|00001q;Avg times=000|009;Max times=0001t|0001m|00003q;Delays=5833|0001avg|0001max(0011)
VCS0028555712/blmbp.home/2012.08.06.19.42.38.842/0:00000000000000000000000000000000:FFFFFFFF:1/0000001d/RTPMessageQueue/RTPSTAT: RTP2: Messages=10852t|00000h|00000m|00000q;Avg times=000|000;Max times=0001t|0001m|00000q;Delays=5743|0001avg|0001max(0006)
VCS0029479936/blmbp.home/2012.08.06.19.42.38.885/0:00000000000000000000000000000000:FFFFFFFF:1/0000001d/RTPMessageQueue/RTPSTAT: RTP1: Messages=10850t|00000h|00000m|00000q;Avg times=000|000;Max times=0001t|0001m|00000q;Delays=5751|0001avg|0001max(0006)
VCS0028555712/blmbp.home/2012.08.06.19.43.38.846/0:00000000000000000000000000000000:FFFFFFFF:1/0000001d/RTPMessageQueue/RTPSTAT: RTP2: Messages=10850t|00000h|00000m|00000q;Avg times=000|000;Max times=0001t|0001m|00000q;Delays=5752|0001avg|0002max(18264)
VCS0029479936/blmbp.home/2012.08.06.19.43.38.891/0:00000000000000000000000000000000:FFFFFFFF:1/0000001d/RTPMessageQueue/RTPSTAT: RTP1: Messages=10848t|00000h|00000m|00000q;Avg times=000|000;Max times=0001t|0001m|00000q;Delays=5764|0001avg|0002max(18221)
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment