SpeakSsmlAsync is cancelled, but SpeakTextAsync is successfull

One More Henry 0

I am trying out the Azure AI service to convert text to speech from a C# WPF application. My calls through SpeakTextAsync are successfull, but my calls through SpeakSsmlAsync are returned with the Reason = Cancelled.

I am on the free tier for South UK.

This is my SSML:

<speak version='1.0' xmlns='https://www.w3.org/2001/10/synthesis' xml:lang='en-GB'><voice name='en-GB-LibbyNeural'><s>This is a test message.</s></voice></speak>

I copied this SSML into the Speech Studio and it works.

navba-MSFT 19,495 Reputation points Microsoft Employee

2024-07-01T04:47:48+00:00
@One More Henry Welcome to Microsoft Q&A Forum, Thank you for posting your query here!

.

To identify the cause of the issue, please follow the below action plans for now:

.

Plan 1:

You can try to find the cause for the Canceled reason as shown below:

if (speech.Reason == ResultReason.Canceled) { var cancellation = CancellationDetails.FromResult(speech); Console.WriteLine(cancellation.Reason); Console.WriteLine(cancellation.ErrorDetails); }

. Plan 2:

You can try enabled the Speech SDK Logging and check the cause of Cancelled . The logging provides additional information and diagnostics from the Speech SDK's core components. It can be enabled by setting the Speech_LogFilename property on a speech configuration object to the location and name of the log file. Logging is handled by a static class in Speech SDK’s native library. You can turn on logging for any Speech SDK recognizer or synthesizer instance.

speechConfig.SetProperty(PropertyId.Speech_LogFilename, "LogfilePathAndName");

Hope this helps. If you have any follow-up questions, please let me know. I would be happy to help.
One More Henry 0 Reputation points

2024-07-01T09:41:57.81+00:00

Hello, thank you for the reply. Using your plan 2, I obtained the detail of the error.

[377563]: 3471ms SPX_TRACE_INFO: usp_connection.cpp:933 TS:419, TransportError: connection:0xa423a020, code=2, string=Connection was closed by the remote host. Error code: 1007. Error details: Data at the root level is invalid. Line 1, position 1.

Does this indicate there is something wrong with my SSML? I cannot find what is wrong with it.

The full log is here:

[86954]: 1746ms SPX_DBG_TRACE_VERBOSE: resource_manager.cpp:133 Created 'CSpxThreadService' as '303073113'

[86954]: 1746ms SPX_DBG_TRACE_VERBOSE: resource_manager.cpp:133 Created 'CSpxThreadService' as '303073113'

[86954]: 1746ms SPX_DBG_TRACE_VERBOSE: usp_tts_engine_adapter.cpp:62 CSpxUspTtsEngineAdapter::CSpxUspTtsEngineAdapter

[86954]: 1746ms SPX_DBG_TRACE_VERBOSE: resource_manager.cpp:133 Created 'CSpxUspTtsEngineAdapter' as '919101823'

[86954]: 1747ms SPX_DBG_TRACE_SCOPE_ENTER: com_init_and_uninit.cpp:18 ComInitAndUnInit ctor enter

[864798]: 1747ms SPX_DBG_TRACE_SCOPE_ENTER: com_init_and_uninit.cpp:44 com worker_thread_proc() enter

[864798]: 1747ms SPX_DBG_TRACE_VERBOSE: com_init_and_uninit.cpp:53 com successfully Initialized

[86954]: 1747ms SPX_DBG_TRACE_SCOPE_EXIT: com_init_and_uninit.cpp:18 ComInitAndUnInit ctor done

[86954]: 1747ms SPX_DBG_TRACE_VERBOSE: resource_manager.cpp:133 Created 'CSpxDefaultSpeaker' as '853898539'

[86954]: 1748ms SPX_DBG_TRACE_VERBOSE: resource_manager.cpp:133 Created 'CSpxPullAudioOutputStream' as '853898539'

[86954]: 1748ms SPX_DBG_TRACE_VERBOSE: named_properties.h:479 ISpxNamedProperties::GetStringValue: this=0x00000227A45D9DE8; name='SPEECH-SynthOutputFormat'; value='audio-24khz-160kbitrate-mono-mp3'

[86954]: 1748ms SPX_DBG_TRACE_VERBOSE: cloud_tts_engine_adapter.cpp:134 CSpxCloudTtsEngineAdapter::SetOutput

[86954]: 1748ms SPX_DBG_TRACE_VERBOSE: handle_table.h:111 CSpxHandleTable::TrackHandle p=0x00000227A45D99B8

[86954]: 1748ms SPX_DBG_TRACE_VERBOSE: handle_table.h:121 CSpxHandleTable::TrackHandle class=ISpxSynthesizer, h=0x00000227A45D99B8, p=0x00000227A45D99B8, tot=1

[86954]: 1748ms SPX_DBG_TRACE_SCOPE_EXIT: speechapi_c_factory.cpp:548 synthesizer_create_speech_synthesizer_from_config

[86954]: 1749ms SPX_TRACE_VERBOSE interop_factory.cs:84 Dispose(True) called for 227a1c3b548

[86954]: 1749ms SPX_DBG_TRACE_VERBOSE: handle_table.h:180 CSpxHandleTable::StopTracking(h) h=0x00000227A1C3B548

