AVS SDK 1.20.0 can not talk with Alexa

[shao-estone]

I'm using Ubuntu 20.04, followed the document to set up my sample app. here is the log. Running app with log level: INFO 2020-07-12 22:10:15.572 [ 1] I AlexaClientSdkInit:initialize:sdkversion=1.20.0 2020-07-12 22:10:15.598 [ 1] I LocaleAssetsManager:initialize:supportedWakeWords=NONE 2020-07-12 22:10:15.598 [ 1] I DeviceInfo:create:result=skipDeviceType,key=deviceType 2020-07-12 22:10:15.598 [ 1] I DeviceInfo:create:result=skipFriendlyName,key=friendlyName 2020-07-12 22:10:15.598 [ 1] I DeviceInfo:create:result=skipRegistrationKey,key=registrationKey 2020-07-12 22:10:15.598 [ 1] I DeviceInfo:create:result=skipProductIdKey,key=productIdKey 2020-07-12 22:10:15.608 [ 1] I Setting:handleSetValue:value=false6142509188972423790 2020-07-12 22:10:15.609 [ 5] I Setting:handleSetValue:value="NONE"6142509188972423790 2020-07-12 22:10:15.609 [ 6] I Setting:handleSetValue:value="NONE"6142509188972423790 2020-07-12 22:10:15.617 [ 5] W UUIDGeneration:low entropy on call to generate UUID:current entropy=0 2020-07-12 22:10:15.618 [ 7] I Setting:handleSetValue:value="NONE"6142509188972423790 2020-07-12 22:10:15.618 [ 5] E MessageRouter:sendFailed:reason=noActiveTransport 2020-07-12 22:10:15.618 [ 5] E SharedAVSSettingProtocol:localChangeFailed:reason=sendEventFailed 2020-07-12 22:10:15.620 [ 6] W UUIDGeneration:low entropy on call to generate UUID:current entropy=0 2020-07-12 22:10:15.620 [ 6] E MessageRouter:sendFailed:reason=noActiveTransport 2020-07-12 22:10:15.620 [ 6] E SharedAVSSettingProtocol:localChangeFailed:reason=sendEventFailed 2020-07-12 22:10:15.623 [ 7] W UUIDGeneration:low entropy on call to generate UUID:current entropy=0 2020-07-12 22:10:15.623 [ 7] E MessageRouter:sendFailed:reason=noActiveTransport 2020-07-12 22:10:15.623 [ 7] E SharedAVSSettingProtocol:localChangeFailed:reason=sendEventFailed 2020-07-12 22:10:15.623 [ 8] I Setting:handleSetValue:value="America/Vancouver"6142509188972423790 2020-07-12 22:10:15.626 [ 8] W UUIDGeneration:low entropy on call to generate UUID:current entropy=0 2020-07-12 22:10:15.626 [ 8] E MessageRouter:sendFailed:reason=noActiveTransport 2020-07-12 22:10:15.626 [ 8] E SharedAVSSettingProtocol:localChangeFailed:reason=sendEventFailed 2020-07-12 22:10:15.626 [ 9] I Setting:handleSetValue:value={}6142509188972423790 2020-07-12 22:10:15.627 [ a] I LocaleAssetsManager:changeAssets:Locale=["en-US"],WakeWords=[] 2020-07-12 22:10:15.629 [ 9] W UUIDGeneration:low entropy on call to generate UUID:current entropy=0 2020-07-12 22:10:15.629 [ 9] E MessageRouter:sendFailed:reason=noActiveTransport 2020-07-12 22:10:15.629 [ 9] E SharedAVSSettingProtocol:localChangeFailed:reason=sendEventFailed 2020-07-12 22:10:15.630 [ 1] I SpeakerManager:mapCreated:numSpeakerVolume=6,numAlertsVolume=2 2020-07-12 22:10:15.632 [ a] W UUIDGeneration:low entropy on call to generate UUID:current entropy=0 2020-07-12 22:10:15.632 [ a] E MessageRouter:sendFailed:reason=noActiveTransport 2020-07-12 22:10:15.632 [ a] E LocaleWakeWordsSetting:synchronizeLocaleFailed:reason=sendEventFailed 2020-07-12 22:10:15.634 [ 1] W UUIDGeneration:low entropy on call to generate UUID:current entropy=0 #################################################

NOTIFICATION INDICATOR STATE: OFF

#################################################

ALSA lib pcm_dsnoop.c:641:(snd_pcm_dsnoop_open) unable to open slave ALSA lib pcm.c:2642:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.rear ALSA lib pcm.c:2642:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.center_lfe ALSA lib pcm.c:2642:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.side ALSA lib pcm_route.c:869:(find_matching_chmap) Found no matching channel map ALSA lib pcm_route.c:869:(find_matching_chmap) Found no matching channel map ALSA lib pcm_route.c:869:(find_matching_chmap) Found no matching channel map Cannot connect to server socket err = No such file or directory Cannot connect to server request channel jack server is not running or cannot be started JackShmReadWritePtr::~JackShmReadWritePtr - Init not done for -1, skipping unlock JackShmReadWritePtr::~JackShmReadWritePtr - Init not done for -1, skipping unlock Cannot connect to server socket err = No such file or directory Cannot connect to server request channel jack server is not running or cannot be started JackShmReadWritePtr::~JackShmReadWritePtr - Init not done for -1, skipping unlock JackShmReadWritePtr::~JackShmReadWritePtr - Init not done for -1, skipping unlock ALSA lib pcm_oss.c:377:(_snd_pcm_oss_open) Unknown field port ALSA lib pcm_oss.c:377:(_snd_pcm_oss_open) Unknown field port ALSA lib pcm_usb_stream.c:486:(_snd_pcm_usb_stream_open) Invalid type for card ALSA lib pcm_usb_stream.c:486:(_snd_pcm_usb_stream_open) Invalid type for card 2020-07-12 22:10:15.728 [ 1] I MessageRouter:setAVSGateway:avsGateway=https://alexa.na.gateway.devices.a2z.com 2020-07-12 22:10:15.728 [ 1] I MessageRouter:enable 2020-07-12 22:10:15.728 [ 1] I MessageRouter:setConnectionStatusLocked:status=PENDING,reason=ACL_CLIENT_REQUEST 2020-07-12 22:10:15.729 [ 1] I MessageRouter:createActiveTransportLocked:transport=0x55760021e550,sizeOf m_transports=0 2020-07-12 22:10:15.729 [ 1] I HTTP2Transport:connect:this=0x55760021e550 2020-07-12 22:10:15.729 [ 1] I HTTP2Transport:setStateLocked:this=0x55760021e550,currentState=INIT,newState=AUTHORIZING,changedReason=ACL_CLIENT_REQUEST 2020-07-12 22:10:15.729 [ 1] I MessageRouter:setAsActiveTransport:transport=0x55760021e550,sizeOf m_transports=1 #############################

Connecting...

#############################

              #    #     #  #####      #####  ######  #    #              
             # #   #     # #     #    #     # #     # #   #               
            #   #  #     # #          #       #     # #  #                
           #     # #     #  #####      #####  #     # ###                 
           #######  #   #        #          # #     # #  #                
           #     #   # #   #     #    #     # #     # #   #               
           #     #    #     #####      #####  ######  #    #              
                                                                          
   #####                                           #                      
  #     #   ##   #    # #####  #      ######      # #   #####  #####      
  #        #  #  ##  ## #    # #      #          #   #  #    # #    #     
   #####  #    # # ## # #    # #      #####     #     # #    # #    #     
        # ###### #    # #####  #      #         ####### #####  #####      
  #     # #    # #    # #      #      #         #     # #      #          
   #####  #    # #    # #      ###### ######    #     # #      #          

   SDK Version 1.20.0

   WARNING! THIS DEVICE HAS BEEN COMPILED IN DEBUG MODE.

   RELEASING A PRODUCTION DEVICE IN DEBUG MODE MAY IMPACT DEVICE PERFORMANCE,
   DOES NOT COMPLY WITH THE AVS SECURITY REQUIREMENTS,
   AND COULD RESULT IN SUSPENSION OR TERMINATION OF THE ALEXA SERVICE ON YOUR DEVICES.

+----------------------------------------------------------------------------+ | Options: | | Tap to talk: | | Press 't' and Enter followed by your query (no need for the 'Alexa').| | Hold to talk: | | Press 'h' followed by Enter to simulate holding a button. | | Then say your query (no need for the 'Alexa'). | | Press 'h' followed by Enter to simulate releasing a button. | | Stop an interaction: | | Press 's' and Enter to stop an ongoing interaction. | | Playback Controls: | | Press '1' for a 'PLAY' button press. | | Press '2' for a 'PAUSE' button press. | | Press '3' for a 'NEXT' button press. | | Press '4' for a 'PREVIOUS' button press. | | Settings: | | Press 'c' followed by Enter at any time to see the settings screen. | | Speaker Control: | | Press 'p' followed by Enter at any time to adjust speaker settings. | | Firmware Version: | | Press 'f' followed by Enter at any time to report a different | | firmware version. | | Info: | | Press 'i' followed by Enter at any time to see the help screen. | | Reset device: | | Press 'k' followed by Enter at any time to reset your device. This | | will erase any data stored in the device and you will have to | | re-register your device. | | This option will also exit the application. | | Reauthorize device: | | Press 'z' followed by Enter at any time to re-authorize your device. | | This will erase any data stored in the device and initiate | | re-authorization. | | | | Quit: | | Press 'q' followed by Enter at any time to quit the application. | +----------------------------------------------------------------------------+

2020-07-12 22:10:15.731 [ 17] I HTTP2Transport:handleAuthorizing:this=0x55760021e550 2020-07-12 22:10:15.731 [ 17] I HTTP2Transport:onAuthStateChange:this=0x55760021e550,newState=UNINITIALIZED,error=SUCCESS 2020-07-12 22:10:15.731 [ 18] W UUIDGeneration:low entropy on call to generate UUID:current entropy=0 2020-07-12 22:10:15.957 [ 19] I MessageRouter:onWakeConnectionRetry 2020-07-12 22:10:15.957 [ 19] I MessageRouter:onWakeConnectionRetry:m_activeTransport=0x55760021e550 2020-07-12 22:10:15.957 [ 19] I HTTP2Transport:onWakeConnectionRetry:this=0x55760021e550 2020-07-12 22:10:15.966 [ 1a] I HTTP2Transport:onAuthStateChange:this=0x55760021e550,newState=REFRESHED,error=SUCCESS t 2020-07-12 22:11:10.082 [ 7] W UUIDGeneration:low entropy on call to generate UUID:current entropy=0 2020-07-12 22:11:10.083 [ 7] I MessageRouter:onWakeConnectionRetry

[shao-estone]

