Communication Problems
140 views
Skip to first unread message
Luis Liranzo
Jun 1, 2022, 12:51:58 PM6/1/22
to UniMRCP
This is the configuration of the files, I understand that the ss part is well configured.
cat /opt/unimrcp/data/cognitive.subscription.key
{
"auth-endpoint": "https://eastus2.api.cognitive.microsoft.com/sts/v1.0/issuetoken",
"auth-key": ******Speech Service Key**************",
{
"auth-endpoint": "https://eastus2.api.cognitive.microsoft.com/sts/v1.0/issuetoken",
"auth-key": ******Speech Service Key**************",
Could you please indicate what information should be here subscription-key?
cat /opt/unimrcp/data/azbot.subscription.key
{
"subscription-key": "***???*******",
"region": "global",
"service-endpoint": "https://ivrchatbot.azurewebsites.net/api/messages",
"api": ""
}
{
"subscription-key": "***???*******",
"region": "global",
"service-endpoint": "https://ivrchatbot.azurewebsites.net/api/messages",
"api": ""
}
This is the information I see in asterisk when I dial the bot extension. I get the default message from the documentation script.
== Using SIP RTP CoS mark 5
-- Executing [702@default:1] Answer("SIP/705-00000005", "") in new stack
-- Executing [702@default:2] AGI("SIP/705-00000005", "agi_azurebot.py") in new stack
-- Launched AGI Script /usr/share/asterisk/agi-bin/agi_azurebot.py
-- AGI Script Executing Application: (SynthandRecog) Options: ("Welcome to Azure Echo bot. Say something, and I will repeat your phrase back.","builtin:speech/transcribe",nif=json&plt=1&b=1&sct=1000&sint=15000&nit=10000)
[Jun 1 16:08:39] WARNING[2602][C-0000002c]: res_agi.c:3143 handle_exec: Could not find application (SynthandRecog)
-- <SIP/705-00000005>AGI Script agi_azurebot.py completed, returning 0
-- Auto fallthrough, channel 'SIP/705-00000005' status is 'UNKNOWN'
Test log information
sxadmin@hefesto:/opt/unimrcp/bin$ sudo ./umc
2022-06-01 16:49:16:508182 [INFO] Start Task [Framework Agent]
>2022-06-01 16:49:16:508281 [NOTICE] UniMRCP Client [1.7.0]
2022-06-01 16:49:16:508284 [INFO] APR [1.5.2]
2022-06-01 16:49:16:508303 [NOTICE] Create MRCP Client
2022-06-01 16:49:16:508312 [NOTICE] Open Config File [/opt/unimrcp/conf/unimrcpclient.xml]
2022-06-01 16:49:16:509126 [INFO] Set Property ip:10.3.0.5
2022-06-01 16:49:16:509138 [INFO] Register Codec [PCMU]
2022-06-01 16:49:16:509145 [INFO] Register Codec [PCMA]
2022-06-01 16:49:16:509147 [INFO] Register Codec [L16]
2022-06-01 16:49:16:509153 [NOTICE] Register Resource [speechsynth]
2022-06-01 16:49:16:509156 [NOTICE] Register Resource [speechrecog]
2022-06-01 16:49:16:509159 [NOTICE] Register Resource [recorder]
2022-06-01 16:49:16:509162 [NOTICE] Register Resource [speakverify]
2022-06-01 16:49:16:509164 [INFO] Register Resource Factory
2022-06-01 16:49:16:509170 [NOTICE] Create SofiaSIP Agent [SIP-Agent-1] [1.12.11-239-g54ef3e2] sip:10.3.0.5:8062;transport=udp
2022-06-01 16:49:16:509174 [INFO] Register Signaling Agent [SIP-Agent-1]
2022-06-01 16:49:16:509179 [NOTICE] Create RTSP Client [RTSP-Agent-1] [100]
2022-06-01 16:49:16:509213 [INFO] Register Signaling Agent [RTSP-Agent-1]
2022-06-01 16:49:16:509223 [NOTICE] Create MRCPv2 Agent [MRCPv2-Agent-1] [100]
2022-06-01 16:49:16:509256 [INFO] Register Connection Agent [MRCPv2-Agent-1]
2022-06-01 16:49:16:509265 [NOTICE] Create Media Engine [Media-Engine-1]
2022-06-01 16:49:16:509274 [INFO] Register Media Engine [Media-Engine-1]
2022-06-01 16:49:16:509282 [NOTICE] Create RTP Termination Factory 10.3.0.5:[4000,5000]
2022-06-01 16:49:16:509290 [INFO] Register RTP Termination Factory [RTP-Factory-1]
2022-06-01 16:49:16:509302 [INFO] Register RTP Settings [RTP-Settings-1]
2022-06-01 16:49:16:509309 [INFO] Enter Directory [/opt/unimrcp/conf/client-profiles]
2022-06-01 16:49:16:509344 [NOTICE] Open Config File [/opt/unimrcp/conf/client-profiles/lumenvox.xml]
2022-06-01 16:49:16:509455 [INFO] Create SIP Settings 10.3.0.5:5060
2022-06-01 16:49:16:509463 [INFO] Register Signaling Settings [LumenVox-SIP-Settings]
2022-06-01 16:49:16:509468 [INFO] Create RTSP Settings 10.3.0.5:554
2022-06-01 16:49:16:509474 [INFO] Register Signaling Settings [LumenVox-RTSP-Settings]
2022-06-01 16:49:16:509481 [NOTICE] Create MRCPv2 Profile [lv2]
2022-06-01 16:49:16:509488 [INFO] Register Profile [lv2]
2022-06-01 16:49:16:509496 [NOTICE] Create MRCPv1 Profile [lv1]
2022-06-01 16:49:16:509501 [INFO] Register Profile [lv1]
2022-06-01 16:49:16:509507 [NOTICE] Open Config File [/opt/unimrcp/conf/client-profiles/nuance.xml]
2022-06-01 16:49:16:509613 [INFO] Create SIP Settings 10.3.0.5:5060
2022-06-01 16:49:16:509621 [INFO] Register Signaling Settings [Nuance-SIP-Settings]
2022-06-01 16:49:16:509626 [INFO] Create RTSP Settings 10.3.0.5:4900
2022-06-01 16:49:16:509632 [INFO] Register Signaling Settings [Nuance-RTSP-Settings]
2022-06-01 16:49:16:509646 [INFO] Register RTP Settings [Nuance-RTP-Settings]
2022-06-01 16:49:16:509655 [NOTICE] Create MRCPv2 Profile [nss2]
2022-06-01 16:49:16:509660 [INFO] Register Profile [nss2]
2022-06-01 16:49:16:509667 [NOTICE] Create MRCPv1 Profile [nss1]
2022-06-01 16:49:16:509673 [INFO] Register Profile [nss1]
2022-06-01 16:49:16:509678 [NOTICE] Open Config File [/opt/unimrcp/conf/client-profiles/unimrcp.xml]
2022-06-01 16:49:16:509759 [INFO] Create SIP Settings 10.3.0.5:8060
2022-06-01 16:49:16:509767 [INFO] Register Signaling Settings [UniMRCP-SIP-Settings]
2022-06-01 16:49:16:509775 [INFO] Create RTSP Settings 10.3.0.5:1554
2022-06-01 16:49:16:509781 [INFO] Register Signaling Settings [UniMRCP-RTSP-Settings]
2022-06-01 16:49:16:509788 [NOTICE] Create MRCPv2 Profile [uni2]
2022-06-01 16:49:16:509793 [INFO] Register Profile [uni2]
2022-06-01 16:49:16:509800 [NOTICE] Create MRCPv1 Profile [uni1]
2022-06-01 16:49:16:509805 [INFO] Register Profile [uni1]
2022-06-01 16:49:16:509810 [NOTICE] Open Config File [/opt/unimrcp/conf/client-profiles/speechpro.xml]
2022-06-01 16:49:16:509881 [INFO] Create RTSP Settings 10.3.0.5:8000
2022-06-01 16:49:16:509888 [INFO] Register Signaling Settings [SpeechPro-RTSP-Settings]
2022-06-01 16:49:16:509893 [NOTICE] Create MRCPv1 Profile [sp1]
2022-06-01 16:49:16:509898 [INFO] Register Profile [sp1]
2022-06-01 16:49:16:509909 [INFO] Leave Directory [/opt/unimrcp/conf]
2022-06-01 16:49:16:509916 [NOTICE] Create Application
2022-06-01 16:49:16:509921 [INFO] Register Application [UMC]
2022-06-01 16:49:16:509928 [INFO] Start Task [MRCP Client]
2022-06-01 16:49:16:509994 [INFO] Start Task [SIP-Agent-1]
2022-06-01 16:49:16:510043 [INFO] Start Task [RTSP-Agent-1]
2022-06-01 16:49:16:510077 [INFO] Start Task [MRCPv2-Agent-1]
2022-06-01 16:49:16:510113 [INFO] Start Task [Media-Engine-1]
sres: /etc/resolv.conf: unknown option
2022-06-01 16:49:16:510886 [NOTICE] MRCP Client Started
2022-06-01 16:49:16:510901 [INFO] Enter Directory [/opt/unimrcp/conf/umc-scenarios]
2022-06-01 16:49:16:510962 [INFO] Load Scenario Name [gsr1] Class [Recognizer]
2022-06-01 16:49:16:511007 [INFO] Load Scenario Name [dtmf] Class [DtmfRecognizer]
2022-06-01 16:49:16:511040 [INFO] Load Scenario Name [j1] Class [Recognizer]
2022-06-01 16:49:16:511104 [INFO] Load Scenario Name [tsr1] Class [Recognizer]
2022-06-01 16:49:16:511139 [INFO] Load Scenario Name [gsr3] Class [DtmfRecognizer]
2022-06-01 16:49:16:511169 [INFO] Load Scenario Name [verify] Class [Verifier]
2022-06-01 16:49:16:511212 [INFO] Load Scenario Name [bss3] Class [Synthesizer]
2022-06-01 16:49:16:511256 [INFO] Load Scenario Name [gdf1] Class [Recognizer]
2022-06-01 16:49:16:511300 [INFO] Load Scenario Name [bss2] Class [Synthesizer]
2022-06-01 16:49:16:511344 [INFO] Load Scenario Name [ps2] Class [Recognizer]
2022-06-01 16:49:16:511389 [INFO] Load Scenario Name [gsr2] Class [Recognizer]
2022-06-01 16:49:16:511436 [INFO] Load Scenario Name [ps1] Class [Recognizer]
2022-06-01 16:49:16:511476 [INFO] Load Scenario Name [gv2] Class [Recognizer]
2022-06-01 16:49:16:511524 [INFO] Load Scenario Name [rec] Class [Recorder]
2022-06-01 16:49:16:511564 [INFO] Load Scenario Name [gv1] Class [Recognizer]
2022-06-01 16:49:16:511607 [INFO] Load Scenario Name [gv4] Class [Recognizer]
2022-06-01 16:49:16:511644 [INFO] Load Scenario Name [params] Class [Params]
2022-06-01 16:49:16:511684 [INFO] Load Scenario Name [recog] Class [Recognizer]
2022-06-01 16:49:16:511731 [INFO] Load Scenario Name [lex1] Class [Recognizer]
2022-06-01 16:49:16:511773 [INFO] Load Scenario Name [bss1] Class [Synthesizer]
2022-06-01 16:49:16:511820 [INFO] Load Scenario Name [j2] Class [Recognizer]
2022-06-01 16:49:16:511863 [INFO] Load Scenario Name [bsr2] Class [DtmfRecognizer]
2022-06-01 16:49:16:511903 [INFO] Load Scenario Name [bsr1] Class [Recognizer]
2022-06-01 16:49:16:511946 [INFO] Load Scenario Name [synth] Class [Synthesizer]
2022-06-01 16:49:16:511989 [INFO] Load Scenario Name [gv3] Class [Recognizer]
run bss1
>[1]
2022-06-01 16:49:30:230257 [NOTICE] Create MRCP Handle 0x7f3558035ae0 [uni2]
2022-06-01 16:49:30:230283 [INFO] Create Channel umc-1 <new>
2022-06-01 16:49:30:230319 [INFO] Receive App Request umc-1 <new> [2]
2022-06-01 16:49:30:230404 [INFO] Add MRCP Handle umc-1 <new>
2022-06-01 16:49:30:230484 [NOTICE] Add Control Channel umc-1 <new@speechsynth>
2022-06-01 16:49:30:230752 [INFO] Send Offer umc-1 <new> [c:1 a:1 v:0] to 10.3.0.5:8060
2022-06-01 16:49:30:230785 [INFO] Local SDP umc-1 <new>
v=0
o=UniMRCPClient 0 0 IN IP4 10.3.0.5
s=-
c=IN IP4 10.3.0.5
t=0 0
m=application 9 TCP/MRCPv2 1
a=setup:active
a=connection:new
a=resource:speechsynth
a=cmid:1
m=audio 4000 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=recvonly
a=ptime:20
a=mid:1
2022-06-01 16:49:30:231352 [INFO] Receive SIP Event [nua_i_state] Status 0 INVITE sent [SIP-Agent-1]
2022-06-01 16:49:30:231372 [NOTICE] SIP Call State umc-1 [calling]
2022-06-01 16:49:30:233603 [INFO] Receive SIP Event [nua_r_invite] Status 200 OK [SIP-Agent-1]
2022-06-01 16:49:30:233708 [INFO] Receive SIP Event [nua_i_state] Status 200 OK [SIP-Agent-1]
2022-06-01 16:49:30:233718 [NOTICE] SIP Call State umc-1 [ready]
2022-06-01 16:49:30:233722 [INFO] Remote SDP umc-1 <new>
v=0
o=UniMRCPServer 5905023136393667314 4988057795324283587 IN IP4 10.3.0.5
s=-
c=IN IP4 10.3.0.5
t=0 0
m=application 1544 TCP/MRCPv2 1
a=setup:passive
a=connection:new
a=channel:f874e9ac4c3249a9@speechsynth
a=cmid:1
m=audio 5000 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendonly
a=ptime:20
a=mid:1
2022-06-01 16:49:30:233764 [INFO] Receive SIP Event [nua_i_active] Status 200 Call active [SIP-Agent-1]
2022-06-01 16:49:30:233767 [INFO] Receive Answer umc-1 <new> [c:1 a:1 v:0] Status 200
2022-06-01 16:49:30:233946 [NOTICE] Established TCP/MRCPv2 Connection 10.3.0.5:52782 <-> 10.3.0.5:1544
2022-06-01 16:49:30:233954 [INFO] Add Control Channel <f874e9ac4c3249a9@speechsynth> 10.3.0.5:52782 <-> 10.3.0.5:1544 [1]
2022-06-01 16:49:30:240767 [INFO] Enable RTP Session 10.3.0.5:4000
2022-06-01 16:49:30:240794 [INFO] Open RTP Receiver 10.3.0.5:4000 <- 10.3.0.5:5000 playout [50 ms] bounds [0 - 600 ms] adaptive [1] skew detection [1]
2022-06-01 16:49:30:240806 [INFO] Media Path umc-1 Source->[PCMU/8000/1]->Decoder->[LPCM/8000/1]->Bridge->[LPCM/8000/1]->Sink
2022-06-01 16:49:30:240824 [INFO] Raise App Response umc-1 <f874e9ac4c3249a9> [2] SUCCESS [0]
2022-06-01 16:49:30:240859 [INFO] Open Speech Output File [/opt/unimrcp/var/synth-8kHz-f874e9ac4c3249a9.pcm] for Writing
2022-06-01 16:49:30:240952 [INFO] Receive App MRCP Request umc-1 <f874e9ac4c3249a9>
2022-06-01 16:49:30:240966 [INFO] Send MRCP Request umc-1 <f874e9ac4c3249a9@speechsynth> [1]
2022-06-01 16:49:30:240992 [INFO] Send MRCPv2 Data 10.3.0.5:52782 <-> 10.3.0.5:1544 [289 bytes]
MRCP/2.0 289 SPEAK 1
Channel-Identifier: f874e9ac4c3249a9@speechsynth
Content-Type: application/ssml+xml
Content-Length: 158
<?xml version="1.0"?>
<speak version="1.0" xml:lang="en-US" xmlns="http://www.w3.org/2001/10/synthesis">
<p>
<s>Welcome to Uni MRCP.</s>
</p>
</speak>
2022-06-01 16:49:31:022973 [INFO] Receive MRCPv2 Data 10.3.0.5:52782 <-> 10.3.0.5:1544 [83 bytes]
MRCP/2.0 83 1 200 IN-PROGRESS
Channel-Identifier: f874e9ac4c3249a9@speechsynth
2022-06-01 16:49:31:023057 [INFO] Raise App MRCP Response umc-1 <f874e9ac4c3249a9>
2022-06-01 16:49:33:733458 [INFO] Receive MRCPv2 Data 10.3.0.5:52782 <-> 10.3.0.5:1544 [122 bytes]
MRCP/2.0 122 SPEAK-COMPLETE 1 COMPLETE
Channel-Identifier: f874e9ac4c3249a9@speechsynth
Completion-Cause: 000 normal
2022-06-01 16:49:33:733526 [INFO] Raise App MRCP Event umc-1 <f874e9ac4c3249a9>
2022-06-01 16:49:33:733593 [INFO] Receive App Request umc-1 <f874e9ac4c3249a9> [1]
2022-06-01 16:49:33:733604 [INFO] Terminate Session umc-1 <f874e9ac4c3249a9>
2022-06-01 16:49:33:733665 [INFO] Remove Control Channel <f874e9ac4c3249a9@speechsynth> [0]
2022-06-01 16:49:33:733675 [INFO] Close TCP/MRCPv2 Connection 10.3.0.5:52782 <-> 10.3.0.5:1544
2022-06-01 16:49:33:734193 [INFO] Receive SIP Event [nua_r_bye] Status 200 OK [SIP-Agent-1]
2022-06-01 16:49:33:734205 [INFO] Receive SIP Event [nua_i_state] Status 200 to BYE [SIP-Agent-1]
2022-06-01 16:49:33:734210 [NOTICE] SIP Call State umc-1 [terminated]
2022-06-01 16:49:33:734249 [INFO] Session Terminated umc-1 <f874e9ac4c3249a9>
2022-06-01 16:49:33:740619 [INFO] Close RTP Receiver 10.3.0.5:4000 <- 10.3.0.5:5000 [r:135 l:0 j:55 p:50 d:0 i:0]
2022-06-01 16:49:33:740638 [INFO] Remove RTP Session 10.3.0.5:4000
2022-06-01 16:49:33:740676 [NOTICE] Destroy TCP/MRCPv2 Connection 10.3.0.5:52782 <-> 10.3.0.5:1544
2022-06-01 16:49:33:740692 [INFO] Remove MRCP Handle umc-1 <f874e9ac4c3249a9>
2022-06-01 16:49:33:740701 [INFO] Raise App Response umc-1 <f874e9ac4c3249a9> [1] SUCCESS [0]
2022-06-01 16:49:33:740769 [NOTICE] Destroy MRCP Handle umc-1
run tsr1
>[2]
2022-06-01 16:49:52:888747 [NOTICE] Create MRCP Handle 0x7f3558035ae0 [uni2]
2022-06-01 16:49:52:888764 [INFO] Create Channel umc-2 <new>
2022-06-01 16:49:52:888785 [INFO] Receive App Request umc-2 <new> [2]
2022-06-01 16:49:52:888843 [INFO] Add MRCP Handle umc-2 <new>
2022-06-01 16:49:52:888873 [NOTICE] Add Control Channel umc-2 <new@speechrecog>
2022-06-01 16:49:52:890671 [INFO] Send Offer umc-2 <new> [c:1 a:1 v:0] to 10.3.0.5:8060
2022-06-01 16:49:52:890694 [INFO] Local SDP umc-2 <new>
v=0
o=UniMRCPClient 0 0 IN IP4 10.3.0.5
s=-
c=IN IP4 10.3.0.5
t=0 0
m=application 9 TCP/MRCPv2 1
a=setup:active
a=connection:new
a=resource:speechrecog
a=cmid:1
m=audio 4002 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
2022-06-01 16:49:52:891313 [INFO] Receive SIP Event [nua_i_state] Status 0 INVITE sent [SIP-Agent-1]
2022-06-01 16:49:52:891325 [NOTICE] SIP Call State umc-2 [calling]
2022-06-01 16:49:52:893538 [INFO] Receive SIP Event [nua_r_invite] Status 200 OK [SIP-Agent-1]
2022-06-01 16:49:52:893584 [INFO] Receive SIP Event [nua_i_state] Status 200 OK [SIP-Agent-1]
2022-06-01 16:49:52:893603 [NOTICE] SIP Call State umc-2 [ready]
2022-06-01 16:49:52:893612 [INFO] Remote SDP umc-2 <new>
v=0
o=UniMRCPServer 155614714551557928 5724579449409710764 IN IP4 10.3.0.5
s=-
c=IN IP4 10.3.0.5
t=0 0
m=application 1544 TCP/MRCPv2 1
a=setup:passive
a=connection:new
a=channel:63e85bf542f64e05@speechrecog
a=cmid:1
m=audio 5002 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
2022-06-01 16:49:52:893724 [INFO] Receive SIP Event [nua_i_active] Status 200 Call active [SIP-Agent-1]
2022-06-01 16:49:52:893744 [INFO] Receive Answer umc-2 <new> [c:1 a:1 v:0] Status 200
2022-06-01 16:49:52:893843 [NOTICE] Established TCP/MRCPv2 Connection 10.3.0.5:52784 <-> 10.3.0.5:1544
2022-06-01 16:49:52:893862 [INFO] Add Control Channel <63e85bf542f64e05@speechrecog> 10.3.0.5:52784 <-> 10.3.0.5:1544 [1]
2022-06-01 16:49:52:900663 [INFO] Enable RTP Session 10.3.0.5:4002
2022-06-01 16:49:52:900677 [INFO] Open RTP Transmitter 10.3.0.5:4002 -> 10.3.0.5:5002
2022-06-01 16:49:52:900698 [INFO] Media Path umc-2 Source->[LPCM/8000/1]->Bridge->[LPCM/8000/1]->Encoder->[PCMU/8000/1]->Sink
2022-06-01 16:49:52:900714 [INFO] Raise App Response umc-2 <63e85bf542f64e05> [2] SUCCESS [0]
2022-06-01 16:49:52:900775 [INFO] Receive App MRCP Request umc-2 <63e85bf542f64e05>
2022-06-01 16:49:52:900787 [INFO] Send MRCP Request umc-2 <63e85bf542f64e05@speechrecog> [1]
2022-06-01 16:49:52:900789 [INFO] Set [/opt/unimrcp/data/makereservation.pcm] as Speech Source
2022-06-01 16:49:52:900824 [INFO] Send MRCPv2 Data 10.3.0.5:52784 <-> 10.3.0.5:1544 [335 bytes]
MRCP/2.0 335 RECOGNIZE 1
Channel-Identifier: 63e85bf542f64e05@speechrecog
Content-Id: request1@form-level
Content-Type: text/uri-list
Cancel-If-Queue: false
No-Input-Timeout: 5000
Recognition-Timeout: 10000
Start-Input-Timers: true
Confidence-Threshold: 0.5
Save-Waveform: true
Content-Length: 25
builtin:speech/transcribe
2022-06-01 16:49:52:903296 [INFO] Receive MRCPv2 Data 10.3.0.5:52784 <-> 10.3.0.5:1544 [83 bytes]
MRCP/2.0 83 1 200 IN-PROGRESS
Channel-Identifier: 63e85bf542f64e05@speechrecog
2022-06-01 16:49:52:903317 [INFO] Raise App MRCP Response umc-2 <63e85bf542f64e05>
2022-06-01 16:49:53:604737 [INFO] Receive MRCPv2 Data 10.3.0.5:52784 <-> 10.3.0.5:1544 [154 bytes]
MRCP/2.0 154 RECOGNITION-COMPLETE 1 COMPLETE
Channel-Identifier: 63e85bf542f64e05@speechrecog
Completion-Cause: 006 recognizer-error
Waveform-Uri:
2022-06-01 16:49:53:604796 [INFO] Raise App MRCP Event umc-2 <63e85bf542f64e05>
2022-06-01 16:49:53:604822 [WARN] No NLSML data available
2022-06-01 16:49:53:604836 [INFO] Receive App Request umc-2 <63e85bf542f64e05> [1]
2022-06-01 16:49:53:604844 [INFO] Terminate Session umc-2 <63e85bf542f64e05>
2022-06-01 16:49:53:604885 [INFO] Remove Control Channel <63e85bf542f64e05@speechrecog> [0]
2022-06-01 16:49:53:604892 [INFO] Close TCP/MRCPv2 Connection 10.3.0.5:52784 <-> 10.3.0.5:1544
2022-06-01 16:49:53:605213 [INFO] Receive SIP Event [nua_r_bye] Status 200 OK [SIP-Agent-1]
2022-06-01 16:49:53:605233 [INFO] Receive SIP Event [nua_i_state] Status 200 to BYE [SIP-Agent-1]
2022-06-01 16:49:53:605242 [NOTICE] SIP Call State umc-2 [terminated]
2022-06-01 16:49:53:605295 [INFO] Session Terminated umc-2 <63e85bf542f64e05>
2022-06-01 16:49:53:610638 [INFO] Close RTP Transmitter 10.3.0.5:4002 -> 10.3.0.5:5002 [s:35 o:5600]
2022-06-01 16:49:53:610657 [INFO] Remove RTP Session 10.3.0.5:4002
2022-06-01 16:49:53:610703 [NOTICE] Destroy TCP/MRCPv2 Connection 10.3.0.5:52784 <-> 10.3.0.5:1544
2022-06-01 16:49:53:610719 [INFO] Remove MRCP Handle umc-2 <63e85bf542f64e05>
2022-06-01 16:49:53:610731 [INFO] Raise App Response umc-2 <63e85bf542f64e05> [1] SUCCESS [0]
2022-06-01 16:49:53:610762 [NOTICE] Destroy MRCP Handle umc-2
2022-06-01 16:49:16:508182 [INFO] Start Task [Framework Agent]
>2022-06-01 16:49:16:508281 [NOTICE] UniMRCP Client [1.7.0]
2022-06-01 16:49:16:508284 [INFO] APR [1.5.2]
2022-06-01 16:49:16:508303 [NOTICE] Create MRCP Client
2022-06-01 16:49:16:508312 [NOTICE] Open Config File [/opt/unimrcp/conf/unimrcpclient.xml]
2022-06-01 16:49:16:509126 [INFO] Set Property ip:10.3.0.5
2022-06-01 16:49:16:509138 [INFO] Register Codec [PCMU]
2022-06-01 16:49:16:509145 [INFO] Register Codec [PCMA]
2022-06-01 16:49:16:509147 [INFO] Register Codec [L16]
2022-06-01 16:49:16:509153 [NOTICE] Register Resource [speechsynth]
2022-06-01 16:49:16:509156 [NOTICE] Register Resource [speechrecog]
2022-06-01 16:49:16:509159 [NOTICE] Register Resource [recorder]
2022-06-01 16:49:16:509162 [NOTICE] Register Resource [speakverify]
2022-06-01 16:49:16:509164 [INFO] Register Resource Factory
2022-06-01 16:49:16:509170 [NOTICE] Create SofiaSIP Agent [SIP-Agent-1] [1.12.11-239-g54ef3e2] sip:10.3.0.5:8062;transport=udp
2022-06-01 16:49:16:509174 [INFO] Register Signaling Agent [SIP-Agent-1]
2022-06-01 16:49:16:509179 [NOTICE] Create RTSP Client [RTSP-Agent-1] [100]
2022-06-01 16:49:16:509213 [INFO] Register Signaling Agent [RTSP-Agent-1]
2022-06-01 16:49:16:509223 [NOTICE] Create MRCPv2 Agent [MRCPv2-Agent-1] [100]
2022-06-01 16:49:16:509256 [INFO] Register Connection Agent [MRCPv2-Agent-1]
2022-06-01 16:49:16:509265 [NOTICE] Create Media Engine [Media-Engine-1]
2022-06-01 16:49:16:509274 [INFO] Register Media Engine [Media-Engine-1]
2022-06-01 16:49:16:509282 [NOTICE] Create RTP Termination Factory 10.3.0.5:[4000,5000]
2022-06-01 16:49:16:509290 [INFO] Register RTP Termination Factory [RTP-Factory-1]
2022-06-01 16:49:16:509302 [INFO] Register RTP Settings [RTP-Settings-1]
2022-06-01 16:49:16:509309 [INFO] Enter Directory [/opt/unimrcp/conf/client-profiles]
2022-06-01 16:49:16:509344 [NOTICE] Open Config File [/opt/unimrcp/conf/client-profiles/lumenvox.xml]
2022-06-01 16:49:16:509455 [INFO] Create SIP Settings 10.3.0.5:5060
2022-06-01 16:49:16:509463 [INFO] Register Signaling Settings [LumenVox-SIP-Settings]
2022-06-01 16:49:16:509468 [INFO] Create RTSP Settings 10.3.0.5:554
2022-06-01 16:49:16:509474 [INFO] Register Signaling Settings [LumenVox-RTSP-Settings]
2022-06-01 16:49:16:509481 [NOTICE] Create MRCPv2 Profile [lv2]
2022-06-01 16:49:16:509488 [INFO] Register Profile [lv2]
2022-06-01 16:49:16:509496 [NOTICE] Create MRCPv1 Profile [lv1]
2022-06-01 16:49:16:509501 [INFO] Register Profile [lv1]
2022-06-01 16:49:16:509507 [NOTICE] Open Config File [/opt/unimrcp/conf/client-profiles/nuance.xml]
2022-06-01 16:49:16:509613 [INFO] Create SIP Settings 10.3.0.5:5060
2022-06-01 16:49:16:509621 [INFO] Register Signaling Settings [Nuance-SIP-Settings]
2022-06-01 16:49:16:509626 [INFO] Create RTSP Settings 10.3.0.5:4900
2022-06-01 16:49:16:509632 [INFO] Register Signaling Settings [Nuance-RTSP-Settings]
2022-06-01 16:49:16:509646 [INFO] Register RTP Settings [Nuance-RTP-Settings]
2022-06-01 16:49:16:509655 [NOTICE] Create MRCPv2 Profile [nss2]
2022-06-01 16:49:16:509660 [INFO] Register Profile [nss2]
2022-06-01 16:49:16:509667 [NOTICE] Create MRCPv1 Profile [nss1]
2022-06-01 16:49:16:509673 [INFO] Register Profile [nss1]
2022-06-01 16:49:16:509678 [NOTICE] Open Config File [/opt/unimrcp/conf/client-profiles/unimrcp.xml]
2022-06-01 16:49:16:509759 [INFO] Create SIP Settings 10.3.0.5:8060
2022-06-01 16:49:16:509767 [INFO] Register Signaling Settings [UniMRCP-SIP-Settings]
2022-06-01 16:49:16:509775 [INFO] Create RTSP Settings 10.3.0.5:1554
2022-06-01 16:49:16:509781 [INFO] Register Signaling Settings [UniMRCP-RTSP-Settings]
2022-06-01 16:49:16:509788 [NOTICE] Create MRCPv2 Profile [uni2]
2022-06-01 16:49:16:509793 [INFO] Register Profile [uni2]
2022-06-01 16:49:16:509800 [NOTICE] Create MRCPv1 Profile [uni1]
2022-06-01 16:49:16:509805 [INFO] Register Profile [uni1]
2022-06-01 16:49:16:509810 [NOTICE] Open Config File [/opt/unimrcp/conf/client-profiles/speechpro.xml]
2022-06-01 16:49:16:509881 [INFO] Create RTSP Settings 10.3.0.5:8000
2022-06-01 16:49:16:509888 [INFO] Register Signaling Settings [SpeechPro-RTSP-Settings]
2022-06-01 16:49:16:509893 [NOTICE] Create MRCPv1 Profile [sp1]
2022-06-01 16:49:16:509898 [INFO] Register Profile [sp1]
2022-06-01 16:49:16:509909 [INFO] Leave Directory [/opt/unimrcp/conf]
2022-06-01 16:49:16:509916 [NOTICE] Create Application
2022-06-01 16:49:16:509921 [INFO] Register Application [UMC]
2022-06-01 16:49:16:509928 [INFO] Start Task [MRCP Client]
2022-06-01 16:49:16:509994 [INFO] Start Task [SIP-Agent-1]
2022-06-01 16:49:16:510043 [INFO] Start Task [RTSP-Agent-1]
2022-06-01 16:49:16:510077 [INFO] Start Task [MRCPv2-Agent-1]
2022-06-01 16:49:16:510113 [INFO] Start Task [Media-Engine-1]
sres: /etc/resolv.conf: unknown option
2022-06-01 16:49:16:510886 [NOTICE] MRCP Client Started
2022-06-01 16:49:16:510901 [INFO] Enter Directory [/opt/unimrcp/conf/umc-scenarios]
2022-06-01 16:49:16:510962 [INFO] Load Scenario Name [gsr1] Class [Recognizer]
2022-06-01 16:49:16:511007 [INFO] Load Scenario Name [dtmf] Class [DtmfRecognizer]
2022-06-01 16:49:16:511040 [INFO] Load Scenario Name [j1] Class [Recognizer]
2022-06-01 16:49:16:511104 [INFO] Load Scenario Name [tsr1] Class [Recognizer]
2022-06-01 16:49:16:511139 [INFO] Load Scenario Name [gsr3] Class [DtmfRecognizer]
2022-06-01 16:49:16:511169 [INFO] Load Scenario Name [verify] Class [Verifier]
2022-06-01 16:49:16:511212 [INFO] Load Scenario Name [bss3] Class [Synthesizer]
2022-06-01 16:49:16:511256 [INFO] Load Scenario Name [gdf1] Class [Recognizer]
2022-06-01 16:49:16:511300 [INFO] Load Scenario Name [bss2] Class [Synthesizer]
2022-06-01 16:49:16:511344 [INFO] Load Scenario Name [ps2] Class [Recognizer]
2022-06-01 16:49:16:511389 [INFO] Load Scenario Name [gsr2] Class [Recognizer]
2022-06-01 16:49:16:511436 [INFO] Load Scenario Name [ps1] Class [Recognizer]
2022-06-01 16:49:16:511476 [INFO] Load Scenario Name [gv2] Class [Recognizer]
2022-06-01 16:49:16:511524 [INFO] Load Scenario Name [rec] Class [Recorder]
2022-06-01 16:49:16:511564 [INFO] Load Scenario Name [gv1] Class [Recognizer]
2022-06-01 16:49:16:511607 [INFO] Load Scenario Name [gv4] Class [Recognizer]
2022-06-01 16:49:16:511644 [INFO] Load Scenario Name [params] Class [Params]
2022-06-01 16:49:16:511684 [INFO] Load Scenario Name [recog] Class [Recognizer]
2022-06-01 16:49:16:511731 [INFO] Load Scenario Name [lex1] Class [Recognizer]
2022-06-01 16:49:16:511773 [INFO] Load Scenario Name [bss1] Class [Synthesizer]
2022-06-01 16:49:16:511820 [INFO] Load Scenario Name [j2] Class [Recognizer]
2022-06-01 16:49:16:511863 [INFO] Load Scenario Name [bsr2] Class [DtmfRecognizer]
2022-06-01 16:49:16:511903 [INFO] Load Scenario Name [bsr1] Class [Recognizer]
2022-06-01 16:49:16:511946 [INFO] Load Scenario Name [synth] Class [Synthesizer]
2022-06-01 16:49:16:511989 [INFO] Load Scenario Name [gv3] Class [Recognizer]
run bss1
>[1]
2022-06-01 16:49:30:230257 [NOTICE] Create MRCP Handle 0x7f3558035ae0 [uni2]
2022-06-01 16:49:30:230283 [INFO] Create Channel umc-1 <new>
2022-06-01 16:49:30:230319 [INFO] Receive App Request umc-1 <new> [2]
2022-06-01 16:49:30:230404 [INFO] Add MRCP Handle umc-1 <new>
2022-06-01 16:49:30:230484 [NOTICE] Add Control Channel umc-1 <new@speechsynth>
2022-06-01 16:49:30:230752 [INFO] Send Offer umc-1 <new> [c:1 a:1 v:0] to 10.3.0.5:8060
2022-06-01 16:49:30:230785 [INFO] Local SDP umc-1 <new>
v=0
o=UniMRCPClient 0 0 IN IP4 10.3.0.5
s=-
c=IN IP4 10.3.0.5
t=0 0
m=application 9 TCP/MRCPv2 1
a=setup:active
a=connection:new
a=resource:speechsynth
a=cmid:1
m=audio 4000 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=recvonly
a=ptime:20
a=mid:1
2022-06-01 16:49:30:231352 [INFO] Receive SIP Event [nua_i_state] Status 0 INVITE sent [SIP-Agent-1]
2022-06-01 16:49:30:231372 [NOTICE] SIP Call State umc-1 [calling]
2022-06-01 16:49:30:233603 [INFO] Receive SIP Event [nua_r_invite] Status 200 OK [SIP-Agent-1]
2022-06-01 16:49:30:233708 [INFO] Receive SIP Event [nua_i_state] Status 200 OK [SIP-Agent-1]
2022-06-01 16:49:30:233718 [NOTICE] SIP Call State umc-1 [ready]
2022-06-01 16:49:30:233722 [INFO] Remote SDP umc-1 <new>
v=0
o=UniMRCPServer 5905023136393667314 4988057795324283587 IN IP4 10.3.0.5
s=-
c=IN IP4 10.3.0.5
t=0 0
m=application 1544 TCP/MRCPv2 1
a=setup:passive
a=connection:new
a=channel:f874e9ac4c3249a9@speechsynth
a=cmid:1
m=audio 5000 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendonly
a=ptime:20
a=mid:1
2022-06-01 16:49:30:233764 [INFO] Receive SIP Event [nua_i_active] Status 200 Call active [SIP-Agent-1]
2022-06-01 16:49:30:233767 [INFO] Receive Answer umc-1 <new> [c:1 a:1 v:0] Status 200
2022-06-01 16:49:30:233946 [NOTICE] Established TCP/MRCPv2 Connection 10.3.0.5:52782 <-> 10.3.0.5:1544
2022-06-01 16:49:30:233954 [INFO] Add Control Channel <f874e9ac4c3249a9@speechsynth> 10.3.0.5:52782 <-> 10.3.0.5:1544 [1]
2022-06-01 16:49:30:240767 [INFO] Enable RTP Session 10.3.0.5:4000
2022-06-01 16:49:30:240794 [INFO] Open RTP Receiver 10.3.0.5:4000 <- 10.3.0.5:5000 playout [50 ms] bounds [0 - 600 ms] adaptive [1] skew detection [1]
2022-06-01 16:49:30:240806 [INFO] Media Path umc-1 Source->[PCMU/8000/1]->Decoder->[LPCM/8000/1]->Bridge->[LPCM/8000/1]->Sink
2022-06-01 16:49:30:240824 [INFO] Raise App Response umc-1 <f874e9ac4c3249a9> [2] SUCCESS [0]
2022-06-01 16:49:30:240859 [INFO] Open Speech Output File [/opt/unimrcp/var/synth-8kHz-f874e9ac4c3249a9.pcm] for Writing
2022-06-01 16:49:30:240952 [INFO] Receive App MRCP Request umc-1 <f874e9ac4c3249a9>
2022-06-01 16:49:30:240966 [INFO] Send MRCP Request umc-1 <f874e9ac4c3249a9@speechsynth> [1]
2022-06-01 16:49:30:240992 [INFO] Send MRCPv2 Data 10.3.0.5:52782 <-> 10.3.0.5:1544 [289 bytes]
MRCP/2.0 289 SPEAK 1
Channel-Identifier: f874e9ac4c3249a9@speechsynth
Content-Type: application/ssml+xml
Content-Length: 158
<?xml version="1.0"?>
<speak version="1.0" xml:lang="en-US" xmlns="http://www.w3.org/2001/10/synthesis">
<p>
<s>Welcome to Uni MRCP.</s>
</p>
</speak>
2022-06-01 16:49:31:022973 [INFO] Receive MRCPv2 Data 10.3.0.5:52782 <-> 10.3.0.5:1544 [83 bytes]
MRCP/2.0 83 1 200 IN-PROGRESS
Channel-Identifier: f874e9ac4c3249a9@speechsynth
2022-06-01 16:49:31:023057 [INFO] Raise App MRCP Response umc-1 <f874e9ac4c3249a9>
2022-06-01 16:49:33:733458 [INFO] Receive MRCPv2 Data 10.3.0.5:52782 <-> 10.3.0.5:1544 [122 bytes]
MRCP/2.0 122 SPEAK-COMPLETE 1 COMPLETE
Channel-Identifier: f874e9ac4c3249a9@speechsynth
Completion-Cause: 000 normal
2022-06-01 16:49:33:733526 [INFO] Raise App MRCP Event umc-1 <f874e9ac4c3249a9>
2022-06-01 16:49:33:733593 [INFO] Receive App Request umc-1 <f874e9ac4c3249a9> [1]
2022-06-01 16:49:33:733604 [INFO] Terminate Session umc-1 <f874e9ac4c3249a9>
2022-06-01 16:49:33:733665 [INFO] Remove Control Channel <f874e9ac4c3249a9@speechsynth> [0]
2022-06-01 16:49:33:733675 [INFO] Close TCP/MRCPv2 Connection 10.3.0.5:52782 <-> 10.3.0.5:1544
2022-06-01 16:49:33:734193 [INFO] Receive SIP Event [nua_r_bye] Status 200 OK [SIP-Agent-1]
2022-06-01 16:49:33:734205 [INFO] Receive SIP Event [nua_i_state] Status 200 to BYE [SIP-Agent-1]
2022-06-01 16:49:33:734210 [NOTICE] SIP Call State umc-1 [terminated]
2022-06-01 16:49:33:734249 [INFO] Session Terminated umc-1 <f874e9ac4c3249a9>
2022-06-01 16:49:33:740619 [INFO] Close RTP Receiver 10.3.0.5:4000 <- 10.3.0.5:5000 [r:135 l:0 j:55 p:50 d:0 i:0]
2022-06-01 16:49:33:740638 [INFO] Remove RTP Session 10.3.0.5:4000
2022-06-01 16:49:33:740676 [NOTICE] Destroy TCP/MRCPv2 Connection 10.3.0.5:52782 <-> 10.3.0.5:1544
2022-06-01 16:49:33:740692 [INFO] Remove MRCP Handle umc-1 <f874e9ac4c3249a9>
2022-06-01 16:49:33:740701 [INFO] Raise App Response umc-1 <f874e9ac4c3249a9> [1] SUCCESS [0]
2022-06-01 16:49:33:740769 [NOTICE] Destroy MRCP Handle umc-1
run tsr1
>[2]
2022-06-01 16:49:52:888747 [NOTICE] Create MRCP Handle 0x7f3558035ae0 [uni2]
2022-06-01 16:49:52:888764 [INFO] Create Channel umc-2 <new>
2022-06-01 16:49:52:888785 [INFO] Receive App Request umc-2 <new> [2]
2022-06-01 16:49:52:888843 [INFO] Add MRCP Handle umc-2 <new>
2022-06-01 16:49:52:888873 [NOTICE] Add Control Channel umc-2 <new@speechrecog>
2022-06-01 16:49:52:890671 [INFO] Send Offer umc-2 <new> [c:1 a:1 v:0] to 10.3.0.5:8060
2022-06-01 16:49:52:890694 [INFO] Local SDP umc-2 <new>
v=0
o=UniMRCPClient 0 0 IN IP4 10.3.0.5
s=-
c=IN IP4 10.3.0.5
t=0 0
m=application 9 TCP/MRCPv2 1
a=setup:active
a=connection:new
a=resource:speechrecog
a=cmid:1
m=audio 4002 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
2022-06-01 16:49:52:891313 [INFO] Receive SIP Event [nua_i_state] Status 0 INVITE sent [SIP-Agent-1]
2022-06-01 16:49:52:891325 [NOTICE] SIP Call State umc-2 [calling]
2022-06-01 16:49:52:893538 [INFO] Receive SIP Event [nua_r_invite] Status 200 OK [SIP-Agent-1]
2022-06-01 16:49:52:893584 [INFO] Receive SIP Event [nua_i_state] Status 200 OK [SIP-Agent-1]
2022-06-01 16:49:52:893603 [NOTICE] SIP Call State umc-2 [ready]
2022-06-01 16:49:52:893612 [INFO] Remote SDP umc-2 <new>
v=0
o=UniMRCPServer 155614714551557928 5724579449409710764 IN IP4 10.3.0.5
s=-
c=IN IP4 10.3.0.5
t=0 0
m=application 1544 TCP/MRCPv2 1
a=setup:passive
a=connection:new
a=channel:63e85bf542f64e05@speechrecog
a=cmid:1
m=audio 5002 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
2022-06-01 16:49:52:893724 [INFO] Receive SIP Event [nua_i_active] Status 200 Call active [SIP-Agent-1]
2022-06-01 16:49:52:893744 [INFO] Receive Answer umc-2 <new> [c:1 a:1 v:0] Status 200
2022-06-01 16:49:52:893843 [NOTICE] Established TCP/MRCPv2 Connection 10.3.0.5:52784 <-> 10.3.0.5:1544
2022-06-01 16:49:52:893862 [INFO] Add Control Channel <63e85bf542f64e05@speechrecog> 10.3.0.5:52784 <-> 10.3.0.5:1544 [1]
2022-06-01 16:49:52:900663 [INFO] Enable RTP Session 10.3.0.5:4002
2022-06-01 16:49:52:900677 [INFO] Open RTP Transmitter 10.3.0.5:4002 -> 10.3.0.5:5002
2022-06-01 16:49:52:900698 [INFO] Media Path umc-2 Source->[LPCM/8000/1]->Bridge->[LPCM/8000/1]->Encoder->[PCMU/8000/1]->Sink
2022-06-01 16:49:52:900714 [INFO] Raise App Response umc-2 <63e85bf542f64e05> [2] SUCCESS [0]
2022-06-01 16:49:52:900775 [INFO] Receive App MRCP Request umc-2 <63e85bf542f64e05>
2022-06-01 16:49:52:900787 [INFO] Send MRCP Request umc-2 <63e85bf542f64e05@speechrecog> [1]
2022-06-01 16:49:52:900789 [INFO] Set [/opt/unimrcp/data/makereservation.pcm] as Speech Source
2022-06-01 16:49:52:900824 [INFO] Send MRCPv2 Data 10.3.0.5:52784 <-> 10.3.0.5:1544 [335 bytes]
MRCP/2.0 335 RECOGNIZE 1
Channel-Identifier: 63e85bf542f64e05@speechrecog
Content-Id: request1@form-level
Content-Type: text/uri-list
Cancel-If-Queue: false
No-Input-Timeout: 5000
Recognition-Timeout: 10000
Start-Input-Timers: true
Confidence-Threshold: 0.5
Save-Waveform: true
Content-Length: 25
builtin:speech/transcribe
2022-06-01 16:49:52:903296 [INFO] Receive MRCPv2 Data 10.3.0.5:52784 <-> 10.3.0.5:1544 [83 bytes]
MRCP/2.0 83 1 200 IN-PROGRESS
Channel-Identifier: 63e85bf542f64e05@speechrecog
2022-06-01 16:49:52:903317 [INFO] Raise App MRCP Response umc-2 <63e85bf542f64e05>
2022-06-01 16:49:53:604737 [INFO] Receive MRCPv2 Data 10.3.0.5:52784 <-> 10.3.0.5:1544 [154 bytes]
MRCP/2.0 154 RECOGNITION-COMPLETE 1 COMPLETE
Channel-Identifier: 63e85bf542f64e05@speechrecog
Completion-Cause: 006 recognizer-error
Waveform-Uri:
2022-06-01 16:49:53:604796 [INFO] Raise App MRCP Event umc-2 <63e85bf542f64e05>
2022-06-01 16:49:53:604822 [WARN] No NLSML data available
2022-06-01 16:49:53:604836 [INFO] Receive App Request umc-2 <63e85bf542f64e05> [1]
2022-06-01 16:49:53:604844 [INFO] Terminate Session umc-2 <63e85bf542f64e05>
2022-06-01 16:49:53:604885 [INFO] Remove Control Channel <63e85bf542f64e05@speechrecog> [0]
2022-06-01 16:49:53:604892 [INFO] Close TCP/MRCPv2 Connection 10.3.0.5:52784 <-> 10.3.0.5:1544
2022-06-01 16:49:53:605213 [INFO] Receive SIP Event [nua_r_bye] Status 200 OK [SIP-Agent-1]
2022-06-01 16:49:53:605233 [INFO] Receive SIP Event [nua_i_state] Status 200 to BYE [SIP-Agent-1]
2022-06-01 16:49:53:605242 [NOTICE] SIP Call State umc-2 [terminated]
2022-06-01 16:49:53:605295 [INFO] Session Terminated umc-2 <63e85bf542f64e05>
2022-06-01 16:49:53:610638 [INFO] Close RTP Transmitter 10.3.0.5:4002 -> 10.3.0.5:5002 [s:35 o:5600]
2022-06-01 16:49:53:610657 [INFO] Remove RTP Session 10.3.0.5:4002
2022-06-01 16:49:53:610703 [NOTICE] Destroy TCP/MRCPv2 Connection 10.3.0.5:52784 <-> 10.3.0.5:1544
2022-06-01 16:49:53:610719 [INFO] Remove MRCP Handle umc-2 <63e85bf542f64e05>
2022-06-01 16:49:53:610731 [INFO] Raise App Response umc-2 <63e85bf542f64e05> [1] SUCCESS [0]
2022-06-01 16:49:53:610762 [NOTICE] Destroy MRCP Handle umc-2
Vahagn Kocharyan
Jun 7, 2022, 10:53:29 AM6/7/22
to UniMRCP
HI please refer to this documentation section 4.4 https://docs.unispeech.io/en/ums/asterisk/azbot-azss
Thanks
Luis Liranzo
Jun 7, 2022, 2:17:39 PM6/7/22
to UniMRCP
I did use that information, but I don't know at what point it takes out the subscription key. Where do you get the subscription key for the azbot.subscription.key?
Luis Liranzo
Jun 7, 2022, 2:36:24 PM6/7/22
to UniMRCP
This is log when I try to dial and the answer from the service, which does not last 3 seconds.
Asterisk Log
[Jun 7 18:32:23] WARNING[1013]: chan_sip.c:4119 retrans_pkt: Retransmission timeout reached on transmission 95898007-402689888-140284800 for seqno 1 (Critical Response) -- See https://wiki.asterisk.org/wiki/display/AST/SIP+Retransmissions
Packet timed out after 32000ms with no response
Packet timed out after 32000ms with no response
== Using SIP RTP CoS mark 5
-- Executing [702@default:1] Answer("SIP/705-00000000", "") in new stack
-- Executing [702@default:2] AGI("SIP/705-00000000", "agi_azurebot.py") in new stack
-- Executing [702@default:2] AGI("SIP/705-00000000", "agi_azurebot.py") in new stack
-- Launched AGI Script /usr/share/asterisk/agi-bin/agi_azurebot.py
-- AGI Script Executing Application: (SynthandRecog) Options: ("Welcome to Azure Echo bot. Say something, and I will repeat your phrase back.","builtin:speech/transcribe",nif=json&plt=1&b=1&sct=1000&sint=15000&nit=10000)
[Jun 7 18:32:27] NOTICE[1674][C-00000004]: app_synthandrecog.c:1345 app_synthandrecog_exec: SynthAndRecog() prompt: Welcome to Azure Echo bot. Say something, and I will repeat your phrase back.
[Jun 7 18:32:27] NOTICE[1674][C-00000004]: app_synthandrecog.c:1353 app_synthandrecog_exec: SynthAndRecog() grammar: builtin:speech/transcribe
[Jun 7 18:32:27] NOTICE[1674][C-00000004]: app_synthandrecog.c:1369 app_synthandrecog_exec: SynthAndRecog() options: nif=json&plt=1&b=1&sct=1000&sint=15000&nit=10000
[Jun 7 18:32:27] NOTICE[1674][C-00000004]: src/mrcp_application.c:117 Create MRCP Handle 0x7f3f140271d8 [ums2]
[Jun 7 18:32:27] NOTICE[1674][C-00000004]: src/mrcp_client_session.c:131 Create Channel ASR-0 <new>
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client_session.c:385 Receive App Request ASR-0 <new> [2]
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client.c:697 Add MRCP Handle ASR-0 <new>
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client_session.c:717 Add Control Channel ASR-0 <new@speechrecog>
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client_session.c:409 Send Offer ASR-0 <new> [c:1 a:1 v:0] to 10.3.0.5:8060
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_sofiasip_client_agent.c:357 Local SDP ASR-0 <new>
v=0
o=Asterisk 0 0 IN IP4 10.3.0.5
[Jun 7 18:32:27] NOTICE[1674][C-00000004]: app_synthandrecog.c:1353 app_synthandrecog_exec: SynthAndRecog() grammar: builtin:speech/transcribe
[Jun 7 18:32:27] NOTICE[1674][C-00000004]: app_synthandrecog.c:1369 app_synthandrecog_exec: SynthAndRecog() options: nif=json&plt=1&b=1&sct=1000&sint=15000&nit=10000
[Jun 7 18:32:27] NOTICE[1674][C-00000004]: src/mrcp_application.c:117 Create MRCP Handle 0x7f3f140271d8 [ums2]
[Jun 7 18:32:27] NOTICE[1674][C-00000004]: src/mrcp_client_session.c:131 Create Channel ASR-0 <new>
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client_session.c:385 Receive App Request ASR-0 <new> [2]
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client.c:697 Add MRCP Handle ASR-0 <new>
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client_session.c:717 Add Control Channel ASR-0 <new@speechrecog>
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client_session.c:409 Send Offer ASR-0 <new> [c:1 a:1 v:0] to 10.3.0.5:8060
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_sofiasip_client_agent.c:357 Local SDP ASR-0 <new>
v=0
o=Asterisk 0 0 IN IP4 10.3.0.5
s=-
c=IN IP4 10.3.0.5
t=0 0
m=application 9 TCP/MRCPv2 1
a=setup:active
a=connection:new
a=resource:speechrecog
a=cmid:1
m=audio 28000 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
[Jun 7 18:32:27] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:617 Receive SIP Event [nua_i_state] Status 0 INVITE sent [ums2]
[Jun 7 18:32:27] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:555 SIP Call State ASR-0 [calling]
[Jun 7 18:32:27] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:617 Receive SIP Event [nua_r_invite] Status 200 OK [ums2]
[Jun 7 18:32:27] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:617 Receive SIP Event [nua_i_state] Status 200 OK [ums2]
[Jun 7 18:32:27] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:555 SIP Call State ASR-0 [ready]
[Jun 7 18:32:27] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:441 Remote SDP ASR-0 <new>
v=0
o=UniMRCPServer 6064231545219709311 807022026566505709 IN IP4 10.3.0.5
[Jun 7 18:32:27] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:555 SIP Call State ASR-0 [calling]
[Jun 7 18:32:27] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:617 Receive SIP Event [nua_r_invite] Status 200 OK [ums2]
[Jun 7 18:32:27] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:617 Receive SIP Event [nua_i_state] Status 200 OK [ums2]
[Jun 7 18:32:27] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:555 SIP Call State ASR-0 [ready]
[Jun 7 18:32:27] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:441 Remote SDP ASR-0 <new>
v=0
o=UniMRCPServer 6064231545219709311 807022026566505709 IN IP4 10.3.0.5
s=-
c=IN IP4 10.3.0.5
t=0 0
m=application 1544 TCP/MRCPv2 1
a=setup:passive
a=connection:new
a=channel:85c7c739480142fc@speechrecog
a=cmid:1
m=audio 5000 RTP/AVP 0 101
a=cmid:1
m=audio 5000 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
[Jun 7 18:32:27] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:617 Receive SIP Event [nua_i_active] Status 200 Call active [ums2]
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client_session.c:149 Receive Answer ASR-0 <new> [c:1 a:1 v:0] Status 200
[Jun 7 18:32:27] NOTICE[1043]: src/mrcp_client_connection.c:346 Established TCP/MRCPv2 Connection 10.3.0.5:49122 <-> 10.3.0.5:1544
[Jun 7 18:32:27] NOTICE[1043]: src/mrcp_client_connection.c:456 Add Control Channel <85c7c739480142fc@speechrecog> 10.3.0.5:49122 <-> 10.3.0.5:1544 [1]
[Jun 7 18:32:27] NOTICE[1044]: src/mpf_rtp_stream.c:331 Enable RTP Session 10.3.0.5:28000
[Jun 7 18:32:27] NOTICE[1044]: src/mpf_rtp_stream.c:921 Open RTP Transmitter 10.3.0.5:28000 -> 10.3.0.5:5000
[Jun 7 18:32:27] NOTICE[1044]: src/mpf_bridge.c:91 Media Path ASR-0 Source->[PCMU/8000/1]->Bridge->[PCMU/8000/1]->Sink
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client_session.c:453 Raise App Response ASR-0 <85c7c739480142fc> [2] SUCCESS [0]
[Jun 7 18:32:27] NOTICE[1042]: app_synthandrecog.c:275 speech_on_channel_add: (ASR-0) Channel ready codec=PCMU, sample rate=8000
[Jun 7 18:32:27] NOTICE[1674][C-00000004]: app_synthandrecog.c:1662 app_synthandrecog_exec: (ASR-0) Recognizing, Start-Input-Timers: 0
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client_session.c:390 Receive App MRCP Request ASR-0 <85c7c739480142fc>
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client_session.c:620 Send MRCP Request ASR-0 <85c7c739480142fc@speechrecog> [1]
[Jun 7 18:32:27] NOTICE[1043]: src/mrcp_client_connection.c:551 Send MRCPv2 Data 10.3.0.5:49122 <-> 10.3.0.5:1544 [293 bytes]
MRCP/2.0 293 RECOGNIZE 1
Channel-Identifier: 85c7c739480142fc@speechrecog
Content-Type: text/uri-list
Cancel-If-Queue: false
Start-Input-Timers: false
Speech-Complete-Timeout: 1000
Speech-Incomplete-Timeout: 15000
No-Input-Timeout: 10000
Content-Length: 25
builtin:speech/transcribe
[Jun 7 18:32:27] NOTICE[1043]: src/mrcp_client_connection.c:656 Receive MRCPv2 Data 10.3.0.5:49122 <-> 10.3.0.5:1544 [83 bytes]
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client_session.c:149 Receive Answer ASR-0 <new> [c:1 a:1 v:0] Status 200
[Jun 7 18:32:27] NOTICE[1043]: src/mrcp_client_connection.c:346 Established TCP/MRCPv2 Connection 10.3.0.5:49122 <-> 10.3.0.5:1544
[Jun 7 18:32:27] NOTICE[1043]: src/mrcp_client_connection.c:456 Add Control Channel <85c7c739480142fc@speechrecog> 10.3.0.5:49122 <-> 10.3.0.5:1544 [1]
[Jun 7 18:32:27] NOTICE[1044]: src/mpf_rtp_stream.c:331 Enable RTP Session 10.3.0.5:28000
[Jun 7 18:32:27] NOTICE[1044]: src/mpf_rtp_stream.c:921 Open RTP Transmitter 10.3.0.5:28000 -> 10.3.0.5:5000
[Jun 7 18:32:27] NOTICE[1044]: src/mpf_bridge.c:91 Media Path ASR-0 Source->[PCMU/8000/1]->Bridge->[PCMU/8000/1]->Sink
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client_session.c:453 Raise App Response ASR-0 <85c7c739480142fc> [2] SUCCESS [0]
[Jun 7 18:32:27] NOTICE[1042]: app_synthandrecog.c:275 speech_on_channel_add: (ASR-0) Channel ready codec=PCMU, sample rate=8000
[Jun 7 18:32:27] NOTICE[1674][C-00000004]: app_synthandrecog.c:1662 app_synthandrecog_exec: (ASR-0) Recognizing, Start-Input-Timers: 0
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client_session.c:390 Receive App MRCP Request ASR-0 <85c7c739480142fc>
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client_session.c:620 Send MRCP Request ASR-0 <85c7c739480142fc@speechrecog> [1]
[Jun 7 18:32:27] NOTICE[1043]: src/mrcp_client_connection.c:551 Send MRCPv2 Data 10.3.0.5:49122 <-> 10.3.0.5:1544 [293 bytes]
MRCP/2.0 293 RECOGNIZE 1
Channel-Identifier: 85c7c739480142fc@speechrecog
Content-Type: text/uri-list
Cancel-If-Queue: false
Start-Input-Timers: false
Speech-Complete-Timeout: 1000
Speech-Incomplete-Timeout: 15000
No-Input-Timeout: 10000
Content-Length: 25
builtin:speech/transcribe
[Jun 7 18:32:27] NOTICE[1043]: src/mrcp_client_connection.c:656 Receive MRCPv2 Data 10.3.0.5:49122 <-> 10.3.0.5:1544 [83 bytes]
MRCP/2.0 83 1 200 IN-PROGRESS
Channel-Identifier: 85c7c739480142fc@speechrecog
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client_session.c:498 Raise App MRCP Response ASR-0 <85c7c739480142fc>
[Jun 7 18:32:27] NOTICE[1674][C-00000004]: src/mrcp_application.c:117 Create MRCP Handle 0x7f3f14037228 [ums2]
[Jun 7 18:32:27] NOTICE[1674][C-00000004]: src/mrcp_client_session.c:131 Create Channel TTS-0 <new>
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client_session.c:385 Receive App Request TTS-0 <new> [2]
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client.c:697 Add MRCP Handle TTS-0 <new>
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client_session.c:717 Add Control Channel TTS-0 <new@speechsynth>
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client_session.c:409 Send Offer TTS-0 <new> [c:1 a:1 v:0] to 10.3.0.5:8060
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_sofiasip_client_agent.c:357 Local SDP TTS-0 <new>
v=0
o=Asterisk 0 0 IN IP4 10.3.0.5
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client_session.c:498 Raise App MRCP Response ASR-0 <85c7c739480142fc>
[Jun 7 18:32:27] NOTICE[1674][C-00000004]: src/mrcp_application.c:117 Create MRCP Handle 0x7f3f14037228 [ums2]
[Jun 7 18:32:27] NOTICE[1674][C-00000004]: src/mrcp_client_session.c:131 Create Channel TTS-0 <new>
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client_session.c:385 Receive App Request TTS-0 <new> [2]
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client.c:697 Add MRCP Handle TTS-0 <new>
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client_session.c:717 Add Control Channel TTS-0 <new@speechsynth>
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client_session.c:409 Send Offer TTS-0 <new> [c:1 a:1 v:0] to 10.3.0.5:8060
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_sofiasip_client_agent.c:357 Local SDP TTS-0 <new>
v=0
o=Asterisk 0 0 IN IP4 10.3.0.5
s=-
c=IN IP4 10.3.0.5
t=0 0
m=application 9 TCP/MRCPv2 1
a=setup:active
a=connection:new
a=resource:speechsynth
a=cmid:1
m=audio 28002 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=recvonly
a=ptime:20
a=mid:1
[Jun 7 18:32:27] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:617 Receive SIP Event [nua_i_state] Status 0 INVITE sent [ums2]
[Jun 7 18:32:27] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:555 SIP Call State TTS-0 [calling]
[Jun 7 18:32:27] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:617 Receive SIP Event [nua_r_invite] Status 200 OK [ums2]
[Jun 7 18:32:27] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:617 Receive SIP Event [nua_i_state] Status 200 OK [ums2]
[Jun 7 18:32:27] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:555 SIP Call State TTS-0 [ready]
[Jun 7 18:32:27] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:441 Remote SDP TTS-0 <new>
v=0
o=UniMRCPServer 8676985220871329713 8022705282788966734 IN IP4 10.3.0.5
[Jun 7 18:32:27] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:555 SIP Call State TTS-0 [calling]
[Jun 7 18:32:27] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:617 Receive SIP Event [nua_r_invite] Status 200 OK [ums2]
[Jun 7 18:32:27] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:617 Receive SIP Event [nua_i_state] Status 200 OK [ums2]
[Jun 7 18:32:27] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:555 SIP Call State TTS-0 [ready]
[Jun 7 18:32:27] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:441 Remote SDP TTS-0 <new>
v=0
o=UniMRCPServer 8676985220871329713 8022705282788966734 IN IP4 10.3.0.5
s=-
c=IN IP4 10.3.0.5
t=0 0
m=application 1544 TCP/MRCPv2 1
a=setup:passive
a=connection:new
a=channel:866c4b3c23ef4e09@speechsynth
a=cmid:1
m=audio 5002 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendonly
a=ptime:20
a=mid:1
a=ptime:20
a=mid:1
[Jun 7 18:32:27] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:617 Receive SIP Event [nua_i_active] Status 200 Call active [ums2]
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client_session.c:149 Receive Answer TTS-0 <new> [c:1 a:1 v:0] Status 200
[Jun 7 18:32:27] NOTICE[1043]: src/mrcp_client_connection.c:346 Established TCP/MRCPv2 Connection 10.3.0.5:49124 <-> 10.3.0.5:1544
[Jun 7 18:32:27] NOTICE[1043]: src/mrcp_client_connection.c:456 Add Control Channel <866c4b3c23ef4e09@speechsynth> 10.3.0.5:49124 <-> 10.3.0.5:1544 [1]
[Jun 7 18:32:27] NOTICE[1044]: src/mpf_rtp_stream.c:331 Enable RTP Session 10.3.0.5:28002
[Jun 7 18:32:27] NOTICE[1044]: src/mpf_rtp_stream.c:509 Open RTP Receiver 10.3.0.5:28002 <- 10.3.0.5:5002 playout [50 ms] bounds [0 - 200 ms] adaptive [0] skew detection [1]
[Jun 7 18:32:27] NOTICE[1044]: src/mpf_bridge.c:91 Media Path TTS-0 Source->[PCMU/8000/1]->Bridge->[PCMU/8000/1]->Sink
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client_session.c:453 Raise App Response TTS-0 <866c4b3c23ef4e09> [2] SUCCESS [0]
[Jun 7 18:32:27] NOTICE[1042]: app_synthandrecog.c:275 speech_on_channel_add: (TTS-0) Channel ready codec=PCMU, sample rate=8000
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client_session.c:390 Receive App MRCP Request TTS-0 <866c4b3c23ef4e09>
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client_session.c:620 Send MRCP Request TTS-0 <866c4b3c23ef4e09@speechsynth> [1]
[Jun 7 18:32:27] NOTICE[1043]: src/mrcp_client_connection.c:551 Send MRCPv2 Data 10.3.0.5:49124 <-> 10.3.0.5:1544 [197 bytes]
MRCP/2.0 197 SPEAK 1
Channel-Identifier: 866c4b3c23ef4e09@speechsynth
Content-Type: text/plain
Content-Length: 77
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client_session.c:149 Receive Answer TTS-0 <new> [c:1 a:1 v:0] Status 200
[Jun 7 18:32:27] NOTICE[1043]: src/mrcp_client_connection.c:346 Established TCP/MRCPv2 Connection 10.3.0.5:49124 <-> 10.3.0.5:1544
[Jun 7 18:32:27] NOTICE[1043]: src/mrcp_client_connection.c:456 Add Control Channel <866c4b3c23ef4e09@speechsynth> 10.3.0.5:49124 <-> 10.3.0.5:1544 [1]
[Jun 7 18:32:27] NOTICE[1044]: src/mpf_rtp_stream.c:331 Enable RTP Session 10.3.0.5:28002
[Jun 7 18:32:27] NOTICE[1044]: src/mpf_rtp_stream.c:509 Open RTP Receiver 10.3.0.5:28002 <- 10.3.0.5:5002 playout [50 ms] bounds [0 - 200 ms] adaptive [0] skew detection [1]
[Jun 7 18:32:27] NOTICE[1044]: src/mpf_bridge.c:91 Media Path TTS-0 Source->[PCMU/8000/1]->Bridge->[PCMU/8000/1]->Sink
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client_session.c:453 Raise App Response TTS-0 <866c4b3c23ef4e09> [2] SUCCESS [0]
[Jun 7 18:32:27] NOTICE[1042]: app_synthandrecog.c:275 speech_on_channel_add: (TTS-0) Channel ready codec=PCMU, sample rate=8000
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client_session.c:390 Receive App MRCP Request TTS-0 <866c4b3c23ef4e09>
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client_session.c:620 Send MRCP Request TTS-0 <866c4b3c23ef4e09@speechsynth> [1]
[Jun 7 18:32:27] NOTICE[1043]: src/mrcp_client_connection.c:551 Send MRCPv2 Data 10.3.0.5:49124 <-> 10.3.0.5:1544 [197 bytes]
MRCP/2.0 197 SPEAK 1
Channel-Identifier: 866c4b3c23ef4e09@speechsynth
Content-Type: text/plain
Content-Length: 77
Welcome to Azure Echo bot. Say something, and I will repeat your phrase back.
[Jun 7 18:32:27] NOTICE[1043]: src/mrcp_client_connection.c:656 Receive MRCPv2 Data 10.3.0.5:49122 <-> 10.3.0.5:1544 [138 bytes]
MRCP/2.0 138 RECOGNITION-COMPLETE 1 COMPLETE
Channel-Identifier: 85c7c739480142fc@speechrecog
Completion-Cause: 006 recognizer-error
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client_session.c:514 Raise App MRCP Event ASR-0 <85c7c739480142fc>
[Jun 7 18:32:28] NOTICE[1043]: src/mrcp_client_connection.c:656 Receive MRCPv2 Data 10.3.0.5:49124 <-> 10.3.0.5:1544 [83 bytes]
MRCP/2.0 138 RECOGNITION-COMPLETE 1 COMPLETE
Channel-Identifier: 85c7c739480142fc@speechrecog
Completion-Cause: 006 recognizer-error
[Jun 7 18:32:27] NOTICE[1042]: src/mrcp_client_session.c:514 Raise App MRCP Event ASR-0 <85c7c739480142fc>
[Jun 7 18:32:28] NOTICE[1043]: src/mrcp_client_connection.c:656 Receive MRCPv2 Data 10.3.0.5:49124 <-> 10.3.0.5:1544 [83 bytes]
MRCP/2.0 83 1 200 IN-PROGRESS
Channel-Identifier: 866c4b3c23ef4e09@speechsynth
[Jun 7 18:32:28] NOTICE[1042]: src/mrcp_client_session.c:498 Raise App MRCP Response TTS-0 <866c4b3c23ef4e09>
[Jun 7 18:32:28] NOTICE[1674][C-00000004]: app_synthandrecog.c:1307 synthandrecog_exit: SynthAndRecog() exiting status: OK on SIP/705-00000000
agi_azurebot.py: got status OK
agi_azurebot.py: got completion cause 006
-- AGI Script Executing Application: (MRCPSynth) Options: ("Welcome to Azure Echo bot. Say something, and I will repeat your phrase back.")
[Jun 7 18:32:28] NOTICE[1674][C-00000004]: app_mrcpsynth.c:515 app_synth_exec: MRCPSynth() prompt: Welcome to Azure Echo bot. Say something, and I will repeat your phrase back.
[Jun 7 18:32:28] NOTICE[1674][C-00000004]: app_mrcpsynth.c:654 app_synth_exec: (TTS-0) Synthesizing, enable DTMFs: 0
[Jun 7 18:32:28] WARNING[1674][C-00000004]: app_mrcpsynth.c:657 app_synth_exec: (TTS-0) Unable to start synthesis
[Jun 7 18:32:28] NOTICE[1042]: src/mrcp_client_session.c:385 Receive App Request TTS-0 <866c4b3c23ef4e09> [1]
[Jun 7 18:32:28] NOTICE[1042]: src/mrcp_client_session.c:828 Terminate Session TTS-0 <866c4b3c23ef4e09>
[Jun 7 18:32:28] NOTICE[1043]: src/mrcp_client_connection.c:480 Remove Control Channel <866c4b3c23ef4e09@speechsynth> [0]
[Jun 7 18:32:28] NOTICE[1043]: src/mrcp_client_connection.c:407 Close TCP/MRCPv2 Connection 10.3.0.5:49124 <-> 10.3.0.5:1544
[Jun 7 18:32:28] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:617 Receive SIP Event [nua_r_bye] Status 200 OK [ums2]
[Jun 7 18:32:28] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:617 Receive SIP Event [nua_i_state] Status 200 to BYE [ums2]
[Jun 7 18:32:28] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:555 SIP Call State TTS-0 [terminated]
[Jun 7 18:32:28] NOTICE[1042]: src/mrcp_client_session.c:207 Session Terminated TTS-0 <866c4b3c23ef4e09>
[Jun 7 18:32:28] NOTICE[1044]: src/mpf_rtp_stream.c:541 Close RTP Receiver 10.3.0.5:28002 <- 10.3.0.5:5002 [r:0 l:0 j:0 p:50 d:0 i:0]
[Jun 7 18:32:28] NOTICE[1044]: src/mpf_rtp_stream.c:418 Remove RTP Session 10.3.0.5:28002
[Jun 7 18:32:28] NOTICE[1042]: src/mrcp_client_connection.c:243 Destroy TCP/MRCPv2 Connection 10.3.0.5:49124 <-> 10.3.0.5:1544
[Jun 7 18:32:28] NOTICE[1042]: src/mrcp_client.c:707 Remove MRCP Handle TTS-0 <866c4b3c23ef4e09>
[Jun 7 18:32:28] NOTICE[1042]: src/mrcp_client_session.c:453 Raise App Response TTS-0 <866c4b3c23ef4e09> [1] SUCCESS [0]
[Jun 7 18:32:28] NOTICE[1042]: src/mrcp_application.c:211 Destroy MRCP Handle TTS-0
[Jun 7 18:32:28] NOTICE[1674][C-00000004]: app_mrcpsynth.c:480 mrcpsynth_exit: MRCPSynth() exiting status: ERROR on SIP/705-00000000
agi_azurebot.py: exiting
-- <SIP/705-00000000>AGI Script agi_azurebot.py completed, returning 0
-- Auto fallthrough, channel 'SIP/705-00000000' status is 'UNKNOWN'
[Jun 7 18:32:28] NOTICE[1042]: src/mrcp_client_session.c:385 Receive App Request ASR-0 <85c7c739480142fc> [1]
[Jun 7 18:32:28] NOTICE[1042]: src/mrcp_client_session.c:828 Terminate Session ASR-0 <85c7c739480142fc>
[Jun 7 18:32:28] NOTICE[1043]: src/mrcp_client_connection.c:480 Remove Control Channel <85c7c739480142fc@speechrecog> [0]
[Jun 7 18:32:28] NOTICE[1043]: src/mrcp_client_connection.c:407 Close TCP/MRCPv2 Connection 10.3.0.5:49122 <-> 10.3.0.5:1544
[Jun 7 18:32:28] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:617 Receive SIP Event [nua_r_bye] Status 200 OK [ums2]
[Jun 7 18:32:28] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:617 Receive SIP Event [nua_i_state] Status 200 to BYE [ums2]
[Jun 7 18:32:28] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:555 SIP Call State ASR-0 [terminated]
[Jun 7 18:32:28] NOTICE[1042]: src/mrcp_client_session.c:207 Session Terminated ASR-0 <85c7c739480142fc>
[Jun 7 18:32:28] NOTICE[1044]: src/mpf_rtp_stream.c:935 Close RTP Transmitter 10.3.0.5:28000 -> 10.3.0.5:5000 [s:0 o:0]
[Jun 7 18:32:28] NOTICE[1044]: src/mpf_rtp_stream.c:418 Remove RTP Session 10.3.0.5:28000
[Jun 7 18:32:28] NOTICE[1042]: src/mrcp_client_connection.c:243 Destroy TCP/MRCPv2 Connection 10.3.0.5:49122 <-> 10.3.0.5:1544
[Jun 7 18:32:28] NOTICE[1042]: src/mrcp_client.c:707 Remove MRCP Handle ASR-0 <85c7c739480142fc>
[Jun 7 18:32:28] NOTICE[1042]: src/mrcp_client_session.c:453 Raise App Response ASR-0 <85c7c739480142fc> [1] SUCCESS [0]
[Jun 7 18:32:28] NOTICE[1042]: src/mrcp_application.c:211 Destroy MRCP Handle ASR-0
[Jun 7 18:32:28] NOTICE[1042]: src/mrcp_client_session.c:498 Raise App MRCP Response TTS-0 <866c4b3c23ef4e09>
[Jun 7 18:32:28] NOTICE[1674][C-00000004]: app_synthandrecog.c:1307 synthandrecog_exit: SynthAndRecog() exiting status: OK on SIP/705-00000000
agi_azurebot.py: got status OK
agi_azurebot.py: got completion cause 006
-- AGI Script Executing Application: (MRCPSynth) Options: ("Welcome to Azure Echo bot. Say something, and I will repeat your phrase back.")
[Jun 7 18:32:28] NOTICE[1674][C-00000004]: app_mrcpsynth.c:515 app_synth_exec: MRCPSynth() prompt: Welcome to Azure Echo bot. Say something, and I will repeat your phrase back.
[Jun 7 18:32:28] NOTICE[1674][C-00000004]: app_mrcpsynth.c:654 app_synth_exec: (TTS-0) Synthesizing, enable DTMFs: 0
[Jun 7 18:32:28] WARNING[1674][C-00000004]: app_mrcpsynth.c:657 app_synth_exec: (TTS-0) Unable to start synthesis
[Jun 7 18:32:28] NOTICE[1042]: src/mrcp_client_session.c:385 Receive App Request TTS-0 <866c4b3c23ef4e09> [1]
[Jun 7 18:32:28] NOTICE[1042]: src/mrcp_client_session.c:828 Terminate Session TTS-0 <866c4b3c23ef4e09>
[Jun 7 18:32:28] NOTICE[1043]: src/mrcp_client_connection.c:480 Remove Control Channel <866c4b3c23ef4e09@speechsynth> [0]
[Jun 7 18:32:28] NOTICE[1043]: src/mrcp_client_connection.c:407 Close TCP/MRCPv2 Connection 10.3.0.5:49124 <-> 10.3.0.5:1544
[Jun 7 18:32:28] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:617 Receive SIP Event [nua_r_bye] Status 200 OK [ums2]
[Jun 7 18:32:28] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:617 Receive SIP Event [nua_i_state] Status 200 to BYE [ums2]
[Jun 7 18:32:28] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:555 SIP Call State TTS-0 [terminated]
[Jun 7 18:32:28] NOTICE[1042]: src/mrcp_client_session.c:207 Session Terminated TTS-0 <866c4b3c23ef4e09>
[Jun 7 18:32:28] NOTICE[1044]: src/mpf_rtp_stream.c:541 Close RTP Receiver 10.3.0.5:28002 <- 10.3.0.5:5002 [r:0 l:0 j:0 p:50 d:0 i:0]
[Jun 7 18:32:28] NOTICE[1044]: src/mpf_rtp_stream.c:418 Remove RTP Session 10.3.0.5:28002
[Jun 7 18:32:28] NOTICE[1042]: src/mrcp_client_connection.c:243 Destroy TCP/MRCPv2 Connection 10.3.0.5:49124 <-> 10.3.0.5:1544
[Jun 7 18:32:28] NOTICE[1042]: src/mrcp_client.c:707 Remove MRCP Handle TTS-0 <866c4b3c23ef4e09>
[Jun 7 18:32:28] NOTICE[1042]: src/mrcp_client_session.c:453 Raise App Response TTS-0 <866c4b3c23ef4e09> [1] SUCCESS [0]
[Jun 7 18:32:28] NOTICE[1042]: src/mrcp_application.c:211 Destroy MRCP Handle TTS-0
[Jun 7 18:32:28] NOTICE[1674][C-00000004]: app_mrcpsynth.c:480 mrcpsynth_exit: MRCPSynth() exiting status: ERROR on SIP/705-00000000
agi_azurebot.py: exiting
-- <SIP/705-00000000>AGI Script agi_azurebot.py completed, returning 0
-- Auto fallthrough, channel 'SIP/705-00000000' status is 'UNKNOWN'
[Jun 7 18:32:28] NOTICE[1042]: src/mrcp_client_session.c:385 Receive App Request ASR-0 <85c7c739480142fc> [1]
[Jun 7 18:32:28] NOTICE[1042]: src/mrcp_client_session.c:828 Terminate Session ASR-0 <85c7c739480142fc>
[Jun 7 18:32:28] NOTICE[1043]: src/mrcp_client_connection.c:480 Remove Control Channel <85c7c739480142fc@speechrecog> [0]
[Jun 7 18:32:28] NOTICE[1043]: src/mrcp_client_connection.c:407 Close TCP/MRCPv2 Connection 10.3.0.5:49122 <-> 10.3.0.5:1544
[Jun 7 18:32:28] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:617 Receive SIP Event [nua_r_bye] Status 200 OK [ums2]
[Jun 7 18:32:28] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:617 Receive SIP Event [nua_i_state] Status 200 to BYE [ums2]
[Jun 7 18:32:28] NOTICE[1047]: src/mrcp_sofiasip_client_agent.c:555 SIP Call State ASR-0 [terminated]
[Jun 7 18:32:28] NOTICE[1042]: src/mrcp_client_session.c:207 Session Terminated ASR-0 <85c7c739480142fc>
[Jun 7 18:32:28] NOTICE[1044]: src/mpf_rtp_stream.c:935 Close RTP Transmitter 10.3.0.5:28000 -> 10.3.0.5:5000 [s:0 o:0]
[Jun 7 18:32:28] NOTICE[1044]: src/mpf_rtp_stream.c:418 Remove RTP Session 10.3.0.5:28000
[Jun 7 18:32:28] NOTICE[1042]: src/mrcp_client_connection.c:243 Destroy TCP/MRCPv2 Connection 10.3.0.5:49122 <-> 10.3.0.5:1544
[Jun 7 18:32:28] NOTICE[1042]: src/mrcp_client.c:707 Remove MRCP Handle ASR-0 <85c7c739480142fc>
[Jun 7 18:32:28] NOTICE[1042]: src/mrcp_client_session.c:453 Raise App Response ASR-0 <85c7c739480142fc> [1] SUCCESS [0]
[Jun 7 18:32:28] NOTICE[1042]: src/mrcp_application.c:211 Destroy MRCP Handle ASR-0
El martes, 7 de junio de 2022 a las 10:53:29 UTC-4, kochary...@gmail.com escribió:
Arsen Chaloyan
Jun 11, 2022, 4:09:23 PM6/11/22
to UniMRCP
Normally, you should use the same speech resource for both speech synthesis and also communication with the bot. So, the same subscription key shall be used and your configuration would look like:
SS
{
"auth-endpoint": "https://eastus2.api.cognitive.microsoft.com/sts/v1.0/issuetoken",
"auth-key": ******Speech Service Key**************",
"auth-endpoint": "https://eastus2.api.cognitive.microsoft.com/sts/v1.0/issuetoken",
"auth-key": ******Speech Service Key**************",
"service-endpoint":
}
}
BS
{
"subscription-key": ******Speech Service Key**************" ,
"region": "eastus2",
"service-endpoint": ,
"api": ""
}
"subscription-key": ******Speech Service Key**************" ,
"region": "eastus2",
"service-endpoint": ,
"api": ""
}
--
You received this message because you are subscribed to the Google Groups "UniMRCP" group.
To unsubscribe from this group and stop receiving emails from it, send an email to unimrcp+u...@googlegroups.com.
To view this discussion on the web visit https://groups.google.com/d/msgid/unimrcp/f474531a-cb75-443c-ba3a-8ff377348423n%40googlegroups.com.
--
Arsen Chaloyan
Jun 11, 2022, 4:09:37 PM6/11/22
to UniMRCP
The Asterisk logs show that the RECOGNIZE request completed with an error. You would need to check the UniMRCP server logs located in the /opt/unimrcp/log directory.
[Jun 7 18:32:27] NOTICE[1043]: src/mrcp_client_connection.c:656 Receive MRCPv2 Data 10.3.0.5:49122 <-> 10.3.0.5:1544 [138 bytes]
MRCP/2.0 138 RECOGNITION-COMPLETE 1 COMPLETEChannel-Identifier: 85c7c739480142fc@speechrecog
Completion-Cause: 006 recognizer-error
--
You received this message because you are subscribed to the Google Groups "UniMRCP" group.
To unsubscribe from this group and stop receiving emails from it, send an email to unimrcp+u...@googlegroups.com.
To view this discussion on the web visit https://groups.google.com/d/msgid/unimrcp/71d667a9-bab6-4d2f-a9f9-676f3e366376n%40googlegroups.com.
Reply all
Reply to author
Forward
0 new messages