[86954]: 1749ms SPX_DBG_TRACE_VERBOSE: handle_table.h:195 CSpxHandleTable::StopTracking(h) class=ISpxNamedProperties, h=0x00000227A1C3B548, p=0x00000227A1C3B548, tot=1

[86954]: 1749ms SPX_DBG_TRACE_VERBOSE: handle_table.h:111 CSpxHandleTable::TrackHandle p=0x00000227A45D9DE8

[86954]: 1749ms SPX_DBG_TRACE_VERBOSE: handle_table.h:121 CSpxHandleTable::TrackHandle class=ISpxNamedProperties, h=0x00000227A45D9DE8, p=0x00000227A45D9DE8, tot=2

[86954]: 2637ms SPX_DBG_TRACE_VERBOSE: named_properties.h:479 ISpxNamedProperties::GetStringValue: this=0x00000227A45AFF38; name='SPEECH-SynthVoice'; value='en-GB-LibbyNeural'

[335257]: 3050ms SPX_DBG_TRACE_VERBOSE: resource_manager.cpp:133 Created 'CSpxAudioDataStream' as '418301898'

[335257]: 3050ms SPX_DBG_TRACE_VERBOSE: null_audio_output.h:93 CSpxNullAudioOutput::SetFormat is called with format 0x00000227A4250210

[335257]: 3050ms SPX_DBG_TRACE_FUNCTION: synthesis_result.cpp:25 CSpxSynthesisResult::CSpxSynthesisResult

[335257]: 3050ms SPX_DBG_TRACE_VERBOSE: resource_manager.cpp:133 Created 'CSpxSynthesisResult' as '3874248'

[335257]: 3050ms SPX_TRACE_INFO: thread_service.cpp:96 Started thread User with ID [516877ll]

[335257]: 3051ms SPX_TRACE_VERBOSE: synthesizer.cpp:217 CSpxSynthesizer::ExecuteSynthesis: synthesis started, request id: 8f612a70cefa4cd1b403d0439e8768fe; text: This is a test message.

[335257]: 3051ms SPX_DBG_TRACE_VERBOSE: synthesizer_timeout_management.cpp:32 SynthesisTimeoutManagement::SetTimeoutValues: RTF set to 2.00; frame timeout interval set to 3000 ms.

[516877]: 3051ms SPX_DBG_TRACE_SCOPE_ENTER: synthesizer.cpp:1185 DispatchEvent task started...

[335257]: 3051ms SPX_DBG_TRACE_FUNCTION: synthesis_request.cpp:27 CSpxSynthesisRequest::CSpxSynthesisRequest

[516877]: 3051ms SPX_DBG_TRACE_VERBOSE: synthesizer.cpp:533 [00000227A45D9980]CSpxSynthesizer::CSpxSynthesizer::FireResultEvent

[516877]: 3051ms SPX_DBG_TRACE_VERBOSE: synthesizer.cpp:602 No listener connected to event

[335257]: 3051ms SPX_DBG_TRACE_VERBOSE: resource_manager.cpp:133 Created 'CSpxSynthesisRequest' as '211460561'

[335257]: 3051ms SPX_DBG_TRACE_FUNCTION: synthesis_request.cpp:37 CSpxSynthesisRequest::Init

[335257]: 3051ms SPX_DBG_TRACE_VERBOSE: usp_tts_engine_adapter.cpp:102 CSpxUspTtsEngineAdapter::Speak

[516877]: 3051ms SPX_DBG_TRACE_SCOPE_EXIT: synthesizer.cpp:1185 DispatchEvent task complete!

[335257]: 3051ms SPX_DBG_TRACE_VERBOSE: usp_tts_engine_adapter.cpp:120 CSpxUspTtsEngineAdapter::Speak: start to send synthesis request, request id : 8f612a70cefa4cd1b403d0439e8768fe, try: 0

[335257]: 3051ms SPX_DBG_TRACE_FUNCTION: synthesis_request.cpp:79 CSpxSynthesisRequest::GetInputContent

[335257]: 3052ms SPX_DBG_TRACE_FUNCTION: synthesis_result.cpp:25 CSpxSynthesisResult::CSpxSynthesisResult

[335257]: 3052ms SPX_DBG_TRACE_VERBOSE: resource_manager.cpp:133 Created 'CSpxSynthesisResult' as '3874248'

[335257]: 3052ms SPX_DBG_TRACE_VERBOSE: usp_tts_engine_adapter.cpp:223 SSML sent to TTS cognitive service: This is a test message.

[335257]: 3052ms SPX_DBG_TRACE_VERBOSE: usp_tts_engine_adapter.cpp:576 CSpxUspTtsEngineAdapter::UspInitialize: this=0x00000227A4240250

[335257]: 3052ms SPX_DBG_TRACE_VERBOSE: named_properties.h:479 ISpxNamedProperties::GetStringValue: this=0x00000227A45D9DE8; name='SPEECH-SubscriptionKey'; value='******************************d7'

[335257]: 3052ms SPX_DBG_TRACE_VERBOSE: named_properties.h:479 ISpxNamedProperties::GetStringValue: this=0x00000227A42402B8; name='AZAC-SDK-PROGRAMMING-LANGUAGE'; value='C#'