this is In DEBUG9 after connected. 2020-07-12 22:12:40.006 [ 24] I HTTP2Transport:handleAuthorizing:this=0x555f563e2550 2020-07-12 22:12:40.006 [ 24] 5 CBLAuthDelegate:addAuthObserver:observer=0x555f563e25c8 2020-07-12 22:12:40.006 [ 24] I HTTP2Transport:onAuthStateChange:this=0x555f563e2550,newState=UNINITIALIZED,error=SUCCESS 2020-07-12 22:12:40.006 [ 25] 5 PostConnectSequencer:mainLoop 2020-07-12 22:12:40.006 [ 25] 5 PostConnectVerifyGatewaySender:performOperation 2020-07-12 22:12:40.006 [ 25] 5 PostConnectVerifyGatewaySender:sendVerifyGateway 2020-07-12 22:12:40.006 [ 25] W UUIDGeneration:low entropy on call to generate UUID:current entropy=0 2020-07-12 22:12:40.006 [ 25] 0 EventBuilder:buildJsonEventString:messageId=0161b8dd-a457-43e2-a9bf-9d2d618bbeec,namespace=Alexa.ApiGateway,name=VerifyGateway 2020-07-12 22:12:40.006 [ 25] 0 EventBuilder:buildJsonEventString:event={"event":{"header":{"namespace":"Alexa.ApiGateway","name":"VerifyGateway","messageId":"0161b8dd-a457-43e2-a9bf-9d2d618bbeec"},"payload":{}}} 2020-07-12 22:12:40.007 [ 25] 7 HTTP2Transport:sendMessage:this=0x555f563e2550 2020-07-12 22:12:40.014 [ 5] 9 LibCurlHttpContentFetcher:bodyCallback:totalContentReceived=419,contentLength=419,currentContentReceived=419,remaining=0,totalBytesWritten=419 2020-07-12 22:12:40.014 [ 5] 9 LibCurlHttpContentFetcher:transferThread::end 2020-07-12 22:12:40.014 [ 5] 9 LibCurlHttpContentFetcher:stateTransition:oldState=FETCHING_BODY,newState=BODY_DONE:State transition 2020-07-12 22:12:40.081 [ 2] 5 HttpPost:doPostSucceeded:code=200 2020-07-12 22:12:40.082 [ 2] 5 CBLAuthDelegate:receiveTokenResponse:code=200 2020-07-12 22:12:40.082 [ 2] 5 CBLAuthDelegate:mapHTTPStatusToError:code=200,error=SUCCESS 2020-07-12 22:12:40.082 [ 2] 5 CBLAuthDelegate:setAuthError:authError=SUCCESS 2020-07-12 22:12:40.082 [ 2] 5 CBLAuthDelegate:setRefreshToken 2020-07-12 22:12:40.082 [ 2] 5 SQLiteCBLAuthDelegateStorage:setRefreshToken 2020-07-12 22:12:40.091 [ 2] 5 CBLAuthDelegate:setAuthState:newAuthState=REFRESHED 2020-07-12 22:12:40.091 [ 2] 9 CBLAuthDelegate:callingOnAuthStateChange:state=REFRESHED,error=SUCCESS 2020-07-12 22:12:40.091 [ 2] I HTTP2Transport:onAuthStateChange:this=0x555f563e2550,newState=REFRESHED,error=SUCCESS 2020-07-12 22:12:40.114 [ 4] 9 InternetConnectionMonitor:testConnection::alreadyReadAllBytes 2020-07-12 22:12:40.114 [ 4] 9 InternetConnectionMonitor:testConnection::Finished reading 2020-07-12 22:12:40.114 [ 4] 5 InternetConnectionMonitor:updateConnectionStatus:connected=true 2020-07-12 22:12:40.114 [ 4] 5 InternetConnectionMonitor:notifyObserversLocked 2020-07-12 22:12:40.114 [ 4] 5 AVSConnectionManager:onConnectionStatusChanged:connected=true,isEnabled=true 2020-07-12 22:12:40.114 [ 4] I MessageRouter:onWakeConnectionRetry 2020-07-12 22:12:40.114 [ 4] I MessageRouter:onWakeConnectionRetry:m_activeTransport=0x555f563e2550 2020-07-12 22:12:40.114 [ 4] I HTTP2Transport:onWakeConnectionRetry:this=0x555f563e2550 t 2020-07-12 22:12:47.752 [ 1] 9 ThreadPool:obtainWorker:created=21,obtained=21,releasedToPool=20,releasedFromPool=1,outstanding=0 2020-07-12 22:12:47.752 [ a] 9 TaskThread:startThread:moniker= a,duration=127 2020-07-12 22:12:47.752 [ a] 5 DefaultClient:notifyOfTapToTalk 2020-07-12 22:12:47.752 [ a] 5 AudioInputProcessor:recognize 2020-07-12 22:12:47.752 [ a] 9 ThreadPool:obtainWorker:created=21,obtained=22,releasedToPool=20,releasedFromPool=1,outstanding=1 2020-07-12 22:12:47.752 [ b] 9 TaskThread:startThread:moniker= b,duration=39 2020-07-12 22:12:47.752 [ b] 0 AudioInputProcessor:notEncodingAudio 2020-07-12 22:12:47.752 [ b] W UUIDGeneration:low entropy on call to generate UUID:current entropy=0 2020-07-12 22:12:47.752 [ b] 5 UserInactivityMonitor:onUserActive 2020-07-12 22:12:47.753 [ b] 0 AudioInputProcessor:setState:from=IDLE,to=RECOGNIZING 2020-07-12 22:12:47.753 [ b] 9 ConnectionRetryTrigger:onStateChanged:state=RECOGNIZING 2020-07-12 22:12:47.753 [ b] 9 AVSConnectionManager:onWakeConnectionRetry 2020-07-12 22:12:47.753 [ b] I MessageRouter:onWakeConnectionRetry

It does not respond to anything I say after 'T+Enter' Please help!

[ereich1217]

It looks like you have a connection issue.

These log lines indicate you aren't successfully sending message to the AVS service. 2020-07-12 22:10:15.632 [ a] E MessageRouter:sendFailed:reason=noActiveTransport 2020-07-12 22:10:15.632 [ a] E LocaleWakeWordsSetting:synchronizeLocaleFailed:reason=sendEventFailed

Your MessageRouter messages should look more like this: 2020-07-13 01:49:05.225 [ 1] 0 MessageRouter:connectionStatusChanged:reason=ACL_CLIENT_REQUEST,newStatus=PENDING 2020-07-13 01:49:06.470 [ 35] 0 MessageRouter:connectionStatusChanged:reason=ACL_CLIENT_REQUEST,newStatus=CONNECTED

You don't have any MessageRouter messages that indicate a valid connection has been achieved. Until you do it will not respond to anything you say.

Look at your MessageRouter as well as any other E codes that you find. Whenever you see errors in the log you usually want to start with those. Other things that cause connection problems are issues with LibCurlHttpContentFetcher.

If you upload the entire log it would be easier to provide specific suggestions.

[shao-estone]

@ereich1217 What can I change to fix it? It passed the authorization phase. would it be something wrong in the AlexaClientSDKConfig.json?

[shao-estone]

Running app with log level: DEBUG9 2020-07-12 22:12:39.724 [ 1] I AlexaClientSdkInit:initialize:sdkversion=1.20.0 2020-07-12 22:12:39.725 [ 1] 0 ConfigurationNode:initializeSuccess 2020-07-12 22:12:39.727 [ 1] 1 InMemoryEqualizerConfiguration:validateConfiguration::Validating Equalizer configuration 2020-07-12 22:12:39.727 [ 1] 1 InMemoryEqualizerConfiguration:validateConfiguration::Validating default Equalizer state 2020-07-12 22:12:39.727 [ 1] 1 InMemoryEqualizerConfiguration:validateConfiguration::Validating Equalizer configuration 2020-07-12 22:12:39.727 [ 1] 1 InMemoryEqualizerConfiguration:validateConfiguration::Validating default Equalizer state 2020-07-12 22:12:39.728 [ 1] 9 MediaPlayer:createCalled:name=SpeakMediaPlayer 2020-07-12 22:12:39.746 [ 1] 9 MediaPlayer:noOutputConversion:name=SpeakMediaPlayer 2020-07-12 22:12:39.747 [ 1] 9 MediaPlayer:createCalled:name=AudioMediaPlayer 2020-07-12 22:12:39.747 [ 1] 9 MediaPlayer:noOutputConversion:name=AudioMediaPlayer 2020-07-12 22:12:39.748 [ 1] 9 MediaPlayer:createCalled:name=AudioMediaPlayer 2020-07-12 22:12:39.748 [ 1] 9 MediaPlayer:noOutputConversion:name=AudioMediaPlayer 2020-07-12 22:12:39.748 [ 1] 9 MediaPlayer:createCalled:name=NotificationsMediaPlayer 2020-07-12 22:12:39.748 [ 1] 9 MediaPlayer:noOutputConversion:name=NotificationsMediaPlayer 2020-07-12 22:12:39.749 [ 1] 9 MediaPlayer:createCalled:name=BluetoothMediaPlayer 2020-07-12 22:12:39.749 [ 1] 9 MediaPlayer:noOutputConversion:name=BluetoothMediaPlayer 2020-07-12 22:12:39.749 [ 1] 9 MediaPlayer:createCalled:name=RingtoneMediaPlayer 2020-07-12 22:12:39.750 [ 1] 9 MediaPlayer:noOutputConversion:name=RingtoneMediaPlayer 2020-07-12 22:12:39.750 [ 1] 9 MediaPlayer:createCalled:name=AlertsMediaPlayer 2020-07-12 22:12:39.750 [ 1] 9 MediaPlayer:noOutputConversion:name=AlertsMediaPlayer 2020-07-12 22:12:39.751 [ 1] 9 MediaPlayer:createCalled:name=SystemSoundMediaPlayer 2020-07-12 22:12:39.751 [ 1] 9 MediaPlayer:noOutputConversion:name=SystemSoundMediaPlayer 2020-07-12 22:12:39.751 [ 1] 5 SQLiteDeviceSettingStorage:create 2020-07-12 22:12:39.751 [ 1] 5 SQLiteBluetoothStorage:create 2020-07-12 22:12:39.752 [ 1] I LocaleAssetsManager:initialize:supportedWakeWords=NONE 2020-07-12 22:12:39.752 [ 1] I DeviceInfo:create:result=skipDeviceType,key=deviceType 2020-07-12 22:12:39.752 [ 1] I DeviceInfo:create:result=skipFriendlyName,key=friendlyName 2020-07-12 22:12:39.752 [ 1] I DeviceInfo:create:result=skipRegistrationKey,key=registrationKey 2020-07-12 22:12:39.752 [ 1] I DeviceInfo:create:result=skipProductIdKey,key=productIdKey 2020-07-12 22:12:39.753 [ 1] 5 CBLAuthDelegate:createAuthDelegateInterface 2020-07-12 22:12:39.754 [ 1] 5 CBLAuthDelegate:CBLAuthDelegate 2020-07-12 22:12:39.754 [ 1] 5 CBLAuthDelegate:init 2020-07-12 22:12:39.754 [ 1] 5 CBLAuthDelegateConfiguration:create 2020-07-12 22:12:39.754 [ 1] 5 CBLAuthDelegateConfiguration:init 2020-07-12 22:12:39.754 [ 1] 5 CBLAuthDelegateConfiguration:initScopeData 2020-07-12 22:12:39.754 [ 1] 9 CBLAuthDelegateConfiguration:initScopeDataSucceeded 2020-07-12 22:12:39.754 [ 1] 5 SQLiteCBLAuthDelegateStorage:open 2020-07-12 22:12:39.754 [ 1] 5 SQLiteCapabilitiesDelegateStorage:create 2020-07-12 22:12:39.754 [ 2] 5 CBLAuthDelegate:handleAuthorizationFlow 2020-07-12 22:12:39.754 [ 2] 5 CBLAuthDelegate:handleStarting 2020-07-12 22:12:39.754 [ 2] 5 SQLiteCBLAuthDelegateStorage:getRefreshToken 2020-07-12 22:12:39.755 [ 2] 5 CBLAuthDelegate:handleRefreshingToken 2020-07-12 22:12:39.755 [ 2] 5 CBLAuthDelegate:requestRefresh 2020-07-12 22:12:39.755 [ 1] 5 SQLiteCapabilitiesDelegateStorage:open 2020-07-12 22:12:39.755 [ 1] 5 CBLAuthDelegate:addAuthObserver:observer=0x555f562e3a28 2020-07-12 22:12:39.755 [ 1] 9 ThreadPool:obtainWorker:created=0,obtained=0,releasedToPool=0,releasedFromPool=0,outstanding=0 2020-07-12 22:12:39.755 [ 1] 5 CapabilitiesDelegate:addCapabilitiesObserver:observer=0x555f562e3a30 2020-07-12 22:12:39.755 [ 1] 5 InternetConnectionMonitor:startMonitoring 2020-07-12 22:12:39.756 [ 4] 5 InternetConnectionMonitor:testConnection 2020-07-12 22:12:39.756 [ 3] 9 TaskThread:startThread:moniker= 3,duration=975 2020-07-12 22:12:39.756 [ 4] 9 HTTPContentFetcherFactory:create::Creating a new http content fetcher 2020-07-12 22:12:39.757 [ 4] 9 LibCurlHttpContentFetcher:stateTransition:oldState=INITIALIZED,newState=FETCHING_HEADER:State transition 2020-07-12 22:12:39.758 [ 5] 9 LibCurlHttpContentFetcher:transferThread::start 2020-07-12 22:12:39.758 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.759 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.759 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.759 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.759 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.759 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.759 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.759 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.759 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.759 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.759 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.759 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.759 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.759 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.759 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.759 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.759 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.759 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.759 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.759 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.759 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.759 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.759 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.759 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.759 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.759 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 1] 5 AVSGatewayManager:create 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1

