twilio / twilio-chat-demo-android

Chat API Demo Application for Android
MIT License
62 stars 51 forks source link

Request to EMS service has failed, unable to set FPA token #126

Closed NeerajaGandla closed 4 years ago

NeerajaGandla commented 4 years ago

Opening a new issue because, the similar issues were closed due to lack of response. We have a web application integrated with twilio chat client and is working fine. We have to build the same feature in android as well. We are using the same token generation process. I'm following the twilio android chat sample app to build a similar app with only the features I need. Tokens are being generated successfully. I'm using it in the app. I'm getting Error code : 3 Request to EMS service has failed, unable to set FPA token at this line: ChatClient.create(context.getApplicationContext(), token, props, this); When I change the token_url in the twilio sample app to mine, it's working. The problem happens only in my app. Am I missing something like registering the app in the website or something similar? But the process is done when the web app was built. And I'm using the same token generation here. Twilio Chat SDK version 3.1.1 Here's the logcat:

2020-04-09 19:14:08.744 23539-23539/? I/z.twilioexampl: Late-enabling -Xcheck:jni 2020-04-09 19:14:08.895 23539-23539/com.apptmyz.twilioexample I/z.twilioexampl: The ClassLoaderContext is a special shared library. 2020-04-09 19:14:09.337 23539-23539/com.apptmyz.twilioexample I/FirebaseInitProvider: FirebaseApp initialization unsuccessful 2020-04-09 19:14:09.347 23539-23539/com.apptmyz.twilioexample I/CrashlyticsInitProvider: CrashlyticsInitProvider skipping initialization 2020-04-09 19:14:09.422 23539-23539/com.apptmyz.twilioexample W/z.twilioexampl: Accessing hidden method Landroid/graphics/drawable/Drawable;->getOpticalInsets()Landroid/graphics/Insets; (light greylist, linking) 2020-04-09 19:14:09.422 23539-23539/com.apptmyz.twilioexample W/z.twilioexampl: Accessing hidden field Landroid/graphics/Insets;->left:I (light greylist, linking) 2020-04-09 19:14:09.422 23539-23539/com.apptmyz.twilioexample W/z.twilioexampl: Accessing hidden field Landroid/graphics/Insets;->right:I (light greylist, linking) 2020-04-09 19:14:09.422 23539-23539/com.apptmyz.twilioexample W/z.twilioexampl: Accessing hidden field Landroid/graphics/Insets;->top:I (light greylist, linking) 2020-04-09 19:14:09.422 23539-23539/com.apptmyz.twilioexample W/z.twilioexampl: Accessing hidden field Landroid/graphics/Insets;->bottom:I (light greylist, linking) 2020-04-09 19:14:09.470 23539-23539/com.apptmyz.twilioexample W/z.twilioexampl: Accessing hidden method Landroid/view/View;->computeFitSystemWindows(Landroid/graphics/Rect;Landroid/graphics/Rect;)Z (light greylist, reflection) 2020-04-09 19:14:09.471 23539-23539/com.apptmyz.twilioexample W/z.twilioexampl: Accessing hidden method Landroid/view/ViewGroup;->makeOptionalFitsSystemWindows()V (light greylist, reflection) 2020-04-09 19:14:09.491 23539-23539/com.apptmyz.twilioexample W/z.twilioexampl: Accessing hidden method Landroid/widget/TextView;->getTextDirectionHeuristic()Landroid/text/TextDirectionHeuristic; (light greylist, linking) 2020-04-09 19:14:09.517 23539-23574/com.apptmyz.twilioexample D/NetworkSecurityConfig: No Network Security Config specified, using platform default 2020-04-09 19:14:09.531 23539-23539/com.apptmyz.twilioexample D/OpenGLRenderer: Skia GL Pipeline 2020-04-09 19:14:09.561 23539-23580/com.apptmyz.twilioexample I/Adreno: QUALCOMM build : 3d7efc4, I45f70159dc Build Date : 10/28/18 OpenGL ES Shader Compiler Version: EV031.25.03.01 Local Branch : Remote Branch : Remote Branch : Reconstruct Branch : 2020-04-09 19:14:09.561 23539-23580/com.apptmyz.twilioexample I/Adreno: Build Config : S L 6.0.7 AArch64 2020-04-09 19:14:09.567 23539-23580/com.apptmyz.twilioexample I/Adreno: PFP: 0x005ff112, ME: 0x005ff066 2020-04-09 19:14:09.571 23539-23580/com.apptmyz.twilioexample I/ConfigStore: android::hardware::configstore::V1_0::ISurfaceFlingerConfigs::hasWideColorDisplay retrieved: 0 2020-04-09 19:14:09.571 23539-23580/com.apptmyz.twilioexample I/ConfigStore: android::hardware::configstore::V1_0::ISurfaceFlingerConfigs::hasHDRDisplay retrieved: 0 2020-04-09 19:14:09.571 23539-23580/com.apptmyz.twilioexample I/OpenGLRenderer: Initialized EGL, version 1.4 2020-04-09 19:14:09.571 23539-23580/com.apptmyz.twilioexample D/OpenGLRenderer: Swap behavior 2 2020-04-09 19:14:10.624 23539-23539/com.apptmyz.twilioexample E/test: test 2020-04-09 19:14:10.624 23539-23539/com.apptmyz.twilioexample D/ChatClientManager: onSuccess: 2020-04-09 19:14:10.627 23539-23539/com.apptmyz.twilioexample E/error: message 2020-04-09 19:14:10.640 23539-23539/com.apptmyz.twilioexample I/ChatClient: Twilio Chat SDK version 3.1.1 2020-04-09 19:14:10.640 23539-23539/com.apptmyz.twilioexample D/ChatClient: Subscribed to ActivityLifecycleCallbacks 2020-04-09 19:14:10.640 23539-23539/com.apptmyz.twilioexample D/ChatClient: Subscribed to ComponentCallbacks2 2020-04-09 19:14:10.647 23539-23539/com.apptmyz.twilioexample D/TWC: ChatClient(native): 547086226760 | 04/09/19:14:10.647 | DEBUG | ChatClient(native) | Started ChatClient nativeCreate() 2020-04-09 19:14:10.648 23539-23539/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7ed55025d0 for method onMessageAdded(Lcom/twilio/chat/Message;)V 2020-04-09 19:14:10.648 23539-23539/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7ed5502620 for method onMessageUpdated(Lcom/twilio/chat/Message;Lcom/twilio/chat/Message$UpdateReason;)V 2020-04-09 19:14:10.648 23539-23539/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7ed55025f8 for method onMessageDeleted(Lcom/twilio/chat/Message;)V 2020-04-09 19:14:10.648 23539-23539/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7ed5502558 for method onMemberAdded(Lcom/twilio/chat/Member;)V 2020-04-09 19:14:10.648 23539-23539/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7ed55025a8 for method onMemberUpdated(Lcom/twilio/chat/Member;Lcom/twilio/chat/Member$UpdateReason;)V 2020-04-09 19:14:10.648 23539-23539/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7ed5502580 for method onMemberDeleted(Lcom/twilio/chat/Member;)V 2020-04-09 19:14:10.648 23539-23539/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7ed5502698 for method onTypingStarted(Lcom/twilio/chat/Channel;Lcom/twilio/chat/Member;)V 2020-04-09 19:14:10.648 23539-23539/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7ed5502670 for method onTypingEnded(Lcom/twilio/chat/Channel;Lcom/twilio/chat/Member;)V 2020-04-09 19:14:10.648 23539-23539/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7ed5502648 for method onSynchronizationChanged(Lcom/twilio/chat/Channel;)V 2020-04-09 19:14:10.648 23539-23539/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7ed4c20780 for method onChannelJoined(Lcom/twilio/chat/Channel;)V 2020-04-09 19:14:10.648 23539-23539/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7ed4c20758 for method onChannelInvited(Lcom/twilio/chat/Channel;)V 2020-04-09 19:14:10.648 23539-23539/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7ed4c20708 for method onChannelAdded(Lcom/twilio/chat/Channel;)V 2020-04-09 19:14:10.648 23539-23539/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7ed4c207d0 for method onChannelUpdated(Lcom/twilio/chat/Channel;Lcom/twilio/chat/Channel$UpdateReason;)V 2020-04-09 19:14:10.648 23539-23539/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7ed4c20730 for method onChannelDeleted(Lcom/twilio/chat/Channel;)V 2020-04-09 19:14:10.648 23539-23539/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7ed4c20898 for method onNewMessageNotification(Ljava/lang/String;Ljava/lang/String;J)V 2020-04-09 19:14:10.648 23539-23539/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7ed4c206e0 for method onAddedToChannelNotification(Ljava/lang/String;)V 2020-04-09 19:14:10.648 23539-23539/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7ed4c20870 for method onInvitedToChannelNotification(Ljava/lang/String;)V 2020-04-09 19:14:10.648 23539-23539/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7ed4c20910 for method onRemovedFromChannelNotification(Ljava/lang/String;)V 2020-04-09 19:14:10.648 23539-23539/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7ed4c208e8 for method onNotificationSubscribed()V 2020-04-09 19:14:10.648 23539-23539/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7ed4c208c0 for method onNotificationFailed(Lcom/twilio/chat/ErrorInfo;)V 2020-04-09 19:14:10.648 23539-23539/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7ed4c20988 for method onUserUpdated(Lcom/twilio/chat/User;Lcom/twilio/chat/User$UpdateReason;)V 2020-04-09 19:14:10.648 23539-23539/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7ed4c20938 for method onUserSubscribed(Lcom/twilio/chat/User;)V 2020-04-09 19:14:10.648 23539-23539/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7ed4c20960 for method onUserUnsubscribed(Lcom/twilio/chat/User;)V 2020-04-09 19:14:10.648 23539-23539/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7ed4c207f8 for method onClientSynchronization(Lcom/twilio/chat/ChatClient$SynchronizationStatus;)V 2020-04-09 19:14:10.648 23539-23539/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7ed4c20820 for method onConnectionStateChange(Lcom/twilio/chat/ChatClient$ConnectionState;)V 2020-04-09 19:14:10.648 23539-23539/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7ed4c20848 for method onError(Lcom/twilio/chat/ErrorInfo;)V 2020-04-09 19:14:10.650 23539-23584/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7ed3219fd0 for method <init>(Landroid/content/Context;)V 2020-04-09 19:14:10.651 23539-23584/com.apptmyz.twilioexample D/TWC:: 544410154224 | 04/09/19:14:10.651 | DEBUG | | Using root certificate store: /data/user/0/com.apptmyz.twilioexample/files/rootcert.pem 2020-04-09 19:14:10.652 23539-23584/com.apptmyz.twilioexample D/TWC: ChatClient(native): 544410154224 | 04/09/19:14:10.652 | DEBUG | ChatClient(native) | Creating notification client observer 2020-04-09 19:14:10.652 23539-23584/com.apptmyz.twilioexample I/TWC: IoService: 544410154224 | 04/09/19:14:10.652 | INFO | IoService | Creating 16 threads in the executor pool 2020-04-09 19:14:10.653 23539-23584/com.apptmyz.twilioexample D/TWC: TNTwilsockClient: 544410154224 | 04/09/19:14:10.653 | DEBUG | 1 | TNTwilsockClient | client: version: 2.5.5, build id: 1, build branch: refs/heads/master, os: android, arch: arm64-v8a 2020-04-09 19:14:10.654 23539-23584/com.apptmyz.twilioexample D/TWC: TNTwilsockClient: 544410154224 | 04/09/19:14:10.654 | DEBUG | 1 | TNTwilsockClient | Default thread pool: Available: 16; Capacity: 16 2020-04-09 19:14:10.654 23539-23584/com.apptmyz.twilioexample I/TWC: TNHttpTransportClient: 544410154224 | 04/09/19:14:10.654 | INFO | 4 | TNHttpTransportClient | initialising... 2020-04-09 19:14:10.654 23539-23584/com.apptmyz.twilioexample I/TWC: TNHttpTransportClient: 544410154224 | 04/09/19:14:10.654 | INFO | 4 | TNHttpTransportClient | initialised 2020-04-09 19:14:10.654 23539-23585/com.apptmyz.twilioexample I/TWC: TNTwilsockClient: 544409113840 | 04/09/19:14:10.654 | INFO | 1 | TNTwilsockClient | connectImpl >> Disconnected 2020-04-09 19:14:10.654 23539-23584/com.apptmyz.twilioexample D/TWC: TCEmsClient: 544410154224 | 04/09/19:14:10.654 | DEBUG | 6 | TCEmsClient | TCEmsClient 2020-04-09 19:14:10.654 23539-23585/com.apptmyz.twilioexample D/TWC: TNTwilsockClientImpl: 544409113840 | 04/09/19:14:10.654 | DEBUG | 3 | TNTwilsockClientImpl | connect 2020-04-09 19:14:10.654 23539-23584/com.apptmyz.twilioexample D/TWC: ChatContinuationTokenStorage(native): 544410154224 | 04/09/19:14:10.654 | DEBUG | ChatContinuationTokenStorage(native) | ctor 2020-04-09 19:14:10.654 23539-23584/com.apptmyz.twilioexample D/TWC: TCBackoffEmsClient: 544410154224 | 04/09/19:14:10.654 | DEBUG | 5 | TCBackoffEmsClient | init 2020-04-09 19:14:10.654 23539-23584/com.apptmyz.twilioexample D/TWC: TCEmsClient: 544410154224 | 04/09/19:14:10.654 | DEBUG | 6 | TCEmsClient | init 2020-04-09 19:14:10.654 23539-23584/com.apptmyz.twilioexample D/TWC: TCBackoffEmsClient: 544410154224 | 04/09/19:14:10.654 | DEBUG | 5 | TCBackoffEmsClient | setToken, 2020-04-09 19:14:10.654 23539-23584/com.apptmyz.twilioexample D/TWC: TCBackoffEmsClient: 544410154224 | 04/09/19:14:10.654 | DEBUG | 5 | TCBackoffEmsClient | scheduleSetToken 2020-04-09 19:14:10.654 23539-23584/com.apptmyz.twilioexample I/TWC: TCBackoffEmsClient: 544410154224 | 04/09/19:14:10.654 | INFO | 5 | TCBackoffEmsClient | schedule new task 2020-04-09 19:14:10.654 23539-23586/com.apptmyz.twilioexample D/TWC: TCBackoffEmsClient: 544397882608 | 04/09/19:14:10.654 | DEBUG | 5 | TCBackoffEmsClient | internal set token run... 2020-04-09 19:14:10.654 23539-23586/com.apptmyz.twilioexample D/TWC: TCEmsClient: 544397882608 | 04/09/19:14:10.654 | DEBUG | 6 | TCEmsClient | setToken 2020-04-09 19:14:10.654 23539-23586/com.apptmyz.twilioexample D/TWC: TCEmsClient: 544397882608 | 04/09/19:14:10.654 | DEBUG | 6 | TCEmsClient | runGenerateTokenTask 2020-04-09 19:14:10.654 23539-23585/com.apptmyz.twilioexample I/TWC: TNDisconnectedState: 544409113840 | 04/09/19:14:10.654 | INFO | 2 | TNDisconnectedState | Leaving state: Disconnected 2020-04-09 19:14:10.654 23539-23604/com.apptmyz.twilioexample D/TWC: TNWebsocket: 544379155696 | 04/09/19:14:10.654 | DEBUG | 7 | TNWebsocket | Connecting... 2020-04-09 19:14:10.654 23539-23585/com.apptmyz.twilioexample I/TWC: TNTwilsockClient: 544409113840 | 04/09/19:14:10.654 | INFO | 1 | TNTwilsockClient | Change state: Disconnected --> Transport connecting 2020-04-09 19:14:10.654 23539-23585/com.apptmyz.twilioexample I/TWC: TNTransportConnectingState: 544409113840 | 04/09/19:14:10.654 | INFO | 8 | TNTransportConnectingState | Entering state: Transport connecting 2020-04-09 19:14:10.654 23539-23585/com.apptmyz.twilioexample D/TWC: TNTwilsockClientImpl: 544409113840 | 04/09/19:14:10.654 | DEBUG | 3 | TNTwilsockClientImpl | startTransportConnectingTimer 2020-04-09 19:14:10.654 23539-23604/com.apptmyz.twilioexample D/TWC: TNWebsocket: 544379155696 | 04/09/19:14:10.654 | DEBUG | 7 | TNWebsocket | Using proxy : except () 2020-04-09 19:14:10.654 23539-23585/com.apptmyz.twilioexample I/TWC: TNTwilsockClient: 544409113840 | 04/09/19:14:10.654 | INFO | 1 | TNTwilsockClient | addObserverImpl >> Transport connecting 2020-04-09 19:14:10.654 23539-23585/com.apptmyz.twilioexample D/TWC: TNTwilsockClientImpl: 544409113840 | 04/09/19:14:10.654 | DEBUG | 3 | TNTwilsockClientImpl | addObserver 2020-04-09 19:14:10.654 23539-23604/com.apptmyz.twilioexample D/TWC: TNWebsocket: 544379155696 | 04/09/19:14:10.654 | DEBUG | 7 | TNWebsocket | Trying to establish connection to: https://tsock.us1.twilio.com 2020-04-09 19:14:10.655 23539-23585/com.apptmyz.twilioexample I/TWC: TNHttpTransportClient: 544409113840 | 04/09/19:14:10.654 | INFO | 4 | TNHttpTransportClient | twilsock is in disconnected state: Unknown reason 2020-04-09 19:14:10.666 23539-23586/com.apptmyz.twilioexample D/TWC: ChatContinuationTokenStorage(native): 544397882608 | 04/09/19:14:10.666 | DEBUG | ChatContinuationTokenStorage(native) | retrieveTokenFromStorage 2020-04-09 19:14:10.666 23539-23586/com.apptmyz.twilioexample D/TWC: ChatContinuationTokenStorage(native): 544397882608 | 04/09/19:14:10.666 | DEBUG | ChatContinuationTokenStorage(native) | fetchContinuationToken retrieved token `` under key default 2020-04-09 19:14:10.666 23539-23586/com.apptmyz.twilioexample D/TWC: TCHttpObserver: 544397882608 | 04/09/19:14:10.666 | DEBUG | 9 | TCHttpObserver | client: version: 2.5.5, build id: 1, build branch: refs/heads/master, os: android, arch: arm64-v8a 2020-04-09 19:14:10.666 23539-23586/com.apptmyz.twilioexample I/TWC: TNHttpTransportClient: 544397882608 | 04/09/19:14:10.666 | INFO | 4 | TNHttpTransportClient | requestId=RQa65b714b85e6426cbc3b03d8a91bcbcd, enqueueing request to: https://ems.us1.twilio.com/v1/token 2020-04-09 19:14:10.666 23539-23586/com.apptmyz.twilioexample D/TWC: TCEmsClient: 544397882608 | 04/09/19:14:10.666 | DEBUG | 6 | TCEmsClient | setToken - end 2020-04-09 19:14:11.144 23539-23604/com.apptmyz.twilioexample W/TWC: TNWebsocket: 544379155696 | 04/09/19:14:11.144 | WARNING | 7 | TNWebsocket | Poco net exception while connecting: SSL Exception: error:1000007e:SSL routines:OPENSSL_internal:CERTIFICATE_VERIFY_FAILED 2020-04-09 19:14:11.144 23539-23585/com.apptmyz.twilioexample I/TWC: TNTwilsockClient: 544409113840 | 04/09/19:14:11.144 | INFO | 1 | TNTwilsockClient | onErrorImpl >> Transport connecting 2020-04-09 19:14:11.144 23539-23585/com.apptmyz.twilioexample D/TWC: TNTwilsockClientImpl: 544409113840 | 04/09/19:14:11.144 | DEBUG | 3 | TNTwilsockClientImpl | notifyAboutError 2020-04-09 19:14:11.144 23539-23585/com.apptmyz.twilioexample D/TWC: TNTwilsockClientImpl: 544409113840 | 04/09/19:14:11.144 | DEBUG | 3 | TNTwilsockClientImpl | disconnect 2020-04-09 19:14:11.144 23539-23585/com.apptmyz.twilioexample D/TWC: TNWebsocket: 544409113840 | 04/09/19:14:11.144 | DEBUG | 7 | TNWebsocket | Disconnect 2020-04-09 19:14:11.144 23539-23585/com.apptmyz.twilioexample D/TWC: TNWebsocket: 544409113840 | 04/09/19:14:11.144 | DEBUG | 7 | TNWebsocket | Reset session 2020-04-09 19:14:11.144 23539-23604/com.apptmyz.twilioexample D/TWC: TNWebsocket: 544379155696 | 04/09/19:14:11.144 | DEBUG | 7 | TNWebsocket | Disconnecting... 2020-04-09 19:14:11.144 23539-23604/com.apptmyz.twilioexample D/TWC: TNWebsocket: 544379155696 | 04/09/19:14:11.144 | DEBUG | 7 | TNWebsocket | Disconnected 2020-04-09 19:14:11.144 23539-23604/com.apptmyz.twilioexample D/TWC: TNTwilsockClient: 544379155696 | 04/09/19:14:11.144 | DEBUG | 1 | TNTwilsockClient | onDisconnected 2020-04-09 19:14:11.144 23539-23585/com.apptmyz.twilioexample I/TWC: TNTwilsockClient: 544409113840 | 04/09/19:14:11.144 | INFO | 1 | TNTwilsockClient | onDisconnectedImpl >> Transport connecting 2020-04-09 19:14:11.144 23539-23585/com.apptmyz.twilioexample I/TWC: TNTransportConnectingState: 544409113840 | 04/09/19:14:11.144 | INFO | 8 | TNTransportConnectingState | Leaving state: Transport connecting 2020-04-09 19:14:11.144 23539-23585/com.apptmyz.twilioexample D/TWC: TNTwilsockClientImpl: 544409113840 | 04/09/19:14:11.144 | DEBUG | 3 | TNTwilsockClientImpl | stopTransportConnectingTimer 2020-04-09 19:14:11.144 23539-23585/com.apptmyz.twilioexample I/TWC: TNTwilsockClient: 544409113840 | 04/09/19:14:11.144 | INFO | 1 | TNTwilsockClient | Change state: Transport connecting --> Retry connect 2020-04-09 19:14:11.144 23539-23585/com.apptmyz.twilioexample I/TWC: TNRetryConnectState: 544409113840 | 04/09/19:14:11.144 | INFO | 10 | TNRetryConnectState | Entering state: Retry connect 2020-04-09 19:14:11.144 23539-23585/com.apptmyz.twilioexample I/TWC: TNTwilsockClient: 544409113840 | 04/09/19:14:11.144 | INFO | 1 | TNTwilsockClient | stopUpstreamRequests 2020-04-09 19:14:11.144 23539-23585/com.apptmyz.twilioexample D/TWC: TNTwilsockClientImpl: 544409113840 | 04/09/19:14:11.144 | DEBUG | 3 | TNTwilsockClientImpl | startRetryTimer 2000 2020-04-09 19:14:13.147 23539-23585/com.apptmyz.twilioexample I/TWC: TNTwilsockClient: 544409113840 | 04/09/19:14:13.147 | INFO | 1 | TNTwilsockClient | retryTimeoutImpl >> Retry connect 2020-04-09 19:14:13.148 23539-23585/com.apptmyz.twilioexample D/TWC: TNTwilsockClientImpl: 544409113840 | 04/09/19:14:13.148 | DEBUG | 3 | TNTwilsockClientImpl | connect 2020-04-09 19:14:13.148 23539-23585/com.apptmyz.twilioexample I/TWC: TNRetryConnectState: 544409113840 | 04/09/19:14:13.148 | INFO | 10 | TNRetryConnectState | Leaving state: Retry connect 2020-04-09 19:14:13.148 23539-23585/com.apptmyz.twilioexample D/TWC: TNTwilsockClientImpl: 544409113840 | 04/09/19:14:13.148 | DEBUG | 3 | TNTwilsockClientImpl | stopRetryTimer 2020-04-09 19:14:13.148 23539-23585/com.apptmyz.twilioexample I/TWC: TNTwilsockClient: 544409113840 | 04/09/19:14:13.148 | INFO | 1 | TNTwilsockClient | Change state: Retry connect --> Transport connecting 2020-04-09 19:14:13.148 23539-23604/com.apptmyz.twilioexample D/TWC: TNWebsocket: 544379155696 | 04/09/19:14:13.148 | DEBUG | 7 | TNWebsocket | Connecting... 2020-04-09 19:14:13.148 23539-23585/com.apptmyz.twilioexample I/TWC: TNTransportConnectingState: 544409113840 | 04/09/19:14:13.148 | INFO | 8 | TNTransportConnectingState | Entering state: Transport connecting 2020-04-09 19:14:13.148 23539-23585/com.apptmyz.twilioexample D/TWC: TNTwilsockClientImpl: 544409113840 | 04/09/19:14:13.148 | DEBUG | 3 | TNTwilsockClientImpl | startTransportConnectingTimer 2020-04-09 19:14:13.148 23539-23604/com.apptmyz.twilioexample D/TWC: TNWebsocket: 544379155696 | 04/09/19:14:13.148 | DEBUG | 7 | TNWebsocket | Using proxy : except () 2020-04-09 19:14:13.148 23539-23604/com.apptmyz.twilioexample D/TWC: TNWebsocket: 544379155696 | 04/09/19:14:13.148 | DEBUG | 7 | TNWebsocket | Trying to establish connection to: https://tsock.us1.twilio.com 2020-04-09 19:14:13.637 23539-23604/com.apptmyz.twilioexample W/TWC: TNWebsocket: 544379155696 | 04/09/19:14:13.637 | WARNING | 7 | TNWebsocket | Poco net exception while connecting: SSL Exception: error:1000007e:SSL routines:OPENSSL_internal:CERTIFICATE_VERIFY_FAILED 2020-04-09 19:14:13.637 23539-23585/com.apptmyz.twilioexample I/TWC: TNTwilsockClient: 544409113840 | 04/09/19:14:13.637 | INFO | 1 | TNTwilsockClient | onErrorImpl >> Transport connecting 2020-04-09 19:14:13.637 23539-23585/com.apptmyz.twilioexample D/TWC: TNTwilsockClientImpl: 544409113840 | 04/09/19:14:13.637 | DEBUG | 3 | TNTwilsockClientImpl | notifyAboutError 2020-04-09 19:14:13.637 23539-23585/com.apptmyz.twilioexample D/TWC: TNTwilsockClientImpl: 544409113840 | 04/09/19:14:13.637 | DEBUG | 3 | TNTwilsockClientImpl | disconnect 2020-04-09 19:14:13.637 23539-23585/com.apptmyz.twilioexample D/TWC: TNWebsocket: 544409113840 | 04/09/19:14:13.637 | DEBUG | 7 | TNWebsocket | Disconnect 2020-04-09 19:14:13.637 23539-23585/com.apptmyz.twilioexample D/TWC: TNWebsocket: 544409113840 | 04/09/19:14:13.637 | DEBUG | 7 | TNWebsocket | Reset session 2020-04-09 19:14:13.638 23539-23604/com.apptmyz.twilioexample D/TWC: TNWebsocket: 544379155696 | 04/09/19:14:13.638 | DEBUG | 7 | TNWebsocket | Disconnecting... 2020-04-09 19:14:13.638 23539-23604/com.apptmyz.twilioexample D/TWC: TNWebsocket: 544379155696 | 04/09/19:14:13.638 | DEBUG | 7 | TNWebsocket | Disconnected 2020-04-09 19:14:13.638 23539-23604/com.apptmyz.twilioexample D/TWC: TNTwilsockClient: 544379155696 | 04/09/19:14:13.638 | DEBUG | 1 | TNTwilsockClient | onDisconnected 2020-04-09 19:14:13.638 23539-23585/com.apptmyz.twilioexample I/TWC: TNTwilsockClient: 544409113840 | 04/09/19:14:13.638 | INFO | 1 | TNTwilsockClient | onDisconnectedImpl >> Transport connecting 2020-04-09 19:14:13.638 23539-23585/com.apptmyz.twilioexample I/TWC: TNTransportConnectingState: 544409113840 | 04/09/19:14:13.638 | INFO | 8 | TNTransportConnectingState | Leaving state: Transport connecting 2020-04-09 19:14:13.638 23539-23585/com.apptmyz.twilioexample D/TWC: TNTwilsockClientImpl: 544409113840 | 04/09/19:14:13.638 | DEBUG | 3 | TNTwilsockClientImpl | stopTransportConnectingTimer 2020-04-09 19:14:13.638 23539-23585/com.apptmyz.twilioexample I/TWC: TNTwilsockClient: 544409113840 | 04/09/19:14:13.638 | INFO | 1 | TNTwilsockClient | Change state: Transport connecting --> Retry connect 2020-04-09 19:14:13.638 23539-23585/com.apptmyz.twilioexample I/TWC: TNRetryConnectState: 544409113840 | 04/09/19:14:13.638 | INFO | 10 | TNRetryConnectState | Entering state: Retry connect 2020-04-09 19:14:13.638 23539-23585/com.apptmyz.twilioexample I/TWC: TNTwilsockClient: 544409113840 | 04/09/19:14:13.638 | INFO | 1 | TNTwilsockClient | stopUpstreamRequests 2020-04-09 19:14:13.638 23539-23585/com.apptmyz.twilioexample D/TWC: TNTwilsockClientImpl: 544409113840 | 04/09/19:14:13.638 | DEBUG | 3 | TNTwilsockClientImpl | startRetryTimer 4000 2020-04-09 19:14:15.671 23539-23587/com.apptmyz.twilioexample D/TWC: TNHttpTransportClient: 544396842224 | 04/09/19:14:15.671 | DEBUG | 4 | TNHttpTransportClient | dequeueing request: RQa65b714b85e6426cbc3b03d8a91bcbcd 2020-04-09 19:14:15.672 23539-23587/com.apptmyz.twilioexample D/TWC: TCHttpObserver: 544396842224 | 04/09/19:14:15.672 | DEBUG | 9 | TCHttpObserver | onFailed - begin 2020-04-09 19:14:15.672 23539-23587/com.apptmyz.twilioexample W/TWC: TCHttpObserver: 544396842224 | 04/09/19:14:15.672 | WARNING | 9 | TCHttpObserver | Request has failed: Transport connection closed (3) 2020-04-09 19:14:15.672 23539-23587/com.apptmyz.twilioexample D/TWC: TCHttpObserver: 544396842224 | 04/09/19:14:15.672 | DEBUG | 9 | TCHttpObserver | setPromise - 3 2020-04-09 19:14:15.672 23539-23587/com.apptmyz.twilioexample D/TWC: TCBackoffEmsClient: 544396842224 | 04/09/19:14:15.672 | DEBUG | 5 | TCBackoffEmsClient | internal set token result: 3 2020-04-09 19:14:15.672 23539-23587/com.apptmyz.twilioexample D/TWC: TCEmsClient: 544396842224 | 04/09/19:14:15.672 | DEBUG | 6 | TCEmsClient | runGenerateTokenTask 2020-04-09 19:14:15.673 23539-23587/com.apptmyz.twilioexample D/TWC: TCHttpObserver: 544396842224 | 04/09/19:14:15.672 | DEBUG | 9 | TCHttpObserver | onFailed - end 2020-04-09 19:14:15.673 23539-23587/com.apptmyz.twilioexample D/TWC: TCHttpObserver: 544396842224 | 04/09/19:14:15.673 | DEBUG | 9 | TCHttpObserver | ~TCHttpObserver - begin 2020-04-09 19:14:15.673 23539-23587/com.apptmyz.twilioexample D/TWC: TCHttpObserver: 544396842224 | 04/09/19:14:15.673 | DEBUG | 9 | TCHttpObserver | ~TCHttpObserver - end 2020-04-09 19:14:15.673 23539-23593/com.apptmyz.twilioexample D/TWC: TCBackoffEmsClient: 544390599920 | 04/09/19:14:15.673 | DEBUG | 5 | TCBackoffEmsClient | internal set token run... 2020-04-09 19:14:15.673 23539-23593/com.apptmyz.twilioexample D/TWC: TCEmsClient: 544390599920 | 04/09/19:14:15.673 | DEBUG | 6 | TCEmsClient | setToken 2020-04-09 19:14:15.673 23539-23593/com.apptmyz.twilioexample D/TWC: TCEmsClient: 544390599920 | 04/09/19:14:15.673 | DEBUG | 6 | TCEmsClient | runGenerateTokenTask 2020-04-09 19:14:15.677 23539-23593/com.apptmyz.twilioexample D/TWC: ChatContinuationTokenStorage(native): 544390599920 | 04/09/19:14:15.676 | DEBUG | ChatContinuationTokenStorage(native) | retrieveTokenFromStorage 2020-04-09 19:14:15.677 23539-23593/com.apptmyz.twilioexample D/TWC: ChatContinuationTokenStorage(native): 544390599920 | 04/09/19:14:15.677 | DEBUG | ChatContinuationTokenStorage(native) | fetchContinuationToken retrieved token `` under key default 2020-04-09 19:14:15.678 23539-23593/com.apptmyz.twilioexample D/TWC: TCHttpObserver: 544390599920 | 04/09/19:14:15.677 | DEBUG | 11 | TCHttpObserver | client: version: 2.5.5, build id: 1, build branch: refs/heads/master, os: android, arch: arm64-v8a 2020-04-09 19:14:15.678 23539-23593/com.apptmyz.twilioexample I/TWC: TNHttpTransportClient: 544390599920 | 04/09/19:14:15.678 | INFO | 4 | TNHttpTransportClient | requestId=RQ716fe058049b431ca2d8d869abea88f0, enqueueing request to: https://ems.us1.twilio.com/v1/token 2020-04-09 19:14:15.678 23539-23593/com.apptmyz.twilioexample D/TWC: TCEmsClient: 544390599920 | 04/09/19:14:15.678 | DEBUG | 6 | TCEmsClient | setToken - end 2020-04-09 19:14:17.641 23539-23585/com.apptmyz.twilioexample I/TWC: TNTwilsockClient: 544409113840 | 04/09/19:14:17.641 | INFO | 1 | TNTwilsockClient | retryTimeoutImpl >> Retry connect 2020-04-09 19:14:17.641 23539-23585/com.apptmyz.twilioexample D/TWC: TNTwilsockClientImpl: 544409113840 | 04/09/19:14:17.641 | DEBUG | 3 | TNTwilsockClientImpl | connect 2020-04-09 19:14:17.641 23539-23585/com.apptmyz.twilioexample I/TWC: TNRetryConnectState: 544409113840 | 04/09/19:14:17.641 | INFO | 10 | TNRetryConnectState | Leaving state: Retry connect 2020-04-09 19:14:17.641 23539-23585/com.apptmyz.twilioexample D/TWC: TNTwilsockClientImpl: 544409113840 | 04/09/19:14:17.641 | DEBUG | 3 | TNTwilsockClientImpl | stopRetryTimer 2020-04-09 19:14:17.642 23539-23585/com.apptmyz.twilioexample I/TWC: TNTwilsockClient: 544409113840 | 04/09/19:14:17.642 | INFO | 1 | TNTwilsockClient | Change state: Retry connect --> Transport connecting 2020-04-09 19:14:17.642 23539-23585/com.apptmyz.twilioexample I/TWC: TNTransportConnectingState: 544409113840 | 04/09/19:14:17.642 | INFO | 8 | TNTransportConnectingState | Entering state: Transport connecting 2020-04-09 19:14:17.642 23539-23604/com.apptmyz.twilioexample D/TWC: TNWebsocket: 544379155696 | 04/09/19:14:17.642 | DEBUG | 7 | TNWebsocket | Connecting... 2020-04-09 19:14:17.642 23539-23585/com.apptmyz.twilioexample D/TWC: TNTwilsockClientImpl: 544409113840 | 04/09/19:14:17.642 | DEBUG | 3 | TNTwilsockClientImpl | startTransportConnectingTimer 2020-04-09 19:14:17.642 23539-23604/com.apptmyz.twilioexample D/TWC: TNWebsocket: 544379155696 | 04/09/19:14:17.642 | DEBUG | 7 | TNWebsocket | Using proxy : except () 2020-04-09 19:14:17.642 23539-23604/com.apptmyz.twilioexample D/TWC: TNWebsocket: 544379155696 | 04/09/19:14:17.642 | DEBUG | 7 | TNWebsocket | Trying to establish connection to: https://tsock.us1.twilio.com 2020-04-09 19:14:18.125 23539-23604/com.apptmyz.twilioexample W/TWC: TNWebsocket: 544379155696 | 04/09/19:14:18.125 | WARNING | 7 | TNWebsocket | Poco net exception while connecting: SSL Exception: error:1000007e:SSL routines:OPENSSL_internal:CERTIFICATE_VERIFY_FAILED 2020-04-09 19:14:18.126 23539-23585/com.apptmyz.twilioexample I/TWC: TNTwilsockClient: 544409113840 | 04/09/19:14:18.126 | INFO | 1 | TNTwilsockClient | onErrorImpl >> Transport connecting 2020-04-09 19:14:18.126 23539-23585/com.apptmyz.twilioexample D/TWC: TNTwilsockClientImpl: 544409113840 | 04/09/19:14:18.126 | DEBUG | 3 | TNTwilsockClientImpl | notifyAboutError 2020-04-09 19:14:18.126 23539-23585/com.apptmyz.twilioexample D/TWC: TNTwilsockClientImpl: 544409113840 | 04/09/19:14:18.126 | DEBUG | 3 | TNTwilsockClientImpl | disconnect 2020-04-09 19:14:18.126 23539-23585/com.apptmyz.twilioexample D/TWC: TNWebsocket: 544409113840 | 04/09/19:14:18.126 | DEBUG | 7 | TNWebsocket | Disconnect 2020-04-09 19:14:18.126 23539-23585/com.apptmyz.twilioexample D/TWC: TNWebsocket: 544409113840 | 04/09/19:14:18.126 | DEBUG | 7 | TNWebsocket | Reset session 2020-04-09 19:14:18.127 23539-23604/com.apptmyz.twilioexample D/TWC: TNWebsocket: 544379155696 | 04/09/19:14:18.127 | DEBUG | 7 | TNWebsocket | Disconnecting... 2020-04-09 19:14:18.127 23539-23604/com.apptmyz.twilioexample D/TWC: TNWebsocket: 544379155696 | 04/09/19:14:18.127 | DEBUG | 7 | TNWebsocket | Disconnected 2020-04-09 19:14:18.127 23539-23604/com.apptmyz.twilioexample D/TWC: TNTwilsockClient: 544379155696 | 04/09/19:14:18.127 | DEBUG | 1 | TNTwilsockClient | onDisconnected 2020-04-09 19:14:18.127 23539-23585/com.apptmyz.twilioexample I/TWC: TNTwilsockClient: 544409113840 | 04/09/19:14:18.127 | INFO | 1 | TNTwilsockClient | onDisconnectedImpl >> Transport connecting 2020-04-09 19:14:18.127 23539-23585/com.apptmyz.twilioexample I/TWC: TNTransportConnectingState: 544409113840 | 04/09/19:14:18.127 | INFO | 8 | TNTransportConnectingState | Leaving state: Transport connecting 2020-04-09 19:14:18.127 23539-23585/com.apptmyz.twilioexample D/TWC: TNTwilsockClientImpl: 544409113840 | 04/09/19:14:18.127 | DEBUG | 3 | TNTwilsockClientImpl | stopTransportConnectingTimer 2020-04-09 19:14:18.128 23539-23585/com.apptmyz.twilioexample I/TWC: TNTwilsockClient: 544409113840 | 04/09/19:14:18.128 | INFO | 1 | TNTwilsockClient | Change state: Transport connecting --> Retry connect 2020-04-09 19:14:18.128 23539-23585/com.apptmyz.twilioexample I/TWC: TNRetryConnectState: 544409113840 | 04/09/19:14:18.128 | INFO | 10 | TNRetryConnectState | Entering state: Retry connect 2020-04-09 19:14:18.128 23539-23585/com.apptmyz.twilioexample I/TWC: TNTwilsockClient: 544409113840 | 04/09/19:14:18.128 | INFO | 1 | TNTwilsockClient | stopUpstreamRequests 2020-04-09 19:14:18.128 23539-23585/com.apptmyz.twilioexample D/TWC: TNTwilsockClientImpl: 544409113840 | 04/09/19:14:18.128 | DEBUG | 3 | TNTwilsockClientImpl | startRetryTimer 8000 2020-04-09 19:14:20.683 23539-23587/com.apptmyz.twilioexample D/TWC: TNHttpTransportClient: 544396842224 | 04/09/19:14:20.683 | DEBUG | 4 | TNHttpTransportClient | dequeueing request: RQ716fe058049b431ca2d8d869abea88f0 2020-04-09 19:14:20.683 23539-23587/com.apptmyz.twilioexample D/TWC: TCHttpObserver: 544396842224 | 04/09/19:14:20.683 | DEBUG | 11 | TCHttpObserver | onFailed - begin 2020-04-09 19:14:20.683 23539-23587/com.apptmyz.twilioexample W/TWC: TCHttpObserver: 544396842224 | 04/09/19:14:20.683 | WARNING | 11 | TCHttpObserver | Request has failed: Transport connection closed (3) 2020-04-09 19:14:20.683 23539-23587/com.apptmyz.twilioexample D/TWC: TCHttpObserver: 544396842224 | 04/09/19:14:20.683 | DEBUG | 11 | TCHttpObserver | setPromise - 3 2020-04-09 19:14:20.683 23539-23587/com.apptmyz.twilioexample D/TWC: TCBackoffEmsClient: 544396842224 | 04/09/19:14:20.683 | DEBUG | 5 | TCBackoffEmsClient | internal set token result: 3 2020-04-09 19:14:20.684 23539-23587/com.apptmyz.twilioexample D/TWC: TCEmsClient: 544396842224 | 04/09/19:14:20.684 | DEBUG | 6 | TCEmsClient | runGenerateTokenTask 2020-04-09 19:14:20.684 23539-23587/com.apptmyz.twilioexample D/TWC: TCHttpObserver: 544396842224 | 04/09/19:14:20.684 | DEBUG | 11 | TCHttpObserver | onFailed - end 2020-04-09 19:14:20.684 23539-23587/com.apptmyz.twilioexample D/TWC: TCHttpObserver: 544396842224 | 04/09/19:14:20.684 | DEBUG | 11 | TCHttpObserver | ~TCHttpObserver - begin 2020-04-09 19:14:20.684 23539-23587/com.apptmyz.twilioexample D/TWC: TCHttpObserver: 544396842224 | 04/09/19:14:20.684 | DEBUG | 11 | TCHttpObserver | ~TCHttpObserver - end 2020-04-09 19:14:20.684 23539-23597/com.apptmyz.twilioexample D/TWC: TCBackoffEmsClient: 544386438384 | 04/09/19:14:20.684 | DEBUG | 5 | TCBackoffEmsClient | internal set token run... 2020-04-09 19:14:20.684 23539-23597/com.apptmyz.twilioexample D/TWC: TCEmsClient: 544386438384 | 04/09/19:14:20.684 | DEBUG | 6 | TCEmsClient | setToken 2020-04-09 19:14:20.684 23539-23597/com.apptmyz.twilioexample D/TWC: TCEmsClient: 544386438384 | 04/09/19:14:20.684 | DEBUG | 6 | TCEmsClient | runGenerateTokenTask 2020-04-09 19:14:20.688 23539-23597/com.apptmyz.twilioexample D/TWC: ChatContinuationTokenStorage(native): 544386438384 | 04/09/19:14:20.687 | DEBUG | ChatContinuationTokenStorage(native) | retrieveTokenFromStorage 2020-04-09 19:14:20.689 23539-23597/com.apptmyz.twilioexample D/TWC: ChatContinuationTokenStorage(native): 544386438384 | 04/09/19:14:20.688 | DEBUG | ChatContinuationTokenStorage(native) | fetchContinuationToken retrieved token `` under key default 2020-04-09 19:14:20.689 23539-23597/com.apptmyz.twilioexample D/TWC: TCHttpObserver: 544386438384 | 04/09/19:14:20.689 | DEBUG | 12 | TCHttpObserver | client: version: 2.5.5, build id: 1, build branch: refs/heads/master, os: android, arch: arm64-v8a 2020-04-09 19:14:20.689 23539-23597/com.apptmyz.twilioexample I/TWC: TNHttpTransportClient: 544386438384 | 04/09/19:14:20.689 | INFO | 4 | TNHttpTransportClient | requestId=RQ657b898558e7414c88e99c6453f36840, enqueueing request to: https://ems.us1.twilio.com/v1/token 2020-04-09 19:14:20.689 23539-23597/com.apptmyz.twilioexample D/TWC: TCEmsClient: 544386438384 | 04/09/19:14:20.689 | DEBUG | 6 | TCEmsClient | setToken - end 2020-04-09 19:14:25.694 23539-23600/com.apptmyz.twilioexample D/TWC: TNHttpTransportClient: 544383317232 | 04/09/19:14:25.694 | DEBUG | 4 | TNHttpTransportClient | dequeueing request: RQ657b898558e7414c88e99c6453f36840 2020-04-09 19:14:25.695 23539-23600/com.apptmyz.twilioexample D/TWC: TCHttpObserver: 544383317232 | 04/09/19:14:25.695 | DEBUG | 12 | TCHttpObserver | onFailed - begin 2020-04-09 19:14:25.695 23539-23600/com.apptmyz.twilioexample W/TWC: TCHttpObserver: 544383317232 | 04/09/19:14:25.695 | WARNING | 12 | TCHttpObserver | Request has failed: Transport connection closed (3) 2020-04-09 19:14:25.695 23539-23600/com.apptmyz.twilioexample D/TWC: TCHttpObserver: 544383317232 | 04/09/19:14:25.695 | DEBUG | 12 | TCHttpObserver | setPromise - 3 2020-04-09 19:14:25.695 23539-23600/com.apptmyz.twilioexample D/TWC: TCBackoffEmsClient: 544383317232 | 04/09/19:14:25.695 | DEBUG | 5 | TCBackoffEmsClient | internal set token result: 3 2020-04-09 19:14:25.695 23539-23600/com.apptmyz.twilioexample I/TWC: TCBackoffEmsClient: 544383317232 | 04/09/19:14:25.695 | INFO | 5 | TCBackoffEmsClient | backoff result: 2 - 'Time is exceeded', setToken result: 3 2020-04-09 19:14:25.695 23539-23600/com.apptmyz.twilioexample D/TWC: TCBackoffEmsClient: 544383317232 | 04/09/19:14:25.695 | DEBUG | 5 | TCBackoffEmsClient | scheduleSetToken 2020-04-09 19:14:25.695 23539-23600/com.apptmyz.twilioexample D/TWC: TCEmsClient: 544383317232 | 04/09/19:14:25.695 | DEBUG | 6 | TCEmsClient | runGenerateTokenTask 2020-04-09 19:14:25.696 23539-23600/com.apptmyz.twilioexample D/TWC: TCHttpObserver: 544383317232 | 04/09/19:14:25.696 | DEBUG | 12 | TCHttpObserver | onFailed - end 2020-04-09 19:14:25.696 23539-23600/com.apptmyz.twilioexample D/TWC: TCHttpObserver: 544383317232 | 04/09/19:14:25.696 | DEBUG | 12 | TCHttpObserver | ~TCHttpObserver - begin 2020-04-09 19:14:25.696 23539-23600/com.apptmyz.twilioexample D/TWC: TCHttpObserver: 544383317232 | 04/09/19:14:25.696 | DEBUG | 12 | TCHttpObserver | ~TCHttpObserver - end 2020-04-09 19:14:25.697 23539-23584/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7ed5697138 for method <init>(ILjava/lang/String;)V 2020-04-09 19:14:25.698 23539-23584/com.apptmyz.twilioexample D/TWC: TNTwilsockClient: 544410154224 | 04/09/19:14:25.698 | DEBUG | 1 | TNTwilsockClient | ~TNTwilsockClient - begin 2020-04-09 19:14:25.698 23539-23584/com.apptmyz.twilioexample D/TWC: TNTwilsockClient: 544410154224 | 04/09/19:14:25.698 | DEBUG | 1 | TNTwilsockClient | Cleaning observers list - begin 2020-04-09 19:14:25.698 23539-23584/com.apptmyz.twilioexample D/TWC: TNTwilsockClient: 544410154224 | 04/09/19:14:25.698 | DEBUG | 1 | TNTwilsockClient | Cleaning observers list - end 2020-04-09 19:14:25.698 23539-23584/com.apptmyz.twilioexample D/TWC: TNTwilsockClient: 544410154224 | 04/09/19:14:25.698 | DEBUG | 1 | TNTwilsockClient | cleanup_threads - begin 2020-04-09 19:14:25.699 23539-23584/com.apptmyz.twilioexample D/TWC: TNTwilsockClient: 544410154224 | 04/09/19:14:25.699 | DEBUG | 1 | TNTwilsockClient | Default thread pool: Available: 16; Capacity: 16 2020-04-09 19:14:25.699 23539-23604/com.apptmyz.twilioexample D/TWC: TNWebsocket: 544379155696 | 04/09/19:14:25.699 | DEBUG | 7 | TNWebsocket | close 2020-04-09 19:14:25.699 23539-23539/com.apptmyz.twilioexample E/error: Request to EMS service has failed, unable to set FPA token 2020-04-09 19:14:25.700 23539-23584/com.apptmyz.twilioexample D/TWC: TNTwilsockClient: 544410154224 | 04/09/19:14:25.700 | DEBUG | 1 | TNTwilsockClient | cleanup_threads - end 2020-04-09 19:14:25.700 23539-23584/com.apptmyz.twilioexample D/TWC: TNTwilsockClient: 544410154224 | 04/09/19:14:25.700 | DEBUG | 1 | TNTwilsockClient | ~TNTwilsockClient - end 2020-04-09 19:14:25.700 23539-23584/com.apptmyz.twilioexample D/TWC: TNWebsocket: 544410154224 | 04/09/19:14:25.700 | DEBUG | 7 | TNWebsocket | ~TNWebsocket - begin 2020-04-09 19:14:25.700 23539-23584/com.apptmyz.twilioexample D/TWC: TNWebsocket: 544410154224 | 04/09/19:14:25.700 | DEBUG | 7 | TNWebsocket | Reset session 2020-04-09 19:14:25.700 23539-23584/com.apptmyz.twilioexample D/TWC: TNWebsocket: 544410154224 | 04/09/19:14:25.700 | DEBUG | 7 | TNWebsocket | ~TNWebsocket - end 2020-04-09 19:14:25.700 23539-23539/com.apptmyz.twilioexample E/error code: 3 2020-04-09 19:14:25.701 23539-23539/com.apptmyz.twilioexample E/error: Request to EMS service has failed, unable to set FPA token 2020-04-09 19:14:25.702 23539-23584/com.apptmyz.twilioexample D/TWC: TNTwilsockClientImpl: 544410154224 | 04/09/19:14:25.702 | DEBUG | 3 | TNTwilsockClientImpl | destructed