[335257]: 3052ms SPX_DBG_TRACE_VERBOSE: named_properties.h:479 ISpxPropertyBagImpl::SetStringValue: this=0x00000227A42402B8; name='HttpHeader#User-agent'; value='SpeechSDK-C#/1.38.0 Windows Client 8'

[335257]: 3052ms SPX_DBG_TRACE_VERBOSE: named_properties.h:479 ISpxNamedProperties::FindPrefix: this=0x00000227A42402B8; name='User-agent'; value='SpeechSDK-C#/1.38.0 Windows Client 8'

[335257]: 3052ms SPX_DBG_TRACE_VERBOSE: resource_manager.cpp:133 Created 'CSpxUspCallbackWrapper' as '710381509'

[335257]: 3052ms SPX_DBG_TRACE_VERBOSE: named_properties.h:479 ISpxNamedProperties::GetStringValue: this=0x00000227A45D9DE8; name='SPEECH-Region'; value='uksouth'

[335257]: 3052ms SPX_DBG_TRACE_VERBOSE: named_properties.h:479 ISpxNamedProperties::GetStringValue: this=0x00000227A45D9DE8; name='SPEECH-ProxyHostBypass'; value=''

[335257]: 3052ms SPX_DBG_TRACE_VERBOSE: resource_manager.cpp:133 Created 'CSpxUspConnection' as '792041254'

[335257]: 3052ms SPX_TRACE_INFO: usp_connection.cpp:485 Microsoft::CognitiveServices::Speech::USP::CSpxUspConnection::Connect: entering...

[335257]: 3052ms SPX_TRACE_INFO: usp_connection.cpp:502 Adding subscription key headers

[335257]: 3052ms SPX_TRACE_INFO: usp_connection.cpp:537 Set a user defined HTTP header 'User-agent':'SpeechSDK-C#/1.38.0 Windows Client 8'

[335257]: 3052ms SPX_TRACE_INFO: usp_connection.cpp:543 Set an underlying io option 'tcp_nodelay'

[335257]: 3052ms SPX_TRACE_INFO: usp_connection.cpp:552 connectionUrl=wss://uksouth.tts.speech.microsoft.com/cognitiveservices/websocket/v1

[335257]: 3052ms SPX_DBG_TRACE_VERBOSE: resource_manager.cpp:133 Created 'CSpxTelemetry' as '151041793'

[335257]: 3052ms SPX_DBG_TRACE_SCOPE_ENTER: web_socket.cpp:216 CSpxWebSocket::CSpxWebSocket

[335257]: 3052ms SPX_DBG_TRACE_SCOPE_EXIT: web_socket.cpp:216 CSpxWebSocket::CSpxWebSocket

[335257]: 3052ms SPX_DBG_TRACE_VERBOSE: resource_manager.cpp:133 Created 'CSpxWebSocket' as '482598724'

[335257]: 3052ms SPX_TRACE_SCOPE_ENTER: uws_web_socket.cpp:31 WebSocketAdapter::UwsWebSocket::UwsWebSocket

[335257]: 3052ms SPX_TRACE_SCOPE_EXIT: uws_web_socket.cpp:31 WebSocketAdapter::UwsWebSocket::UwsWebSocket

[335257]: 3052ms SPX_TRACE_SCOPE_ENTER: uws_web_socket.cpp:43 WebSocketAdapter::UwsWebSocket::Initialize

[335257]: 3052ms SPX_TRACE_SCOPE_EXIT: uws_web_socket.cpp:43 WebSocketAdapter::UwsWebSocket::Initialize

[335257]: 3052ms SPX_TRACE_SCOPE_ENTER: uws_web_socket.cpp:221 WebSocketAdapter::UwsWebSocket::SetRequestHeader

[335257]: 3052ms SPX_TRACE_SCOPE_EXIT: uws_web_socket.cpp:221 WebSocketAdapter::UwsWebSocket::SetRequestHeader

[335257]: 3052ms SPX_TRACE_SCOPE_ENTER: uws_web_socket.cpp:221 WebSocketAdapter::UwsWebSocket::SetRequestHeader

[335257]: 3052ms SPX_TRACE_SCOPE_EXIT: uws_web_socket.cpp:221 WebSocketAdapter::UwsWebSocket::SetRequestHeader

[335257]: 3052ms SPX_TRACE_SCOPE_ENTER: uws_web_socket.cpp:221 WebSocketAdapter::UwsWebSocket::SetRequestHeader

[335257]: 3052ms SPX_TRACE_SCOPE_EXIT: uws_web_socket.cpp:221 WebSocketAdapter::UwsWebSocket::SetRequestHeader

[335257]: 3053ms SPX_TRACE_INFO: thread_service.cpp:96 Started thread Background with ID [377563ll]

[335257]: 3053ms SPX_DBG_TRACE_VERBOSE: named_properties.h:479 ISpxPropertyBagImpl::SetStringValue: this=0x00000227A45D9DE8; name='SPEECH-ConnectionUrl'; value='wss://uksouth.tts.speech.microsoft.com/cognitiveservices/websocket/v1'

[335257]: 3053ms SPX_DBG_TRACE_VERBOSE: usp_tts_engine_adapter.cpp:425 speech.config {"context":{"system":{"version":"1.38.0","name":"SpeechSDK","build":"Windows-x64"},"os":{"platform":"Windows","name":"Client","version":"8"}}}