[shao-estone]

2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 1] 5 AVSGatewayManager:init:avsGateway=https://alexa.na.gateway.devices.a2z.com 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.760 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 1] 5 SynchronizeStateSenderFactory:create 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 1] 5 ExternalCapabilitiesBuilder:ExternalCapabilitiesBuilder 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.761 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 1] 9 ThreadPool:obtainWorker:created=1,obtained=1,releasedToPool=0,releasedFromPool=0,outstanding=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.762 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 1] 5 AVSConnectionManager:create::Subscribing to InternetConnectionMonitor Callbacks 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 1] 5 AVSConnectionManager:onConnectionStatusChanged:connected=false,isEnabled=false 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 6] 9 TaskThread:startThread:moniker= 6,duration=536 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.763 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 7] 9 DirectiveProcessor:processingLoop 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.764 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 1] 5 CapabilitiesDelegate:setMessageSender 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 1] 5 AVSGatewayManager:addObserver 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 1] 5 CapabilitiesDelegate:onConnectionStatusChanged:connectionStatus=DISCONNECTED

[shao-estone]

2020-07-12 22:12:39.765 [ 1] 5 CapabilitiesDelegate:addCapabilitiesObserver:observer=0x555f56522aa0 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 1] 5 EndpointRegistrationManager:onCapabilitiesStateChange:state=UNINITIALIZED,error=UNINITIALIZED,callback=true 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 1] 5 EndpointRegistrationManager:onCapabilityRegistrationStatusChanged 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 1] 9 ThreadPool:obtainWorker:created=2,obtained=2,releasedToPool=0,releasedFromPool=0,outstanding=2 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 8] 9 TaskThread:startThread:moniker= 8,duration=65 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.765 [ 1] 5 SQLiteDeviceSettingStorage:open 2020-07-12 22:12:39.766 [ 1] 5 DNDSettingProtocol:create:settingName=enabled 2020-07-12 22:12:39.766 [ 1] 5 DNDSettingProtocol:restoreValue:setting=Alexa.DoNotDisturb::enabled 2020-07-12 22:12:39.766 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.766 [ 1] 5 SQLiteDeviceSettingStorage:loadSetting:key=Alexa.DoNotDisturb::enabled 2020-07-12 22:12:39.766 [ 1] 5 SQLiteDeviceSettingStorage:loadSetting 2020-07-12 22:12:39.766 [ 1] I Setting:handleSetValue:value=false6142509188972423790 2020-07-12 22:12:39.767 [ 1] 5 SharedAVSSettingProtocol:create:settingName=alarmVolumeRamp 2020-07-12 22:12:39.767 [ 1] 5 SharedAVSSettingProtocol:restoreValue:setting=Alerts::alarmVolumeRamp 2020-07-12 22:12:39.779 [ 1] 5 SQLiteDeviceSettingStorage:loadSetting:key=Alerts::alarmVolumeRamp 2020-07-12 22:12:39.779 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.779 [ 1] 5 SQLiteDeviceSettingStorage:loadSetting 2020-07-12 22:12:39.779 [ 1] 5 SharedAVSSettingProtocol:localChange:setting=Alerts::alarmVolumeRamp 2020-07-12 22:12:39.780 [ 1] 9 ThreadPool:obtainWorker:created=3,obtained=3,releasedToPool=0,releasedFromPool=0,outstanding=3 2020-07-12 22:12:39.780 [ 9] 9 TaskThread:startThread:moniker= 9,duration=98 2020-07-12 22:12:39.780 [ 1] 5 SharedAVSSettingProtocol:create:settingName=wakeWordConfirmation 2020-07-12 22:12:39.780 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.780 [ 1] 5 SharedAVSSettingProtocol:restoreValue:setting=SpeechRecognizer::wakeWordConfirmation 2020-07-12 22:12:39.780 [ 1] 5 SQLiteDeviceSettingStorage:loadSetting:key=SpeechRecognizer::wakeWordConfirmation 2020-07-12 22:12:39.780 [ 9] I Setting:handleSetValue:value="NONE"6142509188972423790 2020-07-12 22:12:39.780 [ 9] 5 SQLiteDeviceSettingStorage:storeSetting:key=Alerts::alarmVolumeRamp,status=LOCAL_CHANGE_IN_PROGRESS 2020-07-12 22:12:39.780 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.780 [ 1] 5 SQLiteDeviceSettingStorage:loadSetting

[shao-estone]

