Menu

asterisk pocketsphinx recognition result

Help
2012-06-13
2012-09-22
  • Rudi Dellinger

    Rudi Dellinger - 2012-06-13

    Hello,

    I am trying to implement pocketsphinx with asterisk and have been quite
    successful in installing pocketsphinx unimrcp and the asterisk connector but
    when testing the recognition with SpeechBackground, I will get no results back
    from unimrcp but can see a 'recognition complete' with corresponding xml:

    2012-06-13 14:48:56:606479 Send MRCPv2 Stream 192.168.1.11:1544 <->
    192.168.1.11:46933
    MRCP/2.0 350 RECOGNITION-COMPLETE 3 COMPLETE
    Channel-Identifier: 1ea09eaeb55611e1@speechrecog
    Completion-Cause: 000 success
    Content-Type: application/x-nlsml
    Content-Length: 165

    <result grammar="digit">
    <interpretation grammar="digit" confidence="99">
    <input mode="speech">ONE
    </interpretation>
    </result>

    But in asterisk the dialplan variables SPEECH_SCORE, SPEECH_TEXT AND
    SPEECH_GRAMMAR are empty.

    Running out on ideas, anyone could help?

    Thanks,
    Rudi

    asterisk full log for the test call:

    DEBUG chan_sip.c: SIP answering channel: SIP/out_4313053051-00000003
    DEBUG res_rtp_asterisk.c: Setting the marker bit due to a source update
    DEBUG chan_sip.c: Setting framing from config on incoming call
    DEBUG chan_sip.c: ** Our capability: 0x8 (alaw) Video flag: True Text flag:
    True
    DEBUG chan_sip.c: ** Our prefcodec: 0x0 (nothing)
    DEBUG chan_sip.c: -- Done with adding codecs to SDP
    DEBUG chan_sip.c: Done building SDP. Settling with this capability: 0x8 (alaw)
    DEBUG chan_sip.c: Trying to put 'SIP/2.0 200' onto UDP socket destined for
    213.185.165.114:5060
    DEBUG chan_sip.c: Stopping retransmission on
    '3e4d7e114e4068400374e87421b77f7c@213.185.165.102:5060' of Response 102: Match
    Found
    DEBUG pbx.c: Launching 'SpeechCreate'
    VERBOSE pbx.c: -- Executing SpeechCreate("SIP/out_4313053051-00000003", "") in
    new stack
    NOTICE app_unimrcp.c: Create MRCP Handle 0x1f8adb8
    DEBUG app_unimrcp.c: Create Channel 0x1f8adb8 <new>
    DEBUG res_speech_unimrcp.c: Send session request type:2
    DEBUG app_unimrcp.c: Signal Message to
    DEBUG res_speech_unimrcp.c: Wait for session response
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Receive App Request 0x1f8adb8 <new>
    DEBUG app_unimrcp.c: Add MRCP Handle 0x1f8adb8 <new>
    DEBUG app_unimrcp.c: Dispatch App Request 0x1f8adb8 <new>
    DEBUG app_unimrcp.c: Signal Message to
    NOTICE app_unimrcp.c: Add Control Channel 0x1f8adb8 new@speechrecog
    DEBUG app_unimrcp.c: Add Media Termination 0x1f8adb8 new@media-tm
    DEBUG app_unimrcp.c: Add Media Termination 0x1f8adb8 new@rtp-tm
    DEBUG app_unimrcp.c: Process Poller Wakeup
    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Control Channel Added 0x1f8adb8 new@speechrecog
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Add Media Context 0x1f8adb8
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Media Termination Added 0x1f8adb8 new@media-tm
    DEBUG app_unimrcp.c: Media Termination Added 0x1f8adb8 new@rtp-tm
    DEBUG app_unimrcp.c: Send Offer 0x1f8adb8 <new> to 192.168.1.11:8060
    DEBUG app_unimrcp.c: Local SDP 0x1f8adb8 <new>
    v=0
    o=UniMRCPClient 0 0 IN IP4 192.168.1.11
    s=-
    c=IN IP4 192.168.1.11
    t=0 0
    m=application 9 TCP/MRCPv2 1
    a=setup:active
    a=connection:new
    a=resource:speechrecog
    a=cmid:1
    m=audio 4004 RTP/AVP 0 8 96 101
    a=rtpmap:0 PCMU/8000
    a=rtpmap:8 PCMA/8000
    a=rtpmap:96 L16/8000
    a=rtpmap:101 telephone-event/8000
    a=fmtp:101 0-15
    a=sendonly
    a=ptime:20
    a=mid:1 </new></new></new></new></new></new>

    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Receive SIP Event Status 0 INVITE sent
    NOTICE app_unimrcp.c: SIP Call State 0x1f8adb8
    DEBUG app_unimrcp.c: Receive SIP Event Status 200 OK
    DEBUG app_unimrcp.c: Receive SIP Event Status 200 OK
    NOTICE app_unimrcp.c: SIP Call State 0x1f8adb8
    DEBUG app_unimrcp.c: Remote SDP 0x1f8adb8 <new>
    v=0
    o=UniMRCPServer 9082869445421288785 2522392476142623092 IN IP4 192.168.1.11
    s=-
    c=IN IP4 192.168.1.11
    t=0 0
    m=application 1544 TCP/MRCPv2 1
    a=setup:passive
    a=connection:new
    a=channel:1ea09eaeb55611e1@speechrecog
    a=cmid:1
    m=audio 5004 RTP/AVP 0 101
    a=rtpmap:0 PCMU/8000
    a=rtpmap:101 telephone-event/8000
    a=fmtp:101 0-15
    a=recvonly
    a=ptime:20
    a=mid:1 </new>

    DEBUG app_unimrcp.c: Receive SIP Event Status 200 Call active
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Receive Answer 0x1f8adb8 <new>
    DEBUG app_unimrcp.c: Modify Control Channel 0x1f8adb8 <1ea09eaeb55611e1>
    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Modify Media Termination 0x1f8adb8 1ea09eaeb55611e1@rtp- tm
    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Poller Wakeup
    DEBUG app_unimrcp.c: Process Message
    NOTICE app_unimrcp.c: Established TCP/MRCPv2 Connection 192.168.1.11:46933 <->
    192.168.1.11:1544
    DEBUG app_unimrcp.c: Add Control Channel 1ea09eaeb55611e1@speechrecog
    192.168.1.11:46933 <-> 192.168.1.11:1544
    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Control Channel Modified 0x1f8adb8
    1ea09eaeb55611e1@speechrecog
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Enable RTP Session 192.168.1.11:4004
    DEBUG app_unimrcp.c: Create Linear Audio Bridge 0x1f8adb8
    DEBUG app_unimrcp.c: Open RTP Transmitter 192.168.1.11:4004 ->
    192.168.1.11:5004
    DEBUG app_unimrcp.c: Media Path 0x1f8adb8 Source->->Bridge->->Encoder->->Sink
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Media Termination Modified 0x1f8adb8 1ea09eaeb55611e1 @rtp-tm
    DEBUG app_unimrcp.c: Raise App Response 0x1f8adb8 <1ea09eaeb55611e1> SUCCESS
    DEBUG res_speech_unimrcp.c: Received message from client stack
    DEBUG res_speech_unimrcp.c: On channel add
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG res_speech_unimrcp.c: Waked up, status code: 0
    DEBUG res_speech_unimrcp.c: Create media buffer frame_size:160
    NOTICE res_speech_unimrcp.c: Created speech instance '1ea09eaeb55611e1'
    DEBUG res_speech_unimrcp.c: Set properties '1ea09eaeb55611e1'
    DEBUG res_speech_unimrcp.c: Send MRCP request
    DEBUG app_unimrcp.c: Signal Message to
    DEBUG res_speech_unimrcp.c: Wait for MRCP response
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Receive App MRCP Request 0x1f8adb8 <1ea09eaeb55611e1>
    DEBUG app_unimrcp.c: Send MRCP Request 0x1f8adb8
    1ea09eaeb55611e1@speechrecog
    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Poller Wakeup
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Send MRCPv2 Stream 192.168.1.11:46933 <->
    192.168.1.11:1544
    MRCP/2.0 132 SET-PARAMS 1
    Channel-Identifier: 1ea09eaeb55611e1@speechrecog
    Recognition-Timeout: 20000
    No-Input-Timeout: 15000 </new>

    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Signalled Descriptor
    DEBUG app_unimrcp.c: Receive MRCPv2 Stream 192.168.1.11:46933 <->
    192.168.1.11:1544
    MRCP/2.0 80 1 200 COMPLETE
    Channel-Identifier: 1ea09eaeb55611e1@speechrecog

    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Raise App MRCP Response 0x1f8adb8 <1ea09eaeb55611e1>
    DEBUG res_speech_unimrcp.c: Received message from client stack
    DEBUG res_speech_unimrcp.c: On message receive
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG res_speech_unimrcp.c: Waked up
    DEBUG pbx.c: Launching 'SpeechLoadGrammar'
    VERBOSE pbx.c: -- Executing SpeechLoadGrammar("SIP/out_4313053051-00000003",
    "digit,/usr/local/unimrcp/data/grammar.jsgf") in new stack
    NOTICE res_speech_unimrcp.c: Load grammar name:digit type:application/x-jsgf
    path:/usr/local/unimrcp/data/grammar.jsgf '1ea09eaeb55611e1'
    DEBUG res_speech_unimrcp.c: Send MRCP request
    DEBUG app_unimrcp.c: Signal Message to
    DEBUG res_speech_unimrcp.c: Wait for MRCP response
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Receive App MRCP Request 0x1f8adb8 <1ea09eaeb55611e1>
    DEBUG app_unimrcp.c: Send MRCP Request 0x1f8adb8
    1ea09eaeb55611e1@speechrecog
    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Poller Wakeup
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Send MRCPv2 Stream 192.168.1.11:46933 <->
    192.168.1.11:1544
    MRCP/2.0 227 DEFINE-GRAMMAR 2
    Channel-Identifier: 1ea09eaeb55611e1@speechrecog
    Content-Type: application/x-jsgf
    Content-Id: digit
    Content-Length: 71

    JSGF V1.0;

    grammar digits;
    public <numbers> = (ONE | TWO | THREE); </numbers>

    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG chan_sip.c: Auto destroying SIP dialog
    '259a277c1bc2f1291506d80842d458be@192.168.1.11'
    DEBUG chan_sip.c: Destroying SIP dialog
    259a277c1bc2f1291506d80842d458be@192.168.1.11
    DEBUG chan_sip.c: Auto destroying SIP dialog
    '081324e0244682ac1811f00c2230092f@192.168.1.11'
    DEBUG chan_sip.c: Destroying SIP dialog
    081324e0244682ac1811f00c2230092f@192.168.1.11
    DEBUG chan_sip.c: Auto destroying SIP dialog
    '20ce0008084b33c044f6897b7d60254f@192.168.1.11'
    DEBUG chan_sip.c: Destroying SIP dialog
    20ce0008084b33c044f6897b7d60254f@192.168.1.11
    DEBUG chan_sip.c: Auto destroying SIP dialog
    '3b43c9e96413fc604ff35dae758ca61f@192.168.1.11'
    DEBUG chan_sip.c: Destroying SIP dialog
    3b43c9e96413fc604ff35dae758ca61f@192.168.1.11
    DEBUG chan_sip.c: Auto destroying SIP dialog
    '2520e67929c0860361464e32067763d0@192.168.1.11'
    DEBUG chan_sip.c: Destroying SIP dialog
    2520e67929c0860361464e32067763d0@192.168.1.11
    DEBUG chan_sip.c: Auto destroying SIP dialog
    '206eca736fc27e5776cf1ffd15d863e2@192.168.1.11'
    DEBUG chan_sip.c: Destroying SIP dialog
    206eca736fc27e5776cf1ffd15d863e2@192.168.1.11
    DEBUG chan_sip.c: Auto destroying SIP dialog
    '7f0d62e1618b8d800ba20e7c409f427c@192.168.1.11'
    DEBUG chan_sip.c: Destroying SIP dialog
    7f0d62e1618b8d800ba20e7c409f427c@192.168.1.11
    DEBUG chan_sip.c: Auto destroying SIP dialog
    '2f675b0211faee541d8ce1ee3fb189b1@192.168.1.11'
    DEBUG chan_sip.c: Destroying SIP dialog
    2f675b0211faee541d8ce1ee3fb189b1@192.168.1.11
    DEBUG chan_sip.c: Auto destroying SIP dialog
    '5b1d78f87fe3995e7d14827749366e46@192.168.1.11'
    DEBUG chan_sip.c: Destroying SIP dialog
    5b1d78f87fe3995e7d14827749366e46@192.168.1.11
    DEBUG chan_sip.c: Auto destroying SIP dialog
    '69bd0428643f79eb674100af1c30bec5@192.168.1.11'
    DEBUG chan_sip.c: Destroying SIP dialog
    69bd0428643f79eb674100af1c30bec5@192.168.1.11
    DEBUG chan_sip.c: Auto destroying SIP dialog
    '47cb5a8478bebbb070fa19c1231d879c@192.168.1.11'
    DEBUG chan_sip.c: Destroying SIP dialog
    47cb5a8478bebbb070fa19c1231d879c@192.168.1.11
    DEBUG app_unimrcp.c: Process Signalled Descriptor
    DEBUG app_unimrcp.c: Receive MRCPv2 Stream 192.168.1.11:46933 <->
    192.168.1.11:1544
    MRCP/2.0 112 2 200 COMPLETE
    Channel-Identifier: 1ea09eaeb55611e1@speechrecog
    Completion-Cause: 000 success

    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Raise App MRCP Response 0x1f8adb8 <1ea09eaeb55611e1>
    DEBUG res_speech_unimrcp.c: Received message from client stack
    DEBUG res_speech_unimrcp.c: On message receive
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG res_speech_unimrcp.c: Waked up
    DEBUG pbx.c: Launching 'SpeechActivateGrammar'
    VERBOSE pbx.c: -- Executing
    SpeechActivateGrammar("SIP/out_4313053051-00000003", "digit") in new stack
    NOTICE res_speech_unimrcp.c: Activate grammar name:digit '1ea09eaeb55611e1'
    DEBUG pbx.c: Launching 'SpeechBackground'
    VERBOSE pbx.c: -- Executing SpeechBackground("SIP/out_4313053051-00000003",
    "/opt/yasssu/voice/yassgen/INTRO_clip,20") in new stack
    DEBUG channel.c: Set channel SIP/out_4313053051-00000003 to read format slin
    NOTICE res_speech_unimrcp.c: Start audio '1ea09eaeb55611e1'
    DEBUG res_speech_unimrcp.c: Send MRCP request
    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Receive App MRCP Request 0x1f8adb8 <1ea09eaeb55611e1>
    DEBUG app_unimrcp.c: Send MRCP Request 0x1f8adb8
    1ea09eaeb55611e1@speechrecog
    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Poller Wakeup
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Send MRCPv2 Stream 192.168.1.11:46933 <->
    192.168.1.11:1544
    MRCP/2.0 190 RECOGNIZE 3
    Channel-Identifier: 1ea09eaeb55611e1@speechrecog
    Content-Type: text/uri-list
    Cancel-If-Queue: false
    Start-Input-Timers: true
    Content-Length: 13

    session:digit
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG res_speech_unimrcp.c: Wait for MRCP response
    DEBUG app_unimrcp.c: Process Signalled Descriptor
    DEBUG app_unimrcp.c: Receive MRCPv2 Stream 192.168.1.11:46933 <->
    192.168.1.11:1544
    MRCP/2.0 83 3 200 IN-PROGRESS
    Channel-Identifier: 1ea09eaeb55611e1@speechrecog

    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Raise App MRCP Response 0x1f8adb8 <1ea09eaeb55611e1>
    DEBUG res_speech_unimrcp.c: Received message from client stack
    DEBUG res_speech_unimrcp.c: On message receive
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG res_speech_unimrcp.c: Waked up
    DEBUG channel.c: Set channel SIP/out_4313053051-00000003 to write format slin
    DEBUG res_rtp_asterisk.c: Ooh, format changed from unknown to alaw
    DEBUG res_rtp_asterisk.c: Created smoother: format: alaw ms: 20 len: 160
    DEBUG channel.c: Scheduling timer at (50 requested / 50 actual) timer ticks
    per second
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG chan_sip.c: Auto destroying SIP dialog
    '3ef6f39c37b5425b019c59533413dec5@192.168.1.11'
    DEBUG chan_sip.c: Destroying SIP dialog
    3ef6f39c37b5425b019c59533413dec5@192.168.1.11
    DEBUG chan_sip.c: Auto destroying SIP dialog
    '184e820e7455df9e570675b216720a17@192.168.1.11'
    DEBUG chan_sip.c: Destroying SIP dialog
    184e820e7455df9e570675b216720a17@192.168.1.11
    DEBUG chan_sip.c: Auto destroying SIP dialog
    '7dfb26b3016888de4d74a5ef121704de@192.168.1.11'
    DEBUG chan_sip.c: Destroying SIP dialog
    7dfb26b3016888de4d74a5ef121704de@192.168.1.11
    DEBUG res_rtp_asterisk.c: Got RTCP report of 64 bytes
    DEBUG chan_sip.c: Auto destroying SIP dialog
    '1e327df839d0b90b6a1018c37addd4de@192.168.1.11'
    DEBUG chan_sip.c: Destroying SIP dialog
    1e327df839d0b90b6a1018c37addd4de@192.168.1.11
    DEBUG chan_sip.c: Auto destroying SIP dialog
    '31da36ca4ed526c05d7383852704712e@192.168.1.11'
    DEBUG chan_sip.c: Destroying SIP dialog
    31da36ca4ed526c05d7383852704712e@192.168.1.11
    DEBUG chan_sip.c: Auto destroying SIP dialog
    '30dd39d97340d7f86d384ba15eb81a56@192.168.1.11'
    DEBUG chan_sip.c: Destroying SIP dialog
    30dd39d97340d7f86d384ba15eb81a56@192.168.1.11
    DEBUG chan_sip.c: Auto destroying SIP dialog
    '32a5cad9146e36246a1d26a309472af9@192.168.1.11'
    DEBUG chan_sip.c: Destroying SIP dialog
    32a5cad9146e36246a1d26a309472af9@192.168.1.11
    DEBUG chan_sip.c: Auto destroying SIP dialog
    '2fd8ef5440bb829d5b99d35a703cc820@192.168.1.11'
    DEBUG chan_sip.c: Destroying SIP dialog
    2fd8ef5440bb829d5b99d35a703cc820@192.168.1.11
    DEBUG chan_sip.c: Auto destroying SIP dialog
    '49bb64a533c79dc25aeab6aa0658d538@192.168.1.11'
    DEBUG chan_sip.c: Destroying SIP dialog
    49bb64a533c79dc25aeab6aa0658d538@192.168.1.11
    DEBUG chan_sip.c: Auto destroying SIP dialog
    '28631cc7473c11345f22ba5a4c86dd07@192.168.1.11'
    DEBUG chan_sip.c: Destroying SIP dialog
    28631cc7473c11345f22ba5a4c86dd07@192.168.1.11
    DEBUG chan_sip.c: Auto destroying SIP dialog
    '5717c53f546810817488f01304f70679@192.168.1.11'
    DEBUG chan_sip.c: Destroying SIP dialog
    5717c53f546810817488f01304f70679@192.168.1.11
    DEBUG chan_sip.c: Auto destroying SIP dialog
    '374f9dbd0a2bf4923db71f486fc22832@192.168.1.11'
    DEBUG chan_sip.c: Destroying SIP dialog
    374f9dbd0a2bf4923db71f486fc22832@192.168.1.11
    DEBUG chan_sip.c: Auto destroying SIP dialog
    '240d42487fdc40807ddd9fa5534da200@192.168.1.11'
    DEBUG chan_sip.c: Destroying SIP dialog
    240d42487fdc40807ddd9fa5534da200@192.168.1.11
    DEBUG chan_sip.c: Auto destroying SIP dialog
    '0ca5806a67dec3087335425a22fc1f6c@192.168.1.11'
    DEBUG chan_sip.c: Destroying SIP dialog
    0ca5806a67dec3087335425a22fc1f6c@192.168.1.11
    DEBUG chan_sip.c: Auto destroying SIP dialog
    '55c4322b69e33b0453df79633e98ba43@192.168.1.11'
    DEBUG chan_sip.c: Destroying SIP dialog
    55c4322b69e33b0453df79633e98ba43@192.168.1.11
    DEBUG chan_sip.c: Auto destroying SIP dialog
    '0f332f877697fd8068aca25f74f88e7f@192.168.1.11'
    DEBUG chan_sip.c: Destroying SIP dialog
    0f332f877697fd8068aca25f74f88e7f@192.168.1.11
    DEBUG chan_sip.c: Auto destroying SIP dialog
    '35252c8f5a0e4fe40d960ef52d27b176@192.168.1.11'
    DEBUG chan_sip.c: Destroying SIP dialog
    35252c8f5a0e4fe40d960ef52d27b176@192.168.1.11
    DEBUG chan_sip.c: Auto destroying SIP dialog
    '7cb2cfb37699bc961458767d28c1890f@192.168.1.11'
    DEBUG chan_sip.c: Destroying SIP dialog
    7cb2cfb37699bc961458767d28c1890f@192.168.1.11
    DEBUG chan_sip.c: Auto destroying SIP dialog
    '172f7f082d94affc4ff828ad77d12cc0@192.168.1.11'
    DEBUG chan_sip.c: Destroying SIP dialog
    172f7f082d94affc4ff828ad77d12cc0@192.168.1.11
    DEBUG chan_sip.c: Auto destroying SIP dialog
    '3e71dfdb5534e5342af34eae3df92fb6@192.168.1.11'
    DEBUG chan_sip.c: Destroying SIP dialog
    3e71dfdb5534e5342af34eae3df92fb6@192.168.1.11
    DEBUG chan_sip.c: Auto destroying SIP dialog
    '53fea5924dc6aa096ebde3475e53b250@192.168.1.11'
    DEBUG chan_sip.c: Destroying SIP dialog
    53fea5924dc6aa096ebde3475e53b250@192.168.1.11
    DEBUG app_unimrcp.c: Process Signalled Descriptor
    DEBUG app_unimrcp.c: Receive MRCPv2 Stream 192.168.1.11:46933 <->
    192.168.1.11:1544
    MRCP/2.0 94 START-OF-INPUT 3 IN-PROGRESS
    Channel-Identifier: 1ea09eaeb55611e1@speechrecog

    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Raise App MRCP Event 0x1f8adb8 <1ea09eaeb55611e1>
    DEBUG res_speech_unimrcp.c: Received message from client stack
    DEBUG res_speech_unimrcp.c: On message receive
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG channel.c: Scheduling timer at (0 requested / 0 actual) timer ticks per
    second
    DEBUG channel.c: Scheduling timer at (0 requested / 0 actual) timer ticks per
    second
    DEBUG channel.c: Set channel SIP/out_4313053051-00000003 to write format alaw
    DEBUG app_unimrcp.c: Process Signalled Descriptor
    DEBUG app_unimrcp.c: Receive MRCPv2 Stream 192.168.1.11:46933 <->
    192.168.1.11:1544
    MRCP/2.0 350 RECOGNITION-COMPLETE 3 COMPLETE
    Channel-Identifier: 1ea09eaeb55611e1@speechrecog
    Completion-Cause: 000 success
    Content-Type: application/x-nlsml
    Content-Length: 165

    <result grammar="digit">
    <interpretation grammar="digit" confidence="99">
    <input mode="speech">ONE
    </interpretation>
    </result>

    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Raise App MRCP Event 0x1f8adb8 <1ea09eaeb55611e1>
    DEBUG res_speech_unimrcp.c: Received message from client stack
    DEBUG res_speech_unimrcp.c: On message receive
    DEBUG app_unimrcp.c: Wait for Messages
    NOTICE res_speech_unimrcp.c: Get result '1ea09eaeb55611e1'
    DEBUG channel.c: Set channel SIP/out_4313053051-00000003 to read format alaw
    DEBUG pbx.c: Function result is '0'
    DEBUG pbx.c: Expression result is '1'
    DEBUG pbx.c: Launching 'GotoIf'
    VERBOSE pbx.c: -- Executing GotoIf("SIP/out_4313053051-00000003", "1?7:9") in
    new stack
    VERBOSE pbx.c: -- Goto (default,4313053058,7)
    DEBUG pbx.c: Launching 'Playback'
    VERBOSE pbx.c: -- Executing Playback("SIP/out_4313053051-00000003", "vm-
    nonumber") in new stack
    DEBUG channel.c: Set channel SIP/out_4313053051-00000003 to write format gsm
    DEBUG res_rtp_asterisk.c: Difference is 2864, ms is 378
    DEBUG channel.c: Scheduling timer at (50 requested / 50 actual) timer ticks
    per second
    VERBOSE file.c: -- <sip out_4313053051-00000003=""> Playing 'vm-nonumber.gsm'
    (language 'en')
    DEBUG res_rtp_asterisk.c: Got RTCP report of 64 bytes
    DEBUG channel.c: Scheduling timer at (0 requested / 0 actual) timer ticks per
    second
    DEBUG channel.c: Scheduling timer at (0 requested / 0 actual) timer ticks per
    second
    DEBUG channel.c: Scheduling timer at (0 requested / 0 actual) timer ticks per
    second
    DEBUG channel.c: Set channel SIP/out_4313053051-00000003 to write format alaw
    DEBUG pbx.c: Function result is '0'
    DEBUG pbx.c: Launching 'Verbose'
    VERBOSE pbx.c: -- Executing Verbose("SIP/out_4313053051-00000003", "1,Results
    is 0") in new stack
    VERBOSE app_verbose.c: Results is 0
    DEBUG pbx.c: Function result is '(null)'
    DEBUG pbx.c: Launching 'Verbose'
    VERBOSE pbx.c: -- Executing Verbose("SIP/out_4313053051-00000003", "1,The
    recognized input is ") in new stack
    VERBOSE app_verbose.c: The recognized input is
    DEBUG pbx.c: Function result is '(null)'
    DEBUG pbx.c: Launching 'Verbose'
    VERBOSE pbx.c: -- Executing Verbose("SIP/out_4313053051-00000003", "1,The
    score is ") in new stack
    VERBOSE app_verbose.c: The score is
    DEBUG pbx.c: Function result is '(null)'
    DEBUG pbx.c: Launching 'Verbose'
    VERBOSE pbx.c: -- Executing Verbose("SIP/out_4313053051-00000003", "1,The
    matched grammar is ") in new stack
    VERBOSE app_verbose.c: The matched grammar is
    DEBUG pbx.c: Launching 'SpeechDeactivateGrammar'
    VERBOSE pbx.c: -- Executing
    SpeechDeactivateGrammar("SIP/out_4313053051-00000003", "digit") in new stack
    NOTICE res_speech_unimrcp.c: Deactivate grammar name:digit '1ea09eaeb55611e1'
    DEBUG pbx.c: Launching 'SpeechUnloadGrammar'
    VERBOSE pbx.c: -- Executing SpeechUnloadGrammar("SIP/out_4313053051-00000003",
    "digit") in new stack
    NOTICE res_speech_unimrcp.c: Unload grammar name:digit '1ea09eaeb55611e1'
    DEBUG res_speech_unimrcp.c: Send MRCP request
    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Receive App MRCP Request 0x1f8adb8 <1ea09eaeb55611e1>
    DEBUG app_unimrcp.c: Send MRCP Request 0x1f8adb8
    1ea09eaeb55611e1@speechrecog
    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG res_speech_unimrcp.c: Wait for MRCP response
    DEBUG app_unimrcp.c: Process Poller Wakeup
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Send MRCPv2 Stream 192.168.1.11:46933 <->
    192.168.1.11:1544
    MRCP/2.0 102 DEFINE-GRAMMAR 4
    Channel-Identifier: 1ea09eaeb55611e1@speechrecog
    Content-Id: digit </sip>

    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Signalled Descriptor
    DEBUG app_unimrcp.c: Receive MRCPv2 Stream 192.168.1.11:46933 <->
    192.168.1.11:1544
    MRCP/2.0 112 4 200 COMPLETE
    Channel-Identifier: 1ea09eaeb55611e1@speechrecog
    Completion-Cause: 000 success

    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Raise App MRCP Response 0x1f8adb8 <1ea09eaeb55611e1>
    DEBUG res_speech_unimrcp.c: Received message from client stack
    DEBUG res_speech_unimrcp.c: On message receive
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG res_speech_unimrcp.c: Waked up
    DEBUG pbx.c: Launching 'SpeechDestroy'
    VERBOSE pbx.c: -- Executing SpeechDestroy("SIP/out_4313053051-00000003", "")
    in new stack
    NOTICE res_speech_unimrcp.c: Destroy speech instance '1ea09eaeb55611e1'
    DEBUG res_speech_unimrcp.c: Send session request type:1
    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Receive App Request 0x1f8adb8 <1ea09eaeb55611e1>
    DEBUG app_unimrcp.c: Dispatch App Request 0x1f8adb8 <1ea09eaeb55611e1>
    DEBUG app_unimrcp.c: Terminate Session 0x1f8adb8 <1ea09eaeb55611e1>
    DEBUG app_unimrcp.c: Remove Control Channel 0x1f8adb8 <1ea09eaeb55611e1>
    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Subtract Media Termination 0x1f8adb8 1ea09eaeb55611e1 @media-tm
    DEBUG app_unimrcp.c: Subtract Media Termination 0x1f8adb8 1ea09eaeb55611e1 @rtp-tm
    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Poller Wakeup
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Remove Control Channel 1ea09eaeb55611e1@speechrecog
    DEBUG app_unimrcp.c: Close TCP/MRCPv2 Connection 192.168.1.11:46933 <->
    192.168.1.11:1544
    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Control Channel Removed 0x1f8adb8
    1ea09eaeb55611e1@speechrecog
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG res_speech_unimrcp.c: Wait for session response
    DEBUG app_unimrcp.c: Receive SIP Event Status 200 OK
    DEBUG app_unimrcp.c: Receive SIP Event Status 200 to BYE
    NOTICE app_unimrcp.c: SIP Call State 0x1f8adb8
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Session Terminated 0x1f8adb8 <1ea09eaeb55611e1>
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Destroy Audio Bridge 0x1f8adb8
    DEBUG app_unimrcp.c: Close RTP Transmitter 192.168.1.11:4004 ->
    192.168.1.11:5004
    DEBUG app_unimrcp.c: Remove Media Context 0x1f8adb8
    DEBUG app_unimrcp.c: Remove RTP Session 192.168.1.11:4004
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Media Termination Subtracted 0x1f8adb8 1ea09eaeb55611e1 @media-tm
    DEBUG app_unimrcp.c: Media Termination Subtracted 0x1f8adb8 1ea09eaeb55611e1 @rtp-tm
    NOTICE app_unimrcp.c: Destroy TCP/MRCPv2 Connection 192.168.1.11:46933 <->
    192.168.1.11:1544
    DEBUG app_unimrcp.c: Remove MRCP Handle 0x1f8adb8 <1ea09eaeb55611e1>
    DEBUG app_unimrcp.c: Raise App Response 0x1f8adb8 <1ea09eaeb55611e1> SUCCESS
    DEBUG res_speech_unimrcp.c: Received message from client stack
    DEBUG res_speech_unimrcp.c: On session terminate
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG res_speech_unimrcp.c: Waked up, status code: 0
    NOTICE app_unimrcp.c: Destroy MRCP Handle 0x1f8adb8
    DEBUG pbx.c: Launching 'Hangup'
    VERBOSE pbx.c: -- Executing Hangup("SIP/out_4313053051-00000003", "") in new
    stack
    DEBUG pbx.c: Spawn extension (default,4313053058,15) exited non-zero on
    'SIP/out_4313053051-00000003'
    VERBOSE pbx.c: == Spawn extension (default, 4313053058, 15) exited non-zero on
    'SIP/out_4313053051-00000003'
    DEBUG channel.c: Soft-Hanging up channel 'SIP/out_4313053051-00000003'
    DEBUG channel.c: Hanging up channel 'SIP/out_4313053051-00000003'
    DEBUG chan_sip.c: Hanging up zombie call. Be scared.
    DEBUG res_rtp_asterisk.c: Setting RTCP address on RTP instance '0x1f86e68'
    DEBUG chan_sip.c: Trying to put 'BYE sip:004' onto UDP socket destined for
    213.185.165.114:5060
    DEBUG chan_sip.c: Checking device state for peer out_4313053051
    DEBUG devicestate.c: Changing state for SIP/out_4313053051 - state 1 (Not in
    use)
    DEBUG devicestate.c: device 'SIP/out_4313053051' state '1'
    DEBUG app_queue.c: Device 'SIP/out_4313053051' changed to state '1' (Not in
    use) but we don't care because they're not a member of any queue.
    DEBUG chan_sip.c: Stopping retransmission on
    '3e4d7e114e4068400374e87421b77f7c@213.185.165.102:5060' of Request 102: Match
    Found
    DEBUG chan_sip.c: Destroying SIP dialog
    3e4d7e114e4068400374e87421b77f7c@213.185.165.102:5060
    DEBUG rtp_engine.c: Destroyed RTP instance '0x1f86e68'

     
  • Nickolay V. Shmyrev

    You need to check unimrcp server log for details too.

     
  • Rudi Dellinger

    Rudi Dellinger - 2012-06-14

    Below please find the corresponding unimrcp server log, can you tell anything
    from it?

    2012-06-14 12:46:37:358222 Receive SIP Event Status 100 Trying
    2012-06-14 12:46:37:358243 Receive SIP Event Status 100 Trying
    2012-06-14 12:46:37:358250 SIP Call State
    2012-06-14 12:46:37:358263 Create Session 0x1eceb68 <new>
    2012-06-14 12:46:37:358270 Remote SDP 0x1eceb68 <new>
    v=0
    o=UniMRCPClient 401928472805083952 1767600382209783814 IN IP4 192.168.1.11
    s=-
    c=IN IP4 192.168.1.11
    t=0 0
    m=application 9 TCP/MRCPv2 1
    a=setup:active
    a=connection:new
    a=resource:speechrecog
    a=cmid:1
    m=audio 4014 RTP/AVP 0 8 96 101
    a=rtpmap:0 PCMU/8000
    a=rtpmap:8 PCMA/8000
    a=rtpmap:96 L16/8000
    a=rtpmap:101 telephone-event/8000
    a=fmtp:101 0-15
    a=sendonly
    a=ptime:20
    a=mid:1 </new></new>

    2012-06-14 12:46:37:358314 Process Message
    2012-06-14 12:46:37:358325 Dispatch Signaling Message
    2012-06-14 12:46:37:358334 Add Session <376e11ceb60e11e1>
    2012-06-14 12:46:37:358342 Receive Offer 0x1eceb68 <376e11ceb60e11e1>
    2012-06-14 12:46:37:358356 Add Control Channel 0x1eceb68
    376e11ceb60e11e1@speechrecog
    2012-06-14 12:46:37:358363 Signal Message to
    2012-06-14 12:46:37:358375 Add Media Termination 0x1eceb68 376e11ceb60e11e1 @rtp-tm
    2012-06-14 12:46:37:358381 Process Poller Wakeup
    2012-06-14 12:46:37:358383 Signal Message to
    2012-06-14 12:46:37:358393 Process Message
    2012-06-14 12:46:37:358403 Wait for Messages
    2012-06-14 12:46:37:358414 Create Container for Pending Control Channels
    2012-06-14 12:46:37:358433 Add Pending Control Channel
    376e11ceb60e11e1@speechrecog
    2012-06-14 12:46:37:358439 Signal Message to
    2012-06-14 12:46:37:358448 Wait for Messages
    2012-06-14 12:46:37:358450 Process Message
    2012-06-14 12:46:37:358461 Control Channel Modified 0x1eceb68
    376e11ceb60e11e1@speechrecog
    2012-06-14 12:46:37:358467 Wait for Messages
    2012-06-14 12:46:37:365720 Process Message
    2012-06-14 12:46:37:365729 Add Media Context 0x1eceb68
    2012-06-14 12:46:37:365811 Enable RTP Session 192.168.1.11:5006
    2012-06-14 12:46:37:365822 Create Linear Audio Bridge 0x1eceb68
    2012-06-14 12:46:37:365830 Open RTP Receiver 192.168.1.11:5006 <-
    192.168.1.11:4014 playout
    2012-06-14 12:46:37:365837 Media Path 0x1eceb68
    Source->->Decoder->->Bridge->->Sink
    2012-06-14 12:46:37:365859 Process Message
    2012-06-14 12:46:37:365867 Media Termination Modified 0x1eceb68
    376e11ceb60e11e1@media-tm
    2012-06-14 12:46:37:365871 Media Termination Modified 0x1eceb68
    376e11ceb60e11e1@rtp-tm
    2012-06-14 12:46:37:365876 Open Channel 376e11ceb60e11e1@pocketsphinx
    2012-06-14 12:46:37:365917 Wait for Messages
    2012-06-14 12:46:37:365923 Run Recognition Thread
    376e11ceb60e11e1@pocketsphinx
    2012-06-14 12:46:37:365933 Signal Message to
    2012-06-14 12:46:37:365940 Wait for incoming messages
    376e11ceb60e11e1@pocketsphinx
    2012-06-14 12:46:37:365943 Process Message
    2012-06-14 12:46:37:365955 Engine Channel Opened 0x1eceb68
    376e11ceb60e11e1@speechrecog
    2012-06-14 12:46:37:365960 Send Answer 0x1eceb68 <376e11ceb60e11e1> Status OK
    2012-06-14 12:46:37:365972 Local SDP 0x1eceb68 <376e11ceb60e11e1>
    v=0
    o=UniMRCPServer 0 0 IN IP4 192.168.1.11
    s=-
    c=IN IP4 192.168.1.11
    t=0 0
    m=application 1544 TCP/MRCPv2 1
    a=setup:passive
    a=connection:new
    a=channel:376e11ceb60e11e1@speechrecog
    a=cmid:1
    m=audio 5006 RTP/AVP 0 101
    a=rtpmap:0 PCMU/8000
    a=rtpmap:101 telephone-event/8000
    a=fmtp:101 0-15
    a=recvonly
    a=ptime:20
    a=mid:1

    2012-06-14 12:46:37:365988 Wait for Messages
    2012-06-14 12:46:37:366211 Receive SIP Event Status 200 OK
    2012-06-14 12:46:37:366221 SIP Call State 0x1eceb68
    2012-06-14 12:46:37:366399 Receive SIP Event Status 200 OK
    2012-06-14 12:46:37:366411 Receive SIP Event Status 200 OK
    2012-06-14 12:46:37:366418 SIP Call State 0x1eceb68
    2012-06-14 12:46:37:366423 Receive SIP Event Status 200 Call active
    2012-06-14 12:46:37:366622 Process Signalled Descriptor
    2012-06-14 12:46:37:366641 Accepted TCP/MRCPv2 Connection 192.168.1.11:1544
    <-> 192.168.1.11:41623
    2012-06-14 12:46:37:366648 Wait for Messages
    2012-06-14 12:46:37:367861 Process Signalled Descriptor
    2012-06-14 12:46:37:367873 Receive MRCPv2 Stream 192.168.1.11:1544 <->
    192.168.1.11:41623
    MRCP/2.0 132 SET-PARAMS 1
    Channel-Identifier: 376e11ceb60e11e1@speechrecog
    Recognition-Timeout: 20000
    No-Input-Timeout: 15000

    2012-06-14 12:46:37:367889 Attach Control Channel
    376e11ceb60e11e1@speechrecog to Connection 192.168.1.11:1544 <->
    192.168.1.11:41623
    2012-06-14 12:46:37:367896 Signal Message to
    2012-06-14 12:46:37:367903 Wait for Messages
    2012-06-14 12:46:37:367906 Process Message
    2012-06-14 12:46:37:367915 Dispatch Signaling Message
    2012-06-14 12:46:37:367920 Process SET-PARAMS Request
    376e11ceb60e11e1@speechrecog
    2012-06-14 12:46:37:367930 Wait for Messages
    2012-06-14 12:46:37:367933 Dispatch Request SET-PARAMS
    376e11ceb60e11e1@pocketsphinx
    2012-06-14 12:46:37:367941 Signal Message to
    2012-06-14 12:46:37:367949 Wait for incoming messages
    376e11ceb60e11e1@pocketsphinx
    2012-06-14 12:46:37:367951 Process Message
    2012-06-14 12:46:37:367963 Process SET-PARAMS Response
    376e11ceb60e11e1@speechrecog
    2012-06-14 12:46:37:367969 Signal Message to
    2012-06-14 12:46:37:367977 Wait for Messages
    2012-06-14 12:46:37:367980 Process Poller Wakeup
    2012-06-14 12:46:37:367988 Process Message
    2012-06-14 12:46:37:367995 Send MRCPv2 Stream 192.168.1.11:1544 <->
    192.168.1.11:41623
    MRCP/2.0 80 1 200 COMPLETE
    Channel-Identifier: 376e11ceb60e11e1@speechrecog

    2012-06-14 12:46:37:368019 Wait for Messages
    2012-06-14 12:46:37:368268 Process Signalled Descriptor
    2012-06-14 12:46:37:368277 Receive MRCPv2 Stream 192.168.1.11:1544 <->
    192.168.1.11:41623
    MRCP/2.0 239 DEFINE-GRAMMAR 2
    Channel-Identifier: 376e11ceb60e11e1@speechrecog
    Content-Type: application/x-jsgf
    Content-Id: digits
    Content-Length: 82

    JSGF V1.0;

    grammar digits;
    public <numbers> = (YES | NO | ONE | TWO | THREE); </numbers>

    2012-06-14 12:46:37:368291 Signal Message to
    2012-06-14 12:46:37:368300 Wait for Messages
    2012-06-14 12:46:37:368303 Process Message
    2012-06-14 12:46:37:368311 Dispatch Signaling Message
    2012-06-14 12:46:37:368316 Process DEFINE-GRAMMAR Request
    376e11ceb60e11e1@speechrecog
    2012-06-14 12:46:37:368324 Wait for Messages
    2012-06-14 12:46:37:368328 Dispatch Request DEFINE-GRAMMAR
    376e11ceb60e11e1@pocketsphinx
    2012-06-14 12:46:37:368340 Create Grammar File 376e11ceb60e11e1@pocketsphinx
    2012-06-14 12:46:37:368382 Init Config rate dictionary
    376e11ceb60e11e1@pocketsphinx
    2012-06-14 12:46:37:368665 Init Decoder 376e11ceb60e11e1@pocketsphinx
    2012-06-14 12:46:42:014847 Signal Message to
    2012-06-14 12:46:42:014879 Wait for incoming messages
    376e11ceb60e11e1@pocketsphinx
    2012-06-14 12:46:42:014883 Process Message
    2012-06-14 12:46:42:014896 Process DEFINE-GRAMMAR Response
    376e11ceb60e11e1@speechrecog
    2012-06-14 12:46:42:014904 Signal Message to
    2012-06-14 12:46:42:014917 Wait for Messages
    2012-06-14 12:46:42:014925 Process Poller Wakeup
    2012-06-14 12:46:42:014932 Process Message
    2012-06-14 12:46:42:014943 Send MRCPv2 Stream 192.168.1.11:1544 <->
    192.168.1.11:41623
    MRCP/2.0 112 2 200 COMPLETE
    Channel-Identifier: 376e11ceb60e11e1@speechrecog
    Completion-Cause: 000 success

    2012-06-14 12:46:42:014978 Wait for Messages
    2012-06-14 12:46:42:015281 Process Signalled Descriptor
    2012-06-14 12:46:42:015292 Receive MRCPv2 Stream 192.168.1.11:1544 <->
    192.168.1.11:41623
    MRCP/2.0 191 RECOGNIZE 3
    Channel-Identifier: 376e11ceb60e11e1@speechrecog
    Content-Type: text/uri-list
    Cancel-If-Queue: false
    Start-Input-Timers: true
    Content-Length: 14

    session:digits
    2012-06-14 12:46:42:015313 Signal Message to
    2012-06-14 12:46:42:015322 Wait for Messages
    2012-06-14 12:46:42:015325 Process Message
    2012-06-14 12:46:42:015334 Dispatch Signaling Message
    2012-06-14 12:46:42:015338 Process RECOGNIZE Request
    376e11ceb60e11e1@speechrecog
    2012-06-14 12:46:42:015347 Wait for Messages
    2012-06-14 12:46:42:015357 Dispatch Request RECOGNIZE
    376e11ceb60e11e1@pocketsphinx
    2012-06-14 12:46:42:015392 Signal Message to
    2012-06-14 12:46:42:015402 Wait for incoming messages
    376e11ceb60e11e1@pocketsphinx
    2012-06-14 12:46:42:015404 Process Message
    2012-06-14 12:46:42:015418 Process RECOGNIZE Response
    376e11ceb60e11e1@speechrecog
    2012-06-14 12:46:42:015423 State Transition IDLE -> RECOGNIZING
    376e11ceb60e11e1@speechrecog
    2012-06-14 12:46:42:015429 Signal Message to
    2012-06-14 12:46:42:015438 Wait for Messages
    2012-06-14 12:46:42:015441 Process Poller Wakeup
    2012-06-14 12:46:42:015449 Process Message
    2012-06-14 12:46:42:015458 Send MRCPv2 Stream 192.168.1.11:1544 <->
    192.168.1.11:41623
    MRCP/2.0 83 3 200 IN-PROGRESS
    Channel-Identifier: 376e11ceb60e11e1@speechrecog

    2012-06-14 12:46:42:015480 Wait for Messages
    2012-06-14 12:46:42:706068 Get Recognition Partial Result Score
    376e11ceb60e11e1@pocketsphinx
    2012-06-14 12:46:46:295973 Detected Voice Activity
    376e11ceb60e11e1@pocketsphinx
    2012-06-14 12:46:46:296007 Signal Message to
    2012-06-14 12:46:46:296023 Process Message
    2012-06-14 12:46:46:296034 Process START-OF-INPUT Event
    376e11ceb60e11e1@speechrecog
    2012-06-14 12:46:46:296041 Signal Message to
    2012-06-14 12:46:46:296054 Wait for Messages
    2012-06-14 12:46:46:296060 Process Poller Wakeup
    2012-06-14 12:46:46:296068 Process Message
    2012-06-14 12:46:46:296080 Send MRCPv2 Stream 192.168.1.11:1544 <->
    192.168.1.11:41623
    MRCP/2.0 94 START-OF-INPUT 3 IN-PROGRESS
    Channel-Identifier: 376e11ceb60e11e1@speechrecog

    2012-06-14 12:46:46:296115 Wait for Messages
    2012-06-14 12:46:46:306027 Get Recognition Partial Result Score
    376e11ceb60e11e1@pocketsphinx
    2012-06-14 12:46:47:346051 Detected Voice Inactivity
    376e11ceb60e11e1@pocketsphinx
    2012-06-14 12:46:47:348841 Get Recognition Final Result Prob Score
    376e11ceb60e11e1@pocketsphinx
    2012-06-14 12:46:47:348861 Signal Message to
    2012-06-14 12:46:47:348872 Wait for incoming messages
    376e11ceb60e11e1@pocketsphinx
    2012-06-14 12:46:47:348875 Process Message
    2012-06-14 12:46:47:348885 Process RECOGNITION-COMPLETE Event
    376e11ceb60e11e1@speechrecog
    2012-06-14 12:46:47:348890 State Transition RECOGNIZING -> RECOGNIZED
    376e11ceb60e11e1@speechrecog
    2012-06-14 12:46:47:348896 Signal Message to
    2012-06-14 12:46:47:348908 Wait for Messages
    2012-06-14 12:46:47:348914 Process Poller Wakeup
    2012-06-14 12:46:47:348922 Process Message
    2012-06-14 12:46:47:348932 Send MRCPv2 Stream 192.168.1.11:1544 <->
    192.168.1.11:41623
    MRCP/2.0 351 RECOGNITION-COMPLETE 3 COMPLETE
    Channel-Identifier: 376e11ceb60e11e1@speechrecog
    Completion-Cause: 000 success
    Content-Type: application/x-nlsml
    Content-Length: 166

    <result grammar="digits">
    <interpretation grammar="digits" confidence="99">
    <input mode="speech">NO
    </interpretation>
    </result>

    2012-06-14 12:46:47:348965 Wait for Messages
    2012-06-14 12:46:49:951047 Process Signalled Descriptor
    2012-06-14 12:46:49:951064 Receive MRCPv2 Stream 192.168.1.11:1544 <->
    192.168.1.11:41623
    MRCP/2.0 102 DEFINE-GRAMMAR 4
    Channel-Identifier: 376e11ceb60e11e1@speechrecog
    Content-Id: digit

    2012-06-14 12:46:49:951087 Signal Message to
    2012-06-14 12:46:49:951097 Wait for Messages
    2012-06-14 12:46:49:951101 Process Message
    2012-06-14 12:46:49:951112 Dispatch Signaling Message
    2012-06-14 12:46:49:951117 Process DEFINE-GRAMMAR Request
    376e11ceb60e11e1@speechrecog
    2012-06-14 12:46:49:951122 State Transition RECOGNIZED -> IDLE
    376e11ceb60e11e1@speechrecog
    2012-06-14 12:46:49:951130 Wait for Messages
    2012-06-14 12:46:49:951135 Dispatch Request DEFINE-GRAMMAR
    376e11ceb60e11e1@pocketsphinx
    2012-06-14 12:46:49:951147 Signal Message to
    2012-06-14 12:46:49:951156 Wait for incoming messages
    376e11ceb60e11e1@pocketsphinx
    2012-06-14 12:46:49:951158 Process Message
    2012-06-14 12:46:49:951171 Process DEFINE-GRAMMAR Response
    376e11ceb60e11e1@speechrecog
    2012-06-14 12:46:49:951183 Signal Message to
    2012-06-14 12:46:49:951193 Wait for Messages
    2012-06-14 12:46:49:951197 Process Poller Wakeup
    2012-06-14 12:46:49:951204 Process Message
    2012-06-14 12:46:49:951212 Send MRCPv2 Stream 192.168.1.11:1544 <->
    192.168.1.11:41623
    MRCP/2.0 112 4 404 COMPLETE
    Channel-Identifier: 376e11ceb60e11e1@speechrecog
    Completion-Cause: 000 success

    2012-06-14 12:46:49:951234 Wait for Messages
    2012-06-14 12:46:49:951789 Process Signalled Descriptor
    2012-06-14 12:46:49:951801 TCP/MRCPv2 Peer Disconnected 192.168.1.11:1544 <->
    192.168.1.11:41623
    2012-06-14 12:46:49:951833 Wait for Messages
    2012-06-14 12:46:49:952071 Receive SIP Event Status 200 Session Terminated
    2012-06-14 12:46:49:952082 Receive SIP Event Status 200 Session Terminated
    2012-06-14 12:46:49:952089 SIP Call State 0x1eceb68
    2012-06-14 12:46:49:952099 Receive SIP Event Status 200 Session Terminated
    2012-06-14 12:46:49:952109 Process Message
    2012-06-14 12:46:49:952115 Dispatch Signaling Message
    2012-06-14 12:46:49:952120 Deactivate Session 0x1eceb68 <376e11ceb60e11e1>
    2012-06-14 12:46:49:952125 Terminate Session 0x1eceb68 <376e11ceb60e11e1>
    2012-06-14 12:46:49:952130 Remove Control Channel 0x1eceb68
    376e11ceb60e11e1@speechrecog
    2012-06-14 12:46:49:952135 Signal Message to
    2012-06-14 12:46:49:952144 Subtract Media Termination 0x1eceb68
    376e11ceb60e11e1@media-tm
    2012-06-14 12:46:49:952150 Close Channel 376e11ceb60e11e1@pocketsphinx
    2012-06-14 12:46:49:952158 Subtract Media Termination 0x1eceb68
    376e11ceb60e11e1@rtp-tm
    2012-06-14 12:46:49:952163 Signal Message to
    2012-06-14 12:46:49:952165 Remove Grammar File 376e11ceb60e11e1@pocketsphinx
    2012-06-14 12:46:49:952168 Remove Session <376e11ceb60e11e1>
    2012-06-14 12:46:49:952201 Wait for Messages
    2012-06-14 12:46:49:952216 Free Decoder 376e11ceb60e11e1@pocketsphinx
    2012-06-14 12:46:49:954484 Process Poller Wakeup
    2012-06-14 12:46:49:954496 Process Message
    2012-06-14 12:46:49:954502 Remove Control Channel
    376e11ceb60e11e1@speechrecog
    2012-06-14 12:46:49:954507 Destroy Container for Pending Control Channels
    2012-06-14 12:46:49:954515 Mark Connection for Removal 192.168.1.11:1544 <->
    192.168.1.11:41623
    2012-06-14 12:46:49:954521 Signal Message to
    2012-06-14 12:46:49:954530 Wait for Messages
    2012-06-14 12:46:49:954539 Process Message
    2012-06-14 12:46:49:954545 Control Channel Removed 0x1eceb68
    376e11ceb60e11e1@speechrecog
    2012-06-14 12:46:49:954550 Wait for Messages
    2012-06-14 12:46:49:955723 Process Message
    2012-06-14 12:46:49:955733 Destroy Audio Bridge 0x1eceb68
    2012-06-14 12:46:49:955739 Close RTP Receiver 192.168.1.11:5006 <-
    192.168.1.11:4014
    2012-06-14 12:46:49:955745 Remove Media Context 0x1eceb68
    2012-06-14 12:46:49:955749 Remove RTP Session 192.168.1.11:5006
    2012-06-14 12:46:49:955778 Process Message
    2012-06-14 12:46:49:955785 Media Termination Subtracted 0x1eceb68
    376e11ceb60e11e1@media-tm
    2012-06-14 12:46:49:955789 Media Termination Subtracted 0x1eceb68
    376e11ceb60e11e1@rtp-tm
    2012-06-14 12:46:49:955795 Wait for Messages
    2012-06-14 12:46:49:959845 Signal Message to
    2012-06-14 12:46:49:959878 Process Message
    2012-06-14 12:46:49:959889 Engine Channel Closed 0x1eceb68
    376e11ceb60e11e1@speechrecog
    2012-06-14 12:46:49:959897 Destroy TCP/MRCPv2 Connection 192.168.1.11:1544 <->
    192.168.1.11:41623
    2012-06-14 12:46:49:959911 Session Terminated 0x1eceb68 <376e11ceb60e11e1>
    2012-06-14 12:46:49:959934 Destroy Session <376e11ceb60e11e1>
    2012-06-14 12:46:49:959942 Wait for Messages

    My dialplan looks like:

    exten => 4313053058,1,Answer()
    exten => 4313053058,n,SpeechCreate()
    exten =>
    4313053058,n,SpeechLoadGrammar(digits,/usr/local/unimrcp/data/grammar.jsgf)
    exten => 4313053058,n,SpeechActivateGrammar(digits)
    exten =>
    4313053058,n,SpeechBackground(/opt/yasssu/voice/yassgen/INTRO_clip,20)
    exten => 4313053058,n,Verbose(1,Results is ${SPEECH(results)})
    exten => 4313053058,n,Verbose(1,The recognized input is ${SPEECH_TEXT(0)})
    exten => 4313053058,n,Verbose(1,The score is ${SPEECH_SCORE(0)})
    exten => 4313053058,n,Verbose(1,The matched grammar is ${SPEECH_GRAMMAR(0)})
    exten => 4313053058,n,SpeechDeactivateGrammar(digits)
    exten => 4313053058,n,SpeechUnloadGrammar(digits)
    exten => 4313053058,n,SpeechDestroy()
    exten => 4313053058,n,Hangup()

    Thanks a lot for your help!
    Rudi

     
  • Nickolay V. Shmyrev

    exten => 4313053058,1,Answer() exten => 4313053058,n,SpeechCreate() exten =>
    4313053058,n,SpeechLoadGrammar(digits,/usr/local/unimrcp/data/grammar.jsgf)
    exten => 4313053058,n,SpeechActivateGrammar(digits) exten =>
    4313053058,n,SpeechBackground(/opt/yasssu/voice/yassgen/INTRO_clip,20) exten
    => 4313053058,n,Verbose(1,Results is ${SPEECH(results)}) exten =>
    4313053058,n,Verbose(1,The recognized input is ${SPEECH_TEXT(0)}) exten =>
    4313053058,n,Verbose(1,The score is ${SPEECH_SCORE(0)}) exten =>
    4313053058,n,Verbose(1,The matched grammar is ${SPEECH_GRAMMAR(0)}) exten =>
    4313053058,n,SpeechDeactivateGrammar(digits) exten =>
    4313053058,n,SpeechUnloadGrammar(digits) exten => 4313053058,n,SpeechDestroy()
    exten => 4313053058,n,Hangup()

    Unlikely it's a dialplan. According to the log it still executes GotoIf from
    the original dialplan of the demo. Reset a dialplan or restart asterisk.
    Provide a log after that.

    VERBOSE pbx.c: -- Executing GotoIf("SIP/out_4313053051-00000003", "1?7:9")
    in new stack

     
  • zaven

    zaven - 2012-06-16

    Hi, I have a similar problem: in spite of what I'm saying it recognizes 'one'.
    I even try to remove word 'one' from the grammar.jsgf, leaving only words
    'two' and 'three' but it is till recognize 'one'.

    Bellow please find dialplan and log of unimrcpserver for the session.
    Any help is appreciated.

    Thanks,
    Zaven

    exten => 1002,1,Answer()
    exten => 1002,2,SpeechCreate()
    exten => 1002,3,SpeechLoadGrammar(digit,/usr/local/unimrcp/data/grammar.jsgf)
    exten => 1002,4,SpeechActivateGrammar(digit)
    exten => 1002,5,SpeechBackground()
    exten => 1002,6,GotoIf($?7:9)
    exten => 1002,7,Playback(vm-nonumber)
    exten => 1002,8,Goto(5)
    exten => 1002,9,Verbose(1,The recognized input is ${SPEECH_TEXT(0)})
    exten => 1002,10,Verbose(1,The score is ${SPEECH_SCORE(0)})
    exten => 1002,11,Verbose(1,The matched grammar is ${SPEECH_GRAMMAR(0)})
    exten => 1002,12,SpeechDeactivateGrammar(digit)
    exten => 1002,13,SpeechUnloadGrammar(digit)
    exten => 1002,14,SpeechDestroy()
    exten => 1002,15,Hangup()

    Unimrcpserver.log

    2012-06-16 15:28:29:533016 Receive SIP Event Status 100 Trying
    2012-06-16 15:28:29:533055 Receive SIP Event Status 100 Trying
    2012-06-16 15:28:29:533069 SIP Call State
    2012-06-16 15:28:29:533091 Create Session 0x7f95bc001988 <new>
    2012-06-16 15:28:29:533104 Remote SDP 0x7f95bc001988 <new>
    v=0
    o=UniMRCPClient 3428211454069122519 6572198265459515576 IN IP4 10.100.77.182
    s=-
    c=IN IP4 10.100.77.182
    t=0 0
    m=application 9 TCP/MRCPv2 1
    a=setup:active
    a=connection:new
    a=resource:speechrecog
    a=cmid:1
    m=audio 4010 RTP/AVP 0 8 96 101
    a=rtpmap:0 PCMU/8000
    a=rtpmap:8 PCMA/8000
    a=rtpmap:96 L16/8000
    a=rtpmap:101 telephone-event/8000
    a=fmtp:101 0-15
    a=sendonly
    a=ptime:20
    a=mid:1 </new></new>

    2012-06-16 15:28:29:533214 Process Message
    2012-06-16 15:28:29:533235 Dispatch Signaling Message
    2012-06-16 15:28:29:533250 Add Session <65a10a62b7a611e1>
    2012-06-16 15:28:29:533262 Receive Offer 0x7f95bc001988 <65a10a62b7a611e1>
    2012-06-16 15:28:29:533282 Add Control Channel 0x7f95bc001988
    65a10a62b7a611e1@speechrecog
    2012-06-16 15:28:29:533294 Signal Message to
    2012-06-16 15:28:29:533311 Add Media Termination 0x7f95bc001988
    65a10a62b7a611e1@rtp-tm
    2012-06-16 15:28:29:533323 Signal Message to
    2012-06-16 15:28:29:533334 Wait for Messages
    2012-06-16 15:28:29:533353 Process Poller Wakeup
    2012-06-16 15:28:29:533364 Process Message
    2012-06-16 15:28:29:533375 Create Container for Pending Control Channels
    2012-06-16 15:28:29:533389 Add Pending Control Channel
    65a10a62b7a611e1@speechrecog
    2012-06-16 15:28:29:533400 Signal Message to
    2012-06-16 15:28:29:533413 Wait for Messages
    2012-06-16 15:28:29:533554 Process Message
    2012-06-16 15:28:29:533576 Control Channel Modified 0x7f95bc001988
    65a10a62b7a611e1@speechrecog
    2012-06-16 15:28:29:533587 Wait for Messages
    2012-06-16 15:28:29:541408 Process Message
    2012-06-16 15:28:29:541440 Add Media Context 0x7f95bc001988
    2012-06-16 15:28:29:541546 Enable RTP Session 10.100.77.182:5010
    2012-06-16 15:28:29:541569 Create Linear Audio Bridge 0x7f95bc001988
    2012-06-16 15:28:29:541583 Open RTP Receiver 10.100.77.182:5010 <-
    10.100.77.182:4010 playout
    2012-06-16 15:28:29:541596 Media Path 0x7f95bc001988
    Source->->Decoder->->Bridge->->Sink
    2012-06-16 15:28:29:541622 Process Message
    2012-06-16 15:28:29:541636 Media Termination Modified 0x7f95bc001988
    65a10a62b7a611e1@media-tm
    2012-06-16 15:28:29:541646 Media Termination Modified 0x7f95bc001988
    65a10a62b7a611e1@rtp-tm
    2012-06-16 15:28:29:541657 Signal Message to
    2012-06-16 15:28:29:541670 Wait for Messages
    2012-06-16 15:28:29:541685 Process Message
    2012-06-16 15:28:29:541697 Signal Message to
    2012-06-16 15:28:29:541709 Wait for Messages
    2012-06-16 15:28:29:541722 Process Message
    2012-06-16 15:28:29:541733 Engine Channel Opened 0x7f95bc001988
    65a10a62b7a611e1@speechrecog
    2012-06-16 15:28:29:541743 Send Answer 0x7f95bc001988 <65a10a62b7a611e1>
    Status OK
    2012-06-16 15:28:29:541765 Local SDP 0x7f95bc001988 <65a10a62b7a611e1>
    v=0
    o=UniMRCPServer 0 0 IN IP4 10.100.77.182
    s=-
    c=IN IP4 10.100.77.182
    t=0 0
    m=application 1544 TCP/MRCPv2 1
    a=setup:passive
    a=connection:new
    a=channel:65a10a62b7a611e1@speechrecog
    a=cmid:1
    m=audio 5010 RTP/AVP 0 101
    a=rtpmap:0 PCMU/8000
    a=rtpmap:101 telephone-event/8000
    a=fmtp:101 0-15
    a=recvonly
    a=ptime:20
    a=mid:1

    2012-06-16 15:28:29:541813 Wait for Messages
    2012-06-16 15:28:29:542227 Receive SIP Event Status 200 OK
    2012-06-16 15:28:29:542255 SIP Call State 0x7f95bc001988
    2012-06-16 15:28:29:542911 Process Signalled Descriptor
    2012-06-16 15:28:29:542952 Accepted TCP/MRCPv2 Connection 10.100.77.182:1544
    <-> 10.100.77.182:41738
    2012-06-16 15:28:29:542967 Wait for Messages
    2012-06-16 15:28:29:543125 Receive SIP Event Status 200 OK
    2012-06-16 15:28:29:543189 Receive SIP Event Status 200 OK
    2012-06-16 15:28:29:543203 SIP Call State 0x7f95bc001988
    2012-06-16 15:28:29:543214 Receive SIP Event Status 200 Call active
    2012-06-16 15:28:29:552282 Process Signalled Descriptor
    2012-06-16 15:28:29:552310 Receive MRCPv2 Stream 10.100.77.182:1544 <->
    10.100.77.182:41738
    MRCP/2.0 132 SET-PARAMS 1
    Channel-Identifier: 65a10a62b7a611e1@speechrecog
    Recognition-Timeout: 20000
    No-Input-Timeout: 15000

    2012-06-16 15:28:29:552341 Attach Control Channel
    65a10a62b7a611e1@speechrecog to Connection 10.100.77.182:1544 <->
    10.100.77.182:41738
    2012-06-16 15:28:29:552355 Signal Message to
    2012-06-16 15:28:29:552369 Wait for Messages
    2012-06-16 15:28:29:552384 Process Message
    2012-06-16 15:28:29:552396 Dispatch Signaling Message
    2012-06-16 15:28:29:552405 Process SET-PARAMS Request
    65a10a62b7a611e1@speechrecog
    2012-06-16 15:28:29:552418 Signal Message to
    2012-06-16 15:28:29:552430 Wait for Messages
    2012-06-16 15:28:29:552444 Process Message
    2012-06-16 15:28:29:552457 Signal Message to
    2012-06-16 15:28:29:552469 Wait for Messages
    2012-06-16 15:28:29:552482 Process Message
    2012-06-16 15:28:29:552493 Process SET-PARAMS Response
    65a10a62b7a611e1@speechrecog
    2012-06-16 15:28:29:552503 Signal Message to
    2012-06-16 15:28:29:552517 Wait for Messages
    2012-06-16 15:28:29:552533 Process Poller Wakeup
    2012-06-16 15:28:29:552544 Process Message
    2012-06-16 15:28:29:552559 Send MRCPv2 Stream 10.100.77.182:1544 <->
    10.100.77.182:41738
    MRCP/2.0 80 1 200 COMPLETE
    Channel-Identifier: 65a10a62b7a611e1@speechrecog

    2012-06-16 15:28:29:552591 Wait for Messages
    2012-06-16 15:28:29:552779 Process Signalled Descriptor
    2012-06-16 15:28:29:552803 Receive MRCPv2 Stream 10.100.77.182:1544 <->
    10.100.77.182:41738
    MRCP/2.0 229 DEFINE-GRAMMAR 2
    Channel-Identifier: 65a10a62b7a611e1@speechrecog
    Content-Type: application/x-jsgf
    Content-Id: grammar-name
    Content-Length: 66

    JSGF V1.0;

    grammar digits;
    public <numbers> = ( two | three); </numbers>

    2012-06-16 15:28:29:552836 Signal Message to
    2012-06-16 15:28:29:552852 Wait for Messages
    2012-06-16 15:28:29:552867 Process Message
    2012-06-16 15:28:29:552878 Dispatch Signaling Message
    2012-06-16 15:28:29:552888 Process DEFINE-GRAMMAR Request
    65a10a62b7a611e1@speechrecog
    2012-06-16 15:28:29:552898 Signal Message to
    2012-06-16 15:28:29:552911 Wait for Messages
    2012-06-16 15:28:29:552924 Process Message
    2012-06-16 15:28:29:552937 Signal Message to
    2012-06-16 15:28:29:552950 Wait for Messages
    2012-06-16 15:28:29:552963 Process Message
    2012-06-16 15:28:29:552981 Process DEFINE-GRAMMAR Response
    65a10a62b7a611e1@speechrecog
    2012-06-16 15:28:29:552996 Signal Message to
    2012-06-16 15:28:29:553010 Wait for Messages
    2012-06-16 15:28:29:553026 Process Poller Wakeup
    2012-06-16 15:28:29:553037 Process Message
    2012-06-16 15:28:29:553050 Send MRCPv2 Stream 10.100.77.182:1544 <->
    10.100.77.182:41738
    MRCP/2.0 112 2 200 COMPLETE
    Channel-Identifier: 65a10a62b7a611e1@speechrecog
    Completion-Cause: 000 success

    2012-06-16 15:28:29:553080 Wait for Messages
    2012-06-16 15:28:29:553460 Process Signalled Descriptor
    2012-06-16 15:28:29:553486 Receive MRCPv2 Stream 10.100.77.182:1544 <->
    10.100.77.182:41738
    MRCP/2.0 222 DEFINE-GRAMMAR 3
    Channel-Identifier: 65a10a62b7a611e1@speechrecog
    Content-Type: application/x-jsgf
    Content-Id: digit
    Content-Length: 66

    JSGF V1.0;

    grammar digits;
    public <numbers> = ( two | three); </numbers>

    2012-06-16 15:28:29:553519 Signal Message to
    2012-06-16 15:28:29:553534 Wait for Messages
    2012-06-16 15:28:29:553549 Process Message
    2012-06-16 15:28:29:553561 Dispatch Signaling Message
    2012-06-16 15:28:29:553570 Process DEFINE-GRAMMAR Request
    65a10a62b7a611e1@speechrecog
    2012-06-16 15:28:29:553581 Signal Message to
    2012-06-16 15:28:29:553593 Wait for Messages
    2012-06-16 15:28:29:553607 Process Message
    2012-06-16 15:28:29:553619 Signal Message to
    2012-06-16 15:28:29:553632 Wait for Messages
    2012-06-16 15:28:29:553644 Process Message
    2012-06-16 15:28:29:553655 Process DEFINE-GRAMMAR Response
    65a10a62b7a611e1@speechrecog
    2012-06-16 15:28:29:553669 Signal Message to
    2012-06-16 15:28:29:553683 Wait for Messages
    2012-06-16 15:28:29:553699 Process Poller Wakeup
    2012-06-16 15:28:29:553709 Process Message
    2012-06-16 15:28:29:553723 Send MRCPv2 Stream 10.100.77.182:1544 <->
    10.100.77.182:41738
    MRCP/2.0 112 3 200 COMPLETE
    Channel-Identifier: 65a10a62b7a611e1@speechrecog
    Completion-Cause: 000 success

    2012-06-16 15:28:29:553752 Wait for Messages
    2012-06-16 15:28:29:553973 Process Signalled Descriptor
    2012-06-16 15:28:29:553997 Receive MRCPv2 Stream 10.100.77.182:1544 <->
    10.100.77.182:41738
    MRCP/2.0 190 RECOGNIZE 4
    Channel-Identifier: 65a10a62b7a611e1@speechrecog
    Content-Type: text/uri-list
    Cancel-If-Queue: false
    Start-Input-Timers: true
    Content-Length: 13

    session:digit
    2012-06-16 15:28:29:554030 Signal Message to
    2012-06-16 15:28:29:554045 Wait for Messages
    2012-06-16 15:28:29:554060 Process Message
    2012-06-16 15:28:29:554071 Dispatch Signaling Message
    2012-06-16 15:28:29:554080 Process RECOGNIZE Request
    65a10a62b7a611e1@speechrecog
    2012-06-16 15:28:29:554092 Signal Message to
    2012-06-16 15:28:29:554105 Wait for Messages
    2012-06-16 15:28:29:554118 Process Message
    2012-06-16 15:28:29:554228 Signal Message to
    2012-06-16 15:28:29:554250 Wait for Messages
    2012-06-16 15:28:29:554389 Process Message
    2012-06-16 15:28:29:554411 Process RECOGNIZE Response
    65a10a62b7a611e1@speechrecog
    2012-06-16 15:28:29:554422 State Transition IDLE -> RECOGNIZING
    65a10a62b7a611e1@speechrecog
    2012-06-16 15:28:29:554433 Signal Message to
    2012-06-16 15:28:29:554460 Wait for Messages
    2012-06-16 15:28:29:554480 Process Poller Wakeup
    2012-06-16 15:28:29:554490 Process Message
    2012-06-16 15:28:29:554505 Send MRCPv2 Stream 10.100.77.182:1544 <->
    10.100.77.182:41738
    MRCP/2.0 83 4 200 IN-PROGRESS
    Channel-Identifier: 65a10a62b7a611e1@speechrecog

    2012-06-16 15:28:29:554536 Wait for Messages
    2012-06-16 15:28:31:241418 Detected Voice Activity
    65a10a62b7a611e1@speechrecog
    2012-06-16 15:28:31:241532 Signal Message to
    2012-06-16 15:28:31:241572 Process Message
    2012-06-16 15:28:31:241586 Process START-OF-INPUT Event
    65a10a62b7a611e1@speechrecog
    2012-06-16 15:28:31:241602 Signal Message to
    2012-06-16 15:28:31:241622 Wait for Messages
    2012-06-16 15:28:31:241641 Process Poller Wakeup
    2012-06-16 15:28:31:241652 Process Message
    2012-06-16 15:28:31:241668 Send MRCPv2 Stream 10.100.77.182:1544 <->
    10.100.77.182:41738
    MRCP/2.0 94 START-OF-INPUT 4 IN-PROGRESS
    Channel-Identifier: 65a10a62b7a611e1@speechrecog

    2012-06-16 15:28:31:241704 Wait for Messages
    2012-06-16 15:28:31:601419 Detected Voice Inactivity
    65a10a62b7a611e1@speechrecog
    2012-06-16 15:28:31:601524 Signal Message to
    2012-06-16 15:28:31:601563 Process Message
    2012-06-16 15:28:31:601577 Process RECOGNITION-COMPLETE Event
    65a10a62b7a611e1@speechrecog
    2012-06-16 15:28:31:601590 State Transition RECOGNIZING -> RECOGNIZED
    65a10a62b7a611e1@speechrecog
    2012-06-16 15:28:31:601603 Signal Message to
    2012-06-16 15:28:31:601617 Wait for Messages
    2012-06-16 15:28:31:601635 Process Poller Wakeup
    2012-06-16 15:28:31:601646 Process Message
    2012-06-16 15:28:31:601663 Send MRCPv2 Stream 10.100.77.182:1544 <->
    10.100.77.182:41738
    MRCP/2.0 397 RECOGNITION-COMPLETE 4 COMPLETE
    Channel-Identifier: 65a10a62b7a611e1@speechrecog
    Completion-Cause: 000 success
    Content-Type: application/x-nlsml
    Content-Length: 212

    <result>
    <interpretation grammar="session:request1@form-level.store" confidence="97">
    <instance>one</instance>
    <input mode="speech">one
    </interpretation>
    </result>
    2012-06-16 15:28:31:601707 Wait for Messages
    2012-06-16 15:28:31:617269 Process Signalled Descriptor
    2012-06-16 15:28:31:617300 Receive MRCPv2 Stream 10.100.77.182:1544 <->
    10.100.77.182:41738
    MRCP/2.0 102 DEFINE-GRAMMAR 5
    Channel-Identifier: 65a10a62b7a611e1@speechrecog
    Content-Id: digit

    2012-06-16 15:28:31:617328 Signal Message to
    2012-06-16 15:28:31:617345 Wait for Messages
    2012-06-16 15:28:31:617360 Process Message
    2012-06-16 15:28:31:617372 Dispatch Signaling Message
    2012-06-16 15:28:31:617382 Process DEFINE-GRAMMAR Request
    65a10a62b7a611e1@speechrecog
    2012-06-16 15:28:31:617391 State Transition RECOGNIZED -> IDLE
    65a10a62b7a611e1@speechrecog
    2012-06-16 15:28:31:617402 Signal Message to
    2012-06-16 15:28:31:617415 Wait for Messages
    2012-06-16 15:28:31:617429 Process Message
    2012-06-16 15:28:31:617441 Signal Message to
    2012-06-16 15:28:31:617454 Wait for Messages
    2012-06-16 15:28:31:617467 Process Message
    2012-06-16 15:28:31:617477 Process DEFINE-GRAMMAR Response
    65a10a62b7a611e1@speechrecog
    2012-06-16 15:28:31:617491 Signal Message to
    2012-06-16 15:28:31:617563 Wait for Messages
    2012-06-16 15:28:31:617587 Process Poller Wakeup
    2012-06-16 15:28:31:617598 Process Message
    2012-06-16 15:28:31:617613 Send MRCPv2 Stream 10.100.77.182:1544 <->
    10.100.77.182:41738
    MRCP/2.0 112 5 200 COMPLETE
    Channel-Identifier: 65a10a62b7a611e1@speechrecog
    Completion-Cause: 000 success

    2012-06-16 15:28:31:617644 Wait for Messages
    2012-06-16 15:28:31:618271 Receive SIP Event Status 200 Session Terminated
    2012-06-16 15:28:31:618302 Receive SIP Event Status 200 Session Terminated
    2012-06-16 15:28:31:618315 SIP Call State 0x7f95bc001988
    2012-06-16 15:28:31:618332 Receive SIP Event Status 200 Session Terminated
    2012-06-16 15:28:31:618497 Process Signalled Descriptor
    2012-06-16 15:28:31:618522 TCP/MRCPv2 Peer Disconnected 10.100.77.182:1544 <->
    10.100.77.182:41738
    2012-06-16 15:28:31:618559 Wait for Messages
    2012-06-16 15:28:31:618579 Process Message
    2012-06-16 15:28:31:618591 Dispatch Signaling Message
    2012-06-16 15:28:31:618600 Deactivate Session 0x7f95bc001988
    <65a10a62b7a611e1>
    2012-06-16 15:28:31:618610 Terminate Session 0x7f95bc001988 <65a10a62b7a611e1>
    2012-06-16 15:28:31:618620 Remove Control Channel 0x7f95bc001988
    65a10a62b7a611e1@speechrecog
    2012-06-16 15:28:31:618631 Signal Message to
    2012-06-16 15:28:31:618645 Subtract Media Termination 0x7f95bc001988
    65a10a62b7a611e1@media-tm
    2012-06-16 15:28:31:618656 Signal Message to
    2012-06-16 15:28:31:618669 Subtract Media Termination 0x7f95bc001988
    65a10a62b7a611e1@rtp-tm
    2012-06-16 15:28:31:618679 Signal Message to
    2012-06-16 15:28:31:618689 Remove Session <65a10a62b7a611e1>
    2012-06-16 15:28:31:618699 Wait for Messages
    2012-06-16 15:28:31:618712 Process Message
    2012-06-16 15:28:31:618795 Signal Message to
    2012-06-16 15:28:31:618821 Wait for Messages
    2012-06-16 15:28:31:618841 Process Poller Wakeup
    2012-06-16 15:28:31:618852 Process Message
    2012-06-16 15:28:31:618863 Remove Control Channel
    65a10a62b7a611e1@speechrecog
    2012-06-16 15:28:31:618873 Destroy Container for Pending Control Channels
    2012-06-16 15:28:31:618884 Mark Connection for Removal 10.100.77.182:1544 <->
    10.100.77.182:41738
    2012-06-16 15:28:31:618894 Signal Message to
    2012-06-16 15:28:31:618904 Wait for Messages
    2012-06-16 15:28:31:619105 Process Message
    2012-06-16 15:28:31:619125 Engine Channel Closed 0x7f95bc001988
    65a10a62b7a611e1@speechrecog
    2012-06-16 15:28:31:619173 Wait for Messages
    2012-06-16 15:28:31:619186 Process Message
    2012-06-16 15:28:31:619195 Control Channel Removed 0x7f95bc001988
    65a10a62b7a611e1@speechrecog
    2012-06-16 15:28:31:619206 Wait for Messages
    2012-06-16 15:28:31:621410 Process Message
    2012-06-16 15:28:31:621438 Destroy Audio Bridge 0x7f95bc001988
    2012-06-16 15:28:31:621449 Close RTP Receiver 10.100.77.182:5010 <-
    10.100.77.182:4010
    2012-06-16 15:28:31:621461 Remove Media Context 0x7f95bc001988
    2012-06-16 15:28:31:621475 Remove RTP Session 10.100.77.182:5010
    2012-06-16 15:28:31:621508 Process Message
    2012-06-16 15:28:31:621522 Media Termination Subtracted 0x7f95bc001988
    65a10a62b7a611e1@media-tm
    2012-06-16 15:28:31:621543 Media Termination Subtracted 0x7f95bc001988
    65a10a62b7a611e1@rtp-tm
    2012-06-16 15:28:31:621554 Destroy TCP/MRCPv2 Connection 10.100.77.182:1544
    <-> 10.100.77.182:41738
    2012-06-16 15:28:31:621566 Session Terminated 0x7f95bc001988
    <65a10a62b7a611e1>
    2012-06-16 15:28:31:621588 Destroy Session <65a10a62b7a611e1>
    2012-06-16 15:28:31:621602 Wait for Messages

     
  • Nickolay V. Shmyrev

    Hi, I have a similar problem: in spite of what I'm saying it recognizes
    'one'. I even try to remove word 'one' from the grammar.jsgf, leaving only
    words 'two' and 'three' but it is till recognize 'one'.

    Your problem is not similar, it's different. You didn't enable pocketsphinx
    plugin as described in documentation and you are using the dummy recognition
    plugin. You need to check unimrcp log to see that pocketsphinx plugin is
    enabled, you need to edit unimrcp configuration file in order to make sure
    that dummy plugin is disabled.

     
  • zaven

    zaven - 2012-06-18

    Hi Nickolay,

    Thank you for the prompt response. I disabled demo plugin and it works!

    Regards,
    Zaven.

     
  • Rudi Dellinger

    Rudi Dellinger - 2012-06-19

    Hello Nickolay,

    find enclosed the log after my forgotten 'dialplan reload'.

    Thanks,
    Rudi

    DEBUG chan_sip.c: SIP answering channel: SIP/out_4313053051-00000045
    DEBUG res_rtp_asterisk.c: Setting the marker bit due to a source update
    DEBUG chan_sip.c: Setting framing from config on incoming call
    DEBUG chan_sip.c: ** Our capability: 0x8 (alaw) Video flag: True Text flag:
    True
    DEBUG chan_sip.c: ** Our prefcodec: 0x0 (nothing)
    DEBUG chan_sip.c: -- Done with adding codecs to SDP
    DEBUG chan_sip.c: Done building SDP. Settling with this capability: 0x8 (alaw)
    DEBUG chan_sip.c: Trying to put 'SIP/2.0 200' onto UDP socket destined for
    213.185.165.114:5060
    DEBUG chan_sip.c: = Looking for Call ID:
    59dc72613eb5c0c920eee6c90ea569a5@213.185.165.103:5060 (Checking From) --From
    tag as22bcd90b --To-tag as368d4193
    DEBUG chan_sip.c: **** Received ACK (6) - Command in SIP ACK
    DEBUG chan_sip.c: Stopping retransmission on
    '59dc72613eb5c0c920eee6c90ea569a5@213.185.165.103:5060' of Response 102: Match
    Found
    DEBUG pbx.c: Launching 'SpeechCreate'
    VERBOSE pbx.c: -- Executing SpeechCreate("SIP/out_4313053051-00000045", "") in
    new stack
    NOTICE app_unimrcp.c: Create MRCP Handle 0x1f529e8
    DEBUG app_unimrcp.c: Create Channel 0x1f529e8 <new>
    DEBUG res_speech_unimrcp.c: Send session request type:2
    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Receive App Request 0x1f529e8 <new>
    DEBUG app_unimrcp.c: Add MRCP Handle 0x1f529e8 <new>
    DEBUG app_unimrcp.c: Dispatch App Request 0x1f529e8 <new>
    DEBUG app_unimrcp.c: Signal Message to
    NOTICE app_unimrcp.c: Add Control Channel 0x1f529e8 new@speechrecog
    DEBUG app_unimrcp.c: Add Media Termination 0x1f529e8 new@media-tm
    DEBUG app_unimrcp.c: Add Media Termination 0x1f529e8 new@rtp-tm
    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Poller Wakeup
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Control Channel Added 0x1f529e8 new@speechrecog
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG res_speech_unimrcp.c: Wait for session response
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Add Media Context 0x1f529e8
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Media Termination Added 0x1f529e8 new@media-tm
    DEBUG app_unimrcp.c: Media Termination Added 0x1f529e8 new@rtp-tm
    DEBUG app_unimrcp.c: Send Offer 0x1f529e8 <new> to 192.168.1.11:8060
    DEBUG app_unimrcp.c: Local SDP 0x1f529e8 <new>
    v=0
    o=UniMRCPClient 0 0 IN IP4 192.168.1.11
    s=-
    c=IN IP4 192.168.1.11
    t=0 0
    m=application 9 TCP/MRCPv2 1
    a=setup:active
    a=connection:new
    a=resource:speechrecog
    a=cmid:1
    m=audio 4018 RTP/AVP 0 8 96 101
    a=rtpmap:0 PCMU/8000
    a=rtpmap:8 PCMA/8000
    a=rtpmap:96 L16/8000
    a=rtpmap:101 telephone-event/8000
    a=fmtp:101 0-15
    a=sendonly
    a=ptime:20
    a=mid:1 </new></new></new></new></new></new>

    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Receive SIP Event Status 0 INVITE sent
    NOTICE app_unimrcp.c: SIP Call State 0x1f529e8
    DEBUG app_unimrcp.c: Receive SIP Event Status 200 OK
    DEBUG app_unimrcp.c: Receive SIP Event Status 200 OK
    NOTICE app_unimrcp.c: SIP Call State 0x1f529e8
    DEBUG app_unimrcp.c: Remote SDP 0x1f529e8 <new>
    v=0
    o=UniMRCPServer 2908332362438450839 6338466491296733729 IN IP4 192.168.1.11
    s=-
    c=IN IP4 192.168.1.11
    t=0 0
    m=application 1544 TCP/MRCPv2 1
    a=setup:passive
    a=connection:new
    a=channel:c7b8effcba0911e1@speechrecog
    a=cmid:1
    m=audio 5010 RTP/AVP 0 101
    a=rtpmap:0 PCMU/8000
    a=rtpmap:101 telephone-event/8000
    a=fmtp:101 0-15
    a=recvonly
    a=ptime:20
    a=mid:1 </new>

    DEBUG app_unimrcp.c: Receive SIP Event Status 200 Call active
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Receive Answer 0x1f529e8 <new>
    DEBUG app_unimrcp.c: Modify Control Channel 0x1f529e8 <c7b8effcba0911e1>
    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Modify Media Termination 0x1f529e8 c7b8effcba0911e1@rtp- tm
    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Poller Wakeup
    DEBUG app_unimrcp.c: Process Message
    NOTICE app_unimrcp.c: Established TCP/MRCPv2 Connection 192.168.1.11:45854 <->
    192.168.1.11:1544
    DEBUG app_unimrcp.c: Add Control Channel c7b8effcba0911e1@speechrecog
    192.168.1.11:45854 <-> 192.168.1.11:1544
    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Control Channel Modified 0x1f529e8
    c7b8effcba0911e1@speechrecog
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Enable RTP Session 192.168.1.11:4018
    DEBUG app_unimrcp.c: Create Linear Audio Bridge 0x1f529e8
    DEBUG app_unimrcp.c: Open RTP Transmitter 192.168.1.11:4018 ->
    192.168.1.11:5010
    DEBUG app_unimrcp.c: Media Path 0x1f529e8 Source->->Bridge->->Encoder->->Sink
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Media Termination Modified 0x1f529e8 c7b8effcba0911e1 @rtp-tm
    DEBUG app_unimrcp.c: Raise App Response 0x1f529e8 <c7b8effcba0911e1> SUCCESS
    DEBUG res_speech_unimrcp.c: Received message from client stack
    DEBUG res_speech_unimrcp.c: On channel add
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG res_speech_unimrcp.c: Waked up, status code: 0
    DEBUG res_speech_unimrcp.c: Create media buffer frame_size:160
    NOTICE res_speech_unimrcp.c: Created speech instance 'c7b8effcba0911e1'
    DEBUG res_speech_unimrcp.c: Set properties 'c7b8effcba0911e1'
    DEBUG res_speech_unimrcp.c: Send MRCP request
    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Receive App MRCP Request 0x1f529e8 <c7b8effcba0911e1>
    DEBUG app_unimrcp.c: Send MRCP Request 0x1f529e8
    c7b8effcba0911e1@speechrecog
    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Poller Wakeup
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Send MRCPv2 Stream 192.168.1.11:45854 <->
    192.168.1.11:1544
    MRCP/2.0 132 SET-PARAMS 1
    Channel-Identifier: c7b8effcba0911e1@speechrecog
    Recognition-Timeout: 20000
    No-Input-Timeout: 15000 </c7b8effcba0911e1></c7b8effcba0911e1></c7b8effcba0911e1></new>

    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG res_speech_unimrcp.c: Wait for MRCP response
    DEBUG app_unimrcp.c: Process Signalled Descriptor
    DEBUG app_unimrcp.c: Receive MRCPv2 Stream 192.168.1.11:45854 <->
    192.168.1.11:1544
    MRCP/2.0 80 1 200 COMPLETE
    Channel-Identifier: c7b8effcba0911e1@speechrecog

    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Raise App MRCP Response 0x1f529e8 <c7b8effcba0911e1>
    DEBUG res_speech_unimrcp.c: Received message from client stack
    DEBUG res_speech_unimrcp.c: On message receive
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG res_speech_unimrcp.c: Waked up
    DEBUG pbx.c: Launching 'SpeechLoadGrammar'
    VERBOSE pbx.c: -- Executing SpeechLoadGrammar("SIP/out_4313053051-00000045",
    "digits,/usr/local/unimrcp/data/grammar.jsgf") in new stack
    NOTICE res_speech_unimrcp.c: Load grammar name:digits type:application/x-jsgf
    path:/usr/local/unimrcp/data/grammar.jsgf 'c7b8effcba0911e1'
    DEBUG res_speech_unimrcp.c: Send MRCP request
    DEBUG app_unimrcp.c: Signal Message to
    DEBUG res_speech_unimrcp.c: Wait for MRCP response
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Receive App MRCP Request 0x1f529e8 <c7b8effcba0911e1>
    DEBUG app_unimrcp.c: Send MRCP Request 0x1f529e8
    c7b8effcba0911e1@speechrecog
    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Poller Wakeup
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Send MRCPv2 Stream 192.168.1.11:45854 <->
    192.168.1.11:1544
    MRCP/2.0 239 DEFINE-GRAMMAR 2
    Channel-Identifier: c7b8effcba0911e1@speechrecog
    Content-Type: application/x-jsgf
    Content-Id: digits
    Content-Length: 82 </c7b8effcba0911e1></c7b8effcba0911e1>

    JSGF V1.0;

    grammar digits;
    public <numbers> = (YES | NO | ONE | TWO | THREE); </numbers>

    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Signalled Descriptor
    DEBUG app_unimrcp.c: Receive MRCPv2 Stream 192.168.1.11:45854 <->
    192.168.1.11:1544
    MRCP/2.0 112 2 200 COMPLETE
    Channel-Identifier: c7b8effcba0911e1@speechrecog
    Completion-Cause: 000 success

    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Raise App MRCP Response 0x1f529e8 <c7b8effcba0911e1>
    DEBUG res_speech_unimrcp.c: Received message from client stack
    DEBUG res_speech_unimrcp.c: On message receive
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG res_speech_unimrcp.c: Waked up
    DEBUG pbx.c: Launching 'SpeechActivateGrammar'
    VERBOSE pbx.c: -- Executing
    SpeechActivateGrammar("SIP/out_4313053051-00000045", "digits") in new stack
    NOTICE res_speech_unimrcp.c: Activate grammar name:digits 'c7b8effcba0911e1'
    DEBUG pbx.c: Launching 'SpeechBackground'
    VERBOSE pbx.c: -- Executing SpeechBackground("SIP/out_4313053051-00000045",
    "/opt/yasssu/voice/yassgen/INTRO_clip,20") in new stack
    DEBUG channel.c: Set channel SIP/out_4313053051-00000045 to read format slin
    NOTICE res_speech_unimrcp.c: Start audio 'c7b8effcba0911e1'
    DEBUG res_speech_unimrcp.c: Send MRCP request
    DEBUG app_unimrcp.c: Signal Message to
    DEBUG res_speech_unimrcp.c: Wait for MRCP response
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Receive App MRCP Request 0x1f529e8 <c7b8effcba0911e1>
    DEBUG app_unimrcp.c: Send MRCP Request 0x1f529e8
    c7b8effcba0911e1@speechrecog
    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Poller Wakeup
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Send MRCPv2 Stream 192.168.1.11:45854 <->
    192.168.1.11:1544
    MRCP/2.0 191 RECOGNIZE 3
    Channel-Identifier: c7b8effcba0911e1@speechrecog
    Content-Type: text/uri-list
    Cancel-If-Queue: false
    Start-Input-Timers: true
    Content-Length: 14 </c7b8effcba0911e1></c7b8effcba0911e1>

    session:digits
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Signalled Descriptor
    DEBUG app_unimrcp.c: Receive MRCPv2 Stream 192.168.1.11:45854 <->
    192.168.1.11:1544
    MRCP/2.0 83 3 200 IN-PROGRESS
    Channel-Identifier: c7b8effcba0911e1@speechrecog

    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Raise App MRCP Response 0x1f529e8 <c7b8effcba0911e1>
    DEBUG res_speech_unimrcp.c: Received message from client stack
    DEBUG res_speech_unimrcp.c: On message receive
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG res_speech_unimrcp.c: Waked up
    DEBUG channel.c: Set channel SIP/out_4313053051-00000045 to write format slin
    DEBUG res_rtp_asterisk.c: Ooh, format changed from unknown to alaw
    DEBUG res_rtp_asterisk.c: Created smoother: format: alaw ms: 20 len: 160
    DEBUG channel.c: Scheduling timer at (50 requested / 50 actual) timer ticks
    per second
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_speech_unimrcp.c: Failed to write audio len:320
    DEBUG res_rtp_asterisk.c: Got RTCP report of 64 bytes
    DEBUG app_unimrcp.c: Process Signalled Descriptor
    DEBUG app_unimrcp.c: Receive MRCPv2 Stream 192.168.1.11:45854 <->
    192.168.1.11:1544
    MRCP/2.0 94 START-OF-INPUT 3 IN-PROGRESS
    Channel-Identifier: c7b8effcba0911e1@speechrecog </c7b8effcba0911e1>

    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Raise App MRCP Event 0x1f529e8 <c7b8effcba0911e1>
    DEBUG res_speech_unimrcp.c: Received message from client stack
    DEBUG res_speech_unimrcp.c: On message receive
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG channel.c: Scheduling timer at (0 requested / 0 actual) timer ticks per
    second
    DEBUG channel.c: Scheduling timer at (0 requested / 0 actual) timer ticks per
    second
    DEBUG channel.c: Set channel SIP/out_4313053051-00000045 to write format alaw
    DEBUG app_unimrcp.c: Process Signalled Descriptor
    DEBUG app_unimrcp.c: Receive MRCPv2 Stream 192.168.1.11:45854 <->
    192.168.1.11:1544
    MRCP/2.0 352 RECOGNITION-COMPLETE 3 COMPLETE
    Channel-Identifier: c7b8effcba0911e1@speechrecog
    Completion-Cause: 000 success
    Content-Type: application/x-nlsml
    Content-Length: 167 </c7b8effcba0911e1>

    <result grammar="digits">
    <interpretation grammar="digits" confidence="99">
    <input mode="speech">TWO
    </interpretation>
    </result>

    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Raise App MRCP Event 0x1f529e8 <c7b8effcba0911e1>
    DEBUG res_speech_unimrcp.c: Received message from client stack
    DEBUG res_speech_unimrcp.c: On message receive
    DEBUG app_unimrcp.c: Wait for Messages
    NOTICE res_speech_unimrcp.c: Get result 'c7b8effcba0911e1'
    DEBUG channel.c: Set channel SIP/out_4313053051-00000045 to read format alaw
    DEBUG pbx.c: Function result is '0'
    DEBUG pbx.c: Expression result is '1'
    DEBUG pbx.c: Launching 'GotoIf'
    VERBOSE pbx.c: -- Executing GotoIf("SIP/out_4313053051-00000045", "1?7:9") in
    new stack
    VERBOSE pbx.c: -- Goto (default,4313053058,7)
    DEBUG pbx.c: Launching 'Playback'
    VERBOSE pbx.c: -- Executing Playback("SIP/out_4313053051-00000045", "vm-
    nonumber") in new stack
    DEBUG channel.c: Set channel SIP/out_4313053051-00000045 to write format gsm
    DEBUG res_rtp_asterisk.c: Difference is 5328, ms is 686
    DEBUG channel.c: Scheduling timer at (50 requested / 50 actual) timer ticks
    per second
    VERBOSE file.c: -- <sip out_4313053051-00000045=""> Playing 'vm-nonumber.gsm'
    (language 'en')
    DEBUG res_rtp_asterisk.c: Got RTCP report of 64 bytes
    DEBUG channel.c: Scheduling timer at (0 requested / 0 actual) timer ticks per
    second
    DEBUG channel.c: Scheduling timer at (0 requested / 0 actual) timer ticks per
    second
    DEBUG channel.c: Scheduling timer at (0 requested / 0 actual) timer ticks per
    second
    DEBUG channel.c: Set channel SIP/out_4313053051-00000045 to write format alaw
    DEBUG pbx.c: Function result is '0'
    DEBUG pbx.c: Launching 'Verbose'
    VERBOSE pbx.c: -- Executing Verbose("SIP/out_4313053051-00000045", "1,Results
    is 0") in new stack
    VERBOSE app_verbose.c: Results is 0
    DEBUG pbx.c: Function result is '(null)'
    DEBUG pbx.c: Launching 'Verbose'
    VERBOSE pbx.c: -- Executing Verbose("SIP/out_4313053051-00000045", "1,The
    recognized input is ") in new stack
    VERBOSE app_verbose.c: The recognized input is
    DEBUG pbx.c: Function result is '(null)'
    DEBUG pbx.c: Launching 'Verbose'
    VERBOSE pbx.c: -- Executing Verbose("SIP/out_4313053051-00000045", "1,The
    score is ") in new stack
    VERBOSE app_verbose.c: The score is
    DEBUG pbx.c: Function result is '(null)'
    DEBUG pbx.c: Launching 'Verbose'
    VERBOSE pbx.c: -- Executing Verbose("SIP/out_4313053051-00000045", "1,The
    matched grammar is ") in new stack
    VERBOSE app_verbose.c: The matched grammar is
    DEBUG pbx.c: Launching 'SpeechDeactivateGrammar'
    VERBOSE pbx.c: -- Executing
    SpeechDeactivateGrammar("SIP/out_4313053051-00000045", "digit") in new stack
    NOTICE res_speech_unimrcp.c: Deactivate grammar name:digit 'c7b8effcba0911e1'
    DEBUG pbx.c: Launching 'SpeechUnloadGrammar'
    VERBOSE pbx.c: -- Executing SpeechUnloadGrammar("SIP/out_4313053051-00000045",
    "digit") in new stack
    NOTICE res_speech_unimrcp.c: Unload grammar name:digit 'c7b8effcba0911e1'
    DEBUG res_speech_unimrcp.c: Send MRCP request
    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Receive App MRCP Request 0x1f529e8 <c7b8effcba0911e1>
    DEBUG app_unimrcp.c: Send MRCP Request 0x1f529e8
    c7b8effcba0911e1@speechrecog
    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG res_speech_unimrcp.c: Wait for MRCP response
    DEBUG app_unimrcp.c: Process Poller Wakeup
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Send MRCPv2 Stream 192.168.1.11:45854 <->
    192.168.1.11:1544
    MRCP/2.0 102 DEFINE-GRAMMAR 4
    Channel-Identifier: c7b8effcba0911e1@speechrecog
    Content-Id: digit </c7b8effcba0911e1></sip></c7b8effcba0911e1>

    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Signalled Descriptor
    DEBUG app_unimrcp.c: Receive MRCPv2 Stream 192.168.1.11:45854 <->
    192.168.1.11:1544
    MRCP/2.0 112 4 404 COMPLETE
    Channel-Identifier: c7b8effcba0911e1@speechrecog
    Completion-Cause: 000 success

    DEBUG app_unimrcp.c: Signal Message to
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG app_unimrcp.c: Process Message
    DEBUG app_unimrcp.c: Raise App MRCP Response 0x1f529e8 <c7b8effcba0911e1>
    DEBUG res_speech_unimrcp.c: Received message from client stack
    DEBUG res_speech_unimrcp.c: On message receive
    DEBUG app_unimrcp.c: Wait for Messages
    DEBUG res_speech_unimrcp.c: Waked up
    WARNING res_speech_unimrcp.c: Received failure response
    DEBUG pbx.c: Spawn extension (default,4313053058,13) exited non-zero on
    'SIP/out_4313053051-00000045'
    VERBOSE pbx.c: == Spawn extension (default, 4313053058, 13) exited non-zero on
    'SIP/out_4313053051-00000045' </c7b8effcba0911e1>

     
  • Rudi Dellinger

    Rudi Dellinger - 2012-06-20

    Hello,

    did some digging in source code and set some debug log notices - in function

    uni_recog_get

    it does not get any values for 'instance and 'input' when calling

    nlsml_interpret_results_get(interpret,&instance,&input);

    Therefore it never enters the if clause (if(instance && input)) and
    'speech->results' is never set.

    How to come over that?

    Thanks so much,
    Rudi

     
  • Nickolay V. Shmyrev

    How to come over that?

    If you look in your log:


    <result grammar="digits">
    <interpretation grammar="digits" confidence="99">
    <input mode="speech">TWO
    </interpretation> </result>

    You see you only get input XML element from the server, and not instance. You
    can compare with the Zaven'ts correct log

    <result> <interpretation grammar="session:request1 @form-level.store" confidence="97"> <instance>one</instance> <input mode="speech">one </interpretation> </result>

    Where he has both instance and input

    It looks your unimrcp server doesn't match ast-unimrcp client. Are you sure
    you are using the same version from bundle? The pocketsphinx plugin is correct
    here:

            body->buf = apr_psprintf(message->pool,
                    "<?xml version=\"1.0\"?>\n"
                    "<result grammar=\"%s\">\n"
                    "  <interpretation grammar=\"%s\" confidence=\"%d\">\n"
                    "    <instance>%s</instance>\n"
                    "    <input mode=\"speech\">%s</input>\n"
                    "  </interpretation>\n"
                    "</result>\n",
    

    Most likely you are not using it for some reason. Some stupid error like your
    dialplan not reloaded before.

     
  • Rudi Dellinger

    Rudi Dellinger - 2012-06-21

    Hello Nickolay,

    this did trick! Used another unimrcp from svn...

    Thanks so much,
    Rudi

     

Log in to post a comment.