[335257]: 3053ms SPX_DBG_TRACE_VERBOSE: usp_tts_engine_adapter.cpp:516 speech.config='{"context":{"system":{"version":"1.38.0","name":"SpeechSDK","build":"Windows-x64"},"os":{"platform":"Windows","name":"Client","version":"8"}}}'

[377563]: 3053ms SPX_TRACE_INFO: web_socket.cpp:800 CSpxWebSocket::DoWork: open transport.

[377563]: 3053ms SPX_TRACE_INFO: web_socket.cpp:479 Start to open websocket. WebSocket: 0xafb8f8a0, wsio handle: 0xae562f90

[335257]: 3053ms SPX_DBG_TRACE_VERBOSE: usp_tts_engine_adapter.cpp:516 synthesis.context='{"synthesis":{"audio":{"outputFormat":"audio-24khz-160kbitrate-mono-mp3","metadataOptions":{"visemeEnabled":false,"bookmarkEnabled":false,"wordBoundaryEnabled":false,"punctuationBoundaryEnabled":false,"sentenceBoundaryEnabled":false,"sessionEndEnabled":true}},"language":{"autoDetection":false}}}'

[377563]: 3053ms SPX_TRACE_SCOPE_ENTER: uws_web_socket.cpp:149 WebSocketAdapter::UwsWebSocket::Open

[335257]: 3058ms SPX_DBG_TRACE_VERBOSE: usp_tts_engine_adapter.cpp:481 ssml This is a test message.

[335257]: 3058ms SPX_DBG_TRACE_VERBOSE: usp_tts_engine_adapter.cpp:516 ssml='This is a test message.'

[377563]: 3136ms SPX_TRACE_SCOPE_EXIT: uws_web_socket.cpp:149 WebSocketAdapter::UwsWebSocket::Open

[377563]: 3136ms SPX_TRACE_INFO: usp_connection.cpp:787 Create requestId for messageType 0

[377563]: 3422ms SPX_TRACE_SCOPE_ENTER: uws_web_socket.cpp:247 WebSocketAdapter::UwsWebSocket::OnWebSocketOpened

[377563]: 3422ms SPX_TRACE_INFO: web_socket.cpp:880 Opening websocket completed. TransportRequest: 0xafb8f8a0, wsio handle: 0xae562f90, time: 2024-07-01T09:32:54.1109797Z

[377563]: 3422ms SPX_TRACE_SCOPE_ENTER: uws_web_socket.cpp:215 WebSocketAdapter::UwsWebSocket::SetOption

[377563]: 3422ms SPX_TRACE_SCOPE_EXIT: uws_web_socket.cpp:215 WebSocketAdapter::UwsWebSocket::SetOption

[377563]: 3422ms SPX_TRACE_INFO: usp_connection.cpp:902 TS:370, OnConnected: connection:0xa423a020

[377563]: 3422ms SPX_TRACE_SCOPE_EXIT: uws_web_socket.cpp:247 WebSocketAdapter::UwsWebSocket::OnWebSocketOpened

[377563]: 3422ms SPX_TRACE_VERBOSE: web_socket.cpp:540 [0x00000227AFB8F8A0] Web socket sending message. Time: 2024-07-01T09:32:54.1112535Z, TimeInQueue: 285ms, IsBinary: 0, Path: speech.config, Size:204 B

[516877]: 3422ms SPX_DBG_TRACE_SCOPE_ENTER: synthesizer.cpp:1185 DispatchEvent task started...

[516877]: 3422ms SPX_DBG_TRACE_SCOPE_ENTER: synthesizer.cpp:649 CSpxSynthesizer::FireConnectionChanged

[516877]: 3422ms SPX_DBG_TRACE_VERBOSE: synthesizer.cpp:650 CSpxSynthesizer::FireConnectionChanged: Connected

[377563]: 3422ms SPX_TRACE_VERBOSE: web_socket.cpp:649 [0x00000227AFB8F8A0] Web socket send message completed. Result: 0, SendTime: 0ms, IsBinary: 0, Path: speech.config, Size:204 B

[516877]: 3422ms SPX_DBG_TRACE_VERBOSE: resource_manager.cpp:133 Created 'CSpxConnectionEventArgs' as '189265475'

[377563]: 3422ms SPX_TRACE_VERBOSE: web_socket.cpp:540 [0x00000227AFB8F8A0] Web socket sending message. Time: 2024-07-01T09:32:54.1114856Z, TimeInQueue: 285ms, IsBinary: 0, Path: synthesis.context, Size:408 B

[516877]: 3422ms SPX_DBG_TRACE_SCOPE_EXIT: synthesizer.cpp:649 CSpxSynthesizer::FireConnectionChanged

[516877]: 3422ms SPX_DBG_TRACE_SCOPE_EXIT: synthesizer.cpp:1185 DispatchEvent task complete!

[377563]: 3422ms SPX_TRACE_VERBOSE: web_socket.cpp:649 [0x00000227AFB8F8A0] Web socket send message completed. Result: 0, SendTime: 0ms, IsBinary: 0, Path: synthesis.context, Size:408 B

[377563]: 3422ms SPX_TRACE_VERBOSE: web_socket.cpp:540 [0x00000227AFB8F8A0] Web socket sending message. Time: 2024-07-01T09:32:54.1116632Z, TimeInQueue: 285ms, IsBinary: 0, Path: ssml, Size:157 B