2020-07-12 22:12:39.780 [ 1] 5 SharedAVSSettingProtocol:localChange:setting=SpeechRecognizer::wakeWordConfirmation 2020-07-12 22:12:39.780 [ 1] 9 ThreadPool:obtainWorker:created=4,obtained=4,releasedToPool=0,releasedFromPool=0,outstanding=4 2020-07-12 22:12:39.780 [ a] 9 TaskThread:startThread:moniker= a,duration=95 2020-07-12 22:12:39.780 [ 1] 5 SharedAVSSettingProtocol:create:settingName=speechConfirmation 2020-07-12 22:12:39.780 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.780 [ 1] 5 SharedAVSSettingProtocol:restoreValue:setting=SpeechRecognizer::speechConfirmation 2020-07-12 22:12:39.780 [ a] I Setting:handleSetValue:value="NONE"6142509188972423790 2020-07-12 22:12:39.787 [ a] 5 SQLiteDeviceSettingStorage:storeSetting:key=SpeechRecognizer::wakeWordConfirmation,status=LOCAL_CHANGE_IN_PROGRESS 2020-07-12 22:12:39.787 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.787 [ 1] 5 SQLiteDeviceSettingStorage:loadSetting:key=SpeechRecognizer::speechConfirmation 2020-07-12 22:12:39.787 [ 9] 5 SettingEventSender:buildEventJson:eventName=AlarmVolumeRampChanged 2020-07-12 22:12:39.788 [ 9] W UUIDGeneration:low entropy on call to generate UUID:current entropy=0 2020-07-12 22:12:39.788 [ 9] 0 EventBuilder:buildJsonEventString:messageId=50a3cf6f-19b7-4d95-9a14-ffbbc9f66286,namespace=Alerts,name=AlarmVolumeRampChanged 2020-07-12 22:12:39.788 [ 9] 0 EventBuilder:buildJsonEventString:event={"event":{"header":{"namespace":"Alerts","name":"AlarmVolumeRampChanged","messageId":"50a3cf6f-19b7-4d95-9a14-ffbbc9f66286"},"payload":{"alarmVolumeRamp":"NONE"}}} 2020-07-12 22:12:39.789 [ 9] 7 SettingEventSender:sendEvent:attempt=0 2020-07-12 22:12:39.789 [ 9] E MessageRouter:sendFailed:reason=noActiveTransport 2020-07-12 22:12:39.789 [ 9] 7 SettingEventSender:sendEvent:status=NOT_CONNECTED 2020-07-12 22:12:39.789 [ 9] E SharedAVSSettingProtocol:localChangeFailed:reason=sendEventFailed 2020-07-12 22:12:39.790 [ a] 5 SettingEventSender:buildEventJson:eventName=WakeWordConfirmationChanged 2020-07-12 22:12:39.791 [ 1] 5 SQLiteDeviceSettingStorage:loadSetting 2020-07-12 22:12:39.791 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.791 [ a] W UUIDGeneration:low entropy on call to generate UUID:current entropy=0 2020-07-12 22:12:39.791 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.791 [ 1] 5 SharedAVSSettingProtocol:localChange:setting=SpeechRecognizer::speechConfirmation 2020-07-12 22:12:39.791 [ a] 0 EventBuilder:buildJsonEventString:messageId=14b706b2-65b1-4454-a9c2-238e82f57e42,namespace=SpeechRecognizer,name=WakeWordConfirmationChanged 2020-07-12 22:12:39.791 [ 1] 9 ThreadPool:obtainWorker:created=5,obtained=5,releasedToPool=0,releasedFromPool=0,outstanding=5 2020-07-12 22:12:39.791 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.791 [ a] 0 EventBuilder:buildJsonEventString:event={"event":{"header":{"namespace":"SpeechRecognizer","name":"WakeWordConfirmationChanged","messageId":"14b706b2-65b1-4454-a9c2-238e82f57e42"},"payload":{"wakeWordConfirmation":"NONE"}}} 2020-07-12 22:12:39.791 [ a] 7 SettingEventSender:sendEvent:attempt=0 2020-07-12 22:12:39.791 [ a] E MessageRouter:sendFailed:reason=noActiveTransport 2020-07-12 22:12:39.791 [ b] 9 TaskThread:startThread:moniker= b,duration=103 2020-07-12 22:12:39.791 [ a] 7 SettingEventSender:sendEvent:status=NOT_CONNECTED 2020-07-12 22:12:39.791 [ 1] 5 SharedAVSSettingProtocol:create:settingName=timeZone 2020-07-12 22:12:39.791 [ a] E SharedAVSSettingProtocol:localChangeFailed:reason=sendEventFailed 2020-07-12 22:12:39.791 [ b] I Setting:handleSetValue:value="NONE"6142509188972423790 2020-07-12 22:12:39.791 [ 1] 5 SharedAVSSettingProtocol:restoreValue:setting=System::timeZone 2020-07-12 22:12:39.791 [ b] 5 SQLiteDeviceSettingStorage:storeSetting:key=SpeechRecognizer::speechConfirmation,status=LOCAL_CHANGE_IN_PROGRESS 2020-07-12 22:12:39.791 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.791 [ 1] 5 SQLiteDeviceSettingStorage:loadSetting:key=System::timeZone 2020-07-12 22:12:39.794 [ b] 5 SettingEventSender:buildEventJson:eventName=SpeechConfirmationChanged 2020-07-12 22:12:39.794 [ 1] 5 SQLiteDeviceSettingStorage:loadSetting 2020-07-12 22:12:39.794 [ b] W UUIDGeneration:low entropy on call to generate UUID:current entropy=0 2020-07-12 22:12:39.794 [ 1] 5 SharedAVSSettingProtocol:localChange:setting=System::timeZone 2020-07-12 22:12:39.794 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.794 [ b] 0 EventBuilder:buildJsonEventString:messageId=28f94059-1b3d-499a-a4eb-83d5e8be6eb3,namespace=SpeechRecognizer,name=SpeechConfirmationChanged 2020-07-12 22:12:39.794 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.794 [ b] 0 EventBuilder:buildJsonEventString:event={"event":{"header":{"namespace":"SpeechRecognizer","name":"SpeechConfirmationChanged","messageId":"28f94059-1b3d-499a-a4eb-83d5e8be6eb3"},"payload":{"speechConfirmation":"NONE"}}} 2020-07-12 22:12:39.794 [ 1] 9 ThreadPool:obtainWorker:created=6,obtained=6,releasedToPool=0,releasedFromPool=0,outstanding=6 2020-07-12 22:12:39.794 [ b] 7 SettingEventSender:sendEvent:attempt=0 2020-07-12 22:12:39.794 [ b] E MessageRouter:sendFailed:reason=noActiveTransport 2020-07-12 22:12:39.794 [ b] 7 SettingEventSender:sendEvent:status=NOT_CONNECTED 2020-07-12 22:12:39.794 [ b] E SharedAVSSettingProtocol:localChangeFailed:reason=sendEventFailed 2020-07-12 22:12:39.794 [ c] 9 TaskThread:startThread:moniker= c,duration=148 2020-07-12 22:12:39.794 [ 1] 5 SharedAVSSettingProtocol:create:settingName=networkInfo 2020-07-12 22:12:39.794 [ c] I Setting:handleSetValue:value="America/Vancouver"6142509188972423790 2020-07-12 22:12:39.794 [ c] 5 SQLiteDeviceSettingStorage:storeSetting:key=System::timeZone,status=LOCAL_CHANGE_IN_PROGRESS 2020-07-12 22:12:39.795 [ 1] 5 SharedAVSSettingProtocol:restoreValue:setting=System::networkInfo 2020-07-12 22:12:39.795 [ 1] 5 SQLiteDeviceSettingStorage:loadSetting:key=System::networkInfo 2020-07-12 22:12:39.798 [ c] 5 SettingEventSender:buildEventJson:eventName=TimeZoneChanged 2020-07-12 22:12:39.798 [ 1] 5 SQLiteDeviceSettingStorage:loadSetting 2020-07-12 22:12:39.798 [ c] W UUIDGeneration:low entropy on call to generate UUID:current entropy=0 2020-07-12 22:12:39.798 [ 1] 5 SharedAVSSettingProtocol:localChange:setting=System::networkInfo 2020-07-12 22:12:39.798 [ c] 0 EventBuilder:buildJsonEventString:messageId=dc49c965-a06b-4739-82c2-e85262fc49bf,namespace=System,name=TimeZoneChanged 2020-07-12 22:12:39.798 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.798 [ c] 0 EventBuilder:buildJsonEventString:event={"event":{"header":{"namespace":"System","name":"TimeZoneChanged","messageId":"dc49c965-a06b-4739-82c2-e85262fc49bf"},"payload":{"timeZone":"America/Vancouver"}}} 2020-07-12 22:12:39.798 [ 1] 9 ThreadPool:obtainWorker:created=7,obtained=7,releasedToPool=0,releasedFromPool=0,outstanding=7

This just seems like a lot of repeating message.

[shao-estone]