rusmonster commented 4 years ago

Hi @NeerajaGandla! The log says it cannot connect because of SSL error. btw SDK 3.1.1 is really old. Could you update to 5.0.1 and provide logs if problem still occurred? https://bintray.com/twilio/releases/chat-android/5.0.1

NeerajaGandla commented 4 years ago

Hi @rusmonster I have updated the SDK Version to 5.0.1. The previous problem doesn't appear now. But there's another error regarding CERTIFICATE_VERIFY_FAILED. Please have a look at the logs below and advise accordingly:

2020-04-10 10:39:47.014 9527-9527/com.apptmyz.twilioexample W/ActivityThread: handleWindowVisibility: no activity for token android.os.BinderProxy@c11bfbe 2020-04-10 10:39:47.037 9527-9527/com.apptmyz.twilioexample D/ChatClient: Application foregrounded 2020-04-10 10:39:47.037 9527-9576/com.apptmyz.twilioexample D/TWC: 3 | Twilsock Client | reconnect - begin 2020-04-10 10:39:47.037 9527-9576/com.apptmyz.twilioexample D/TWC: 3 | Twilsock Client | reconnect 2020-04-10 10:39:47.037 9527-9576/com.apptmyz.twilioexample D/TWC: 3 | Twilsock Client | reconnect - end 2020-04-10 10:39:48.187 9527-9527/com.apptmyz.twilioexample E/test: test 2020-04-10 10:39:48.190 9527-9527/com.apptmyz.twilioexample I/ChatClient: T**wilio Chat SDK version 5.0.1-cb4f7d0b** 2020-04-10 10:39:48.190 9527-9527/com.apptmyz.twilioexample D/ChatClient: Subscribed to ActivityLifecycleCallbacks 2020-04-10 10:39:48.190 9527-9527/com.apptmyz.twilioexample D/ChatClient: Subscribed to ComponentCallbacks2 2020-04-10 10:39:48.192 9527-9527/com.apptmyz.twilioexample D/ChatClient: BOARD msm8953 2020-04-10 10:39:48.193 9527-9527/com.apptmyz.twilioexample D/ChatClient: BRAND motorola 2020-04-10 10:39:48.193 9527-9527/com.apptmyz.twilioexample D/ChatClient: DEVICE river 2020-04-10 10:39:48.193 9527-9527/com.apptmyz.twilioexample D/ChatClient: DISPLAY PPOS29.80-61-2 2020-04-10 10:39:48.193 9527-9527/com.apptmyz.twilioexample D/ChatClient: FINGERPRINT motorola/river/river:9/PPOS29.80-61-2/b7f44:user/release-keys 2020-04-10 10:39:48.193 9527-9527/com.apptmyz.twilioexample D/ChatClient: HARDWARE qcom 2020-04-10 10:39:48.193 9527-9527/com.apptmyz.twilioexample D/ChatClient: MANUFACTURER motorola 2020-04-10 10:39:48.193 9527-9527/com.apptmyz.twilioexample D/ChatClient: MODEL moto g(7) 2020-04-10 10:39:48.193 9527-9527/com.apptmyz.twilioexample D/ChatClient: PRODUCT river 2020-04-10 10:39:48.193 9527-9576/com.apptmyz.twilioexample D/TWC: | SDK ChatClient(native) | Started ChatClient nativeCreate() 2020-04-10 10:39:48.193 9527-9527/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7da55b5900 for method onMessageAdded(Lcom/twilio/chat/Message;)V 2020-04-10 10:39:48.193 9527-9527/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7da55b5950 for method onMessageUpdated(Lcom/twilio/chat/Message;Lcom/twilio/chat/Message$UpdateReason;)V 2020-04-10 10:39:48.193 9527-9527/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7da55b5928 for method onMessageDeleted(Lcom/twilio/chat/Message;)V 2020-04-10 10:39:48.193 9527-9527/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7da55b5888 for method onMemberAdded(Lcom/twilio/chat/Member;)V 2020-04-10 10:39:48.193 9527-9527/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7da55b58d8 for method onMemberUpdated(Lcom/twilio/chat/Member;Lcom/twilio/chat/Member$UpdateReason;)V 2020-04-10 10:39:48.193 9527-9527/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7da55b58b0 for method onMemberDeleted(Lcom/twilio/chat/Member;)V 2020-04-10 10:39:48.194 9527-9527/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7da55b59c8 for method onTypingStarted(Lcom/twilio/chat/Channel;Lcom/twilio/chat/Member;)V 2020-04-10 10:39:48.194 9527-9527/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7da55b59a0 for method onTypingEnded(Lcom/twilio/chat/Channel;Lcom/twilio/chat/Member;)V 2020-04-10 10:39:48.194 9527-9527/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7da55b5978 for method onSynchronizationChanged(Lcom/twilio/chat/Channel;)V 2020-04-10 10:39:48.194 9527-9527/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7da537cfa8 for method onChannelJoined(Lcom/twilio/chat/Channel;)V 2020-04-10 10:39:48.194 9527-9527/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7da537cf80 for method onChannelInvited(Lcom/twilio/chat/Channel;)V 2020-04-10 10:39:48.194 9527-9527/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7da537cf30 for method onChannelAdded(Lcom/twilio/chat/Channel;)V 2020-04-10 10:39:48.194 9527-9527/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7da537cff8 for method onChannelUpdated(Lcom/twilio/chat/Channel;Lcom/twilio/chat/Channel$UpdateReason;)V 2020-04-10 10:39:48.194 9527-9527/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7da537cf58 for method onChannelDeleted(Lcom/twilio/chat/Channel;)V 2020-04-10 10:39:48.194 9527-9527/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7da537d0c0 for method onNewMessageNotification(Ljava/lang/String;Ljava/lang/String;J)V 2020-04-10 10:39:48.194 9527-9527/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7da537cf08 for method onAddedToChannelNotification(Ljava/lang/String;)V 2020-04-10 10:39:48.194 9527-9527/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7da537d098 for method onInvitedToChannelNotification(Ljava/lang/String;)V 2020-04-10 10:39:48.194 9527-9527/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7da537d138 for method onRemovedFromChannelNotification(Ljava/lang/String;)V 2020-04-10 10:39:48.194 9527-9527/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7da537d110 for method onNotificationSubscribed()V 2020-04-10 10:39:48.194 9527-9527/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7da537d0e8 for method onNotificationFailed(Lcom/twilio/chat/ErrorInfo;)V 2020-04-10 10:39:48.194 9527-9527/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7da537d200 for method onUserUpdated(Lcom/twilio/chat/User;Lcom/twilio/chat/User$UpdateReason;)V 2020-04-10 10:39:48.194 9527-9527/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7da537d1b0 for method onUserSubscribed(Lcom/twilio/chat/User;)V 2020-04-10 10:39:48.194 9527-9527/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7da537d1d8 for method onUserUnsubscribed(Lcom/twilio/chat/User;)V 2020-04-10 10:39:48.194 9527-9527/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7da537d020 for method onClientSynchronization(Lcom/twilio/chat/ChatClient$SynchronizationStatus;)V 2020-04-10 10:39:48.194 9527-9527/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7da537d048 for method onConnectionStateChange(Lcom/twilio/chat/ChatClient$ConnectionState;)V 2020-04-10 10:39:48.194 9527-9527/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7da537d070 for method onError(Lcom/twilio/chat/ErrorInfo;)V 2020-04-10 10:39:48.194 9527-9527/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7da537d188 for method onTokenExpired()V 2020-04-10 10:39:48.194 9527-9527/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7da537d160 for method onTokenAboutToExpire()V 2020-04-10 10:39:48.194 9527-9576/com.apptmyz.twilioexample I/TWC: 34 | Twilio ThreadedExecutor.Impl | Creating 16 threads in the executor pool 2020-04-10 10:39:48.196 9527-9820/com.apptmyz.twilioexample D/jni_mate: Got method ID 0x7da4b06e00 for method <init>(Landroid/content/Context;)V 2020-04-10 10:39:48.197 9527-9576/com.apptmyz.twilioexample D/TWC: | SDK ChatContinuationTokenStorage(native) | ctor 2020-04-10 10:39:48.197 9527-9576/com.apptmyz.twilioexample I/TWC: | Sync NotificationRouter | Registering interest in notification events 2020-04-10 10:39:48.197 9527-9576/com.apptmyz.twilioexample D/TWC: 36 | Twilsock Client | addObserverImpl in state Disconnected 2020-04-10 10:39:48.197 9527-9576/com.apptmyz.twilioexample D/TWC: | SDK TwilsockObserver | Disconnected 2020-04-10 10:39:48.197 9527-9576/com.apptmyz.twilioexample D/TWC: | SDK ChatClientListener(native) | onTransportStateChanged 2020-04-10 10:39:48.198 9527-9576/com.apptmyz.twilioexample D/TWC: | SDK ChatClient(native) | Creating notification client 2020-04-10 10:39:48.198 9527-9576/com.apptmyz.twilioexample D/TWC: | SDK ChatClient(native) | Creating the ChatClient. Endpoint platform is Android|5.0.1-cb4f7d0b|Motorola|Motorola moto g(7)| 2020-04-10 10:39:48.198 9527-9576/com.apptmyz.twilioexample D/TWC: | Chat IPM | client: platform: Android|5.0.1-cb4f7d0b|Motorola|Motorola moto g(7)| 2020-04-10 10:39:48.198 9527-9576/com.apptmyz.twilioexample D/TWC: 36 | Twilsock Client | connectImpl in state Disconnected 2020-04-10 10:39:48.198 9527-9576/com.apptmyz.twilioexample D/TWC: 36 | Twilsock Client | doConnect 2020-04-10 10:39:48.198 9527-9576/com.apptmyz.twilioexample D/TWC: | Chat IPM | 8 concurrent threads are supported 2020-04-10 10:39:48.198 9527-9576/com.apptmyz.twilioexample I/TWC: 59 | Sync Subscriptions | constructed 2020-04-10 10:39:48.198 9527-9576/com.apptmyz.twilioexample I/TWC: 39 | Twilsock State.Disconnected | Leaving state: Disconnected 2020-04-10 10:39:48.198 9527-9576/com.apptmyz.twilioexample I/TWC: 40 | Twilsock State.Connecting | Entering state: Connecting 2020-04-10 10:39:48.198 9527-9576/com.apptmyz.twilioexample D/TWC: 36 | Twilsock Client | startTransportConnectingTimer timeout: 60 2020-04-10 10:39:48.198 9527-9576/com.apptmyz.twilioexample I/TWC: 60 | Sync NotificationRouter | constructed 2020-04-10 10:39:48.198 9527-9576/com.apptmyz.twilioexample D/TWC: 57 | Twilsock Websocket | Connecting... 2020-04-10 10:39:48.198 9527-9576/com.apptmyz.twilioexample D/TWC: 36 | Twilsock Client | notifyAboutConnecting 2020-04-10 10:39:48.198 9527-9576/com.apptmyz.twilioexample I/TWC: 62 | Sync CoreDataService | constructed 2020-04-10 10:39:48.198 9527-9576/com.apptmyz.twilioexample D/TWC: | SDK TwilsockObserver | Connecting 2020-04-10 10:39:48.198 9527-9576/com.apptmyz.twilioexample D/TWC: | SDK ChatClientListener(native) | onTransportStateChanged 2020-04-10 10:39:48.198 9527-9576/com.apptmyz.twilioexample D/TWC: 36 | Twilsock Client | addObserverImpl in state Connecting 2020-04-10 10:39:48.198 9527-9576/com.apptmyz.twilioexample I/TWC: 60 | Sync NotificationRouter | Transport state changed. Is enabled: 0 2020-04-10 10:39:48.198 9527-9576/com.apptmyz.twilioexample I/TWC: | Chat IPM | [DULEj] client: StateNoState->StateNotInitialized 2020-04-10 10:39:48.199 9527-9576/com.apptmyz.twilioexample I/TWC: | Chat IPM | [DULEj] client: StateNotInitialized->StateInitializing 2020-04-10 10:39:48.199 9527-9576/com.apptmyz.twilioexample D/TWC: 36 | Twilsock Client | addObserverImpl in state Connecting 2020-04-10 10:39:48.199 9527-9576/com.apptmyz.twilioexample I/TWC: | Chat IPM | session: start initialization 2020-04-10 10:39:48.199 9527-9576/com.apptmyz.twilioexample I/TWC: | Chat IPM | [listener] on client sync 0 2020-04-10 10:39:48.199 9527-9576/com.apptmyz.twilioexample D/TWC: | Chat IPM | [listener] on subscribed 2020-04-10 10:39:48.199 9527-9576/com.apptmyz.twilioexample I/TWC: | Chat IPM | [e82fY] session: StateNoState->StateNotInitialized 2020-04-10 10:39:48.199 9527-9576/com.apptmyz.twilioexample I/TWC: | Chat IPM | [e82fY] session: StateNotInitialized->StateInitializing 2020-04-10 10:39:48.199 9527-9576/com.apptmyz.twilioexample I/TWC: 63 | Sync List | constructed 2020-04-10 10:39:48.199 9527-9576/com.apptmyz.twilioexample I/TWC: 64 | Sync TSCollectionCreateActivity | constructed 2020-04-10 10:39:48.199 9527-9576/com.apptmyz.twilioexample I/TWC: 64 | Sync TSCollectionCreateActivity | start 1 2020-04-10 10:39:48.199 9527-9576/com.apptmyz.twilioexample I/TWC: 63 | Sync List | create action id: 1, name: '[nullopt]', purpose: com.twilio.rtd.ipmsg 2020-04-10 10:39:48.199 9527-9576/com.apptmyz.twilioexample D/TWC: | Chat IPM | session: start initialization done 2020-04-10 10:39:48.199 9527-9576/com.apptmyz.twilioexample D/TWC: | Sync CoreDataActivity | retryOperation 0 2020-04-10 10:39:48.199 9527-9576/com.apptmyz.twilioexample D/TWC: | Sync CoreDataActivity | retryOperation calling retrierAttempt 2020-04-10 10:39:48.199 9527-9576/com.apptmyz.twilioexample D/TWC: | SDK ChatClient(native) | Completed ChatClient nativeCreate() 2020-04-10 10:39:48.199 9527-9576/com.apptmyz.twilioexample I/TWC: | Sync CoreDataActivity | query [0] /v3/Lists 2020-04-10 10:39:48.199 9527-9576/com.apptmyz.twilioexample D/TWC: | SDK ChatClientListener(native) | onClientSynchronization 2020-04-10 10:39:48.199 9527-9576/com.apptmyz.twilioexample I/TWC: | Twilsock Message::makePayload | Payload size 160 2020-04-10 10:39:48.199 9527-9576/com.apptmyz.twilioexample I/TWC: | Twilsock Message::encode | Read Payload to string {"context":{"apiVersion":"3","endpointPlatform":"Android|5.0.1-cb4f7d0b|Motorola|Motorola moto g(7)|","type":"channelSession"},"purpose":"com.twilio.rtd.ipmsg"} 2020-04-10 10:39:48.199 9527-9576/com.apptmyz.twilioexample D/TWC: 36 | Twilsock Client | sendRequestImpl in state Connecting : requestId=RQd783cdb4022f431bad007d54f294b93f, Host: cds.us1.twilio.com, path: /v3/Lists 2020-04-10 10:39:48.199 9527-9576/com.apptmyz.twilioexample D/TWC: 36 | Twilsock Client | In state: Connecting, save event for future performing: UpstreamRequest (current size: 0) 2020-04-10 10:39:48.199 9527-9576/com.apptmyz.twilioexample D/TWC: 40 | Twilsock Connecting | Unable to send message in this state, sending rescheduled with timeout=60000 2020-04-10 10:39:48.200 9527-9811/com.apptmyz.twilioexample D/ChatClientListenerForwarder: Client synchronization update - STARTED 2020-04-10 10:39:48.200 9527-9576/com.apptmyz.twilioexample D/TWC: | SDK ChatClientListener(native) | onNotificationSubscribed 2020-04-10 10:39:48.711 9527-9576/com.apptmyz.twilioexample E/TWC: 57 | Twilsock Websocket | reportConnectFail Failed on ssl handshake: CERTIFICATE_VERIFY_FAILED, 2 2020-04-10 10:39:48.711 9527-9576/com.apptmyz.twilioexample D/TWC: 36 | Twilsock Client | onTransportDisconnected in state Connecting 2020-04-10 10:39:48.711 9527-9576/com.apptmyz.twilioexample D/TWC: 36 | Twilsock Client | onTransportDisconnectedImpl in state Connecting 2020-04-10 10:39:48.711 9527-9576/com.apptmyz.twilioexample D/TWC: 36 | Twilsock Client | notifyAboutDisconnected: Failed on ssl handshake: CERTIFICATE_VERIFY_FAILED 2020-04-10 10:39:48.711 9527-9576/com.apptmyz.twilioexample D/TWC: 36 | Twilsock Client | stop - begin 2020-04-10 10:39:48.711 9527-9576/com.apptmyz.twilioexample D/TWC: | SDK TwilsockObserver | Disconnected 2020-04-10 10:39:48.711 9527-9576/com.apptmyz.twilioexample D/TWC: | SDK ChatClientListener(native) | onTransportStateChanged 2020-04-10 10:39:48.711 9527-9576/com.apptmyz.twilioexample D/TWC: 36 | Twilsock Client | stop - end 2020-04-10 10:39:48.711 9527-9576/com.apptmyz.twilioexample D/TWC: 36 | Twilsock Client | stopTransportConnectingTimer 2020-04-10 10:39:48.711 9527-9576/com.apptmyz.twilioexample I/TWC: 40 | Twilsock State.Connecting | Leaving state: Connecting 2020-04-10 10:39:48.711 9527-9576/com.apptmyz.twilioexample I/TWC: 38 | Twilsock State.Final | Entering state: Final state 2020-04-10 10:39:48.712 9527-9576/com.apptmyz.twilioexample I/TWC: 60 | Sync NotificationRouter | Transport state changed. Is enabled: 0 2020-04-10 10:40:17.433 9527-9527/com.apptmyz.twilioexample D/ChatClient: Application backgrounded 2020-04-10 10:40:17.433 9527-9527/com.apptmyz.twilioexample D/ChatClient: Application backgrounded 2020-04-10 10:40:48.260 9527-9576/com.apptmyz.twilioexample D/TWC: 64 | Sync TSCollectionCreateActivity | handleError 2020-04-10 10:40:52.607 9527-9576/com.apptmyz.twilioexample D/TWC: | Sync CoreDataActivity | retryOperation 4332 2020-04-10 10:40:52.608 9527-9576/com.apptmyz.twilioexample D/TWC: | Sync CoreDataActivity | retryOperation calling retrierAttempt 2020-04-10 10:40:52.608 9527-9576/com.apptmyz.twilioexample I/TWC: | Sync CoreDataActivity | query [0] /v3/Lists 2020-04-10 10:40:52.608 9527-9576/com.apptmyz.twilioexample W/TWC: 36 | Twilsock Client | Ignoring request: transport stopped