[377563]: 3423ms SPX_TRACE_VERBOSE: web_socket.cpp:649 [0x00000227AFB8F8A0] Web socket send message completed. Result: 0, SendTime: 0ms, IsBinary: 0, Path: ssml, Size:157 B

[377563]: 3441ms SPX_TRACE_VERBOSE: usp_web_socket.cpp:209 USP message received. IsBinary=0, Path=turn.start, Size=186 B, Time=2024-07-01T09:32:54.1301161Z

[377563]: 3441ms SPX_TRACE_INFO: usp_connection.cpp:993 Service originated request received with requestId: 8f612a70cefa4cd1b403d0439e8768fe

[377563]: 3441ms SPX_TRACE_INFO: usp_connection.cpp:1008 Response Message: content type: application/json; charset=utf-8.

[377563]: 3441ms SPX_TRACE_INFO: usp_connection.cpp:1028 TS:390 Response Message: path: turn.start, size: 75.

[377563]: 3471ms SPX_TRACE_INFO: AZ_LOG_INFO: uws_client.c:1496 on_underlying_io_bytes_received: Close frame received

[377563]: 3471ms SPX_TRACE_INFO: AZ_LOG_INFO: uws_client.c:1583 on_underlying_io_bytes_received: received close frame, sending a close response frame.

[377563]: 3471ms SPX_TRACE_INFO: AZ_LOG_INFO: uws_client.c:960 on_underlying_io_close_sent: uws_client=00000227AE141320, io_send_result:0

[377563]: 3471ms SPX_TRACE_INFO: AZ_LOG_INFO: uws_client.c:969 on_underlying_io_close_sent: closing underlying io.

[377563]: 3471ms SPX_TRACE_INFO: AZ_LOG_INFO: uws_client.c:939 on_underlying_io_close_complete: uws_state: 6.

[377563]: 3471ms SPX_TRACE_SCOPE_ENTER: uws_web_socket.cpp:259 WebSocketAdapter::UwsWebSocket::OnWebSocketPeerClosed

[377563]: 3471ms SPX_TRACE_INFO: web_socket.cpp:982 CSpxWebSocket::OnWebSocketPeerClosed: context=00000227AFB8F8A0

[377563]: 3471ms SPX_TRACE_INFO: usp_connection.cpp:933 TS:419, TransportError: connection:0xa423a020, code=2, string=Connection was closed by the remote host. Error code: 1007. Error details: Data at the root level is invalid. Line 1, position 1.

[377563]: 3471ms SPX_TRACE_INFO: usp_connection.cpp:938 TS:419, OnDisconnected: connection:0xa423a020

[377563]: 3471ms SPX_DBG_TRACE_VERBOSE: usp_tts_engine_adapter.cpp:1014 Response: On Error: Code:2, Message: Connection was closed by the remote host. Error code: 1007. Error details: Data at the root level is invalid. Line 1, position 1..

[516877]: 3471ms SPX_DBG_TRACE_SCOPE_ENTER: synthesizer.cpp:1185 DispatchEvent task started...

[377563]: 3471ms SPX_DBG_TRACE_VERBOSE: create_object_helpers.h:78 SpxTerm: ptr=0x00000227AE0B4C98

[377563]: 3471ms SPX_DBG_TRACE_SCOPE_ENTER: usp_connection.cpp:146 Microsoft::CognitiveServices::Speech::USP::CSpxUspConnection::~CSpxUspConnection

[516877]: 3471ms SPX_DBG_TRACE_SCOPE_ENTER: synthesizer.cpp:649 CSpxSynthesizer::FireConnectionChanged

[516877]: 3471ms SPX_DBG_TRACE_VERBOSE: synthesizer.cpp:650 CSpxSynthesizer::FireConnectionChanged: Disconnected

[377563]: 3471ms SPX_DBG_TRACE_SCOPE_EXIT: usp_connection.cpp:146 Microsoft::CognitiveServices::Speech::USP::CSpxUspConnection::~CSpxUspConnection

[335257]: 3471ms SPX_DBG_TRACE_VERBOSE: named_properties.h:479 ISpxPropertyBagImpl::SetStringValue: this=0x00000227AE1D95B0; name='CancellationDetails_ReasonDetailedText'; value='Connection was closed by the remote host. Error code: 1007. Error details: Data at the root level is invalid. Line 1, position 1. USP state: TurnStarted. Received audio size: 0 bytes.'

[516877]: 3471ms SPX_DBG_TRACE_VERBOSE: resource_manager.cpp:133 Created 'CSpxConnectionEventArgs' as '189265475'

[516877]: 3471ms SPX_DBG_TRACE_SCOPE_EXIT: synthesizer.cpp:649 CSpxSynthesizer::FireConnectionChanged

[335257]: 3471ms SPX_DBG_TRACE_VERBOSE: named_properties.h:479 ISpxPropertyBagImpl::SetStringValue: this=0x00000227AE1D95B0; name='CancellationDetails_ReasonDetailedText'; value='Connection was closed by the remote host. Error code: 1007. Error details: Data at the root level is invalid. Line 1, position 1. USP state: TurnStarted. Received audio size: 0 bytes.'