2020-07-12 22:12:39.803 [ 1] 0 ChannelVolumeManager:getSpeakerSettings 2020-07-12 22:12:39.803 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.803 [ 1] 9 MediaPlayer:getSpeakerSettingsCalled:name=RingtoneMediaPlayer 2020-07-12 22:12:39.803 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.803 [ 16] 9 MediaPlayer:handleGetSpeakerSettingsCalled:name=RingtoneMediaPlayer 2020-07-12 22:12:39.803 [ 1] 0 ChannelVolumeManager:getSpeakerSettings 2020-07-12 22:12:39.803 [ 1] 9 MediaPlayer:getSpeakerSettingsCalled:name=AlertsMediaPlayer 2020-07-12 22:12:39.803 [ 17] 9 MediaPlayer:handleGetSpeakerSettingsCalled:name=AlertsMediaPlayer 2020-07-12 22:12:39.803 [ 1] 0 ChannelVolumeManager:getSpeakerSettings 2020-07-12 22:12:39.803 [ 1] 9 MediaPlayer:getSpeakerSettingsCalled:name=NotificationsMediaPlayer 2020-07-12 22:12:39.803 [ 18] 9 MediaPlayer:handleGetSpeakerSettingsCalled:name=NotificationsMediaPlayer 2020-07-12 22:12:39.803 [ 1] I SpeakerManager:mapCreated:numSpeakerVolume=6,numAlertsVolume=2 2020-07-12 22:12:39.804 [ 1] 0 ChannelVolumeManager:getSpeakerSettings 2020-07-12 22:12:39.804 [ 1] 9 MediaPlayer:getSpeakerSettingsCalled:name=SpeakMediaPlayer 2020-07-12 22:12:39.804 [ 11] 9 MediaPlayer:handleGetSpeakerSettingsCalled:name=SpeakMediaPlayer 2020-07-12 22:12:39.804 [ 1] 0 ChannelVolumeManager:getSpeakerSettings 2020-07-12 22:12:39.804 [ 1] 9 MediaPlayer:getSpeakerSettingsCalled:name=SystemSoundMediaPlayer 2020-07-12 22:12:39.804 [ f] 9 MediaPlayer:handleGetSpeakerSettingsCalled:name=SystemSoundMediaPlayer 2020-07-12 22:12:39.804 [ 1] 0 ChannelVolumeManager:getSpeakerSettings 2020-07-12 22:12:39.804 [ 1] 9 MediaPlayer:getSpeakerSettingsCalled:name=AudioMediaPlayer 2020-07-12 22:12:39.804 [ 13] 9 MediaPlayer:handleGetSpeakerSettingsCalled:name=AudioMediaPlayer 2020-07-12 22:12:39.804 [ 1] 0 ChannelVolumeManager:getSpeakerSettings 2020-07-12 22:12:39.804 [ 1] 9 MediaPlayer:getSpeakerSettingsCalled:name=AudioMediaPlayer 2020-07-12 22:12:39.804 [ e] 5 LocaleWakeWordsSetting:notifyObserversOfSuccess:id=1 2020-07-12 22:12:39.804 [ 14] 9 MediaPlayer:handleGetSpeakerSettingsCalled:name=AudioMediaPlayer 2020-07-12 22:12:39.804 [ e] 5 SettingEventSender:buildEventJson:eventName=LocalesChanged 2020-07-12 22:12:39.804 [ 1] 0 ChannelVolumeManager:getSpeakerSettings 2020-07-12 22:12:39.804 [ 1] 9 MediaPlayer:getSpeakerSettingsCalled:name=BluetoothMediaPlayer 2020-07-12 22:12:39.804 [ 15] 9 MediaPlayer:handleGetSpeakerSettingsCalled:name=BluetoothMediaPlayer 2020-07-12 22:12:39.804 [ e] W UUIDGeneration:low entropy on call to generate UUID:current entropy=0 2020-07-12 22:12:39.804 [ 1] 0 ChannelVolumeManager:getSpeakerSettings 2020-07-12 22:12:39.804 [ 1] 9 MediaPlayer:getSpeakerSettingsCalled:name=RingtoneMediaPlayer 2020-07-12 22:12:39.804 [ 16] 9 MediaPlayer:handleGetSpeakerSettingsCalled:name=RingtoneMediaPlayer 2020-07-12 22:12:39.804 [ e] 0 EventBuilder:buildJsonEventString:messageId=c6d2ebf6-9ab8-409a-bc74-3fe2c34460f2,namespace=System,name=LocalesChanged 2020-07-12 22:12:39.804 [ 1] 9 SpeakerManager:validateSpeakerSettingsConsistencyResult:consistent=true 2020-07-12 22:12:39.804 [ e] 0 EventBuilder:buildJsonEventString:event={"event":{"header":{"namespace":"System","name":"LocalesChanged","messageId":"c6d2ebf6-9ab8-409a-bc74-3fe2c34460f2"},"payload":{"locales":["en-US"]}}} 2020-07-12 22:12:39.804 [ 1] 9 SpeakerManager:validateSpeakerSettings:volume=100,mute=false 2020-07-12 22:12:39.804 [ e] 7 SettingEventSender:sendEvent:attempt=0 2020-07-12 22:12:39.804 [ 1] 9 SpeakerManager:updateContextManagerCalled:speakerType=AVS_SPEAKER_VOLUME 2020-07-12 22:12:39.804 [ e] E MessageRouter:sendFailed:reason=noActiveTransport 2020-07-12 22:12:39.804 [ e] 7 SettingEventSender:sendEvent:status=NOT_CONNECTED 2020-07-12 22:12:39.804 [ 1] 5 ContextManager:setState 2020-07-12 22:12:39.804 [ e] E LocaleWakeWordsSetting:synchronizeLocaleFailed:reason=sendEventFailed 2020-07-12 22:12:39.804 [ 1] 9 ThreadPool:obtainWorker:created=11,obtained=11,releasedToPool=0,releasedFromPool=0,outstanding=11 2020-07-12 22:12:39.804 [ 19] 9 TaskThread:startThread:moniker= 19,duration=52 2020-07-12 22:12:39.805 [ 1] 5 ContextManager:addStateProvider 2020-07-12 22:12:39.805 [ 1] 5 Renderer:resetSourceId 2020-07-12 22:12:39.805 [ 1] 9 MediaPlayer:addObserverCalled:name=AlertsMediaPlayer 2020-07-12 22:12:39.805 [ 17] 0 MediaPlayer:handleAddObserverCalled:name=AlertsMediaPlayer 2020-07-12 22:12:39.805 [ 1] 9 AlertScheduler:setTimerForNextAlertLocked 2020-07-12 22:12:39.805 [ 1] 9 AlertScheduler:executeScheduleNextAlertForRendering::no work to do. 2020-07-12 22:12:39.806 [ 1] 9 SpeakerManager:getSpeakerSettingsCalled 2020-07-12 22:12:39.806 [ 1] 9 ThreadPool:obtainWorker:created=12,obtained=12,releasedToPool=0,releasedFromPool=0,outstanding=12 2020-07-12 22:12:39.806 [ 1a] 9 TaskThread:startThread:moniker= 1a,duration=135 2020-07-12 22:12:39.806 [ 1a] 9 SpeakerManager:executeGetSpeakerSettingsCalled 2020-07-12 22:12:39.806 [ 1a] 0 ChannelVolumeManager:getSpeakerSettings 2020-07-12 22:12:39.806 [ 1a] 9 MediaPlayer:getSpeakerSettingsCalled:name=AlertsMediaPlayer 2020-07-12 22:12:39.806 [ 17] 9 MediaPlayer:handleGetSpeakerSettingsCalled:name=AlertsMediaPlayer 2020-07-12 22:12:39.806 [ 1a] 0 ChannelVolumeManager:getSpeakerSettings 2020-07-12 22:12:39.806 [ 1a] 9 MediaPlayer:getSpeakerSettingsCalled:name=NotificationsMediaPlayer 2020-07-12 22:12:39.806 [ 18] 9 MediaPlayer:handleGetSpeakerSettingsCalled:name=NotificationsMediaPlayer 2020-07-12 22:12:39.806 [ 1a] 9 SpeakerManager:validateSpeakerSettingsConsistencyResult:consistent=true 2020-07-12 22:12:39.806 [ 1a] 9 SpeakerManager:validateSpeakerSettings:volume=100,mute=false 2020-07-12 22:12:39.806 [ 1] 5 ContextManager:setState 2020-07-12 22:12:39.807 [ 1] 9 ThreadPool:obtainWorker:created=13,obtained=13,releasedToPool=0,releasedFromPool=0,outstanding=13 2020-07-12 22:12:39.807 [ 1] 9 SpeakerManager:addSpeakerManagerObserverCalled 2020-07-12 22:12:39.807 [ 1] 9 SpeakerManager:addSpeakerManagerObserver:observer=0x555f5654bd10 2020-07-12 22:12:39.807 [ 1] 5 NotificationRenderer:create 2020-07-12 22:12:39.807 [ 1] 9 MediaPlayer:addObserverCalled:name=NotificationsMediaPlayer 2020-07-12 22:12:39.807 [ 18] 0 MediaPlayer:handleAddObserverCalled:name=NotificationsMediaPlayer 2020-07-12 22:12:39.807 [ 1b] 9 TaskThread:startThread:moniker= 1b,duration=567 2020-07-12 22:12:39.807 [ 1b] 1 AlertsCapabilityAgent:executeOnConnectionStatusChanged:status=DISCONNECTED,reason=ACL_CLIENT_REQUEST 2020-07-12 22:12:39.808 [ 1] 5 NotificationsCapabilityAgent:init 2020-07-12 22:12:39.808 [ 1] 5 NotificationRenderer:addObserver 2020-07-12 22:12:39.808 [ 1] 5 ContextManager:addStateProvider 2020-07-12 22:12:39.808 [ 1] 9 ThreadPool:obtainWorker:created=14,obtained=14,releasedToPool=0,releasedFromPool=0,outstanding=14 2020-07-12 22:12:39.808 [ 1c] 9 TaskThread:startThread:moniker= 1c,duration=146 2020-07-12 22:12:39.808 [ 1c] 5 NotificationsCapabilityAgent:executeInit 2020-07-12 22:12:39.808 [ 1] 5 InteractionModel:InteractionModelCapabilityAgent 2020-07-12 22:12:39.809 [ 1c] 5 NotificationsCapabilityAgent:notifyObserversOfIndicatorState:indicatorState=0 2020-07-12 22:12:39.809 [ 1c] 5 NotificationsCapabilityAgent:executeProvideState:sendToken=false,stateRequestToken=0 2020-07-12 22:12:39.809 [ 1c] 5 ContextManager:setState 2020-07-12 22:12:39.809 [ 1] 5 ExternalMediaPlayer:init 2020-07-12 22:12:39.809 [ 1] 5 AuthorizedSender:create 2020-07-12 22:12:39.809 [ 1] 5 ContextManager:addStateProvider 2020-07-12 22:12:39.809 [ 1] 5 ContextManager:addStateProvider 2020-07-12 22:12:39.809 [ 1] 0 ExternalMediaPlayer:createAdapters 2020-07-12 22:12:39.809 [ 1] W UUIDGeneration:low entropy on call to generate UUID:current entropy=0 2020-07-12 22:12:39.810 [ 1] 0 EventBuilder:buildJsonEventString:messageId=e03ad16b-5866-4804-8cff-e872e68e6544,namespace=ExternalMediaPlayer,name=ReportDiscoveredPlayers 2020-07-12 22:12:39.810 [ 1] 0 EventBuilder:buildJsonEventString:event={"event":{"header":{"namespace":"ExternalMediaPlayer","name":"ReportDiscoveredPlayers","messageId":"e03ad16b-5866-4804-8cff-e872e68e6544"},"payload":{"agent":"CQCAFYNYDC","players":[]}}} 2020-07-12 22:12:39.810 [ 1] 9 ThreadPool:obtainWorker:created=15,obtained=15,releasedToPool=0,releasedFromPool=0,outstanding=15 2020-07-12 22:12:39.810 [ 1d] 9 TaskThread:startThread:moniker= 1d,duration=112 2020-07-12 22:12:39.810 [ 1] 5 ContextManager:addStateProvider 2020-07-12 22:12:39.810 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.810 [ 1] 5 ExternalMediaPlayer:setObserver 2020-07-12 22:12:39.810 [ 1] 1 AudioPlayer:setObserver 2020-07-12 22:12:39.811 [ 1] 9 ThreadPool:obtainWorker:created=16,obtained=16,releasedToPool=0,releasedFromPool=0,outstanding=16 2020-07-12 22:12:39.811 [ 1e] 9 TaskThread:startThread:moniker= 1e,duration=92 2020-07-12 22:12:39.811 [ 1] 5 ExternalCapabilitiesBuilder:withTemplateRunTime 2020-07-12 22:12:39.811 [ 6] 5 TemplateRuntime:onDialogUXStateChanged:state=IDLE 2020-07-12 22:12:39.811 [ 6] 9 ThreadPool:obtainWorker:created=17,obtained=17,releasedToPool=0,releasedFromPool=0,outstanding=17 2020-07-12 22:12:39.811 [ 1f] 9 TaskThread:startThread:moniker= 1f,duration=111 2020-07-12 22:12:39.811 [ 1] 5 ContextManager:setState 2020-07-12 22:12:39.811 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.813 [ 1] 5 DefaultClient:bluetoothCapabilityAgentDisabled:reason=nullBluetoothDeviceManager 2020-07-12 22:12:39.813 [ 1] 5 ApiGateway:create 2020-07-12 22:12:39.813 [ 1] 0 DefaultClient:initialize::Diagnostics Not Enabled 2020-07-12 22:12:39.813 [ 1] 5 AlexaInterfaceCapabilityAgent:create 2020-07-12 22:12:39.814 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=System,name=SetLocales,handler=0x555f5632be00,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False 2020-07-12 22:12:39.814 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=System,name=SetTimeZone,handler=0x555f562e3c50,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False 2020-07-12 22:12:39.814 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=System,name=ReportState,handler=0x555f563d2c00,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False 2020-07-12 22:12:39.814 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=System,name=ResetUserInactivity,handler=0x555f562a1208,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False 2020-07-12 22:12:39.814 [ 1] 5 ExternalCapabilitiesBuilder:buildCapabilities 2020-07-12 22:12:39.814 [ 1] 9 SpeakerManager:addSpeakerManagerObserverCalled 2020-07-12 22:12:39.814 [ 1] 9 SpeakerManager:addSpeakerManagerObserver:observer=0x555f562e3a48 2020-07-12 22:12:39.815 [ 1] 5 NotificationsCapabilityAgent:addObserver 2020-07-12 22:12:39.815 [ 1] 5 DefaultClient:addBluetoothDeviceObserver::bluetooth is disabled, not adding observer #################################################

NOTIFICATION INDICATOR STATE: OFF

#################################################

[shao-estone]