rusmonster commented 4 years ago

When I change the token_url in the twilio sample app to mine, it's working. The problem happens only in my app.

Did you run the twilio sample app on the same or on different device?

NeerajaGandla commented 4 years ago

On the same device.

rusmonster commented 4 years ago

And it's working means that you can see at least list of channels using the sample app. Correct?

NeerajaGandla commented 4 years ago

Yes. I'm able to view the channels using the Twilio sample app using our tokens

rusmonster commented 4 years ago

Do you have

    <uses-permission android:name="android.permission.INTERNET" />

in your app's AndroidManifest.xml ?

NeerajaGandla commented 4 years ago

Yes. I'm able to make network requests

rusmonster commented 4 years ago

How do you build ChatClient.Properties which you pass into ChatClient.create ?

NeerajaGandla commented 4 years ago
        ChatClient.Properties props = new ChatClient.Properties.Builder().setRegion("us1").createProperties();
rusmonster commented 4 years ago

copy-paste following function into your app. What does it print?

    static void printCerts(Context context) {
        int res = context.getResources().getIdentifier("rootcert", "raw", context.getPackageName());
        InputStream inputStream = context.getResources().openRawResource(res);
        final StringBuilder out = new StringBuilder();

        try {
            final int bufferSize = 4096;
            final char[] buffer = new char[bufferSize];
            Reader in = new InputStreamReader(inputStream, "UTF-8");
            while (true) {
                int rsz = in.read(buffer, 0, buffer.length);
                if (rsz < 0)
                    break;
                out.append(buffer, 0, rsz);
            }
            for (String s : out.toString().split("\n")) {
                Log.d("!!!", s);
            }
        } catch (Exception e) {
            Log.e("!!!","error in printCerts: ", e);
        } finally {
            try {
                inputStream.close();
            } catch (IOException e) {
                e.printStackTrace();
            }
        }
    }