[335257]: 3471ms SPX_TRACE_ERROR: usp_tts_engine_adapter.cpp:138 Synthesis cancelled by user, won't retry.

[335257]: 3471ms SPX_DBG_TRACE_FUNCTION: synthesis_request.cpp:32 CSpxSynthesisRequest::~CSpxSynthesisRequest

[377563]: 3471ms SPX_TRACE_SCOPE_EXIT: uws_web_socket.cpp:259 WebSocketAdapter::UwsWebSocket::OnWebSocketPeerClosed

[335257]: 3471ms SPX_DBG_TRACE_VERBOSE: named_properties.h:479 ISpxPropertyBagImpl::SetStringValue: this=0x00000227A64F1398; name='RESULT-SynthesisBackend'; value='online (websocket)'

[516877]: 3471ms SPX_DBG_TRACE_SCOPE_EXIT: synthesizer.cpp:1185 DispatchEvent task complete!

[335257]: 3471ms SPX_DBG_TRACE_VERBOSE: named_properties.h:479 ISpxPropertyBagImpl::SetStringValue: this=0x00000227A64F1398; name='RESULT-SynthesisFirstByteLatencyMs'; value='-1'

[335257]: 3471ms SPX_DBG_TRACE_VERBOSE: named_properties.h:479 ISpxPropertyBagImpl::SetStringValue: this=0x00000227A64F1398; name='RESULT-SynthesisFinishLatencyMs'; value='420'

[335257]: 3471ms SPX_DBG_TRACE_VERBOSE: named_properties.h:479 ISpxPropertyBagImpl::SetStringValue: this=0x00000227A64F1398; name='RESULT-SynthesisConnectionLatencyMs'; value='371'

[335257]: 3472ms SPX_DBG_TRACE_VERBOSE: named_properties.h:479 ISpxPropertyBagImpl::SetStringValue: this=0x00000227A64F1398; name='RESULT-SynthesisNetworkLatencyMs'; value='19'

[335257]: 3472ms SPX_DBG_TRACE_VERBOSE: named_properties.h:479 ISpxPropertyBagImpl::SetStringValue: this=0x00000227A64F1398; name='RESULT-SynthesisServiceLatencyMs'; value='-1'

[335257]: 3472ms SPX_DBG_TRACE_VERBOSE: named_properties.h:479 ISpxPropertyBagImpl::SetStringValue: this=0x00000227A64F1398; name='RESULT-SynthesisUnderrunTimeMs'; value='0'

[335257]: 3472ms SPX_DBG_TRACE_VERBOSE: named_properties.h:479 ISpxPropertyBagImpl::SetStringValue: this=0x00000227A64F1398; name='CancellationDetails_ReasonDetailedText'; value='Connection was closed by the remote host. Error code: 1007. Error details: Data at the root level is invalid. Line 1, position 1. USP state: TurnStarted. Received audio size: 0 bytes.'

[335257]: 3472ms SPX_DBG_TRACE_VERBOSE: pull_audio_output_stream.cpp:166 Signal End of Writing is called

[335257]: 3472ms SPX_DBG_TRACE_VERBOSE: pull_audio_output_stream.cpp:166 Signal End of Writing is called

[335257]: 3472ms SPX_DBG_TRACE_FUNCTION: synthesis_result.cpp:30 CSpxSynthesisResult::~CSpxSynthesisResult

[335257]: 3472ms SPX_DBG_TRACE_VERBOSE: handle_table.h:111 CSpxHandleTable::TrackHandle p=0x00000227AE1D9590

[335257]: 3472ms SPX_DBG_TRACE_VERBOSE: handle_table.h:121 CSpxHandleTable::TrackHandle class=ISpxSynthesisResult, h=0x00000227AE1D9590, p=0x00000227AE1D9590, tot=1

[516877]: 3472ms SPX_DBG_TRACE_SCOPE_ENTER: synthesizer.cpp:1185 DispatchEvent task started...

[516877]: 3472ms SPX_DBG_TRACE_VERBOSE: synthesizer.cpp:533 [00000227A45D9980]CSpxSynthesizer::CSpxSynthesizer::FireResultEvent

[516877]: 3472ms SPX_DBG_TRACE_VERBOSE: synthesizer.cpp:602 No listener connected to event

[516877]: 3472ms SPX_DBG_TRACE_SCOPE_EXIT: synthesizer.cpp:1185 DispatchEvent task complete!

[335257]: 3473ms SPX_DBG_TRACE_VERBOSE: handle_table.h:111 CSpxHandleTable::TrackHandle p=0x00000227AE1D95B0

[335257]: 3473ms SPX_DBG_TRACE_VERBOSE: handle_table.h:121 CSpxHandleTable::TrackHandle class=ISpxNamedProperties, h=0x00000227AE1D95B0, p=0x00000227AE1D95B0, tot=3

[377563]: 3481ms SPX_DBG_TRACE_SCOPE_ENTER: web_socket.cpp:221 CSpxWebSocket::~CSpxWebSocket

[377563]: 3481ms SPX_DBG_TRACE_SCOPE_EXIT: web_socket.cpp:221 CSpxWebSocket::~CSpxWebSocket

[377563]: 3481ms SPX_TRACE_SCOPE_ENTER: uws_web_socket.cpp:36 WebSocketAdapter::UwsWebSocket::~UwsWebSocket