2020-07-12 22:12:39.815 [ 1] 5 TemplateRuntime:addObserver 2020-07-12 22:12:39.815 [ 1f] 5 TemplateRuntime:addObserverInExecutor 2020-07-12 22:12:39.816 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.817 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.853 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.912 [ 5] 9 LibCurlHttpContentFetcher:transferThread:numTransfersLeft=1 2020-07-12 22:12:39.912 [ 5] 9 LibCurlHttpContentFetcher:headerCallback::CALLED 2020-07-12 22:12:39.913 [ 5] 9 LibCurlHttpContentFetcher:headerCallback::CALLED 2020-07-12 22:12:39.913 [ 5] 9 LibCurlHttpContentFetcher:headerCallback::CALLED 2020-07-12 22:12:39.913 [ 5] 9 LibCurlHttpContentFetcher:headerCallback::CALLED 2020-07-12 22:12:39.913 [ 5] 9 LibCurlHttpContentFetcher:headerCallback::CALLED 2020-07-12 22:12:39.913 [ 5] 9 LibCurlHttpContentFetcher:headerCallback::CALLED 2020-07-12 22:12:39.913 [ 5] 9 LibCurlHttpContentFetcher:headerCallback::CALLED 2020-07-12 22:12:39.913 [ 5] 9 LibCurlHttpContentFetcher:headerCallback::CALLED 2020-07-12 22:12:39.913 [ 5] 9 LibCurlHttpContentFetcher:headerCallback::CALLED 2020-07-12 22:12:39.913 [ 5] 9 LibCurlHttpContentFetcher:headerCallback:type=content-length,length=419 2020-07-12 22:12:39.913 [ 5] 9 LibCurlHttpContentFetcher:headerCallback::CALLED 2020-07-12 22:12:39.913 [ 5] 9 LibCurlHttpContentFetcher:headerCallback::CALLED 2020-07-12 22:12:39.913 [ 5] 9 LibCurlHttpContentFetcher:headerCallback::CALLED 2020-07-12 22:12:39.913 [ 5] 9 LibCurlHttpContentFetcher:bodyCallback::End of header found. 2020-07-12 22:12:39.913 [ 5] 9 LibCurlHttpContentFetcher:stateTransition:oldState=FETCHING_HEADER,newState=HEADER_DONE:State transition 2020-07-12 22:12:39.913 [ 4] 9 InternetConnectionMonitor:testConnection:contentLength=419 2020-07-12 22:12:39.913 [ 4] 9 LibCurlHttpContentFetcher:stateTransition:oldState=HEADER_DONE,newState=FETCHING_BODY:State transition ALSA lib pcm.c:2642:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.rear ALSA lib pcm.c:2642:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.center_lfe ALSA lib pcm.c:2642:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.side ALSA lib pcm_route.c:869:(find_matching_chmap) Found no matching channel map ALSA lib pcm_route.c:869:(find_matching_chmap) Found no matching channel map ALSA lib pcm_route.c:869:(find_matching_chmap) Found no matching channel map ALSA lib pcm_route.c:869:(find_matching_chmap) Found no matching channel map Cannot connect to server socket err = No such file or directory Cannot connect to server request channel jack server is not running or cannot be started JackShmReadWritePtr::~JackShmReadWritePtr - Init not done for -1, skipping unlock JackShmReadWritePtr::~JackShmReadWritePtr - Init not done for -1, skipping unlock Cannot connect to server socket err = No such file or directory Cannot connect to server request channel jack server is not running or cannot be started JackShmReadWritePtr::~JackShmReadWritePtr - Init not done for -1, skipping unlock JackShmReadWritePtr::~JackShmReadWritePtr - Init not done for -1, skipping unlock ALSA lib pcm_oss.c:377:(_snd_pcm_oss_open) Unknown field port ALSA lib pcm_oss.c:377:(_snd_pcm_oss_open) Unknown field port ALSA lib pcm_usb_stream.c:486:(_snd_pcm_usb_stream_open) Invalid type for card ALSA lib pcm_usb_stream.c:486:(_snd_pcm_usb_stream_open) Invalid type for card 2020-07-12 22:12:39.995 [ 1] 5 CBLAuthDelegate:addAuthObserver:observer=0x555f5658aad0 2020-07-12 22:12:39.995 [ 6] 9 ThreadPool:obtainWorker:created=18,obtained=18,releasedToPool=0,releasedFromPool=0,outstanding=18 2020-07-12 22:12:39.995 [ 1] 5 CapabilitiesDelegate:addCapabilitiesObserver:observer=0x555f5658aad8 2020-07-12 22:12:39.995 [ 20] 9 TaskThread:startThread:moniker= 20,duration=308 2020-07-12 22:12:39.996 [ 1] 2 EndpointBuilder:buildImplementation:isDefault=true,#capabilities=23 2020-07-12 22:12:39.996 [ 1] 5 EndpointRegistrationManager:registerEndpoint 2020-07-12 22:12:39.996 [ 8] 5 EndpointRegistrationManager:executeRegisterEndpoint 2020-07-12 22:12:39.997 [ 8] 5 DoNotDisturbCapabilityAgent:getConfiguration 2020-07-12 22:12:39.997 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.DoNotDisturb,name=SetDoNotDisturb,handler=0x555f56360000,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False 2020-07-12 22:12:39.997 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Notifications,name=ClearIndicator,handler=0x555f56355008,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False 2020-07-12 22:12:39.997 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Notifications,name=SetIndicator,handler=0x555f56355008,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False 2020-07-12 22:12:39.997 [ 8] 5 EndpointRegistrationManager:registerEndpoint:emptyHandler=VisualActivityTracker 2020-07-12 22:12:39.997 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Speaker,name=SetMute,handler=0x555f56439000,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False 2020-07-12 22:12:39.997 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Speaker,name=AdjustVolume,handler=0x555f56439000,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False 2020-07-12 22:12:39.997 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Speaker,name=SetVolume,handler=0x555f56439000,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False 2020-07-12 22:12:39.997 [ 8] 5 EndpointRegistrationManager:registerEndpoint:emptyHandler=PlaybackController 2020-07-12 22:12:39.997 [ 8] 5 EndpointRegistrationManager:registerEndpoint:emptyHandler=AudioActivityTracker 2020-07-12 22:12:39.997 [ 8] 5 EndpointRegistrationManager:registerEndpoint:emptyHandler=Alexa.SoftwareComponentReporter 2020-07-12 22:12:39.998 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.SeekController,name=SetSeekPosition,handler=0x555f56584930,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False 2020-07-12 22:12:39.998 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaylistController,name=DisableShuffle,handler=0x555f56584930,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False 2020-07-12 22:12:39.998 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaylistController,name=EnableShuffle,handler=0x555f56584930,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False 2020-07-12 22:12:39.998 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaylistController,name=DisableRepeat,handler=0x555f56584930,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False 2020-07-12 22:12:39.998 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.FavoritesController,name=Unfavorite,handler=0x555f56584930,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False 2020-07-12 22:12:39.998 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaylistController,name=EnableRepeat,handler=0x555f56584930,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False 2020-07-12 22:12:39.998 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.SeekController,name=AdjustSeekPosition,handler=0x555f56584930,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False 2020-07-12 22:12:39.998 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=Rewind,handler=0x555f56584930,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False 2020-07-12 22:12:39.998 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=Previous,handler=0x555f56584930,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False 2020-07-12 22:12:39.998 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaylistController,name=EnableRepeatOne,handler=0x555f56584930,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False 2020-07-12 22:12:39.998 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=Next,handler=0x555f56584930,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False 2020-07-12 22:12:39.998 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=StartOver,handler=0x555f56584930,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False 2020-07-12 22:12:39.998 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=Stop,handler=0x555f56584930,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False 2020-07-12 22:12:39.998 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=Pause,handler=0x555f56584930,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False 2020-07-12 22:12:39.998 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=Play,handler=0x555f56584930,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False 2020-07-12 22:12:39.998 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=ExternalMediaPlayer,name=Logout,handler=0x555f56584930,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False 2020-07-12 22:12:39.998 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.FavoritesController,name=Favorite,handler=0x555f56584930,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False 2020-07-12 22:12:39.998 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=FastForward,handler=0x555f56584930,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False 2020-07-12 22:12:39.998 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=ExternalMediaPlayer,name=Login,handler=0x555f56584930,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False 2020-07-12 22:12:39.998 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=ExternalMediaPlayer,name=Play,handler=0x555f56584930,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False 2020-07-12 22:12:39.999 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=ExternalMediaPlayer,name=AuthorizeDiscoveredPlayers,handler=0x555f56584930,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False 2020-07-12 22:12:39.999 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=SpeechSynthesizer,name=Speak,handler=0x555f565469c0,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:True 2020-07-12 22:12:39.999 [ 8] 5 EqualizerController:getConfiguration 2020-07-12 22:12:39.999 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=EqualizerController,name=SetMode,handler=0x555f562b78e8,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False 2020-07-12 22:12:39.999 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=EqualizerController,name=ResetBands,handler=0x555f562b78e8,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False 2020-07-12 22:12:39.999 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=EqualizerController,name=AdjustBands,handler=0x555f562b78e8,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False 2020-07-12 22:12:39.999 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=EqualizerController,name=SetBands,handler=0x555f562b78e8,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False 2020-07-12 22:12:39.999 [ 8] 5 ApiGateway:getConfiguration 2020-07-12 22:12:39.999 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.ApiGateway,name=SetGateway,handler=0x555f56369c00,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False 2020-07-12 22:12:39.999 [ 8] 5 TemplateRuntime:getConfiguration 2020-07-12 22:12:39.999 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=TemplateRuntime,name=RenderPlayerInfo,handler=0x555f56587170,policy= Mediums:MEDIUM_VISUAL10 .isBlocking:False 2020-07-12 22:12:39.999 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=TemplateRuntime,name=RenderTemplate,handler=0x555f56587170,policy= Mediums:MEDIUM_VISUAL10 .isBlocking:False 2020-07-12 22:12:39.999 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=AudioPlayer,name=UpdateProgressReportInterval,handler=0x555f5654af80,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False 2020-07-12 22:12:39.999 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=AudioPlayer,name=ClearQueue,handler=0x555f5654af80,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False 2020-07-12 22:12:39.999 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=AudioPlayer,name=Stop,handler=0x555f5654af80,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False 2020-07-12 22:12:39.999 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=AudioPlayer,name=Play,handler=0x555f5654af80,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False 2020-07-12 22:12:39.999 [ 8] 5 AlexaInterfaceCapabilityAgent:getConfiguration 2020-07-12 22:12:39.999 [ 8] 5 AlexaInterfaceCapabilityAgent:registeringEventProcessedDirective:reason=defaultEndpoint 2020-07-12 22:12:40.000 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa,name=ReportState,handler=0x555f56452000,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False 2020-07-12 22:12:40.000 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa,name=EventProcessed,handler=0x555f56452000,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False 2020-07-12 22:12:40.000 [ 8] 5 EndpointRegistrationManager:registerEndpoint:emptyHandler=System 2020-07-12 22:12:40.000 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=SpeechRecognizer,name=SetSpeechConfirmation,handler=0x555f56544c20,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False 2020-07-12 22:12:40.000 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=SpeechRecognizer,name=SetWakeWords,handler=0x555f56544c20,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False 2020-07-12 22:12:40.000 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=SpeechRecognizer,name=SetWakeWordConfirmation,handler=0x555f56544c20,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False 2020-07-12 22:12:40.000 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=SpeechRecognizer,name=SetEndOfSpeechOffset,handler=0x555f56544c20,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False 2020-07-12 22:12:40.000 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=SpeechRecognizer,name=ExpectSpeech,handler=0x555f56544c20,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:True 2020-07-12 22:12:40.000 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=SpeechRecognizer,name=StopCapture,handler=0x555f56544c20,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False 2020-07-12 22:12:40.000 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=InteractionModel,name=RequestProcessingCompleted,handler=0x555f565841a0,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False 2020-07-12 22:12:40.000 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=InteractionModel,name=RequestProcessingStarted,handler=0x555f565841a0,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False 2020-07-12 22:12:40.000 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=InteractionModel,name=NewDialogRequest,handler=0x555f565841a0,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False 2020-07-12 22:12:40.000 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alerts,name=SetAlarmVolumeRamp,handler=0x555f5654bc50,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False 2020-07-12 22:12:40.000 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alerts,name=AdjustVolume,handler=0x555f5654bc50,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False 2020-07-12 22:12:40.000 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alerts,name=SetVolume,handler=0x555f5654bc50,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False 2020-07-12 22:12:40.000 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alerts,name=DeleteAlerts,handler=0x555f5654bc50,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False 2020-07-12 22:12:40.000 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alerts,name=DeleteAlert,handler=0x555f5654bc50,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False 2020-07-12 22:12:40.000 [ 8] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alerts,name=SetAlert,handler=0x555f5654bc50,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False 2020-07-12 22:12:40.001 [ 8] 5 CapabilitiesDelegate:addOrUpdateEndpoint 2020-07-12 22:12:40.002 [ 8] 9 ThreadPool:obtainWorker:created=19,obtained=19,releasedToPool=0,releasedFromPool=0,outstanding=19 2020-07-12 22:12:40.002 [ 21] 9 TaskThread:startThread:moniker= 21,duration=175 2020-07-12 22:12:40.002 [ 8] 2 EndpointRegistrationManager:executeRegisterEndpoint:result=finished 2020-07-12 22:12:40.002 [ 21] 5 CapabilitiesDelegate:executeSendPendingEndpoints 2020-07-12 22:12:40.002 [ 21] 5 CapabilitiesDelegate:executeSendPendingEndpoints:Deferred=Not connected 2020-07-12 22:12:40.002 [ 1] 5 AVSGatewayManager:setAVSGatewayAssigner 2020-07-12 22:12:40.002 [ 1] I MessageRouter:setAVSGateway:avsGateway=https://alexa.na.gateway.devices.a2z.com 2020-07-12 22:12:40.002 [ 1] 5 AVSConnectionManager:enable 2020-07-12 22:12:40.002 [ 1] I MessageRouter:enable 2020-07-12 22:12:40.002 [ 1] I MessageRouter:setConnectionStatusLocked:status=PENDING,reason=ACL_CLIENT_REQUEST 2020-07-12 22:12:40.002 [ 1] 0 MessageRouter:connectionStatusChanged:reason=ACL_CLIENT_REQUEST,newStatus=PENDING 2020-07-12 22:12:40.002 [ 1] 9 ThreadPool:obtainWorker:created=20,obtained=20,releasedToPool=0,releasedFromPool=0,outstanding=20 2020-07-12 22:12:40.003 [ 1] 5 LibcurlHTTP2ConnectionFactory:createHTTP2Connection 2020-07-12 22:12:40.003 [ 22] 9 TaskThread:startThread:moniker= 22,duration=194 2020-07-12 22:12:40.003 [ 23] 5 LibcurlHTTP2Connection:networkLoop 2020-07-12 22:12:40.003 [ 1] 5 HTTP2Transport:create:authDelegate=0x555f562c5000,avsGateway=https://alexa.na.gateway.devices.a2z.com,http2Connection=0x555f565f4240,messageConsumer=0x555f56456878,attachmentManager=0x555f56507160,transportObserver=0x555f56456870,postConnectFactory=0x555f56506d40,sharedRequestQueue=0x555f562b4960 2020-07-12 22:12:40.003 [ 1] I MessageRouter:createActiveTransportLocked:transport=0x555f563e2550,sizeOf m_transports=0 2020-07-12 22:12:40.003 [ 1] I HTTP2Transport:connect:this=0x555f563e2550 2020-07-12 22:12:40.003 [ 1] I HTTP2Transport:setStateLocked:this=0x555f563e2550,currentState=INIT,newState=AUTHORIZING,changedReason=ACL_CLIENT_REQUEST 2020-07-12 22:12:40.004 [ 24] 7 HTTP2Transport:mainLoop:this=0x555f563e2550 2020-07-12 22:12:40.004 [ 1] I MessageRouter:setAsActiveTransport:transport=0x555f563e2550,sizeOf m_transports=1 2020-07-12 22:12:40.004 [ 22] 5 CapabilitiesDelegate:onConnectionStatusChanged:connectionStatus=PENDING 2020-07-12 22:12:40.004 [ 24] 5 SynchronizeStateSenderFactory:createPostConnectOperation #############################

