calejost / unimrcp

Automatically exported from code.google.com/p/unimrcp
Apache License 2.0
0 stars 0 forks source link

Asterisk restart after MRCPRecog with lumenvox server #173

Closed GoogleCodeExporter closed 8 years ago

GoogleCodeExporter commented 8 years ago
What steps will reproduce the problem?
1.Install latest uni-ast-package with all components, and lumenvox server with 
sppech recognition license
2.Configure basic lumenvox conection 
(http://www.lumenvox.com/knowledgebase/index.php?/article/AA-01129/0)
3. Test asterisk with a simple dialplan 
(http://www.lumenvox.com/knowledgebase/index.php?/article/AA-01130/0)
4. Asterisk restart and it seems to send a TEARDOWN RTSP message at the 
beginning:
-- Executing [s@lumenvox-asr:3] MRCPRecog("SIP/401-00000000", 
"builtin:grammar/boolean") in new stack
[Jul 28 16:01:40] NOTICE[21538][C-00000000]: app_mrcprecog.c:1152 
app_recog_exec: DTMF enable: 0
[Jul 28 16:01:40] DEBUG[21538][C-00000000]: audio_queue.c:253 
audio_queue_create: (ASR-0) audio queue created
[Jul 28 16:01:40] DEBUG[21538][C-00000000]: speech_channel.c:239 
speech_channel_create: Created speech channel: Name=ASR-0, Type=RECOGNIZER, 
Codec=PCMU, Rate=8000
[Jul 28 16:01:40] NOTICE[21538][C-00000000]: app_unimrcp.c:121 unimrcp_log: 
Create MRCP Handle 0x7f0f30011348 [speech-lumenvox-mrcp1]
[Jul 28 16:01:40] DEBUG[21538][C-00000000]: app_unimrcp.c:125 unimrcp_log: 
Create Channel ASR-0 <new>
[Jul 28 16:01:40] DEBUG[21538][C-00000000]: app_unimrcp.c:125 unimrcp_log: 
Signal Message to [MRCP Client] [0x7f0f300019f0;4;0]
[Jul 28 16:01:40] DEBUG[21521]: app_unimrcp.c:125 unimrcp_log: Process Message 
[MRCP Client] [0x7f0f300019f0;4;0]
[Jul 28 16:01:40] DEBUG[21521]: app_unimrcp.c:125 unimrcp_log: Receive App 
Request ASR-0 <new> [2]
[Jul 28 16:01:40] NOTICE[21521]: app_unimrcp.c:121 unimrcp_log: Create RTSP 
Handle 0x30d9808
[Jul 28 16:01:40] DEBUG[21521]: app_unimrcp.c:125 unimrcp_log: Add MRCP Handle 
ASR-0 <new>
[Jul 28 16:01:40] DEBUG[21521]: app_unimrcp.c:125 unimrcp_log: Dispatch App 
Request ASR-0 <new> [2]
[Jul 28 16:01:40] DEBUG[21521]: app_unimrcp.c:125 unimrcp_log: Signal Message 
to [MRCPv2ConnectionAgent] [0x30eddd0;1;0]
[Jul 28 16:01:40] NOTICE[21521]: app_unimrcp.c:121 unimrcp_log: Add Control 
Channel ASR-0 <new@speechrecog>
[Jul 28 16:01:40] DEBUG[21521]: app_unimrcp.c:125 unimrcp_log: Add Media 
Termination ASR-0 <new@media-tm>
[Jul 28 16:01:40] DEBUG[21521]: app_unimrcp.c:125 unimrcp_log: Add Media 
Termination ASR-0 <new@rtp-tm>
[Jul 28 16:01:40] DEBUG[21521]: app_unimrcp.c:125 unimrcp_log: Signal Message 
to [MediaEngine] [0x30dce60;1;0]
[Jul 28 16:01:40] DEBUG[21521]: app_unimrcp.c:125 unimrcp_log: Wait for 
Messages [MRCP Client]
[Jul 28 16:01:40] DEBUG[21522]: app_unimrcp.c:125 unimrcp_log: Process Poller 
Wakeup [MRCPv2ConnectionAgent]
[Jul 28 16:01:40] DEBUG[21522]: app_unimrcp.c:125 unimrcp_log: Process Message 
[MRCPv2ConnectionAgent] [0x30eddd0;1;0]
[Jul 28 16:01:40] DEBUG[21522]: app_unimrcp.c:125 unimrcp_log: Signal Message 
to [MRCP Client] [0x7f0eec035c10;2;0]
[Jul 28 16:01:40] DEBUG[21522]: app_unimrcp.c:125 unimrcp_log: Wait for 
Messages [MRCPv2ConnectionAgent]
[Jul 28 16:01:40] DEBUG[21521]: app_unimrcp.c:125 unimrcp_log: Process Message 
[MRCP Client] [0x7f0eec035c10;2;0]
[Jul 28 16:01:40] DEBUG[21521]: app_unimrcp.c:125 unimrcp_log: Control Channel 
Added ASR-0 <new@speechrecog>
[Jul 28 16:01:40] DEBUG[21521]: app_unimrcp.c:125 unimrcp_log: Wait for 
Messages [MRCP Client]
[Jul 28 16:01:40] DEBUG[21523]: app_unimrcp.c:125 unimrcp_log: Process Message 
[MediaEngine] [0x30dce60;1;0]
[Jul 28 16:01:40] DEBUG[21523]: app_unimrcp.c:125 unimrcp_log: Add Media 
Context ASR-0
[Jul 28 16:01:40] DEBUG[21523]: app_unimrcp.c:125 unimrcp_log: Signal Message 
to [MRCP Client] [0x7f0f3c000e60;3;0]
[Jul 28 16:01:40] DEBUG[21521]: app_unimrcp.c:125 unimrcp_log: Process Message 
[MRCP Client] [0x7f0f3c000e60;3;0]
[Jul 28 16:01:40] DEBUG[21521]: app_unimrcp.c:125 unimrcp_log: Media 
Termination Added ASR-0 <new@media-tm>
[Jul 28 16:01:40] DEBUG[21521]: app_unimrcp.c:125 unimrcp_log: Media 
Termination Added ASR-0 <new@rtp-tm>
[Jul 28 16:01:40] DEBUG[21521]: app_unimrcp.c:125 unimrcp_log: Send Offer ASR-0 
<new> [c:1 a:1 v:0] to 10.10.7.15:554
[Jul 28 16:01:40] DEBUG[21521]: app_unimrcp.c:125 unimrcp_log: Signal Message 
to [speech-lumenvox-mrcp1] [0x30dee80;1;0]
[Jul 28 16:01:40] DEBUG[21521]: app_unimrcp.c:125 unimrcp_log: Wait for 
Messages [MRCP Client]
[Jul 28 16:01:40] DEBUG[21524]: app_unimrcp.c:125 unimrcp_log: Process Poller 
Wakeup [speech-lumenvox-mrcp1]
[Jul 28 16:01:40] DEBUG[21524]: app_unimrcp.c:125 unimrcp_log: Process Message 
[speech-lumenvox-mrcp1] [0x30dee80;1;0]
[Jul 28 16:01:40] NOTICE[21524]: app_unimrcp.c:121 unimrcp_log: Established 
RTSP Connection 10.10.9.14:41775 <-> 10.10.7.15:554
[Jul 28 16:01:40] DEBUG[21524]: app_unimrcp.c:125 unimrcp_log: Add RTSP Handle 
0x30d9808
[Jul 28 16:01:40] DEBUG[21524]: app_unimrcp.c:125 unimrcp_log: Send RTSP Stream 
10.10.9.14:41775 <-> 10.10.7.15:554 [65 bytes]
TEARDOWN rtsp://10.10.7.15:554/media/(null) RTSP/1.0
CSeq: 1

[Jul 28 16:01:40] DEBUG[21524]: app_unimrcp.c:125 unimrcp_log: Push RTSP 
Request to In-Progress Queue 0x30d9808 <new> CSeq:1
[Jul 28 16:01:40] DEBUG[21524]: app_unimrcp.c:125 unimrcp_log: Wait for 
Messages [speech-lumenvox-mrcp1]
[Jul 28 16:01:40] DEBUG[21524]: app_unimrcp.c:125 unimrcp_log: Process 
Signalled Descriptor [speech-lumenvox-mrcp1]

Here asterisk restarts.

What version of the product are you using? On what operating system?
I'm using uni-ast-packege-1.2.0, and the latest lumenvox.

Please provide any additional information below.
I tested the lumenvox ASR and media server using unimrcpclient program and it 
works fine, but with asterisk it doesn't work. I also tried with uni-ast v1.0.0 
and v1.1.0 and the result is the same. Attach asterisk verbose and debug, and 
lumenvox debug.

Original issue reported on code.google.com by laar78...@gmail.com on 28 Jul 2014 at 9:07

Attachments:

GoogleCodeExporter commented 8 years ago
version 1.1.0 works. 

Original comment by flu...@gmail.com on 4 Aug 2014 at 2:59

GoogleCodeExporter commented 8 years ago
As far as I can see, although an MRCPv1 profile was used with MRCPRecog(), the 
MRCPv2 agent was still somehow involved in session initialization, which is 
definitely not the expected behavior.

[Aug  1 10:20:08] DEBUG[1795] src/apt_task.c: Signal Message to 
[MRCPv2ConnectionAgent] [0x7fa5bc005fa0;1;0]

I'm not even sure whether this can be a configuration or build issue or 
anything else. As the next step, can you provide additional information such as 
configuration and build related details (Linux, gcc version,...).

Original comment by achalo...@gmail.com on 12 Aug 2014 at 1:16

GoogleCodeExporter commented 8 years ago
I'm using Centos 6.5, kernel 2.6.32-431.20.3.el6.x86_64, I use 
gcc-4.4.7-4.el6.x86_64 to build uni-ast-package-1.2.0. I send you all the 
configs. Thank's for the response....please tell me if you need more info

Original comment by laar78...@gmail.com on 12 Aug 2014 at 10:05

Attachments:

GoogleCodeExporter commented 8 years ago
It looks like app_unimrcp loads MRCP version 1 profiles incorrectly (MRCP 
version 2 profiles are not affected).

I had made a few related changes in the client stack recently which were 
included in UniMRCP-1.2.0 release. The client stack itself is not affected, 
both v1 and v2 profiles work as intended. However, app_unimrcp needs to be 
patched.

Temporary workarounds:

1) Use MRCPv2 instead of MRCPv1
or
2) Use unimrcp-1.1.0 with the latest Asterisk modules 1.2.0
or
3) Downgrade to uni-ast-package-1.1.0 completely

Original comment by achalo...@gmail.com on 14 Aug 2014 at 5:32

GoogleCodeExporter commented 8 years ago
Fixed in r2161. Thanks for bringing this up.

Original comment by achalo...@gmail.com on 18 Aug 2014 at 7:15