[377563]: 3481ms SPX_TRACE_SCOPE_EXIT: uws_web_socket.cpp:36 WebSocketAdapter::UwsWebSocket::~UwsWebSocket

[86954]: 22675ms SPX_TRACE_VERBOSE interop_factory.cs:84 Dispose(True) called for 227a45d9de8

[86954]: 22675ms SPX_DBG_TRACE_VERBOSE: handle_table.h:180 CSpxHandleTable::StopTracking(h) h=0x00000227A45D9DE8

[86954]: 22675ms SPX_DBG_TRACE_VERBOSE: handle_table.h:195 CSpxHandleTable::StopTracking(h) class=ISpxNamedProperties, h=0x00000227A45D9DE8, p=0x00000227A45D9DE8, tot=2

[86954]: 22679ms SPX_TRACE_VERBOSE interop_factory.cs:84 Dispose(True) called for 227a45d99b8

[86954]: 22681ms SPX_DBG_TRACE_FUNCTION: synthesizer.cpp:488 CSpxSynthesizer::SetDisposing

[86954]: 22681ms SPX_DBG_TRACE_VERBOSE: handle_table.h:180 CSpxHandleTable::StopTracking(h) h=0x00000227A45D99B8

[86954]: 22681ms SPX_DBG_TRACE_VERBOSE: handle_table.h:195 CSpxHandleTable::StopTracking(h) class=ISpxSynthesizer, h=0x00000227A45D99B8, p=0x00000227A45D99B8, tot=0

[86954]: 22681ms SPX_DBG_TRACE_SCOPE_ENTER: synthesizer.cpp:42 CSpxSynthesizer::~CSpxSynthesizer

[86954]: 22681ms SPX_DBG_TRACE_VERBOSE: create_object_helpers.h:78 SpxTerm: ptr=0x00000227A42402A8

[86954]: 22681ms SPX_DBG_TRACE_SCOPE_ENTER: usp_tts_engine_adapter.cpp:88 CSpxUspTtsEngineAdapter::Term

[86954]: 22681ms SPX_DBG_TRACE_SCOPE_EXIT: usp_tts_engine_adapter.cpp:88 CSpxUspTtsEngineAdapter::Term

[86954]: 22681ms SPX_DBG_TRACE_VERBOSE: usp_tts_engine_adapter.cpp:67 CSpxUspTtsEngineAdapter::~CSpxUspTtsEngineAdapter: this=0x00000227A4240250

[86954]: 22681ms SPX_DBG_TRACE_VERBOSE: create_object_helpers.h:78 SpxTerm: ptr=0x00000227A6090BE8

[86954]: 22681ms SPX_DBG_TRACE_SCOPE_ENTER: thread_service.cpp:45 CSpxThreadService::Term

[86954]: 22681ms SPX_DBG_TRACE_SCOPE_EXIT: thread_service.cpp:45 CSpxThreadService::Term

[86954]: 22682ms SPX_DBG_TRACE_VERBOSE: create_object_helpers.h:78 SpxTerm: ptr=0x00000227ADFDBDA8

[86954]: 22682ms SPX_DBG_TRACE_SCOPE_EXIT: synthesizer.cpp:42 CSpxSynthesizer::~CSpxSynthesizer

[86954]: 22682ms SPX_DBG_TRACE_SCOPE_ENTER: thread_service.cpp:45 CSpxThreadService::Term

[86954]: 22682ms SPX_DBG_TRACE_SCOPE_EXIT: thread_service.cpp:45 CSpxThreadService::Term

[86954]: 22682ms SPX_DBG_TRACE_SCOPE_ENTER: thread_service.cpp:45 CSpxThreadService::Term

[86954]: 22682ms SPX_DBG_TRACE_SCOPE_EXIT: thread_service.cpp:45 CSpxThreadService::Term

[864798]: 22682ms SPX_DBG_TRACE_SCOPE_EXIT: com_init_and_uninit.cpp:44 com worker_thread_proc done

[887619]: 23947ms SPX_TRACE_VERBOSE interop_factory.cs:105 InteropSafeHandle Finalizer for 227a45affa8

[887619]: 23947ms SPX_TRACE_VERBOSE interop_factory.cs:84 Dispose(False) called for 227a45affa8

[887619]: 23947ms SPX_DBG_TRACE_VERBOSE: handle_table.h:180 CSpxHandleTable::StopTracking(h) h=0x00000227A45AFFA8

[887619]: 23947ms SPX_DBG_TRACE_VERBOSE: handle_table.h:195 CSpxHandleTable::StopTracking(h) class=ISpxSpeechConfig, h=0x00000227A45AFFA8, p=0x00000227A45AFFA8, tot=0

[887619]: 23947ms SPX_TRACE_VERBOSE interop_factory.cs:84 Dispose(False) called for 00000000

[887619]: 23947ms SPX_TRACE_VERBOSE interop_factory.cs:105 InteropSafeHandle Finalizer for 227a1c3b5b8

[887619]: 23947ms SPX_TRACE_VERBOSE interop_factory.cs:84 Dispose(False) called for 227a1c3b5b8

[887619]: 23947ms SPX_DBG_TRACE_VERBOSE: handle_table.h:180 CSpxHandleTable::StopTracking(h) h=0x00000227A1C3B5B8