Connecting...

#############################

2020-07-12 22:12:40.004 [ 24] 5 AVSGatewayManager:createPostConnectOperation 2020-07-12 22:12:40.004 [ 1b] 1 AlertsCapabilityAgent:executeOnConnectionStatusChanged:status=PENDING,reason=ACL_CLIENT_REQUEST 2020-07-12 22:12:40.004 [ 24] 5 CapabilitiesDelegate:createPostConnectOperation 2020-07-12 22:12:40.004 [ 24] 5 CapabilitiesDelegate:resetDiscoveryEventSender 2020-07-12 22:12:40.005 [ 24] 5 CapabilitiesDelegate:moveInFlightEndpointsToPendingLocked 2020-07-12 22:12:40.005 [ 24] 5 SQLiteCapabilitiesDelegateStorage:load 2020-07-12 22:12:40.005 [ 24] 5 CapabilitiesDelegate:createPostConnectOperation:num endpoints stored=0 2020-07-12 22:12:40.005 [ 24] 5 CapabilitiesDelegate:createPostConnectOperation:num endpoints to add=1,num endpoints to delete=0 2020-07-12 22:12:40.006 [ 24] 5 CapabilitiesDelegate:addDiscoveryEventSender 2020-07-12 22:12:40.006 [ 24] 5 CapabilitiesDelegate:resetDiscoveryEventSender 2020-07-12 22:12:40.006 [ 24] 5 DiscoveryEventSender:addDiscoveryStatusObserver

[shao-estone]

              #    #     #  #####      #####  ######  #    #              
             # #   #     # #     #    #     # #     # #   #               
            #   #  #     # #          #       #     # #  #                
           #     # #     #  #####      #####  #     # ###                 
           #######  #   #        #          # #     # #  #                
           #     #   # #   #     #    #     # #     # #   #               
           #     #    #     #####      #####  ######  #    #              
                                                                          
   #####                                           #                      
  #     #   ##   #    # #####  #      ######      # #   #####  #####      
  #        #  #  ##  ## #    # #      #          #   #  #    # #    #     
   #####  #    # # ## # #    # #      #####     #     # #    # #    #     
        # ###### #    # #####  #      #         ####### #####  #####      
  #     # #    # #    # #      #      #         #     # #      #          
   #####  #    # #    # #      ###### ######    #     # #      #          

   SDK Version 1.20.0

   WARNING! THIS DEVICE HAS BEEN COMPILED IN DEBUG MODE.

   RELEASING A PRODUCTION DEVICE IN DEBUG MODE MAY IMPACT DEVICE PERFORMANCE,
   DOES NOT COMPLY WITH THE AVS SECURITY REQUIREMENTS,
   AND COULD RESULT IN SUSPENSION OR TERMINATION OF THE ALEXA SERVICE ON YOUR DEVICES.

2020-07-12 22:12:40.006 [ 24] 5 PostConnectSequencer:doPostConnect +----------------------------------------------------------------------------+ | Options: | | Tap to talk: | | Press 't' and Enter followed by your query (no need for the 'Alexa').| | Hold to talk: | | Press 'h' followed by Enter to simulate holding a button. | | Then say your query (no need for the 'Alexa'). | | Press 'h' followed by Enter to simulate releasing a button. | | Stop an interaction: | | Press 's' and Enter to stop an ongoing interaction. | | Playback Controls: | | Press '1' for a 'PLAY' button press. | | Press '2' for a 'PAUSE' button press. | | Press '3' for a 'NEXT' button press. | | Press '4' for a 'PREVIOUS' button press. | | Settings: | | Press 'c' followed by Enter at any time to see the settings screen. | | Speaker Control: | | Press 'p' followed by Enter at any time to adjust speaker settings. | | Firmware Version: | | Press 'f' followed by Enter at any time to report a different | | firmware version. | | Info: | | Press 'i' followed by Enter at any time to see the help screen. | | Reset device: | | Press 'k' followed by Enter at any time to reset your device. This | | will erase any data stored in the device and you will have to | | re-register your device. | | This option will also exit the application. | | Reauthorize device: | | Press 'z' followed by Enter at any time to re-authorize your device. | | This will erase any data stored in the device and initiate | | re-authorization. | | | | Quit: | | Press 'q' followed by Enter at any time to quit the application. | +----------------------------------------------------------------------------+