NeerajaGandla commented 4 years ago

It printed the certificate. Here's the entire logcat if that would help you.

04/10 22:43:11: Launching 'app' on motorola moto g(7). $ adb shell am start -n "com.apptmyz.twilioexample/com.apptmyz.twilioexample.ChatScreen" -a android.intent.action.MAIN -c android.intent.category.LAUNCHER Connected to process 31068 on device 'motorola-moto_g7-ZF6224BDLT'. Capturing and displaying logcat messages from application. This behavior can be disabled in the "Logcat output" section of the "Debugger" settings page. I/z.twilioexampl: The ClassLoaderContext is a special shared library. I/FirebaseInitProvider: FirebaseApp initialization unsuccessful I/CrashlyticsInitProvider: CrashlyticsInitProvider skipping initialization W/z.twilioexampl: Accessing hidden method Landroid/graphics/drawable/Drawable;->getOpticalInsets()Landroid/graphics/Insets; (light greylist, linking) Accessing hidden field Landroid/graphics/Insets;->left:I (light greylist, linking) Accessing hidden field Landroid/graphics/Insets;->right:I (light greylist, linking) Accessing hidden field Landroid/graphics/Insets;->top:I (light greylist, linking) Accessing hidden field Landroid/graphics/Insets;->bottom:I (light greylist, linking) W/z.twilioexampl: Accessing hidden method Landroid/view/View;->computeFitSystemWindows(Landroid/graphics/Rect;Landroid/graphics/Rect;)Z (light greylist, reflection) W/z.twilioexampl: Accessing hidden method Landroid/view/ViewGroup;->makeOptionalFitsSystemWindows()V (light greylist, reflection) W/z.twilioexampl: Accessing hidden method Landroid/widget/TextView;->getTextDirectionHeuristic()Landroid/text/TextDirectionHeuristic; (light greylist, linking) D/!!!: -----BEGIN CERTIFICATE----- MIIEIDCCAwigAwIBAgIQNE7VVyDV7exJ9C/ON9srbTANBgkqhkiG9w0BAQUFADCB qTELMAkGA1UEBhMCVVMxFTATBgNVBAoTDHRoYXd0ZSwgSW5jLjEoMCYGA1UECxMf Q2VydGlmaWNhdGlvbiBTZXJ2aWNlcyBEaXZpc2lvbjE4MDYGA1UECxMvKGMpIDIw MDYgdGhhd3RlLCBJbmMuIC0gRm9yIGF1dGhvcml6ZWQgdXNlIG9ubHkxHzAdBgNV BAMTFnRoYXd0ZSBQcmltYXJ5IFJvb3QgQ0EwHhcNMDYxMTE3MDAwMDAwWhcNMzYw NzE2MjM1OTU5WjCBqTELMAkGA1UEBhMCVVMxFTATBgNVBAoTDHRoYXd0ZSwgSW5j LjEoMCYGA1UECxMfQ2VydGlmaWNhdGlvbiBTZXJ2aWNlcyBEaXZpc2lvbjE4MDYG A1UECxMvKGMpIDIwMDYgdGhhd3RlLCBJbmMuIC0gRm9yIGF1dGhvcml6ZWQgdXNl IG9ubHkxHzAdBgNVBAMTFnRoYXd0ZSBQcmltYXJ5IFJvb3QgQ0EwggEiMA0GCSqG SIb3DQEBAQUAA4IBDwAwggEKAoIBAQCsoPD7gFnUnMekz52hWXMJEEUMDSxuaPFs W0hoSVk3/AszGcJ3f8wQLZU0HObrTQmnHNK4yZc2AreJ1CRfBsDMRJSUjQJib+ta 3RGNKJpchJAQeg29dGYvajig4tVUROsdB58Hum/u6f1OCyn1PoSgAfGcq/gcfomk 6KHYcWUNo1F77rzSImANuVud37r8UVsLr5iy6S7pBOhih94ryNdOwUxkHt3Ph1i6 Sk/KaAcdHJ1KxtUvkcx8cXIcxcBn6zL9yZJclNqFwJu/U30rCfSMnZEfl2pSy94J NqR32HuHUETVPm4pafs5SSYeCaWAe0At6+gnhcn+Yf1+5nyXHdWdAgMBAAGjQjBA MA8GA1UdEwEB/wQFMAMBAf8wDgYDVR0PAQH/BAQDAgEGMB0GA1UdDgQWBBR7W0XP r87Lev0xkhpqtvNG61dIUDANBgkqhkiG9w0BAQUFAAOCAQEAeRHAS7ORtvzw6WfU DW5FvlXok9LOAz/t2iWwHVfLHjp2oEzsUHboZHIMpKnxuIvW1oeEuzLlQRHAd9mz YJ3rG9XRbkREqaYB7FViHXe4XI5ISXycO1cRrK1zN44veFyQaEfZYGDm/Ac9IiAX xPcW6cTYcvnIc3zfFi8VqT79aie2oetaupgf1eNNZAqdE8hhuvU5HIe6uL17In/2 /qxAeeWsEG89jxt5dovEN7MhGITlNgDrYyCZuen+MwS7QcjBAvlEYyCegc5C09Y/ LHbTY5xZ3Y+m4Q6gLkH3LpVHz7z9M/P2C2F+fpErgUfCJzDupxBdN49cOSvkBPB7 jVaMaA== -----END CERTIFICATE----- D/NetworkSecurityConfig: No Network Security Config specified, using platform default D/OpenGLRenderer: Skia GL Pipeline I/Adreno: QUALCOMM build : 3d7efc4, I45f70159dc Build Date : 10/28/18 OpenGL ES Shader Compiler Version: EV031.25.03.01 Local Branch : Remote Branch : Remote Branch : Reconstruct Branch : Build Config : S L 6.0.7 AArch64 I/Adreno: PFP: 0x005ff112, ME: 0x005ff066 I/ConfigStore: android::hardware::configstore::V1_0::ISurfaceFlingerConfigs::hasWideColorDisplay retrieved: 0 android::hardware::configstore::V1_0::ISurfaceFlingerConfigs::hasHDRDisplay retrieved: 0 I/OpenGLRenderer: Initialized EGL, version 1.4 D/OpenGLRenderer: Swap behavior 2 E/test: test E/error: message I/ChatClient: Twilio Chat SDK version 5.0.1-cb4f7d0b D/ChatClient: Subscribed to ActivityLifecycleCallbacks Subscribed to ComponentCallbacks2 D/ChatClient: BOARD msm8953 BRAND motorola DEVICE river DISPLAY PPOS29.80-61-2 FINGERPRINT motorola/river/river:9/PPOS29.80-61-2/b7f44:user/release-keys HARDWARE qcom MANUFACTURER motorola MODEL moto g(7) D/ChatClient: PRODUCT river D/TWC: | SDK ChatClient(native) | Started ChatClient nativeCreate() D/jni_mate: Got method ID 0x7da55b5a58 for method onMessageAdded(Lcom/twilio/chat/Message;)V Got method ID 0x7da55b5aa8 for method onMessageUpdated(Lcom/twilio/chat/Message;Lcom/twilio/chat/Message$UpdateReason;)V Got method ID 0x7da55b5a80 for method onMessageDeleted(Lcom/twilio/chat/Message;)V Got method ID 0x7da55b59e0 for method onMemberAdded(Lcom/twilio/chat/Member;)V Got method ID 0x7da55b5a30 for method onMemberUpdated(Lcom/twilio/chat/Member;Lcom/twilio/chat/Member$UpdateReason;)V Got method ID 0x7da55b5a08 for method onMemberDeleted(Lcom/twilio/chat/Member;)V Got method ID 0x7da55b5b20 for method onTypingStarted(Lcom/twilio/chat/Channel;Lcom/twilio/chat/Member;)V Got method ID 0x7da55b5af8 for method onTypingEnded(Lcom/twilio/chat/Channel;Lcom/twilio/chat/Member;)V Got method ID 0x7da55b5ad0 for method onSynchronizationChanged(Lcom/twilio/chat/Channel;)V Got method ID 0x7da537cfa8 for method onChannelJoined(Lcom/twilio/chat/Channel;)V Got method ID 0x7da537cf80 for method onChannelInvited(Lcom/twilio/chat/Channel;)V Got method ID 0x7da537cf30 for method onChannelAdded(Lcom/twilio/chat/Channel;)V Got method ID 0x7da537cff8 for method onChannelUpdated(Lcom/twilio/chat/Channel;Lcom/twilio/chat/Channel$UpdateReason;)V Got method ID 0x7da537cf58 for method onChannelDeleted(Lcom/twilio/chat/Channel;)V Got method ID 0x7da537d0c0 for method onNewMessageNotification(Ljava/lang/String;Ljava/lang/String;J)V Got method ID 0x7da537cf08 for method onAddedToChannelNotification(Ljava/lang/String;)V Got method ID 0x7da537d098 for method onInvitedToChannelNotification(Ljava/lang/String;)V Got method ID 0x7da537d138 for method onRemovedFromChannelNotification(Ljava/lang/String;)V Got method ID 0x7da537d110 for method onNotificationSubscribed()V Got method ID 0x7da537d0e8 for method onNotificationFailed(Lcom/twilio/chat/ErrorInfo;)V Got method ID 0x7da537d200 for method onUserUpdated(Lcom/twilio/chat/User;Lcom/twilio/chat/User$UpdateReason;)V Got method ID 0x7da537d1b0 for method onUserSubscribed(Lcom/twilio/chat/User;)V Got method ID 0x7da537d1d8 for method onUserUnsubscribed(Lcom/twilio/chat/User;)V Got method ID 0x7da537d020 for method onClientSynchronization(Lcom/twilio/chat/ChatClient$SynchronizationStatus;)V Got method ID 0x7da537d048 for method onConnectionStateChange(Lcom/twilio/chat/ChatClient$ConnectionState;)V Got method ID 0x7da537d070 for method onError(Lcom/twilio/chat/ErrorInfo;)V Got method ID 0x7da537d188 for method onTokenExpired()V Got method ID 0x7da537d160 for method onTokenAboutToExpire()V I/TWC: 1 | Twilio ThreadedExecutor.Impl | Creating 16 threads in the executor pool D/jni_mate: Got method ID 0x7da4b06e00 for method (Landroid/content/Context;)V D/TWC: | SDK ChatContinuationTokenStorage(native) | ctor I/TWC: | Sync NotificationRouter | Registering interest in notification events D/TWC: 3 | Twilsock Client | addObserverImpl in state Disconnected | SDK TwilsockObserver | Disconnected | SDK ChatClientListener(native) | onTransportStateChanged | SDK ChatClient(native) | Creating notification client | SDK ChatClient(native) | Creating the ChatClient. Endpoint platform is Android|5.0.1-cb4f7d0b|Motorola|Motorola moto g(7)| | Chat IPM | client: platform: Android|5.0.1-cb4f7d0b|Motorola|Motorola moto g(7)| D/TWC: | Chat IPM | 8 concurrent threads are supported I/TWC: 25 | Sync Subscriptions | constructed 26 | Sync NotificationRouter | constructed 27 | Sync CoreDataService | constructed D/TWC: 3 | Twilsock Client | connectImpl in state Disconnected 3 | Twilsock Client | doConnect I/TWC: | Chat IPM | [Zymm4] client: StateNoState->StateNotInitialized | Chat IPM | [Zymm4] client: StateNotInitialized->StateInitializing | Chat IPM | session: start initialization | Chat IPM | [listener] on client sync 0 6 | Twilsock State.Disconnected | Leaving state: Disconnected 7 | Twilsock State.Connecting | Entering state: Connecting D/TWC: 28 | Twilsock Websocket | Connecting... 3 | Twilsock Client | startTransportConnectingTimer timeout: 60 3 | Twilsock Client | notifyAboutConnecting | Chat IPM | [listener] on subscribed I/TWC: | Chat IPM | [PNbDB] session: StateNoState->StateNotInitialized D/TWC: 3 | Twilsock Client | addObserverImpl in state Connecting I/TWC: | Chat IPM | [PNbDB] session: StateNotInitialized->StateInitializing 26 | Sync NotificationRouter | Transport state changed. Is enabled: 0 D/TWC: 3 | Twilsock Client | addObserverImpl in state Connecting | SDK TwilsockObserver | Connecting | SDK ChatClientListener(native) | onTransportStateChanged I/TWC: 30 | Sync List | constructed I/TWC: 31 | Sync TSCollectionCreateActivity | constructed 31 | Sync TSCollectionCreateActivity | start 1 30 | Sync List | create action id: 1, name: '[nullopt]', purpose: com.twilio.rtd.ipmsg D/TWC: | Sync CoreDataActivity | retryOperation 0 | Chat IPM | session: start initialization done | Sync CoreDataActivity | retryOperation calling retrierAttempt | SDK ChatClient(native) | Completed ChatClient nativeCreate() I/TWC: | Sync CoreDataActivity | query [0] /v3/Lists D/TWC: | SDK ChatClientListener(native) | onClientSynchronization I/TWC: | Twilsock Message::makePayload | Payload size 160 | Twilsock Message::encode | Read Payload to string {"context":{"apiVersion":"3","endpointPlatform":"Android|5.0.1-cb4f7d0b|Motorola|Motorola moto g(7)|","type":"channelSession"},"purpose":"com.twilio.rtd.ipmsg"} D/TWC: 3 | Twilsock Client | sendRequestImpl in state Connecting : requestId=RQ5dd0a299cdff4bef91db370d875e9939, Host: cds.us1.twilio.com, path: /v3/Lists 3 | Twilsock Client | In state: Connecting, save event for future performing: UpstreamRequest (current size: 0) 7 | Twilsock Connecting | Unable to send message in this state, sending rescheduled with timeout=60000 D/ChatClientListenerForwarder: Client synchronization update - STARTED D/TWC: | SDK ChatClientListener(native) | onNotificationSubscribed E/TWC: 28 | Twilsock Websocket | reportConnectFail Failed on ssl handshake: CERTIFICATE_VERIFY_FAILED, 2 D/TWC: 3 | Twilsock Client | onTransportDisconnected in state Connecting 3 | Twilsock Client | onTransportDisconnectedImpl in state Connecting 3 | Twilsock Client | notifyAboutDisconnected: Failed on ssl handshake: CERTIFICATE_VERIFY_FAILED D/TWC: 3 | Twilsock Client | stop - begin I/TWC: 26 | Sync NotificationRouter | Transport state changed. Is enabled: 0 D/TWC: | SDK TwilsockObserver | Disconnected | SDK ChatClientListener(native) | onTransportStateChanged 3 | Twilsock Client | stop - end 3 | Twilsock Client | stopTransportConnectingTimer I/TWC: 7 | Twilsock State.Connecting | Leaving state: Connecting I/TWC: 5 | Twilsock State.Final | Entering state: Final state D/ChatClient: Application backgrounded D/TWC: 31 | Sync TSCollectionCreateActivity | handleError D/TWC: | Sync CoreDataActivity | retryOperation 4024 | Sync CoreDataActivity | retryOperation calling retrierAttempt I/TWC: | Sync CoreDataActivity | query [0] /v3/Lists W/TWC: 3 | Twilsock Client | Ignoring request: transport stopped