[887619]: 23947ms SPX_DBG_TRACE_VERBOSE: handle_table.h:195 CSpxHandleTable::StopTracking(h) class=ISpxAudioConfig, h=0x00000227A1C3B5B8, p=0x00000227A1C3B5B8, tot=0

[887619]: 23947ms SPX_TRACE_VERBOSE interop_factory.cs:84 Dispose(False) called for 00000000

[887619]: 23947ms SPX_TRACE_VERBOSE interop_factory.cs:105 InteropSafeHandle Finalizer for 227a45aff38

[887619]: 23947ms SPX_TRACE_VERBOSE interop_factory.cs:84 Dispose(False) called for 227a45aff38

[887619]: 23947ms SPX_DBG_TRACE_VERBOSE: handle_table.h:180 CSpxHandleTable::StopTracking(h) h=0x00000227A45AFF38

[887619]: 23947ms SPX_DBG_TRACE_VERBOSE: handle_table.h:195 CSpxHandleTable::StopTracking(h) class=ISpxNamedProperties, h=0x00000227A45AFF38, p=0x00000227A45AFF38, tot=1

[887619]: 23947ms SPX_TRACE_VERBOSE interop_factory.cs:84 Dispose(False) called for 00000000

[887619]: 23966ms SPX_TRACE_VERBOSE interop_factory.cs:105 InteropSafeHandle Finalizer for 227ae1d95b0

[887619]: 23966ms SPX_TRACE_VERBOSE interop_factory.cs:84 Dispose(False) called for 227ae1d95b0

[887619]: 23966ms SPX_DBG_TRACE_VERBOSE: handle_table.h:180 CSpxHandleTable::StopTracking(h) h=0x00000227AE1D95B0

[887619]: 23966ms SPX_DBG_TRACE_VERBOSE: handle_table.h:195 CSpxHandleTable::StopTracking(h) class=ISpxNamedProperties, h=0x00000227AE1D95B0, p=0x00000227AE1D95B0, tot=0

[887619]: 23966ms SPX_TRACE_VERBOSE interop_factory.cs:84 Dispose(False) called for 00000000

[887619]: 23966ms SPX_TRACE_VERBOSE interop_factory.cs:105 InteropSafeHandle Finalizer for 227ae1d9590

[887619]: 23966ms SPX_TRACE_VERBOSE interop_factory.cs:84 Dispose(False) called for 227ae1d9590

[887619]: 23966ms SPX_DBG_TRACE_VERBOSE: handle_table.h:180 CSpxHandleTable::StopTracking(h) h=0x00000227AE1D9590

[887619]: 23966ms SPX_DBG_TRACE_VERBOSE: handle_table.h:195 CSpxHandleTable::StopTracking(h) class=ISpxSynthesisResult, h=0x00000227AE1D9590, p=0x00000227AE1D9590, tot=0

[887619]: 23966ms SPX_DBG_TRACE_FUNCTION: synthesis_result.cpp:30 CSpxSynthesisResult::~CSpxSynthesisResult

[887619]: 23966ms SPX_TRACE_SCOPE_ENTER: audio_data_stream.cpp:25 CSpxAudioDataStream::~CSpxAudioDataStream

[887619]: 23966ms SPX_TRACE_SCOPE_EXIT: audio_data_stream.cpp:25 CSpxAudioDataStream::~CSpxAudioDataStream

[887619]: 23966ms SPX_TRACE_VERBOSE interop_factory.cs:84 Dispose(False) called for 00000000
One More Henry 0 Reputation points

2024-07-01T09:44:27.65+00:00

Here is the ssml:

<speak version='1.0' xmlns='https://www.w3.org/2001/10/synthesis' xml:lang='en-GB'><voice name='en-GB-LibbyNeural'><s>This is a test message.</s></voice></speak>
One More Henry 0 Reputation points

2024-07-01T15:07:17.4233333+00:00

Thanks again for the reply. The service appears to working now, with both your ssml and my previous ssml. Will report back if it stops working again. Fixed!
navba-MSFT 19,495 Reputation points Microsoft Employee

2024-07-02T02:58:07.86+00:00

@One More Henry Thanks for the update. I am glad it is working fine now. For the below answer, please do not forget to "Accept the answer” and “up-vote” wherever the information provided helps you, this can be beneficial to other community members.

Also if the issue encounters again, please do let me know. I would be happy to assist again.

1 answer

navba-MSFT 19,495 Reputation points Microsoft Employee

2024-07-01T09:48:35.1966667+00:00
@One More Henry Thanks for getting back. Could you please test with the below and check if that helps ?

<speak version="1.0" xmlns="http://www.w3.org/2001/10/synthesis" xml:lang="string" xmlns:mstts="https://www.w3.org/2001/mstts"><voice name="en-GB-LibbyNeural">Hello World </voice></speak>
Please sign in to rate this answer.
navba-MSFT 19,495 Reputation points Microsoft Employee

2024-07-02T02:58:20.34+00:00

@One More Henry Thanks for the update. I am glad it is working fine now. For the above answer, please do not forget to "Accept the answer” and “up-vote” wherever the information provided helps you, this can be beneficial to other community members. Also if the issue encounters again, please do let me know. I would be happy to assist again.
Sign in to comment

Share via

SpeakSsmlAsync is cancelled, but SpeakTextAsync is successfull

1 answer