2020-07-12 22:12:40.006 [ 24] I HTTP2Transport:handleAuthorizing:this=0x555f563e2550 2020-07-12 22:12:40.006 [ 24] 5 CBLAuthDelegate:addAuthObserver:observer=0x555f563e25c8 2020-07-12 22:12:40.006 [ 24] I HTTP2Transport:onAuthStateChange:this=0x555f563e2550,newState=UNINITIALIZED,error=SUCCESS 2020-07-12 22:12:40.006 [ 25] 5 PostConnectSequencer:mainLoop 2020-07-12 22:12:40.006 [ 25] 5 PostConnectVerifyGatewaySender:performOperation 2020-07-12 22:12:40.006 [ 25] 5 PostConnectVerifyGatewaySender:sendVerifyGateway 2020-07-12 22:12:40.006 [ 25] W UUIDGeneration:low entropy on call to generate UUID:current entropy=0 2020-07-12 22:12:40.006 [ 25] 0 EventBuilder:buildJsonEventString:messageId=0161b8dd-a457-43e2-a9bf-9d2d618bbeec,namespace=Alexa.ApiGateway,name=VerifyGateway 2020-07-12 22:12:40.006 [ 25] 0 EventBuilder:buildJsonEventString:event={"event":{"header":{"namespace":"Alexa.ApiGateway","name":"VerifyGateway","messageId":"0161b8dd-a457-43e2-a9bf-9d2d618bbeec"},"payload":{}}} 2020-07-12 22:12:40.007 [ 25] 7 HTTP2Transport:sendMessage:this=0x555f563e2550 2020-07-12 22:12:40.014 [ 5] 9 LibCurlHttpContentFetcher:bodyCallback:totalContentReceived=419,contentLength=419,currentContentReceived=419,remaining=0,totalBytesWritten=419 2020-07-12 22:12:40.014 [ 5] 9 LibCurlHttpContentFetcher:transferThread::end 2020-07-12 22:12:40.014 [ 5] 9 LibCurlHttpContentFetcher:stateTransition:oldState=FETCHING_BODY,newState=BODY_DONE:State transition 2020-07-12 22:12:40.081 [ 2] 5 HttpPost:doPostSucceeded:code=200 2020-07-12 22:12:40.082 [ 2] 5 CBLAuthDelegate:receiveTokenResponse:code=200 2020-07-12 22:12:40.082 [ 2] 5 CBLAuthDelegate:mapHTTPStatusToError:code=200,error=SUCCESS 2020-07-12 22:12:40.082 [ 2] 5 CBLAuthDelegate:setAuthError:authError=SUCCESS 2020-07-12 22:12:40.082 [ 2] 5 CBLAuthDelegate:setRefreshToken 2020-07-12 22:12:40.082 [ 2] 5 SQLiteCBLAuthDelegateStorage:setRefreshToken 2020-07-12 22:12:40.091 [ 2] 5 CBLAuthDelegate:setAuthState:newAuthState=REFRESHED 2020-07-12 22:12:40.091 [ 2] 9 CBLAuthDelegate:callingOnAuthStateChange:state=REFRESHED,error=SUCCESS 2020-07-12 22:12:40.091 [ 2] I HTTP2Transport:onAuthStateChange:this=0x555f563e2550,newState=REFRESHED,error=SUCCESS 2020-07-12 22:12:40.114 [ 4] 9 InternetConnectionMonitor:testConnection::alreadyReadAllBytes 2020-07-12 22:12:40.114 [ 4] 9 InternetConnectionMonitor:testConnection::Finished reading 2020-07-12 22:12:40.114 [ 4] 5 InternetConnectionMonitor:updateConnectionStatus:connected=true 2020-07-12 22:12:40.114 [ 4] 5 InternetConnectionMonitor:notifyObserversLocked 2020-07-12 22:12:40.114 [ 4] 5 AVSConnectionManager:onConnectionStatusChanged:connected=true,isEnabled=true 2020-07-12 22:12:40.114 [ 4] I MessageRouter:onWakeConnectionRetry 2020-07-12 22:12:40.114 [ 4] I MessageRouter:onWakeConnectionRetry:m_activeTransport=0x555f563e2550 2020-07-12 22:12:40.114 [ 4] I HTTP2Transport:onWakeConnectionRetry:this=0x555f563e2550 t 2020-07-12 22:12:47.752 [ 1] 9 ThreadPool:obtainWorker:created=21,obtained=21,releasedToPool=20,releasedFromPool=1,outstanding=0 2020-07-12 22:12:47.752 [ a] 9 TaskThread:startThread:moniker= a,duration=127 2020-07-12 22:12:47.752 [ a] 5 DefaultClient:notifyOfTapToTalk 2020-07-12 22:12:47.752 [ a] 5 AudioInputProcessor:recognize 2020-07-12 22:12:47.752 [ a] 9 ThreadPool:obtainWorker:created=21,obtained=22,releasedToPool=20,releasedFromPool=1,outstanding=1 2020-07-12 22:12:47.752 [ b] 9 TaskThread:startThread:moniker= b,duration=39 2020-07-12 22:12:47.752 [ b] 0 AudioInputProcessor:notEncodingAudio 2020-07-12 22:12:47.752 [ b] W UUIDGeneration:low entropy on call to generate UUID:current entropy=0 2020-07-12 22:12:47.752 [ b] 5 UserInactivityMonitor:onUserActive 2020-07-12 22:12:47.753 [ b] 0 AudioInputProcessor:setState:from=IDLE,to=RECOGNIZING 2020-07-12 22:12:47.753 [ b] 9 ConnectionRetryTrigger:onStateChanged:state=RECOGNIZING 2020-07-12 22:12:47.753 [ b] 9 AVSConnectionManager:onWakeConnectionRetry 2020-07-12 22:12:47.753 [ b] I MessageRouter:onWakeConnectionRetry

[alexandrekm-amzn]

Hi @shao-estone Can you please attach the DEBUG9 full log file as a txt file ?

[shao-estone]

Authorization_Debug9.txt Debug9_2.txt

Authorization_Debug9.txt is when I start the sample app for the first time. it freezes after I authorize on the web page. Debug9_2.txt is when I start the sample app again.

Please help

Thank you!

Hi @shao-estone Can you please attach the DEBUG9 full log file as a txt file ?

[angelobt]

Hi, I have the same issue.

If I press "p" option, then select "1" and then "2" to lower volume, Alexa goes in idle.

Logs in attachment log_avs_sdk_1_20.txt

Thanks in advance, Angelo

[scotthea-amazon]

Hello @shao-estone,

Thank you for the logs. This looks to be an interesting problem. So far we have not been able to reproduce it. Can you tell us more about your set-up? Have you changed any of the SDK code?

In both logs it appears that HTTP2Transport::onAuthStateChanged(REFRESHED, SUCESS) has gotten blocked. You can see the log line:

HTTP2Transport:onAuthStateChange:this=0x55f065d6c800,newState=REFRESHED,error=SUCCESS

However, there is no subsequent logging. In both cases HTTP2Transport::m_state should be AUTHORIZING, so the switch and if in onAuthStateChanged() should have reached this line:

setStateLocked(State::CONNECTING, ConnectionStatusObserverInterface::ChangedReason::SUCCESS);

setStateLocked() always logs, but we do not see that log output. My best guess is that some other thread is holding HTTP2Transport::m_mutex. However, from the other log lines I do not see any path that would cause that.

I suggest adding a log line right after HTTP2Transport::onAuthStateChanged() acquires m_mutex to verify that this analysis is in fact correct.

Assuming that it is, the next step would be to add logging to verify that the other calls to HTTP2Transport that acquire m_mutex have in fact released it.

Please let us know what you find.

Best regards, -SWH

[scotthea-amazon]

Hello @angelobt,

Thank you for the log file. Your log indicates an entirely different condition than the one that started this issue. The command sequence "p" then "1" then "2" should lower the speaker volume, and the logs indicate that it has done just that. Entering the IDLE state is normal after a connection with AVS has been established. If you are experiencing problematic behavior, please create a separate issue and describe in more detail what problem you are encountering.

Best regards, -SWH

[angelobt]

@scotthea-amazon Hi, maybe there is a misundertanding:

I have the same issue, as a workaround to get alexa connected I did the trick of changing volume (that seems is forcing the connection).

I attach logs about mutex.

Regards logs_2020_07_30.txt

[angelobt]

@scotthea-amazon

Hi,

more logs sourranding all lock(m_mutex) inside HTTP2Transport

logs.zip

thanks for any help

[angelobt]

@scotthea-amazon

Hi,

the application loops forever in

    m_wakeEvent.wait_until(lock, wakeTime, [this, whileState, messageRequestTime] {
        return m_state != whileState || m_sharedRequestQueue->peekRequestTime() != messageRequestTime;
    });

inside HTTP2Transport::State HTTP2Transport::monitorSharedQueueWhileWaiting

m_state and whileState are "CONNECTING"

Regards, Angelo

[scotthea-amazon]

Hello @angelobt,

I agree that the logs point to a thread being stuck in monitorSharedQueueWhileWaiting() with the CONNECTING state.

From your logs I see two threads waiting for m_mutex:

• HTTP2Transport::onActivity()
• HTTP2Transport::sendMessage()

I can see that MimeResponseSink::onReceiveResponseCode() with a code of 200. That is getting blocked in its call to HTTP2Transport::onActivity(). That prevents the subsequent call to m_handler->onReceiveResponseCode (which is DownchannelHandler::onReceiveResponseCode()). For a 200 that would call HTTP2Transport::onDownchannelConnected() - which is how the loop in monitorSharedQueueWhileWaiting() with CONNECTING is supposed to terminate.

So, it still looks like some thread is holding m_mutex. Unfortunately, even with your additional logs I don't see where that is happening.

Have you made any further progress tracking this down?

Best regards, -SWH

[angelobt]

Hello @scotthea-amazon,

I tried to add logs wherever a mutex is issued and (maybe I'm wrong because I'm not very familiar with these c++ constructs) my idea is that monitorSharedQueueWhileWaiting() in locking the mutex for

• HTTP2Transport::onActivity()
  

• HTTP2Transport::sendMessage()
  

I have tried to do a patch.

in my case, m_wakeEvent.wait_until loops forever with

m_state = whileState = "CONNECTING" messageRequestTime.hasValue = false

so I thought that the condition m_sharedRequestQueue->peekRequestTime() != messageRequestTime could never be verified if messageRequestTime.hasValue = false

I have added !messageRequestTime.hasValue() in the exit condition.

diff --git a/ACL/src/Transport/HTTP2Transport.cpp b/ACL/src/Transport/HTTP2Transport.cpp index 34e6811..4dc2e49 100644 --- a/ACL/src/Transport/HTTP2Transport.cpp +++ b/ACL/src/Transport/HTTP2Transport.cpp @@ -737,7 +737,7 @@ HTTP2Transport::State HTTP2Transport::monitorSharedQueueWhileWaiting(

     std::unique_lock<std::mutex> lock(m_mutex);
     m_wakeEvent.wait_until(lock, wakeTime, [this, whileState, messageRequestTime] {

•        return m_state != whileState || m_sharedRequestQueue->peekRequestTime() != messageRequestTime;
  

•        return m_state != whileState || !messageRequestTime.hasValue() || m_sharedRequestQueue->peekRequestTime() != messageRequestTime;
     });
     if (whileState != m_state || std::chrono::steady_clock::now() >= maxWakeTime) {
  

-- 2.25.1

Please let me know if it can be right or if it is working by accident

Best regards,

Angelo

[gabrieldespindula]

Hi folks, just commenting that perhaps I'm talking about the same thing in a different issue here: https://github.com/alexa/avs-device-sdk/issues/1319

[mvelegon-amzn]

Hi @angelobt @gabrieldespindula

It does appear that the SDK gets stuck in the m_wakeEvent.wait_until condition which is causing other methods to get blocked waiting on the lock. Before we figure out the right fix for this, it would help us to understand how you are able to reproduce this issue. Are there any specific instructions you could provide so that we could reproduce this behavior locally?

[wjennings]

Hi @angelobt @gabrieldespindula

It does appear that the SDK gets stuck in the m_wakeEvent.wait_until condition which is causing other methods to get blocked waiting on the lock. Before we figure out the right fix for this, it would help us to understand how you are able to reproduce this issue. Are there any specific instructions you could provide so that we could reproduce this behavior locally?

Please provide a patch for this, I have been tripped up by this as well and I'm sure others are too. There is nothing specific I do to create this, similar to the issue found here https://github.com/alexa/avs-device-sdk/issues/1319#issue-433224824 The 1st time I run it, it works OK, but every time after I stop it, and re-run, it gets stuck. That's it, for me 100% reproduceable.

[blazusiak-amazon]

Hello @shao-estone, @angelobt, and @wjennings,

Are you able to still reproduce this issue? Are you still experiencing this on the latest SDK Version?

[kjkh]

Closing due to inactivity. If further assistance is required, please open a new ticket with reference to this one.