berkus commented 4 years ago

Try enabling setDeferCertificateTrustToPlatform to true when creating Properties for the client.

berkus commented 4 years ago

@rusmonster looks like stored cert is invalid - its not the entire chain?

NeerajaGandla commented 4 years ago

Hi @berkus the chat client is initialized successfully now. Thanks

Try enabling setDeferCertificateTrustToPlatform to true when creating Properties for the client.

This worked

berkus commented 4 years ago

Cool @NeerajaGandla glad it works now. However, could you please help us investigate this further?

We suspect that there's some other SDK or component in your app that has overwritten rootcert file with a different version. Could you check if you have any other components added in your app, probably related to networking or some reporting facilities? Thanks!

berkus commented 4 years ago

@rusmonster this looks like thawte root cert

-----BEGIN CERTIFICATE-----
MIIEIDCCAwigAwIBAgIQNE7VVyDV7exJ9C/ON9srbTANBgkqhkiG9w0BAQUFADCB
qTELMAkGA1UEBhMCVVMxFTATBgNVBAoTDHRoYXd0ZSwgSW5jLjEoMCYGA1UECxMf
Q2VydGlmaWNhdGlvbiBTZXJ2aWNlcyBEaXZpc2lvbjE4MDYGA1UECxMvKGMpIDIw
MDYgdGhhd3RlLCBJbmMuIC0gRm9yIGF1dGhvcml6ZWQgdXNlIG9ubHkxHzAdBgNV
BAMTFnRoYXd0ZSBQcmltYXJ5IFJvb3QgQ0EwHhcNMDYxMTE3MDAwMDAwWhcNMzYw
NzE2MjM1OTU5WjCBqTELMAkGA1UEBhMCVVMxFTATBgNVBAoTDHRoYXd0ZSwgSW5j
LjEoMCYGA1UECxMfQ2VydGlmaWNhdGlvbiBTZXJ2aWNlcyBEaXZpc2lvbjE4MDYG
A1UECxMvKGMpIDIwMDYgdGhhd3RlLCBJbmMuIC0gRm9yIGF1dGhvcml6ZWQgdXNl
IG9ubHkxHzAdBgNVBAMTFnRoYXd0ZSBQcmltYXJ5IFJvb3QgQ0EwggEiMA0GCSqG
SIb3DQEBAQUAA4IBDwAwggEKAoIBAQCsoPD7gFnUnMekz52hWXMJEEUMDSxuaPFs
W0hoSVk3/AszGcJ3f8wQLZU0HObrTQmnHNK4yZc2AreJ1CRfBsDMRJSUjQJib+ta
3RGNKJpchJAQeg29dGYvajig4tVUROsdB58Hum/u6f1OCyn1PoSgAfGcq/gcfomk
6KHYcWUNo1F77rzSImANuVud37r8UVsLr5iy6S7pBOhih94ryNdOwUxkHt3Ph1i6
Sk/KaAcdHJ1KxtUvkcx8cXIcxcBn6zL9yZJclNqFwJu/U30rCfSMnZEfl2pSy94J
NqR32HuHUETVPm4pafs5SSYeCaWAe0At6+gnhcn+Yf1+5nyXHdWdAgMBAAGjQjBA
MA8GA1UdEwEB/wQFMAMBAf8wDgYDVR0PAQH/BAQDAgEGMB0GA1UdDgQWBBR7W0XP
r87Lev0xkhpqtvNG61dIUDANBgkqhkiG9w0BAQUFAAOCAQEAeRHAS7ORtvzw6WfU
DW5FvlXok9LOAz/t2iWwHVfLHjp2oEzsUHboZHIMpKnxuIvW1oeEuzLlQRHAd9mz
YJ3rG9XRbkREqaYB7FViHXe4XI5ISXycO1cRrK1zN44veFyQaEfZYGDm/Ac9IiAX
xPcW6cTYcvnIc3zfFi8VqT79aie2oetaupgf1eNNZAqdE8hhuvU5HIe6uL17In/2
/qxAeeWsEG89jxt5dovEN7MhGITlNgDrYyCZuen+MwS7QcjBAvlEYyCegc5C09Y/
LHbTY5xZ3Y+m4Q6gLkH3LpVHz7z9M/P2C2F+fpErgUfCJzDupxBdN49cOSvkBPB7
jVaMaA==
-----END CERTIFICATE-----
rusmonster commented 4 years ago

this looks like thawte root cert

@berkus Yes, it is what called thawte Primary Root CA in our rootcert file. But where are others? It looks like the rootcert file has been overwritten during merging resources as you suggested above

NeerajaGandla commented 4 years ago

@berkus I checked in my Android source code. I don't find any other components that could potentially overwrite the certificate.

berkus commented 4 years ago

Interesting @NeerajaGandla thank you for that information.

I've tracked the source, and this is indeed the original (VERY OLD) certificate we used in SDK between early 2017 and early 2018 (SDK versions approximately 0.12.1 to 2.0.8).

So just updating the SDK to the latest version, cleaning the project (just in case there's a cert file cached somewhere) and rebuilding it again should also fix the issue, without the need to call setDeferCertificateTrustToPlatform, however I still recommend using the Android's certificate store (unless you require cert pinning).

NeerajaGandla commented 4 years ago

Closing the issue as it is solved.