· 5 years ago · Jun 12, 2020, 11:44 AM
12020-06-12 14:32:47.459 8187-8376/com.rubarb.app.debug D/OkHttp: --> GET https://api.rubarb-test.app/mobile/v1/onboarding/identificationProcessId
22020-06-12 14:32:47.459 8187-8376/com.rubarb.app.debug D/OkHttp: x-api-key: 957f7ad4-df74-42ad-9342-29699a01bc80
32020-06-12 14:32:47.459 8187-8376/com.rubarb.app.debug D/OkHttp: Authorization: Bearer eyJraWQiOiJtVzBBV2M3V3ZqWWhSRVwvK0lFYmNXMkQ0bDFrc3NYSHFLajR6bHZNWklGbz0iLCJhbGciOiJSUzI1NiJ9.eyJzdWIiOiIxY2Q4ZGVkYi1lOTdmLTQ1ODAtOWMzMy1iM2NiOWFjNmQ2OTYiLCJjb2duaXRvOmdyb3VwcyI6WyJBcHBVc2VycyJdLCJlbWFpbF92ZXJpZmllZCI6ZmFsc2UsImlzcyI6Imh0dHBzOlwvXC9jb2duaXRvLWlkcC5ldS1jZW50cmFsLTEuYW1hem9uYXdzLmNvbVwvZXUtY2VudHJhbC0xX1I4REVrY09oRSIsInBob25lX251bWJlcl92ZXJpZmllZCI6dHJ1ZSwiY29nbml0bzp1c2VybmFtZSI6IjFjZDhkZWRiLWU5N2YtNDU4MC05YzMzLWIzY2I5YWM2ZDY5NiIsImNvZ25pdG86cm9sZXMiOlsiYXJuOmF3czppYW06OjU3ODU5MDc1NDU0Njpyb2xlXC9ydWJhcmJDb2duaXRvQXBwVXNlcnNHcm91cFJvbGUiXSwiYXVkIjoiN2xpZDQ1bXZxNHI5dmRxbWRkaHFvZDEya2giLCJldmVudF9pZCI6IjllMGY4YzRjLWZkMmYtNGE0OC05NWJiLWFlZjAzNDhjYWZlNyIsInRva2VuX3VzZSI6ImlkIiwiYXV0aF90aW1lIjoxNTkxOTYxNTYyLCJwaG9uZV9udW1iZXIiOiIrMzU5ODk4OTIwNjMwIiwiZXhwIjoxNTkxOTY1MTYyLCJpYXQiOjE1OTE5NjE1NjIsImVtYWlsIjoibmFkeWFAeWEuYmcifQ.FCgnvM1MOMwgnFLINP4l9odJ2-HmOdGZPn3HYEsuWZOLwnwjB35shrgBmh2gPur8wDIruF4o3D1YKyjDihPayOXw3EIwlxfJ_whMadzg-38cgKq4RX03CbkSgvA0EeZhxRgT7_glF__erdLS5UTpqP4K40KIvVjV9dDbBEK8cWxpdpksNt2-EvJx-49tBSiR3EdQ1CWCzxVMWMl09NLunk18hWDUD-jtMQ4myZPSMuE4cFR6zmut5mR5FiiR-tPPstiywNL5QvlIEPWlfpT3Yp62RUxv1fzrEZ99kjrirGempCB7fh8B_oOn6WOUXZ77B0RzS7n95xOa7smYeqnmUA
42020-06-12 14:32:47.459 8187-8376/com.rubarb.app.debug D/OkHttp: --> END GET
52020-06-12 14:32:48.332 8187-8376/com.rubarb.app.debug D/OkHttp: <-- 200 https://api.rubarb-test.app/mobile/v1/onboarding/identificationProcessId (872ms)
62020-06-12 14:32:48.332 8187-8376/com.rubarb.app.debug D/OkHttp: date: Fri, 12 Jun 2020 11:32:48 GMT
72020-06-12 14:32:48.332 8187-8376/com.rubarb.app.debug D/OkHttp: content-type: application/json
82020-06-12 14:32:48.333 8187-8376/com.rubarb.app.debug D/OkHttp: content-length: 51
92020-06-12 14:32:48.333 8187-8376/com.rubarb.app.debug D/OkHttp: x-amzn-requestid: a2e47999-915b-4a82-8fa8-c2dd8fb2fd5e
102020-06-12 14:32:48.333 8187-8376/com.rubarb.app.debug D/OkHttp: x-amz-apigw-id: OA0q8GYRliAFX2g=
112020-06-12 14:32:48.333 8187-8376/com.rubarb.app.debug D/OkHttp: x-amzn-trace-id: Root=1-5ee367df-eecab7652bd02cd8e80ff227;Sampled=0
122020-06-12 14:32:48.337 8187-8376/com.rubarb.app.debug D/OkHttp: {"IDNowIdentID":"TST-JLQST","companyName":"rubarb"}
132020-06-12 14:32:48.337 8187-8376/com.rubarb.app.debug D/OkHttp: <-- END HTTP (51-byte body)
142020-06-12 14:32:48.421 8187-8187/com.rubarb.app.debug I/IDNOW_UTIL: select test server
152020-06-12 14:32:48.476 8187-8233/com.rubarb.app.debug V/FA: Recording user engagement, ms: 1831
162020-06-12 14:32:48.483 8187-8224/com.rubarb.app.debug V/FA: onActivityCreated
172020-06-12 14:32:48.485 8187-8233/com.rubarb.app.debug V/FA: Activity paused, time: 1474259557
182020-06-12 14:32:48.564 8187-8187/com.rubarb.app.debug I/IDNOW_ENTRY: Front Camera and Back camera are available
192020-06-12 14:32:48.566 8187-8187/com.rubarb.app.debug I/IDNOW_UTIL: online
202020-06-12 14:32:48.566 8187-8187/com.rubarb.app.debug I/IDNOW_UTIL: select test server
212020-06-12 14:32:48.566 8187-8187/com.rubarb.app.debug I/IDNOW_RESTCLIENT: getRestClient()
222020-06-12 14:32:48.568 8187-8187/com.rubarb.app.debug I/IDNOW_OKHTTP_FACTORY: API LEVEL26
232020-06-12 14:32:48.574 8187-8187/com.rubarb.app.debug I/IDNOW_RESTCLIENT: SYSTEM-LANGUAGE: en
242020-06-12 14:32:48.582 8187-8233/com.rubarb.app.debug V/FA: Activity resumed, time: 1474259677
252020-06-12 14:32:48.595 8187-8391/com.rubarb.app.debug I/IDNOW_RESTCLIENT: ---> HTTP GET https://api.test.idnow.de/api/v1/rubarb
262020-06-12 14:32:48.597 8187-8187/com.rubarb.app.debug D/InputTransport: Input channel constructed: fd=83
272020-06-12 14:32:48.597 8187-8187/com.rubarb.app.debug D/ViewRootImpl@e22e431[Activities_EntryActivity]: setView = DecorView@5484716[Activities_EntryActivity] TM=true MM=false
282020-06-12 14:32:48.600 8187-8187/com.rubarb.app.debug D/ViewRootImpl@c2c383c[ModalActivity]: MSG_WINDOW_FOCUS_CHANGED 0
292020-06-12 14:32:48.606 8187-8187/com.rubarb.app.debug D/ViewRootImpl@e22e431[Activities_EntryActivity]: dispatchAttachedToWindow
302020-06-12 14:32:48.626 8187-8187/com.rubarb.app.debug V/Surface: sf_framedrop debug : 0x4f4c, game : false, logging : 0
312020-06-12 14:32:48.627 8187-8187/com.rubarb.app.debug D/ViewRootImpl@e22e431[Activities_EntryActivity]: Relayout returned: old=[0,0][0,0] new=[0,0][1080,2076] result=0x7 surface={valid=true 542818017280} changed=true
322020-06-12 14:32:48.634 8187-8252/com.rubarb.app.debug D/mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, egl_color_buffer_format *, EGLBoolean) returns 0x3000, [1080x2076]-format:1
332020-06-12 14:32:48.634 8187-8252/com.rubarb.app.debug D/OpenGLRenderer: eglCreateWindowSurface = 0x7e603daea0, 0x7e6279a010
342020-06-12 14:32:48.740 8187-8187/com.rubarb.app.debug D/ViewRootImpl@e22e431[Activities_EntryActivity]: MSG_RESIZED_REPORT: frame=Rect(0, 0 - 1080, 2076) ci=Rect(0, 72 - 0, 0) vi=Rect(0, 72 - 0, 0) or=1
352020-06-12 14:32:48.741 8187-8187/com.rubarb.app.debug D/ViewRootImpl@e22e431[Activities_EntryActivity]: MSG_WINDOW_FOCUS_CHANGED 1
362020-06-12 14:32:48.746 8187-8187/com.rubarb.app.debug V/InputMethodManager: Starting input: tba=android.view.inputmethod.EditorInfo@7ea1c6 nm : com.rubarb.app.debug ic=null
372020-06-12 14:32:48.746 8187-8187/com.rubarb.app.debug I/InputMethodManager: startInputInner - mService.startInputOrWindowGainedFocus
382020-06-12 14:32:48.748 8187-8187/com.rubarb.app.debug D/InputTransport: Input channel constructed: fd=98
392020-06-12 14:32:48.748 8187-8187/com.rubarb.app.debug D/InputTransport: Input channel destroyed: fd=87
402020-06-12 14:32:48.767 8187-8252/com.rubarb.app.debug D/OpenGLRenderer: eglDestroySurface = 0x7e85a161a0, 0x7e62797000
412020-06-12 14:32:48.777 8187-8187/com.rubarb.app.debug D/ViewRootImpl@c2c383c[ModalActivity]: Relayout returned: old=[0,0][1080,2220] new=[0,0][1080,2220] result=0x5 surface={valid=false 0} changed=true
422020-06-12 14:32:49.230 8187-8192/com.rubarb.app.debug I/zygote64: Compiler allocated 8MB to compile void android.view.ViewRootImpl.performTraversals()
432020-06-12 14:32:49.345 8187-8391/com.rubarb.app.debug I/IDNOW_RESTCLIENT: <--- HTTP 200 https://api.test.idnow.de/api/v1/rubarb (749ms)
442020-06-12 14:32:49.383 8187-8187/com.rubarb.app.debug I/IDNOW_ENTRY: office hours call was successful
452020-06-12 14:32:49.383 8187-8187/com.rubarb.app.debug I/IDNOW_ENTRY: office open: true
462020-06-12 14:32:49.384 8187-8187/com.rubarb.app.debug I/IDNOW_ENTRY: textChat enabled: false
472020-06-12 14:32:49.384 8187-8187/com.rubarb.app.debug I/IDNOW_ENTRY: Suc Url: null
482020-06-12 14:32:49.384 8187-8187/com.rubarb.app.debug I/IDNOW_ENTRY: fail Url: null
492020-06-12 14:32:49.384 8187-8187/com.rubarb.app.debug I/IDNOW_ENTRY: message: Thank you for using our online identification service! You can now close the app and will be informed about the next steps.
502020-06-12 14:32:49.893 8187-8397/com.rubarb.app.debug I/IDNOW_SDK_INIT: Successfully requested messages: https://api.test.idnow.de/assets/messages.json?shortName=rubarb
512020-06-12 14:32:50.026 8187-8187/com.rubarb.app.debug I/IDNOW_RESTCLIENT: getRestClient()
522020-06-12 14:32:50.032 8187-8187/com.rubarb.app.debug I/IDNOW_RESTCLIENT: SYSTEM-LANGUAGE: en
532020-06-12 14:32:50.036 8187-8391/com.rubarb.app.debug I/IDNOW_RESTCLIENT: ---> HTTP GET https://api.test.idnow.de/api/v1/rubarb/identifications/TST-JLQST
542020-06-12 14:32:50.036 8187-8187/com.rubarb.app.debug I/Choreographer: Skipped 38 frames! The application may be doing too much work on its main thread.
552020-06-12 14:32:50.171 8187-8391/com.rubarb.app.debug I/IDNOW_RESTCLIENT: <--- HTTP 200 https://api.test.idnow.de/api/v1/rubarb/identifications/TST-JLQST (132ms)
562020-06-12 14:32:50.262 8187-8233/com.rubarb.app.debug V/FA: Recording user engagement, ms: 1670
572020-06-12 14:32:50.275 8187-8233/com.rubarb.app.debug V/FA: Activity paused, time: 1474261348
582020-06-12 14:32:50.276 8187-8224/com.rubarb.app.debug V/FA: onActivityCreated
592020-06-12 14:32:50.363 8187-8187/com.rubarb.app.debug D/ScrollView: initGoToTop
602020-06-12 14:32:50.404 8187-8187/com.rubarb.app.debug I/IDNOW_RESTCLIENT: getRestClient()
612020-06-12 14:32:50.415 8187-8187/com.rubarb.app.debug I/IDNOW_UTIL: {"backCameraHeight":"480","backCameraWidth":"640","clientVersion":"ANDROIDSDK,4.1.6","connectionType":"ConnectivityManager.TYPE_WIFI","deviceInfo":"jackpotlte","flashLight":true,"frontCameraHeight":"480","frontCameraWidth":"640","language":"en","locale":"en_GB","osVersion":"26","screenHeight":"2076","screenWidth":"1080","timezone":"Europe/Sofia"}
622020-06-12 14:32:50.416 8187-8187/com.rubarb.app.debug I/IDNOW_RESTCLIENT: SYSTEM-LANGUAGE: en
632020-06-12 14:32:50.420 8187-8233/com.rubarb.app.debug V/FA: Activity resumed, time: 1474261515
642020-06-12 14:32:50.428 8187-8187/com.rubarb.app.debug D/InputTransport: Input channel constructed: fd=96
652020-06-12 14:32:50.429 8187-8187/com.rubarb.app.debug D/ViewRootImpl@6ec55d4[Activities_VideoLiveStreamActivity_CallQualityCheck]: setView = DecorView@e94d272[Activities_VideoLiveStreamActivity_CallQualityCheck] TM=true MM=false
662020-06-12 14:32:50.433 8187-8187/com.rubarb.app.debug D/ViewRootImpl@e22e431[Activities_EntryActivity]: MSG_WINDOW_FOCUS_CHANGED 0
672020-06-12 14:32:50.433 8187-8391/com.rubarb.app.debug I/IDNOW_RESTCLIENT: ---> HTTP POST https://api.test.idnow.de/api/v1/rubarb/identifications/TST-JLQST/startCallQualityTest
682020-06-12 14:32:50.441 8187-8187/com.rubarb.app.debug D/ViewRootImpl@6ec55d4[Activities_VideoLiveStreamActivity_CallQualityCheck]: dispatchAttachedToWindow
692020-06-12 14:32:50.468 8187-8187/com.rubarb.app.debug V/Surface: sf_framedrop debug : 0x4f4c, game : false, logging : 0
702020-06-12 14:32:50.469 8187-8187/com.rubarb.app.debug D/ViewRootImpl@6ec55d4[Activities_VideoLiveStreamActivity_CallQualityCheck]: Relayout returned: old=[0,0][0,0] new=[0,0][1080,2076] result=0x7 surface={valid=true 543007170560} changed=true
712020-06-12 14:32:50.477 8187-8252/com.rubarb.app.debug D/mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, egl_color_buffer_format *, EGLBoolean) returns 0x3000, [1080x2076]-format:1
722020-06-12 14:32:50.478 8187-8252/com.rubarb.app.debug D/OpenGLRenderer: eglCreateWindowSurface = 0x7e85a161a0, 0x7e6dbfe010
732020-06-12 14:32:50.482 8187-8187/com.rubarb.app.debug D/ScrollView: onsize change changed
742020-06-12 14:32:50.523 8187-8187/com.rubarb.app.debug D/ViewRootImpl@6ec55d4[Activities_VideoLiveStreamActivity_CallQualityCheck]: MSG_RESIZED_REPORT: frame=Rect(0, 0 - 1080, 2076) ci=Rect(0, 72 - 0, 0) vi=Rect(0, 72 - 0, 0) or=1
752020-06-12 14:32:50.523 8187-8187/com.rubarb.app.debug D/ViewRootImpl@6ec55d4[Activities_VideoLiveStreamActivity_CallQualityCheck]: MSG_WINDOW_FOCUS_CHANGED 1
762020-06-12 14:32:50.532 8187-8391/com.rubarb.app.debug I/IDNOW_RESTCLIENT: <--- HTTP 412 https://api.test.idnow.de/api/v1/rubarb/identifications/TST-JLQST/startCallQualityTest (98ms)
772020-06-12 14:32:50.537 8187-8187/com.rubarb.app.debug V/InputMethodManager: Starting input: tba=android.view.inputmethod.EditorInfo@63cf258 nm : com.rubarb.app.debug ic=null
782020-06-12 14:32:50.537 8187-8187/com.rubarb.app.debug I/InputMethodManager: startInputInner - mService.startInputOrWindowGainedFocus
792020-06-12 14:32:50.542 8187-8187/com.rubarb.app.debug D/InputTransport: Input channel constructed: fd=100
802020-06-12 14:32:50.542 8187-8187/com.rubarb.app.debug D/InputTransport: Input channel destroyed: fd=98
812020-06-12 14:32:50.559 8187-8187/com.rubarb.app.debug E/IDNOW: RETROFIT ERROR: 412 Precondition Failed
822020-06-12 14:32:50.560 8187-8187/com.rubarb.app.debug I/UtilRetrofit: {"errors":[{"cause":"PRECONDITION_FAILED","errorType":"IDENTIFICATION_FINISHED","id":"51505228","key":null,"message":"The identification was already finished","translationKey":null}]}
832020-06-12 14:32:50.574 8187-8187/com.rubarb.app.debug D/ScrollView: initGoToTop
842020-06-12 14:32:50.600 8187-8187/com.rubarb.app.debug D/InputTransport: Input channel constructed: fd=98
852020-06-12 14:32:50.600 8187-8187/com.rubarb.app.debug D/ViewRootImpl@214786e[Activities_VideoLiveStreamActivity_CallQualityCheck]: setView = DecorView@27cfb0f[] TM=true MM=false
862020-06-12 14:32:50.601 8187-8187/com.rubarb.app.debug I/IDNOW_CALL_QUALITY_TEST: SDP Error: 412 Precondition Failed
872020-06-12 14:32:50.601 8187-8187/com.rubarb.app.debug I/IDNOW_CALL_QUALITY_TEST: SDP result: {"errors":[{"cause":"PRECONDITION_FAILED","errorType":"IDENTIFICATION_FINISHED","id":"51505228","key":null,"message":"The identification was already finished","translationKey":null}]}
882020-06-12 14:32:50.611 8187-8187/com.rubarb.app.debug W/AudioManager: setStreamMute is deprecated. adjustStreamVolume should be used instead.
892020-06-12 14:32:50.617 8187-8187/com.rubarb.app.debug W/AudioManager: setStreamMute is deprecated. adjustStreamVolume should be used instead.
902020-06-12 14:32:50.617 8187-8187/com.rubarb.app.debug W/AudioManager: setStreamMute is deprecated. adjustStreamVolume should be used instead.
912020-06-12 14:32:50.625 8187-8187/com.rubarb.app.debug W/AudioManager: setStreamMute is deprecated. adjustStreamVolume should be used instead.
922020-06-12 14:32:50.630 8187-8252/com.rubarb.app.debug D/OpenGLRenderer: eglDestroySurface = 0x7e603daea0, 0x7e6279a000
932020-06-12 14:32:50.647 8187-8187/com.rubarb.app.debug D/ViewRootImpl@e22e431[Activities_EntryActivity]: Relayout returned: old=[0,0][1080,2076] new=[0,0][1080,2076] result=0x5 surface={valid=false 0} changed=true
942020-06-12 14:32:50.650 8187-8187/com.rubarb.app.debug D/ViewRootImpl@214786e[Activities_VideoLiveStreamActivity_CallQualityCheck]: dispatchAttachedToWindow
952020-06-12 14:32:50.692 8187-8187/com.rubarb.app.debug V/Surface: sf_framedrop debug : 0x4f4c, game : false, logging : 0
962020-06-12 14:32:50.693 8187-8187/com.rubarb.app.debug D/ViewRootImpl@214786e[Activities_VideoLiveStreamActivity_CallQualityCheck]: Relayout returned: old=[0,0][0,0] new=[27,853][1053,1294] result=0x27 surface={valid=true 542818017280} changed=true
972020-06-12 14:32:50.697 8187-8252/com.rubarb.app.debug D/mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, egl_color_buffer_format *, EGLBoolean) returns 0x3000, [1026x441]-format:1
982020-06-12 14:32:50.697 8187-8252/com.rubarb.app.debug D/OpenGLRenderer: eglCreateWindowSurface = 0x7e603daea0, 0x7e6279a010
992020-06-12 14:32:50.701 8187-8187/com.rubarb.app.debug D/ScrollView: onsize change changed
1002020-06-12 14:32:50.731 8187-8187/com.rubarb.app.debug D/ViewRootImpl@214786e[Activities_VideoLiveStreamActivity_CallQualityCheck]: MSG_WINDOW_FOCUS_CHANGED 1
1012020-06-12 14:32:50.761 8187-8187/com.rubarb.app.debug D/ViewRootImpl@214786e[Activities_VideoLiveStreamActivity_CallQualityCheck]: MSG_RESIZED_REPORT: frame=Rect(27, 853 - 1053, 1294) ci=Rect(0, 0 - 0, 0) vi=Rect(0, 0 - 0, 0) or=1
1022020-06-12 14:32:50.773 8187-8187/com.rubarb.app.debug D/ViewRootImpl@6ec55d4[Activities_VideoLiveStreamActivity_CallQualityCheck]: MSG_WINDOW_FOCUS_CHANGED 0
1032020-06-12 14:32:52.310 8187-8187/com.rubarb.app.debug D/ViewRootImpl@214786e[Activities_VideoLiveStreamActivity_CallQualityCheck]: ViewPostIme pointer 0
1042020-06-12 14:32:52.392 8187-8187/com.rubarb.app.debug D/ViewRootImpl@214786e[Activities_VideoLiveStreamActivity_CallQualityCheck]: ViewPostIme pointer 1
1052020-06-12 14:32:52.414 8187-8252/com.rubarb.app.debug D/OpenGLRenderer: eglDestroySurface = 0x7e603daea0, 0x7e6279a000
1062020-06-12 14:32:52.414 8187-8187/com.rubarb.app.debug D/ViewRootImpl@214786e[Activities_VideoLiveStreamActivity_CallQualityCheck]: dispatchDetachedFromWindow
1072020-06-12 14:32:52.415 8187-8187/com.rubarb.app.debug D/InputEventReceiver: channel '6f7058b com.rubarb.app.debug/de.idnow.sdk.Activities.Activities_VideoLiveStreamActivity_CallQualityCheck (client)' ~ Disposing input event receiver.
1082020-06-12 14:32:52.415 8187-8187/com.rubarb.app.debug D/InputEventReceiver: channel '6f7058b com.rubarb.app.debug/de.idnow.sdk.Activities.Activities_VideoLiveStreamActivity_CallQualityCheck (client)' ~NativeInputEventReceiver.
1092020-06-12 14:32:52.425 8187-8187/com.rubarb.app.debug D/InputTransport: Input channel destroyed: fd=98
1102020-06-12 14:32:52.436 8187-8187/com.rubarb.app.debug D/ViewRootImpl@6ec55d4[Activities_VideoLiveStreamActivity_CallQualityCheck]: MSG_WINDOW_FOCUS_CHANGED 1
1112020-06-12 14:32:52.442 8187-8187/com.rubarb.app.debug E/ViewRootImpl: sendUserActionEvent() returned.
1122020-06-12 14:32:52.471 8187-8187/com.rubarb.app.debug D/ViewRootImpl@6ec55d4[Activities_VideoLiveStreamActivity_CallQualityCheck]: MSG_WINDOW_FOCUS_CHANGED 0
1132020-06-12 14:32:52.471 8187-8233/com.rubarb.app.debug V/FA: Recording user engagement, ms: 2035
1142020-06-12 14:32:52.473 8187-8187/com.rubarb.app.debug I/IDNOW_ENTRY: onActivityResult called
1152020-06-12 14:32:52.483 8187-8233/com.rubarb.app.debug V/FA: Activity paused, time: 1474263551
1162020-06-12 14:32:52.507 8187-8187/com.rubarb.app.debug D/ViewRootImpl@e22e431[Activities_EntryActivity]: Relayout returned: old=[0,0][1080,2076] new=[0,0][1080,2076] result=0x1 surface={valid=false 0} changed=false
1172020-06-12 14:32:52.526 8187-8187/com.rubarb.app.debug D/IDNow result: failed, error: Identification failed.
1182020-06-12 14:32:52.528 8187-8187/com.rubarb.app.debug D/EventBus: No subscribers registered for event class com.upnetix.presentation.navigation.NavigationEvent
1192020-06-12 14:32:52.529 8187-8187/com.rubarb.app.debug D/EventBus: No subscribers registered for event class org.greenrobot.eventbus.NoSubscriberEvent
1202020-06-12 14:32:52.562 8187-8187/com.rubarb.app.debug V/Surface: sf_framedrop debug : 0x4f4c, game : false, logging : 0
1212020-06-12 14:32:52.563 8187-8187/com.rubarb.app.debug D/ViewRootImpl@c2c383c[ModalActivity]: Relayout returned: old=[0,0][1080,2220] new=[0,0][1080,2220] result=0x7 surface={valid=true 542818017280} changed=true
1222020-06-12 14:32:52.569 8187-8233/com.rubarb.app.debug V/FA: Activity resumed, time: 1474263631
1232020-06-12 14:32:52.575 8187-8252/com.rubarb.app.debug D/mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, egl_color_buffer_format *, EGLBoolean) returns 0x3000, [1080x2220]-format:1
1242020-06-12 14:32:52.576 8187-8252/com.rubarb.app.debug D/OpenGLRenderer: eglCreateWindowSurface = 0x7e603daea0, 0x7e6279a010
1252020-06-12 14:32:52.600 8187-8187/com.rubarb.app.debug D/ViewRootImpl@c2c383c[ModalActivity]: MSG_WINDOW_FOCUS_CHANGED 1
1262020-06-12 14:32:52.620 8187-8187/com.rubarb.app.debug V/InputMethodManager: Starting input: tba=android.view.inputmethod.EditorInfo@5baf382 nm : com.rubarb.app.debug ic=null
1272020-06-12 14:32:52.620 8187-8187/com.rubarb.app.debug I/InputMethodManager: startInputInner - mService.startInputOrWindowGainedFocus
1282020-06-12 14:32:52.629 8187-8187/com.rubarb.app.debug D/InputTransport: Input channel constructed: fd=92
1292020-06-12 14:32:52.629 8187-8187/com.rubarb.app.debug D/InputTransport: Input channel destroyed: fd=100
1302020-06-12 14:32:52.652 8187-8187/com.rubarb.app.debug D/ViewRootImpl@e22e431[Activities_EntryActivity]: Relayout returned: old=[0,0][1080,2076] new=[0,0][1080,2076] result=0x1 surface={valid=false 0} changed=false
1312020-06-12 14:32:52.655 8187-8252/com.rubarb.app.debug D/OpenGLRenderer: eglDestroySurface = 0x7e85a161a0, 0x7e6dbfe000
1322020-06-12 14:32:52.665 8187-8187/com.rubarb.app.debug D/ViewRootImpl@6ec55d4[Activities_VideoLiveStreamActivity_CallQualityCheck]: Relayout returned: old=[0,0][1080,2076] new=[0,0][1080,2076] result=0x5 surface={valid=false 0} changed=true
1332020-06-12 14:32:53.054 8187-8187/com.rubarb.app.debug D/ViewRootImpl@e22e431[Activities_EntryActivity]: dispatchDetachedFromWindow
1342020-06-12 14:32:53.055 8187-8187/com.rubarb.app.debug D/InputEventReceiver: channel 'e3806f0 com.rubarb.app.debug/de.idnow.sdk.Activities.Activities_EntryActivity (client)' ~ Disposing input event receiver.
1352020-06-12 14:32:53.055 8187-8187/com.rubarb.app.debug D/InputEventReceiver: channel 'e3806f0 com.rubarb.app.debug/de.idnow.sdk.Activities.Activities_EntryActivity (client)' ~NativeInputEventReceiver.
1362020-06-12 14:32:53.068 8187-8187/com.rubarb.app.debug D/InputTransport: Input channel destroyed: fd=83
1372020-06-12 14:32:53.125 8187-8187/com.rubarb.app.debug D/ViewRootImpl@6ec55d4[Activities_VideoLiveStreamActivity_CallQualityCheck]: dispatchDetachedFromWindow
1382020-06-12 14:32:53.126 8187-8187/com.rubarb.app.debug D/InputEventReceiver: channel '27fb476 com.rubarb.app.debug/de.idnow.sdk.Activities.Activities_VideoLiveStreamActivity_CallQualityCheck (client)' ~ Disposing input event receiver.
1392020-06-12 14:32:53.126 8187-8187/com.rubarb.app.debug D/InputEventReceiver: channel '27fb476 com.rubarb.app.debug/de.idnow.sdk.Activities.Activities_VideoLiveStreamActivity_CallQualityCheck (client)' ~NativeInputEventReceiver.
1402020-06-12 14:32:53.139 8187-8187/com.rubarb.app.debug D/InputTransport: Input channel destroyed: fd=96
1412020-06-12 14:32:57.672 8187-8233/com.rubarb.app.debug V/FA: Inactivity, disconnecting from the service
1422020-06-12 14:33:45.021 8187-8187/com.rubarb.app.debug D/ViewRootImpl@c2c383c[ModalActivity]: ViewPostIme pointer 0
1432020-06-12 14:33:45.899 8187-8187/com.rubarb.app.debug D/ViewRootImpl@c2c383c[ModalActivity]: ViewPostIme pointer 1
1442020-06-12 14:33:47.724 8187-8187/com.rubarb.app.debug D/ViewRootImpl@c2c383c[ModalActivity]: ViewPostIme pointer 0
1452020-06-12 14:33:48.135 8187-8187/com.rubarb.app.debug D/ViewRootImpl@c2c383c[ModalActivity]: ViewPostIme pointer 1
1462020-06-12 14:33:49.901 8187-8187/com.rubarb.app.debug D/ViewRootImpl@c2c383c[ModalActivity]: ViewPostIme pointer 0
1472020-06-12 14:33:50.294 8187-8187/com.rubarb.app.debug D/ViewRootImpl@c2c383c[ModalActivity]: ViewPostIme pointer 1
1482020-06-12 14:33:54.274 8187-8194/com.rubarb.app.debug I/zygote64: Debugger is active
1492020-06-12 14:34:07.141 8187-8187/com.rubarb.app.debug D/ViewRootImpl@c2c383c[ModalActivity]: ViewPostIme pointer 0
1502020-06-12 14:34:07.625 8187-8187/com.rubarb.app.debug D/ViewRootImpl@c2c383c[ModalActivity]: ViewPostIme pointer 1
1512020-06-12 14:34:09.043 8187-8187/com.rubarb.app.debug D/ViewRootImpl@c2c383c[ModalActivity]: ViewPostIme pointer 0
1522020-06-12 14:34:09.643 8187-8187/com.rubarb.app.debug D/ViewRootImpl@c2c383c[ModalActivity]: ViewPostIme pointer 1
1532020-06-12 14:34:11.477 8187-8187/com.rubarb.app.debug D/ViewRootImpl@c2c383c[ModalActivity]: ViewPostIme pointer 0
1542020-06-12 14:34:11.619 8187-8187/com.rubarb.app.debug D/ViewRootImpl@c2c383c[ModalActivity]: ViewPostIme pointer 1
1552020-06-12 14:34:11.745 8187-8187/com.rubarb.app.debug D/ViewRootImpl@c2c383c[ModalActivity]: ViewPostIme pointer 0
1562020-06-12 14:34:14.405 8187-8187/com.rubarb.app.debug D/ViewRootImpl@c2c383c[ModalActivity]: ViewPostIme pointer 1
1572020-06-12 14:34:33.697 8187-8187/com.rubarb.app.debug D/ViewRootImpl@c2c383c[ModalActivity]: ViewPostIme pointer 0
1582020-06-12 14:34:33.938 8187-8187/com.rubarb.app.debug D/ViewRootImpl: [ViewRootImpl] action cancel - 1, eccen:3.2307692
1592020-06-12 14:34:33.954 8187-8187/com.rubarb.app.debug D/ViewRootImpl: [ViewRootImpl] action cancel - 1, eccen:3.357143
1602020-06-12 14:34:33.971 8187-8187/com.rubarb.app.debug D/ViewRootImpl: [ViewRootImpl] action cancel - 1, eccen:3.5
1612020-06-12 14:34:33.990 8187-8187/com.rubarb.app.debug D/ViewRootImpl: [ViewRootImpl] action cancel - 1, eccen:3.7142856
1622020-06-12 14:34:34.005 8187-8187/com.rubarb.app.debug D/ViewRootImpl: [ViewRootImpl] action cancel - 1, eccen:3.7857144
1632020-06-12 14:34:34.022 8187-8187/com.rubarb.app.debug D/ViewRootImpl: [ViewRootImpl] action cancel - 1, eccen:4.0
1642020-06-12 14:34:34.038 8187-8187/com.rubarb.app.debug D/ViewRootImpl: [ViewRootImpl] action cancel - 1, eccen:4.214286
1652020-06-12 14:34:34.055 8187-8187/com.rubarb.app.debug D/ViewRootImpl: [ViewRootImpl] action cancel - 1, eccen:3.625
1662020-06-12 14:34:34.072 8187-8187/com.rubarb.app.debug I/chatty: uid=11024(u0_a1024) com.rubarb.app.debug identical 1 line
1672020-06-12 14:34:34.088 8187-8187/com.rubarb.app.debug D/ViewRootImpl: [ViewRootImpl] action cancel - 1, eccen:3.625
1682020-06-12 14:34:34.105 8187-8187/com.rubarb.app.debug D/ViewRootImpl: [ViewRootImpl] action cancel - 1, eccen:4.214286
1692020-06-12 14:34:34.122 8187-8187/com.rubarb.app.debug D/ViewRootImpl: [ViewRootImpl] action cancel - 1, eccen:4.214286
1702020-06-12 14:34:34.138 8187-8187/com.rubarb.app.debug D/ViewRootImpl: [ViewRootImpl] action cancel - 1, eccen:4.214286
1712020-06-12 14:34:34.155 8187-8187/com.rubarb.app.debug D/ViewRootImpl: [ViewRootImpl] action cancel - 1, eccen:3.8
1722020-06-12 14:34:34.172 8187-8187/com.rubarb.app.debug D/ViewRootImpl: [ViewRootImpl] action cancel - 1, eccen:3.8
1732020-06-12 14:34:34.188 8187-8187/com.rubarb.app.debug D/ViewRootImpl: [ViewRootImpl] action cancel - 1, eccen:4.0
1742020-06-12 14:34:34.205 8187-8187/com.rubarb.app.debug D/ViewRootImpl: [ViewRootImpl] action cancel - 1, eccen:3.9285715
1752020-06-12 14:34:34.223 8187-8187/com.rubarb.app.debug D/ViewRootImpl: [ViewRootImpl] action cancel - 1, eccen:4.230769
1762020-06-12 14:34:34.238 8187-8187/com.rubarb.app.debug D/ViewRootImpl: [ViewRootImpl] action cancel - 1, eccen:3.7857144
1772020-06-12 14:34:34.255 8187-8187/com.rubarb.app.debug D/ViewRootImpl: [ViewRootImpl] action cancel - 1, eccen:4.5
1782020-06-12 14:34:34.273 8187-8187/com.rubarb.app.debug D/ViewRootImpl: [ViewRootImpl] action cancel - 1, eccen:3.7142856
1792020-06-12 14:34:34.289 8187-8187/com.rubarb.app.debug D/ViewRootImpl: [ViewRootImpl] action cancel - 1, eccen:3.7857144
1802020-06-12 14:34:34.305 8187-8187/com.rubarb.app.debug D/ViewRootImpl: [ViewRootImpl] action cancel - 1, eccen:4.0
1812020-06-12 14:34:34.323 8187-8187/com.rubarb.app.debug D/ViewRootImpl: [ViewRootImpl] action cancel - 1, eccen:4.0
1822020-06-12 14:34:34.339 8187-8187/com.rubarb.app.debug D/ViewRootImpl: [ViewRootImpl] action cancel - 1, eccen:4.25
1832020-06-12 14:34:34.439 8187-8187/com.rubarb.app.debug I/chatty: uid=11024(u0_a1024) com.rubarb.app.debug identical 6 lines
1842020-06-12 14:34:34.456 8187-8187/com.rubarb.app.debug D/ViewRootImpl: [ViewRootImpl] action cancel - 1, eccen:4.25
1852020-06-12 14:34:34.477 8187-8187/com.rubarb.app.debug D/ViewRootImpl: [ViewRootImpl] action cancel - 1, eccen:4.1666665
1862020-06-12 14:34:34.557 8187-8187/com.rubarb.app.debug I/chatty: uid=11024(u0_a1024) com.rubarb.app.debug identical 5 lines
1872020-06-12 14:34:34.574 8187-8187/com.rubarb.app.debug D/ViewRootImpl: [ViewRootImpl] action cancel - 1, eccen:4.1666665
1882020-06-12 14:34:34.590 8187-8187/com.rubarb.app.debug D/ViewRootImpl: [ViewRootImpl] action cancel - 1, eccen:4.0
1892020-06-12 14:34:34.607 8187-8187/com.rubarb.app.debug D/ViewRootImpl: [ViewRootImpl] action cancel - 1, eccen:4.181818
1902020-06-12 14:34:34.624 8187-8187/com.rubarb.app.debug D/ViewRootImpl: [ViewRootImpl] action cancel - 1, eccen:3.909091
1912020-06-12 14:34:34.640 8187-8187/com.rubarb.app.debug I/chatty: uid=11024(u0_a1024) com.rubarb.app.debug identical 1 line
1922020-06-12 14:34:34.657 8187-8187/com.rubarb.app.debug D/ViewRootImpl: [ViewRootImpl] action cancel - 1, eccen:3.909091
1932020-06-12 14:34:34.674 8187-8187/com.rubarb.app.debug D/ViewRootImpl: [ViewRootImpl] action cancel - 1, eccen:3.6363637
1942020-06-12 14:34:35.007 8187-8187/com.rubarb.app.debug D/ViewRootImpl@c2c383c[ModalActivity]: ViewPostIme pointer 1
1952020-06-12 14:34:35.370 8187-8187/com.rubarb.app.debug D/SmartClipDataCropperImpl: doExtractSmartClipData : Extraction start! reqId = 18 Cropped area = Rect(540, 1110 - 541, 1111) Package = com.rubarb.app.debug
1962020-06-12 14:34:35.379 8187-8187/com.rubarb.app.debug D/SmartClipDataCropperImpl: addAppMetaTag : package name is com.rubarb.app.debug
1972020-06-12 14:34:35.380 8187-8187/com.rubarb.app.debug D/SmartClipDataCropperImpl: sendExtractionResultToSmartClipService : -- Extracted SmartClip data information --
1982020-06-12 14:34:35.380 8187-8187/com.rubarb.app.debug D/SmartClipDataCropperImpl: sendExtractionResultToSmartClipService : Request Id : 18
1992020-06-12 14:34:35.381 8187-8187/com.rubarb.app.debug D/SmartClipDataCropperImpl: sendExtractionResultToSmartClipService : Extraction mode : 1
2002020-06-12 14:34:35.381 8187-8187/com.rubarb.app.debug D/SemSmartClipDataRepository: ----- Start of SmartClip repository informations -----
2012020-06-12 14:34:35.381 8187-8187/com.rubarb.app.debug D/SemSmartClipDataRepository: ** Content type : image
2022020-06-12 14:34:35.381 8187-8187/com.rubarb.app.debug D/SemSmartClipDataRepository: ** Meta area rect : Rect(0, 0 - 0, 0)
2032020-06-12 14:34:35.381 8187-8187/com.rubarb.app.debug D/SemSmartClipDataRepository: ** Captured image file path : null
2042020-06-12 14:34:35.381 8187-8187/com.rubarb.app.debug D/SemSmartClipDataRepository: ----- End of SmartClip repository informations -----
2052020-06-12 14:34:35.391 8187-8187/com.rubarb.app.debug D/SmartClipDataCropperImpl: sendExtractionResultToSmartClipService : Elapsed = 21
2062020-06-12 14:34:36.907 8187-8187/com.rubarb.app.debug D/SmartClipRemoteRequestDispatcher: dispatchScrollableAreaInfo : windowRect = Rect(0, 0 - 1080, 2220)
2072020-06-12 14:34:36.921 8187-8187/com.rubarb.app.debug D/SmartClipRemoteRequestDispatcher: dispatchScrollableAreaInfo : Scrollable view count = 1
2082020-06-12 14:34:36.922 8187-8187/com.rubarb.app.debug D/SmartClipRemoteRequestDispatcher: dispatchScrollableAreaInfo : Unscrollable view count = 0
2092020-06-12 14:34:36.924 8187-8187/com.rubarb.app.debug D/SmartClipRemoteRequestDispatcher: dispatchScrollableAreaInfo : Pkg=com.rubarb.app.debug Activity=null
2102020-06-12 14:34:37.162 8187-8187/com.rubarb.app.debug D/ViewRootImpl@c2c383c[ModalActivity]: MSG_WINDOW_FOCUS_CHANGED 0
2112020-06-12 14:34:40.214 8187-8187/com.rubarb.app.debug D/ViewRootImpl@c2c383c[ModalActivity]: MSG_WINDOW_FOCUS_CHANGED 1
2122020-06-12 14:34:41.095 8187-8187/com.rubarb.app.debug D/ViewRootImpl@c2c383c[ModalActivity]: ViewPostIme pointer 0
2132020-06-12 14:34:41.203 8187-8187/com.rubarb.app.debug D/ViewRootImpl@c2c383c[ModalActivity]: ViewPostIme pointer 1
2142020-06-12 14:34:41.213 8187-8187/com.rubarb.app.debug D/InputMethodManager: HSIFW - flag : 0 Pid : 8187
2152020-06-12 14:34:41.230 8187-8714/com.rubarb.app.debug D/OkHttp: --> GET https://api.rubarb-test.app/mobile/v1/onboarding/identificationProcessId
2162020-06-12 14:34:41.231 8187-8714/com.rubarb.app.debug D/OkHttp: x-api-key: 957f7ad4-df74-42ad-9342-29699a01bc80
2172020-06-12 14:34:41.231 8187-8714/com.rubarb.app.debug D/OkHttp: Authorization: Bearer eyJraWQiOiJtVzBBV2M3V3ZqWWhSRVwvK0lFYmNXMkQ0bDFrc3NYSHFLajR6bHZNWklGbz0iLCJhbGciOiJSUzI1NiJ9.eyJzdWIiOiIxY2Q4ZGVkYi1lOTdmLTQ1ODAtOWMzMy1iM2NiOWFjNmQ2OTYiLCJjb2duaXRvOmdyb3VwcyI6WyJBcHBVc2VycyJdLCJlbWFpbF92ZXJpZmllZCI6ZmFsc2UsImlzcyI6Imh0dHBzOlwvXC9jb2duaXRvLWlkcC5ldS1jZW50cmFsLTEuYW1hem9uYXdzLmNvbVwvZXUtY2VudHJhbC0xX1I4REVrY09oRSIsInBob25lX251bWJlcl92ZXJpZmllZCI6dHJ1ZSwiY29nbml0bzp1c2VybmFtZSI6IjFjZDhkZWRiLWU5N2YtNDU4MC05YzMzLWIzY2I5YWM2ZDY5NiIsImNvZ25pdG86cm9sZXMiOlsiYXJuOmF3czppYW06OjU3ODU5MDc1NDU0Njpyb2xlXC9ydWJhcmJDb2duaXRvQXBwVXNlcnNHcm91cFJvbGUiXSwiYXVkIjoiN2xpZDQ1bXZxNHI5dmRxbWRkaHFvZDEya2giLCJldmVudF9pZCI6IjllMGY4YzRjLWZkMmYtNGE0OC05NWJiLWFlZjAzNDhjYWZlNyIsInRva2VuX3VzZSI6ImlkIiwiYXV0aF90aW1lIjoxNTkxOTYxNTYyLCJwaG9uZV9udW1iZXIiOiIrMzU5ODk4OTIwNjMwIiwiZXhwIjoxNTkxOTY1MTYyLCJpYXQiOjE1OTE5NjE1NjIsImVtYWlsIjoibmFkeWFAeWEuYmcifQ.FCgnvM1MOMwgnFLINP4l9odJ2-HmOdGZPn3HYEsuWZOLwnwjB35shrgBmh2gPur8wDIruF4o3D1YKyjDihPayOXw3EIwlxfJ_whMadzg-38cgKq4RX03CbkSgvA0EeZhxRgT7_glF__erdLS5UTpqP4K40KIvVjV9dDbBEK8cWxpdpksNt2-EvJx-49tBSiR3EdQ1CWCzxVMWMl09NLunk18hWDUD-jtMQ4myZPSMuE4cFR6zmut5mR5FiiR-tPPstiywNL5QvlIEPWlfpT3Yp62RUxv1fzrEZ99kjrirGempCB7fh8B_oOn6WOUXZ77B0RzS7n95xOa7smYeqnmUA
2182020-06-12 14:34:41.231 8187-8714/com.rubarb.app.debug D/OkHttp: --> END GET
2192020-06-12 14:34:41.346 8187-8714/com.rubarb.app.debug D/OkHttp: <-- 200 https://api.rubarb-test.app/mobile/v1/onboarding/identificationProcessId (114ms)
2202020-06-12 14:34:41.346 8187-8714/com.rubarb.app.debug D/OkHttp: date: Fri, 12 Jun 2020 11:34:41 GMT
2212020-06-12 14:34:41.346 8187-8714/com.rubarb.app.debug D/OkHttp: content-type: application/json
2222020-06-12 14:34:41.346 8187-8714/com.rubarb.app.debug D/OkHttp: content-length: 51
2232020-06-12 14:34:41.346 8187-8714/com.rubarb.app.debug D/OkHttp: x-amzn-requestid: 07a5b3d5-6df6-40c3-9174-cf6ae2367635
2242020-06-12 14:34:41.347 8187-8714/com.rubarb.app.debug D/OkHttp: x-amz-apigw-id: OA08tG8CliAFYMw=
2252020-06-12 14:34:41.347 8187-8714/com.rubarb.app.debug D/OkHttp: x-amzn-trace-id: Root=1-5ee36851-b0965bf4fd5b07420c973cd9;Sampled=0
2262020-06-12 14:34:41.349 8187-8714/com.rubarb.app.debug D/OkHttp: {"IDNowIdentID":"TST-VNHHW","companyName":"rubarb"}
2272020-06-12 14:34:41.349 8187-8714/com.rubarb.app.debug D/OkHttp: <-- END HTTP (51-byte body)
2282020-06-12 14:34:41.379 8187-8187/com.rubarb.app.debug I/IDNOW_UTIL: select test server
2292020-06-12 14:34:41.433 8187-8716/com.rubarb.app.debug V/FA: Recording user engagement, ms: 108884
2302020-06-12 14:34:41.442 8187-8716/com.rubarb.app.debug V/FA: Connecting to remote service
2312020-06-12 14:34:41.449 8187-8715/com.rubarb.app.debug V/FA: onActivityCreated
2322020-06-12 14:34:41.454 8187-8716/com.rubarb.app.debug V/FA: Activity paused, time: 1474372516
2332020-06-12 14:34:41.502 8187-8187/com.rubarb.app.debug I/IDNOW_ENTRY: Front Camera and Back camera are available
2342020-06-12 14:34:41.503 8187-8187/com.rubarb.app.debug I/IDNOW_UTIL: online
2352020-06-12 14:34:41.503 8187-8187/com.rubarb.app.debug I/IDNOW_UTIL: select test server
2362020-06-12 14:34:41.503 8187-8187/com.rubarb.app.debug I/IDNOW_RESTCLIENT: getRestClient()
2372020-06-12 14:34:41.504 8187-8187/com.rubarb.app.debug I/IDNOW_RESTCLIENT: SYSTEM-LANGUAGE: en
2382020-06-12 14:34:41.508 8187-8717/com.rubarb.app.debug I/IDNOW_RESTCLIENT: ---> HTTP GET https://api.test.idnow.de/api/v1/rubarb
2392020-06-12 14:34:41.542 8187-8187/com.rubarb.app.debug D/InputTransport: Input channel constructed: fd=95
2402020-06-12 14:34:41.543 8187-8187/com.rubarb.app.debug D/ViewRootImpl@581d6c1[Activities_EntryActivity]: setView = DecorView@3cc27c0[Activities_EntryActivity] TM=true MM=false
2412020-06-12 14:34:41.544 8187-8187/com.rubarb.app.debug D/ViewRootImpl@c2c383c[ModalActivity]: MSG_WINDOW_FOCUS_CHANGED 0
2422020-06-12 14:34:41.553 8187-8187/com.rubarb.app.debug D/ViewRootImpl@581d6c1[Activities_EntryActivity]: dispatchAttachedToWindow
2432020-06-12 14:34:41.554 8187-8716/com.rubarb.app.debug V/FA: Connection attempt already in progress
2442020-06-12 14:34:41.558 8187-8716/com.rubarb.app.debug V/FA: Activity resumed, time: 1474372613
2452020-06-12 14:34:41.573 8187-8187/com.rubarb.app.debug V/Surface: sf_framedrop debug : 0x4f4c, game : false, logging : 0
2462020-06-12 14:34:41.574 8187-8187/com.rubarb.app.debug D/ViewRootImpl@581d6c1[Activities_EntryActivity]: Relayout returned: old=[0,0][0,0] new=[0,0][1080,2076] result=0x7 surface={valid=true 542982852608} changed=true
2472020-06-12 14:34:41.581 8187-8252/com.rubarb.app.debug D/mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, egl_color_buffer_format *, EGLBoolean) returns 0x3000, [1080x2076]-format:1
2482020-06-12 14:34:41.581 8187-8252/com.rubarb.app.debug D/OpenGLRenderer: eglCreateWindowSurface = 0x7e6f3e3360, 0x7e6c4cd010
2492020-06-12 14:34:41.593 8187-8187/com.rubarb.app.debug D/ViewRootImpl@581d6c1[Activities_EntryActivity]: MSG_RESIZED_REPORT: frame=Rect(0, 0 - 1080, 2076) ci=Rect(0, 72 - 0, 0) vi=Rect(0, 72 - 0, 0) or=1
2502020-06-12 14:34:41.593 8187-8187/com.rubarb.app.debug D/ViewRootImpl@581d6c1[Activities_EntryActivity]: MSG_WINDOW_FOCUS_CHANGED 1
2512020-06-12 14:34:41.594 8187-8187/com.rubarb.app.debug V/InputMethodManager: Starting input: tba=android.view.inputmethod.EditorInfo@d2bffec nm : com.rubarb.app.debug ic=null
2522020-06-12 14:34:41.594 8187-8187/com.rubarb.app.debug I/InputMethodManager: startInputInner - mService.startInputOrWindowGainedFocus
2532020-06-12 14:34:41.597 8187-8187/com.rubarb.app.debug D/InputTransport: Input channel constructed: fd=99
2542020-06-12 14:34:41.597 8187-8187/com.rubarb.app.debug D/InputTransport: Input channel destroyed: fd=92
2552020-06-12 14:34:41.629 8187-8716/com.rubarb.app.debug V/FA: Connection attempt already in progress
2562020-06-12 14:34:41.632 8187-8716/com.rubarb.app.debug V/FA: Connection attempt already in progress
2572020-06-12 14:34:41.633 8187-8716/com.rubarb.app.debug D/FA: Connected to remote service
2582020-06-12 14:34:41.634 8187-8716/com.rubarb.app.debug V/FA: Processing queued up service tasks: 4
2592020-06-12 14:34:41.639 8187-8252/com.rubarb.app.debug D/OpenGLRenderer: eglDestroySurface = 0x7e603daea0, 0x7e6279a000
2602020-06-12 14:34:41.651 8187-8187/com.rubarb.app.debug D/ViewRootImpl@c2c383c[ModalActivity]: Relayout returned: old=[0,0][1080,2220] new=[0,0][1080,2220] result=0x5 surface={valid=false 0} changed=true
2612020-06-12 14:34:41.900 8187-8717/com.rubarb.app.debug I/IDNOW_RESTCLIENT: <--- HTTP 200 https://api.test.idnow.de/api/v1/rubarb (391ms)
2622020-06-12 14:34:41.924 8187-8187/com.rubarb.app.debug I/IDNOW_ENTRY: office hours call was successful
2632020-06-12 14:34:41.924 8187-8187/com.rubarb.app.debug I/IDNOW_ENTRY: office open: true
2642020-06-12 14:34:41.926 8187-8187/com.rubarb.app.debug I/IDNOW_ENTRY: textChat enabled: false
2652020-06-12 14:34:41.927 8187-8187/com.rubarb.app.debug I/IDNOW_ENTRY: Suc Url: null
2662020-06-12 14:34:41.927 8187-8187/com.rubarb.app.debug I/IDNOW_ENTRY: fail Url: null
2672020-06-12 14:34:41.929 8187-8187/com.rubarb.app.debug I/IDNOW_ENTRY: message: Thank you for using our online identification service! You can now close the app and will be informed about the next steps.
2682020-06-12 14:34:42.331 8187-8397/com.rubarb.app.debug I/IDNOW_SDK_INIT: Successfully requested messages: https://api.test.idnow.de/assets/messages.json?shortName=rubarb
2692020-06-12 14:34:42.382 8187-8187/com.rubarb.app.debug I/IDNOW_RESTCLIENT: getRestClient()
2702020-06-12 14:34:42.385 8187-8187/com.rubarb.app.debug I/IDNOW_RESTCLIENT: SYSTEM-LANGUAGE: en
2712020-06-12 14:34:42.386 8187-8717/com.rubarb.app.debug I/IDNOW_RESTCLIENT: ---> HTTP GET https://api.test.idnow.de/api/v1/rubarb/identifications/TST-VNHHW
2722020-06-12 14:34:42.409 8187-8197/com.rubarb.app.debug E/System: Uncaught exception thrown by finalizer
2732020-06-12 14:34:42.415 8187-8197/com.rubarb.app.debug E/System: java.lang.IllegalStateException: Binder has been finalized!
274 at android.os.BinderProxy.transactNative(Native Method)
275 at android.os.BinderProxy.transact(Binder.java:761)
276 at android.security.IKeystoreService$Stub$Proxy.abort(IKeystoreService.java:1449)
277 at android.security.KeyStore.abort(KeyStore.java:971)
278 at android.security.keystore.AndroidKeyStoreCipherSpiBase.finalize(AndroidKeyStoreCipherSpiBase.java:744)
279 at android.security.keystore.AndroidKeyStoreUnauthenticatedAESCipherSpi$CBC$PKCS7Padding.finalize(Unknown Source:0)
280 at java.lang.Daemons$FinalizerDaemon.doFinalize(Daemons.java:250)
281 at java.lang.Daemons$FinalizerDaemon.runInternal(Daemons.java:237)
282 at java.lang.Daemons$Daemon.run(Daemons.java:103)
283 at java.lang.Thread.run(Thread.java:764)
2842020-06-12 14:34:42.528 8187-8717/com.rubarb.app.debug I/IDNOW_RESTCLIENT: <--- HTTP 200 https://api.test.idnow.de/api/v1/rubarb/identifications/TST-VNHHW (141ms)
2852020-06-12 14:34:42.581 8187-8715/com.rubarb.app.debug V/FA: onActivityCreated
2862020-06-12 14:34:42.584 8187-8716/com.rubarb.app.debug V/FA: Recording user engagement, ms: 1051
2872020-06-12 14:34:42.604 8187-8716/com.rubarb.app.debug V/FA: Activity paused, time: 1474373664
2882020-06-12 14:34:42.676 8187-8187/com.rubarb.app.debug D/ScrollView: initGoToTop
2892020-06-12 14:34:42.718 8187-8187/com.rubarb.app.debug I/IDNOW_RESTCLIENT: getRestClient()
2902020-06-12 14:34:42.730 8187-8187/com.rubarb.app.debug I/IDNOW_UTIL: {"backCameraHeight":"480","backCameraWidth":"640","clientVersion":"ANDROIDSDK,4.1.6","connectionType":"ConnectivityManager.TYPE_WIFI","deviceInfo":"jackpotlte","flashLight":true,"frontCameraHeight":"480","frontCameraWidth":"640","language":"en","locale":"en_GB","osVersion":"26","screenHeight":"2076","screenWidth":"1080","timezone":"Europe/Sofia"}
2912020-06-12 14:34:42.731 8187-8187/com.rubarb.app.debug I/IDNOW_RESTCLIENT: SYSTEM-LANGUAGE: en
2922020-06-12 14:34:42.736 8187-8716/com.rubarb.app.debug V/FA: Activity resumed, time: 1474373831
2932020-06-12 14:34:42.743 8187-8717/com.rubarb.app.debug I/IDNOW_RESTCLIENT: ---> HTTP POST https://api.test.idnow.de/api/v1/rubarb/identifications/TST-VNHHW/startCallQualityTest
2942020-06-12 14:34:42.743 8187-8187/com.rubarb.app.debug D/InputTransport: Input channel constructed: fd=100
2952020-06-12 14:34:42.744 8187-8187/com.rubarb.app.debug D/ViewRootImpl@df8af47[Activities_VideoLiveStreamActivity_CallQualityCheck]: setView = DecorView@347374[Activities_VideoLiveStreamActivity_CallQualityCheck] TM=true MM=false
2962020-06-12 14:34:42.747 8187-8187/com.rubarb.app.debug D/ViewRootImpl@581d6c1[Activities_EntryActivity]: MSG_WINDOW_FOCUS_CHANGED 0
2972020-06-12 14:34:42.757 8187-8187/com.rubarb.app.debug D/ViewRootImpl@df8af47[Activities_VideoLiveStreamActivity_CallQualityCheck]: dispatchAttachedToWindow
2982020-06-12 14:34:42.785 8187-8187/com.rubarb.app.debug V/Surface: sf_framedrop debug : 0x4f4c, game : false, logging : 0
2992020-06-12 14:34:42.785 8187-8187/com.rubarb.app.debug D/ViewRootImpl@df8af47[Activities_VideoLiveStreamActivity_CallQualityCheck]: Relayout returned: old=[0,0][0,0] new=[0,0][1080,2076] result=0x7 surface={valid=true 542983200768} changed=true
3002020-06-12 14:34:42.792 8187-8252/com.rubarb.app.debug D/mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, egl_color_buffer_format *, EGLBoolean) returns 0x3000, [1080x2076]-format:1
3012020-06-12 14:34:42.793 8187-8252/com.rubarb.app.debug D/OpenGLRenderer: eglCreateWindowSurface = 0x7e580a7be0, 0x7e6c522010
3022020-06-12 14:34:42.797 8187-8187/com.rubarb.app.debug D/ScrollView: onsize change changed
3032020-06-12 14:34:42.816 8187-8192/com.rubarb.app.debug I/zygote64: Do full code cache collection, code=1003KB, data=670KB
3042020-06-12 14:34:42.819 8187-8192/com.rubarb.app.debug I/zygote64: After code cache collection, code=975KB, data=578KB
3052020-06-12 14:34:42.842 8187-8187/com.rubarb.app.debug D/ViewRootImpl@df8af47[Activities_VideoLiveStreamActivity_CallQualityCheck]: MSG_RESIZED_REPORT: frame=Rect(0, 0 - 1080, 2076) ci=Rect(0, 72 - 0, 0) vi=Rect(0, 72 - 0, 0) or=1
3062020-06-12 14:34:42.843 8187-8187/com.rubarb.app.debug D/ViewRootImpl@df8af47[Activities_VideoLiveStreamActivity_CallQualityCheck]: MSG_WINDOW_FOCUS_CHANGED 1
3072020-06-12 14:34:42.856 8187-8187/com.rubarb.app.debug V/InputMethodManager: Starting input: tba=android.view.inputmethod.EditorInfo@e4d02d1 nm : com.rubarb.app.debug ic=null
3082020-06-12 14:34:42.857 8187-8187/com.rubarb.app.debug I/InputMethodManager: startInputInner - mService.startInputOrWindowGainedFocus
3092020-06-12 14:34:42.862 8187-8187/com.rubarb.app.debug D/InputTransport: Input channel constructed: fd=106
3102020-06-12 14:34:42.862 8187-8187/com.rubarb.app.debug D/InputTransport: Input channel destroyed: fd=99
3112020-06-12 14:34:42.886 8187-8252/com.rubarb.app.debug D/OpenGLRenderer: eglDestroySurface = 0x7e6f3e3360, 0x7e6c4cd000
3122020-06-12 14:34:42.916 8187-8187/com.rubarb.app.debug D/ViewRootImpl@581d6c1[Activities_EntryActivity]: Relayout returned: old=[0,0][1080,2076] new=[0,0][1080,2076] result=0x5 surface={valid=false 0} changed=true
3132020-06-12 14:34:42.922 8187-8717/com.rubarb.app.debug I/IDNOW_RESTCLIENT: <--- HTTP 200 https://api.test.idnow.de/api/v1/rubarb/identifications/TST-VNHHW/startCallQualityTest (178ms)
3142020-06-12 14:34:42.935 8187-8187/com.rubarb.app.debug I/IDNOW_CALL_QUALITY_TEST: Success creating test connection, sending SDP offer.
3152020-06-12 14:34:42.974 8187-8187/com.rubarb.app.debug D/AudioTrack: Client defaulted notificationFrames to 1924 for frameCount 3848
3162020-06-12 14:34:42.981 8187-8187/com.rubarb.app.debug W/AudioTrack: Use of stream types is deprecated for operations other than volume control
3172020-06-12 14:34:42.981 8187-8187/com.rubarb.app.debug W/AudioTrack: See the documentation of AudioTrack() for what to use instead with android.media.AudioAttributes to qualify your playback use case
3182020-06-12 14:34:43.006 8187-8187/com.rubarb.app.debug D/AudioTrack: Client defaulted notificationFrames to 432 for frameCount 1296
3192020-06-12 14:34:43.009 8187-8187/com.rubarb.app.debug W/AudioTrack: Use of stream types is deprecated for operations other than volume control
3202020-06-12 14:34:43.010 8187-8187/com.rubarb.app.debug W/AudioTrack: See the documentation of AudioTrack() for what to use instead with android.media.AudioAttributes to qualify your playback use case
3212020-06-12 14:34:43.023 8187-8187/com.rubarb.app.debug D/AudioTrack: Client defaulted notificationFrames to 218 for frameCount 656
3222020-06-12 14:34:43.027 8187-8187/com.rubarb.app.debug W/AudioTrack: Use of stream types is deprecated for operations other than volume control
3232020-06-12 14:34:43.028 8187-8187/com.rubarb.app.debug W/AudioTrack: See the documentation of AudioTrack() for what to use instead with android.media.AudioAttributes to qualify your playback use case
3242020-06-12 14:34:43.042 8187-8187/com.rubarb.app.debug D/AudioTrack: Client defaulted notificationFrames to 218 for frameCount 656
3252020-06-12 14:34:43.046 8187-8187/com.rubarb.app.debug W/AudioTrack: Use of stream types is deprecated for operations other than volume control
3262020-06-12 14:34:43.046 8187-8187/com.rubarb.app.debug W/AudioTrack: See the documentation of AudioTrack() for what to use instead with android.media.AudioAttributes to qualify your playback use case
3272020-06-12 14:34:43.348 8187-8192/com.rubarb.app.debug I/zygote64: Do partial code cache collection, code=1006KB, data=604KB
3282020-06-12 14:34:43.349 8187-8192/com.rubarb.app.debug I/zygote64: After code cache collection, code=1006KB, data=604KB
3292020-06-12 14:34:43.349 8187-8192/com.rubarb.app.debug I/zygote64: Increasing code cache capacity to 3MB
3302020-06-12 14:34:43.367 8187-8187/com.rubarb.app.debug D/JNI: Initialized libvpxfm encoder.
3312020-06-12 14:34:43.368 8187-8187/com.rubarb.app.debug D/JNI: VPX native encoder setting config.
3322020-06-12 14:34:43.368 8187-8187/com.rubarb.app.debug D/JNI: Creating new VPX encoder configuration for VP8.
3332020-06-12 14:34:43.380 8187-8187/com.rubarb.app.debug D/JNI: Initialized libvpxfm encoder.
3342020-06-12 14:34:43.380 8187-8187/com.rubarb.app.debug D/JNI: VPX native encoder setting config.
3352020-06-12 14:34:43.381 8187-8187/com.rubarb.app.debug D/JNI: Creating new VPX encoder configuration for VP9.
3362020-06-12 14:34:43.381 8187-8187/com.rubarb.app.debug D/JNI: VPX native encoder setting config.
3372020-06-12 14:34:43.396 8187-8187/com.rubarb.app.debug D/LocalMedia: sourceInputs: {"name":"Back-Facing Camera","id":"0"}
3382020-06-12 14:34:43.396 8187-8187/com.rubarb.app.debug D/LocalMedia: sourceInputs: {"name":"Front-Facing Camera","id":"1"}
3392020-06-12 14:34:43.477 8187-8187/com.rubarb.app.debug W/AudioManager: Use of stream types is deprecated for operations other than volume control
3402020-06-12 14:34:43.477 8187-8187/com.rubarb.app.debug W/AudioManager: See the documentation of requestAudioFocus() for what to use instead with android.media.AudioAttributes to qualify your playback use case
3412020-06-12 14:34:43.480 8187-8187/com.rubarb.app.debug D/AudioManager: requestAudioFocus status : 1
3422020-06-12 14:34:43.480 8187-8187/com.rubarb.app.debug I/IDNOW_CALL_QUALITY_TEST: Focus request granted
3432020-06-12 14:34:43.480 8187-8187/com.rubarb.app.debug I/IDNOW_ICELINK3: START !
3442020-06-12 14:34:43.490 8187-8187/com.rubarb.app.debug W/AudioManager: setStreamMute is deprecated. adjustStreamVolume should be used instead.
3452020-06-12 14:34:43.513 8187-8187/com.rubarb.app.debug W/AudioManager: setStreamMute is deprecated. adjustStreamVolume should be used instead.
3462020-06-12 14:34:43.526 8187-8748/com.rubarb.app.debug I/LocalMedia: local media state: Starting
3472020-06-12 14:34:43.527 8187-8748/com.rubarb.app.debug I/LocalMedia: addOnAudioStarted
3482020-06-12 14:34:43.527 8187-8748/com.rubarb.app.debug I/LocalMedia: local media state: Starting
3492020-06-12 14:34:43.528 8187-8748/com.rubarb.app.debug I/LocalMedia: local audio track started
3502020-06-12 14:34:43.541 8187-8755/com.rubarb.app.debug D/SensorManager: registerListener :: 1, LSM6DSL Accelerometer, 200000, 0,
3512020-06-12 14:34:43.620 8187-8755/com.rubarb.app.debug I/LocalMedia: local media state: Starting
3522020-06-12 14:34:43.620 8187-8755/com.rubarb.app.debug I/LocalMedia: addOnVideoStarted
3532020-06-12 14:34:43.620 8187-8755/com.rubarb.app.debug I/LocalMedia: local media state: Starting
3542020-06-12 14:34:43.620 8187-8755/com.rubarb.app.debug I/LocalMedia: local video track started
3552020-06-12 14:34:43.622 8187-8755/com.rubarb.app.debug I/IDNOW_ICELINK3: Connection state: Initializing
3562020-06-12 14:34:43.633 8187-8187/com.rubarb.app.debug V/Surface: sf_framedrop debug : 0x4f4c, game : false, logging : 0
3572020-06-12 14:34:44.241 8187-8199/com.rubarb.app.debug I/zygote64: Background concurrent copying GC freed 137111(4MB) AllocSpace objects, 10(640KB) LOS objects, 49% free, 11MB/22MB, paused 265us total 229.593ms
3582020-06-12 14:34:44.593 8187-8199/com.rubarb.app.debug I/zygote64: Background concurrent copying GC freed 121273(3MB) AllocSpace objects, 6(10MB) LOS objects, 50% free, 13MB/27MB, paused 3.304ms total 120.473ms
3592020-06-12 14:34:44.743 8187-8755/com.rubarb.app.debug I/IDNOW_CALL_QUALITY_TEST: -------> SENDING SDP TO SERVER
3602020-06-12 14:34:44.743 8187-8755/com.rubarb.app.debug I/IDNOW_RESTCLIENT: getRestClient()
3612020-06-12 14:34:44.745 8187-8755/com.rubarb.app.debug I/IDNOW_OKHTTP_FACTORY: API LEVEL26
3622020-06-12 14:34:44.747 8187-8755/com.rubarb.app.debug I/IDNOW_CALL_QUALITY_TEST: sendSdpOffer() CQC
3632020-06-12 14:34:44.758 8187-8755/com.rubarb.app.debug I/IDNOW_RESTCLIENT: SYSTEM-LANGUAGE: en
3642020-06-12 14:34:44.761 8187-8755/com.rubarb.app.debug D/IDNOW_CALL_QUALITY_TEST: Warm up: 3
3652020-06-12 14:34:44.768 8187-8826/com.rubarb.app.debug I/IDNOW_RESTCLIENT: ---> HTTP POST https://video.test.idnow.de/api/v1/conferences/dc821c40-fe5c-4a6a-b8b1-36de61ee28c2/USER/dc233f27-a548-43fc-8528-71484b2c66ea/sendSdpOffer
3662020-06-12 14:34:45.130 8187-8826/com.rubarb.app.debug I/IDNOW_RESTCLIENT: <--- HTTP 200 https://video.test.idnow.de/api/v1/conferences/dc821c40-fe5c-4a6a-b8b1-36de61ee28c2/USER/dc233f27-a548-43fc-8528-71484b2c66ea/sendSdpOffer (361ms)
3672020-06-12 14:34:45.152 8187-8187/com.rubarb.app.debug I/IDNOW_CALL_QUALITY_TEST: <------- RECEIVING SDP TO SERVER
3682020-06-12 14:34:45.152 8187-8187/com.rubarb.app.debug I/IDNOW_CALL_QUALITY_TEST: Sent SDP: success
3692020-06-12 14:34:45.244 8187-8187/com.rubarb.app.debug I/IDNOW_CALL_QUALITY_TEST: RECEIVED SDP: {"isOffer":false,"sdpMessage":"v=0\r\no=IceLink-3.8.1.24993 4544006800787975168 1 IN IP4 127.0.0.1\r\ns=Frozen Mountain\r\nt=0 0\r\na=ice-options:trickle\r\na=group:BUNDLE audio video data\r\nm=audio 6284 UDP\/TLS\/RTP\/SAVPF 96 9 0 8 97 98\r\nc=IN IP4 52.48.216.0\r\na=mid:audio\r\na=candidate:5deecf38d4125470134b826a636af975 1 udp 1686086911 52.48.216.0 6284 typ srflx raddr 52.48.216.0 rport 6284\r\na=ssrc:4132397896 cname:fd31217161cc4a89b5eb278eb8f47ef6\r\na=ssrc:4132397896 msid:fd31217161cc4a89b5eb278eb8f47ef6 ed091b48e59d4c73868fb9de47f0edec\r\na=ssrc:4132397896 mslabel:fd31217161cc4a89b5eb278eb8f47ef6\r\na=ssrc:4132397896 label:ed091b48e59d4c73868fb9de47f0edec\r\na=ssrc:4132397896 max-br:64000\r\na=ice-pwd:4a6d14253d634bc2b1eb2b54f5925506\r\na=rtcp-mux\r\na=rtpmap:96 opus\/48000\/2\r\na=fmtp:96 useinbandfec=1\r\na=rtpmap:9 G722\/8000\r\na=rtpmap:0 PCMU\/8000\r\na=rtpmap:8 PCMA\/8000\r\na=rtpmap:97 telephone-event\/48000\r\na=rtpmap:98 telephone-event\/8000\r\na=setup:active\r\na=fingerprint:sha-256 35:CA:15:FE:14:7D:9E:71:6F:34:C3:C4:37:16:75:DF:32:6E:EF:4B:B5:F0:64:1D:CD:94:AD:84:E0:44:49:62\r\na=sendrecv\r\na=ice-ufrag:73faf414\r\na=extmap:2\/sendrecv urn:ietf:params:rtp-hdrext:sdes:mid\r\na=rtcp:6284 IN IP4 52.48.216.0\r\nm=video 6284 UDP\/TLS\/RTP\/SAVPF 100\r\nc=IN IP4 0.0.0.0\r\nb=AS:800\r\na=mid:video\r\na=ssrc:816323721 cname:fd31217161cc4a89b5eb278eb8f47ef6\r\na=ssrc:816323721 msid:fd31217161cc4a89b5eb278eb8f47ef6 1f62599d31f946888b80f95a4e95fc1d\r\na=ssrc:816323721 mslabel:fd31217161cc4a89b5eb278eb8f47ef6\r\na=ssrc:816323721 label:1f62599d31f946888b80f95a4e95fc1d\r\na=ssrc:816323721 max-br:768000\r\na=rtcp-mux\r\na=ice-pwd:4a6d14253d634bc2b1eb2b54f5925506\r\na=rtpmap:100 VP9\/90000\r\na=rtcp-fb:100 nack pli\r\na=rtcp-fb:100 goog-remb\r\na=rtcp-fb:100 ccm fir\r\na=rtcp-fb:100 nack\r\na=setup:active\r\na=fingerprint:sha-256 35:CA:15:FE:14:7D:9E:71:6F:34:C3:C4:37:16:75:DF:32:6E:EF:4B:B5:F0:64:1D:CD:94:AD:84:E0:44:49:62\r\na=sendrecv\r\na=ice-ufrag:73faf414\r\na=extmap:2\/sendrecv urn:ietf:params:rtp-hdrext:sdes:mid\r\nm=application 6284 UDP\/DTLS\/SCTP webrtc-datachannel\r\nc=IN IP4 0.0.0.0\r\na=mid:data\r\na=rtcp-mux\r\na=ice-pwd:4a6d14253d634bc2b1eb2b54f5925506\r\na=setup:active\r\na=fingerprint:sha-256 35:CA:15:FE:14:7D:9E:71:6F:34:C3:C4:37:16:75:DF:32:6E:EF:4B:B5:F0:64:1D:CD:94:AD:84:E0:44:49:62\r\na=sendrecv\r\na=ice-ufrag:73faf414\r\na=sctp-port:5000\r\na=max-message-size:2147483647\r\n","tieBreaker":"4a8a1aac10ca4f5bb74d5df6845c2422"}
3702020-06-12 14:34:45.246 8187-8187/com.rubarb.app.debug I/IDNOW_ICELINK3: Setting targetBitrate for VPX encoder 800
3712020-06-12 14:34:45.246 8187-8187/com.rubarb.app.debug I/IDNOW_ICELINK3: Setting targetBitrate for VPX encoder 800
3722020-06-12 14:34:45.283 8187-8754/com.rubarb.app.debug D/JNI: Creating Opus Encoder...
3732020-06-12 14:34:45.283 8187-8754/com.rubarb.app.debug D/JNI: Opusfm encoder initialized (ClockRate: 48000, Channels: 2, PacketTime: 20.00).
3742020-06-12 14:34:45.283 8187-8754/com.rubarb.app.debug D/JNI: Opusfm decoder initialized (ClockRate: 48000, Channels: 2, PacketTime: 20.00).
3752020-06-12 14:34:45.285 8187-8754/com.rubarb.app.debug D/JNI: Setting Opus bitrate to 6 kbps in native encoder.
3762020-06-12 14:34:45.286 8187-8754/com.rubarb.app.debug D/JNI: Setting Opus bitrate to 32 kbps in native encoder.
3772020-06-12 14:34:45.288 8187-8187/com.rubarb.app.debug I/IDNOW_ICELINK3: Connection state: Connecting
3782020-06-12 14:34:45.290 8187-8187/com.rubarb.app.debug I/IDNOW_CALL_QUALITY_TEST: ----------> SENDING LOCAL CANDIDATE!
3792020-06-12 14:34:45.290 8187-8187/com.rubarb.app.debug I/IDNOW_RESTCLIENT: getRestClient()
3802020-06-12 14:34:45.294 8187-8187/com.rubarb.app.debug I/IDNOW_RESTCLIENT: SYSTEM-LANGUAGE: en
3812020-06-12 14:34:45.345 8187-8826/com.rubarb.app.debug I/IDNOW_RESTCLIENT: ---> HTTP POST https://video.test.idnow.de/api/v1/conferences/dc821c40-fe5c-4a6a-b8b1-36de61ee28c2/USER/dc233f27-a548-43fc-8528-71484b2c66ea/sendCandidate
3822020-06-12 14:34:45.398 8187-8804/com.rubarb.app.debug D/JNI: Creating and configuring VPX encoder.
3832020-06-12 14:34:45.437 8187-8804/com.rubarb.app.debug D/JNI: VPX encoder configured in VP9 mode.
3842020-06-12 14:34:45.442 8187-8826/com.rubarb.app.debug I/IDNOW_RESTCLIENT: <--- HTTP 204 https://video.test.idnow.de/api/v1/conferences/dc821c40-fe5c-4a6a-b8b1-36de61ee28c2/USER/dc233f27-a548-43fc-8528-71484b2c66ea/sendCandidate (96ms)
3852020-06-12 14:34:45.442 8187-8187/com.rubarb.app.debug I/IDNOW_CALL_QUALITY_TEST: <---------- RECEIVING LOCAL CANDIDATE!
3862020-06-12 14:34:45.442 8187-8187/com.rubarb.app.debug I/IDNOW_CALL_QUALITY_TEST: Sent candidate {"sdpCandidateAttribute":"a=candidate:988a1ac7b76d72fd623e202e68d0ae45 1 udp 1686086655 82.147.157.205 58160 typ srflx raddr 192.168.100.7 rport 58160","sdpMediaIndex":0}
3872020-06-12 14:34:45.443 8187-8187/com.rubarb.app.debug I/IDNOW_CALL_QUALITY_TEST: Sent candidate response status: 204
3882020-06-12 14:34:46.674 8187-8199/com.rubarb.app.debug I/zygote64: Background concurrent copying GC freed 153688(5MB) AllocSpace objects, 6(10MB) LOS objects, 50% free, 21MB/42MB, paused 404us total 109.721ms
3892020-06-12 14:34:47.522 8187-8813/com.rubarb.app.debug I/IDNOW_ICELINK3: Connection state: Connected
3902020-06-12 14:34:47.595 8187-8187/com.rubarb.app.debug D/SurfaceView: BG show() Surface(name=Background for - SurfaceView - com.rubarb.app.debug/de.idnow.sdk.Activities.Activities_VideoLiveStreamActivity_CallQualityCheck@1ae504b@0) fm.icelink.android.OpenGLView{1ae504b V.E...... ......ID 0,0-1080,1860}
3912020-06-12 14:34:47.605 8187-8748/com.rubarb.app.debug D/JNI: Creating Opus Encoder...
3922020-06-12 14:34:47.605 8187-8748/com.rubarb.app.debug D/JNI: Opusfm encoder initialized (ClockRate: 48000, Channels: 2, PacketTime: 20.00).
3932020-06-12 14:34:47.605 8187-8748/com.rubarb.app.debug D/JNI: Opusfm decoder initialized (ClockRate: 48000, Channels: 2, PacketTime: 20.00).
3942020-06-12 14:34:47.611 8187-8187/com.rubarb.app.debug V/Surface: sf_framedrop debug : 0x4f4c, game : false, logging : 0
3952020-06-12 14:34:47.613 8187-8187/com.rubarb.app.debug D/SurfaceView: surfaceCreated 1 #8 fm.icelink.android.OpenGLView{1ae504b V.E...... ......ID 0,0-1080,1860}
3962020-06-12 14:34:47.614 8187-8187/com.rubarb.app.debug D/SurfaceView: surfaceChanged (1080,1860) 1 #8 fm.icelink.android.OpenGLView{1ae504b V.E...... ......ID 0,0-1080,1860}
3972020-06-12 14:34:47.627 8187-8744/com.rubarb.app.debug D/mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, egl_color_buffer_format *, EGLBoolean) returns 0x3000, [1080x1860]-format:2
3982020-06-12 14:34:47.687 8187-8804/com.rubarb.app.debug D/JNI: Forcing VPX encoder to generate keyframe
3992020-06-12 14:34:47.726 8187-8187/com.rubarb.app.debug D/ViewRootImpl@df8af47[Activities_VideoLiveStreamActivity_CallQualityCheck]: Relayout returned: old=[0,0][1080,2076] new=[0,0][1080,2076] result=0x1 surface={valid=true 542983200768} changed=false
4002020-06-12 14:34:47.861 8187-8716/com.rubarb.app.debug V/FA: Inactivity, disconnecting from the service
4012020-06-12 14:34:47.896 8187-8804/com.rubarb.app.debug D/JNI: Forcing VPX encoder to generate keyframe
4022020-06-12 14:34:48.118 8187-8755/com.rubarb.app.debug D/JNI: Initialized libvpxfm decoder in VP9 mode.
4032020-06-12 14:34:48.908 8187-8199/com.rubarb.app.debug I/zygote64: Background concurrent copying GC freed 62458(1366KB) AllocSpace objects, 15(25MB) LOS objects, 50% free, 22MB/44MB, paused 2.620ms total 112.351ms
4042020-06-12 14:34:49.556 8187-8813/com.rubarb.app.debug D/IDNOW_CALL_QUALITY_TEST: Call Quality data: {"callQuality":{"user":{"video":{"quality":3},"audio":{"quality":3}},"agent":{"audio":{"quality":0},"video":{"quality":0}}}}
4052020-06-12 14:34:50.544 8187-8813/com.rubarb.app.debug D/IDNOW_CALL_QUALITY_TEST: Call Quality data: {"callQuality":{"user":{"video":{"quality":3},"audio":{"quality":3}},"agent":{"audio":{"quality":0},"video":{"quality":0}}}}
4062020-06-12 14:34:51.551 8187-8813/com.rubarb.app.debug D/IDNOW_CALL_QUALITY_TEST: Call Quality data: {"callQuality":{"user":{"video":{"quality":3},"audio":{"quality":3}},"agent":{"audio":{"quality":0},"video":{"quality":0}}}}
4072020-06-12 14:34:51.555 8187-8813/com.rubarb.app.debug I/IDNOW_CALL_QUALITY_TEST: Received call quality sample with video: 3 / audio: 3
4082020-06-12 14:34:52.599 8187-8813/com.rubarb.app.debug D/IDNOW_CALL_QUALITY_TEST: Call Quality data: {"callQuality":{"user":{"video":{"quality":3},"audio":{"quality":3}},"agent":{"audio":{"quality":0},"video":{"quality":0}}}}
4092020-06-12 14:34:52.600 8187-8813/com.rubarb.app.debug I/IDNOW_CALL_QUALITY_TEST: Received call quality sample with video: 3 / audio: 3
4102020-06-12 14:34:52.740 8187-8199/com.rubarb.app.debug I/zygote64: Background concurrent copying GC freed 38214(853KB) AllocSpace objects, 12(20MB) LOS objects, 50% free, 21MB/42MB, paused 2.309ms total 159.146ms
4112020-06-12 14:34:53.540 8187-8813/com.rubarb.app.debug D/IDNOW_CALL_QUALITY_TEST: Call Quality data: {"callQuality":{"user":{"video":{"quality":3},"audio":{"quality":3}},"agent":{"audio":{"quality":0},"video":{"quality":0}}}}
4122020-06-12 14:34:53.545 8187-8813/com.rubarb.app.debug I/IDNOW_CALL_QUALITY_TEST: Received call quality sample with video: 3 / audio: 3
4132020-06-12 14:34:54.530 8187-8813/com.rubarb.app.debug D/IDNOW_CALL_QUALITY_TEST: Call Quality data: {"callQuality":{"user":{"video":{"quality":3},"audio":{"quality":3}},"agent":{"audio":{"quality":0},"video":{"quality":0}}}}
4142020-06-12 14:34:54.531 8187-8813/com.rubarb.app.debug W/AudioManager: setStreamMute is deprecated. adjustStreamVolume should be used instead.
4152020-06-12 14:34:54.544 8187-8187/com.rubarb.app.debug I/IDNOW_CALL_QUALITY_TEST: Call quality was EXCELLENT. Proceeding to identification.
4162020-06-12 14:34:54.545 8187-8187/com.rubarb.app.debug W/AudioManager: setStreamMute is deprecated. adjustStreamVolume should be used instead.
4172020-06-12 14:34:54.574 8187-8187/com.rubarb.app.debug W/AudioManager: setStreamMute is deprecated. adjustStreamVolume should be used instead.
4182020-06-12 14:34:54.576 8187-8187/com.rubarb.app.debug I/IDNOW_ICELINK3: Stopping conference=Conference{mode=CQC, activity=Activities_VideoLiveStreamActivity_CallQualityCheck}
4192020-06-12 14:34:54.577 8187-8813/com.rubarb.app.debug W/AudioManager: setStreamMute is deprecated. adjustStreamVolume should be used instead.
4202020-06-12 14:34:54.583 8187-8813/com.rubarb.app.debug I/IDNOW_ICELINK3: Stopping conference=Conference{mode=CQC, activity=Activities_VideoLiveStreamActivity_CallQualityCheck}
4212020-06-12 14:34:54.584 8187-8813/com.rubarb.app.debug I/IDNOW_ICELINK3: Connection state: Closing
4222020-06-12 14:34:54.612 8187-8813/com.rubarb.app.debug D/JNI: Opusfm decoder destroyed.
4232020-06-12 14:34:54.721 8187-8726/com.rubarb.app.debug D/AudioTrack: stop() called with 557960 frames delivered
4242020-06-12 14:34:54.822 8187-8728/com.rubarb.app.debug D/AudioTrack: stop() called with 189216 frames delivered
4252020-06-12 14:34:54.870 8187-8730/com.rubarb.app.debug D/AudioTrack: stop() called with 94464 frames delivered
4262020-06-12 14:34:54.943 8187-8737/com.rubarb.app.debug D/AudioTrack: stop() called with 94792 frames delivered
4272020-06-12 14:34:54.994 8187-8813/com.rubarb.app.debug I/System.out: !@#
4282020-06-12 14:34:55.022 8187-8187/com.rubarb.app.debug I/IDNOW_CALL_QUALITY_TEST: Stopped connection with error: Local media cannot be stopped while it is being stopped on a different thread.
4292020-06-12 14:34:55.024 8187-8187/com.rubarb.app.debug I/IDNOW_RESTCLIENT: getRestClient()
4302020-06-12 14:34:55.057 8187-8767/com.rubarb.app.debug I/IDNOW_ICELINK3: Connection state: Closed
4312020-06-12 14:34:55.058 8187-8187/com.rubarb.app.debug I/IDNOW_UTIL: {"backCameraHeight":"480","backCameraWidth":"640","clientVersion":"ANDROIDSDK,4.1.6","connectionType":"ConnectivityManager.TYPE_WIFI","deviceInfo":"jackpotlte","flashLight":true,"frontCameraHeight":"480","frontCameraWidth":"640","language":"en","locale":"en_GB","osVersion":"26","screenHeight":"2076","screenWidth":"1080","timezone":"Europe/Sofia"}
4322020-06-12 14:34:55.065 8187-8187/com.rubarb.app.debug I/IDNOW_RESTCLIENT: SYSTEM-LANGUAGE: en
4332020-06-12 14:34:55.075 8187-8187/com.rubarb.app.debug I/Choreographer: Skipped 32 frames! The application may be doing too much work on its main thread.
4342020-06-12 14:34:55.092 8187-8187/com.rubarb.app.debug D/SurfaceView: BG show() Surface(name=Background for - SurfaceView - com.rubarb.app.debug/de.idnow.sdk.Activities.Activities_VideoLiveStreamActivity_CallQualityCheck@1ae504b@0) fm.icelink.android.OpenGLView{1ae504b V.E...... ........ 0,0-1080,1860}
4352020-06-12 14:34:55.093 8187-8187/com.rubarb.app.debug D/SurfaceView: surfaceDestroyed 1 #2 fm.icelink.android.OpenGLView{1ae504b V.E...... ........ 0,0-1080,1860}
4362020-06-12 14:34:55.102 8187-8187/com.rubarb.app.debug D/SurfaceView: BG destroy() Surface(name=Background for - SurfaceView - com.rubarb.app.debug/de.idnow.sdk.Activities.Activities_VideoLiveStreamActivity_CallQualityCheck@1ae504b@0) fm.icelink.android.OpenGLView{1ae504b V.E...... ........ 0,0-1080,1860}
4372020-06-12 14:34:55.102 8187-8717/com.rubarb.app.debug I/IDNOW_RESTCLIENT: ---> HTTP POST https://api.test.idnow.de/api/v1/rubarb/identifications/TST-VNHHW/start
4382020-06-12 14:34:55.152 8187-8845/com.rubarb.app.debug I/LocalMedia: local media state: Stopping
4392020-06-12 14:34:55.152 8187-8845/com.rubarb.app.debug I/LocalMedia: local audio track stopped
4402020-06-12 14:34:55.361 8187-8717/com.rubarb.app.debug I/IDNOW_RESTCLIENT: <--- HTTP 200 https://api.test.idnow.de/api/v1/rubarb/identifications/TST-VNHHW/start (256ms)
4412020-06-12 14:34:55.369 8187-8187/com.rubarb.app.debug D/IDNOW_CALL_QUALITY_TEST: success
4422020-06-12 14:34:55.423 8187-8716/com.rubarb.app.debug V/FA: Recording user engagement, ms: 12669
4432020-06-12 14:34:55.433 8187-8715/com.rubarb.app.debug V/FA: onActivityCreated
4442020-06-12 14:34:55.445 8187-8716/com.rubarb.app.debug V/FA: Connecting to remote service
4452020-06-12 14:34:55.459 8187-8716/com.rubarb.app.debug V/FA: Activity paused, time: 1474386501
4462020-06-12 14:34:55.470 8187-8755/com.rubarb.app.debug D/SensorManager: unregisterListener ::
4472020-06-12 14:34:55.472 8187-8755/com.rubarb.app.debug I/LocalMedia: local media state: Stopping
4482020-06-12 14:34:55.472 8187-8755/com.rubarb.app.debug I/LocalMedia: local video track stopped
4492020-06-12 14:34:55.515 8187-8716/com.rubarb.app.debug V/FA: Connection attempt already in progress
4502020-06-12 14:34:55.636 8187-8187/com.rubarb.app.debug W/ResourceType: Found multiple library tables, ignoring...
4512020-06-12 14:34:55.639 8187-8187/com.rubarb.app.debug I/WebViewFactory: Loading com.android.chrome version 83.0.4103.101 (code 410410173)
4522020-06-12 14:34:55.645 8187-8187/com.rubarb.app.debug I/zygote64: no shared libraies, dex_files: 1
4532020-06-12 14:34:55.654 8187-8187/com.rubarb.app.debug W/zygote64: sanity check size of dex files (2 * 2) and split shared libraries (2)
4542020-06-12 14:34:55.839 8187-8187/com.rubarb.app.debug I/cr_LibraryLoader: Loaded native library version number "83.0.4103.101"
4552020-06-12 14:34:55.842 8187-8187/com.rubarb.app.debug I/cr_CachingUmaRecorder: Flushed 3 samples from 3 histograms.
4562020-06-12 14:34:55.892 8187-8187/com.rubarb.app.debug W/ResourceType: Failure getting entry for 0x7f130569 (t=18 e=1385) (error -2147483647)
4572020-06-12 14:34:55.933 8187-8187/com.rubarb.app.debug E/chromium: [ERROR:filesystem_posix.cc(62)] mkdir /data/user/0/com.rubarb.app.debug/cache/WebView/Crashpad: No such file or directory (2)
4582020-06-12 14:34:56.218 8187-8187/com.rubarb.app.debug D/ConnectivityManager: requestNetwork; CallingUid : 11024, CallingPid : 8187
4592020-06-12 14:34:56.362 8187-8187/com.rubarb.app.debug D/ScrollView: initGoToTop
4602020-06-12 14:34:56.389 8187-8187/com.rubarb.app.debug D/ScrollView: initGoToTop
4612020-06-12 14:34:56.418 8187-8187/com.rubarb.app.debug D/ScrollView: initGoToTop
4622020-06-12 14:34:56.506 8187-8187/com.rubarb.app.debug I/IDNOW_ICELINK: Instance ID: de.idnow.sdk.Activities.Activities_VideoLiveStreamActivity_IceLink@bf1d6af
4632020-06-12 14:34:56.515 8187-8187/com.rubarb.app.debug D/AudioTrack: Client defaulted notificationFrames to 1924 for frameCount 3848
4642020-06-12 14:34:56.517 8187-8187/com.rubarb.app.debug W/AudioTrack: Use of stream types is deprecated for operations other than volume control
4652020-06-12 14:34:56.518 8187-8187/com.rubarb.app.debug W/AudioTrack: See the documentation of AudioTrack() for what to use instead with android.media.AudioAttributes to qualify your playback use case
4662020-06-12 14:34:56.526 8187-8187/com.rubarb.app.debug D/AudioTrack: Client defaulted notificationFrames to 432 for frameCount 1296
4672020-06-12 14:34:56.529 8187-8187/com.rubarb.app.debug W/AudioTrack: Use of stream types is deprecated for operations other than volume control
4682020-06-12 14:34:56.530 8187-8187/com.rubarb.app.debug W/AudioTrack: See the documentation of AudioTrack() for what to use instead with android.media.AudioAttributes to qualify your playback use case
4692020-06-12 14:34:56.537 8187-8187/com.rubarb.app.debug D/AudioTrack: Client defaulted notificationFrames to 218 for frameCount 656
4702020-06-12 14:34:56.539 8187-8187/com.rubarb.app.debug W/AudioTrack: Use of stream types is deprecated for operations other than volume control
4712020-06-12 14:34:56.539 8187-8187/com.rubarb.app.debug W/AudioTrack: See the documentation of AudioTrack() for what to use instead with android.media.AudioAttributes to qualify your playback use case
4722020-06-12 14:34:56.548 8187-8187/com.rubarb.app.debug D/AudioTrack: Client defaulted notificationFrames to 218 for frameCount 656
4732020-06-12 14:34:56.550 8187-8187/com.rubarb.app.debug W/AudioTrack: Use of stream types is deprecated for operations other than volume control
4742020-06-12 14:34:56.550 8187-8187/com.rubarb.app.debug W/AudioTrack: See the documentation of AudioTrack() for what to use instead with android.media.AudioAttributes to qualify your playback use case
4752020-06-12 14:34:56.625 8187-8187/com.rubarb.app.debug D/JNI: Initialized libvpxfm encoder.
4762020-06-12 14:34:56.626 8187-8187/com.rubarb.app.debug D/JNI: VPX native encoder setting config.
4772020-06-12 14:34:56.626 8187-8187/com.rubarb.app.debug D/JNI: Creating new VPX encoder configuration for VP8.
4782020-06-12 14:34:56.633 8187-8187/com.rubarb.app.debug D/JNI: Initialized libvpxfm encoder.
4792020-06-12 14:34:56.633 8187-8187/com.rubarb.app.debug D/JNI: VPX native encoder setting config.
4802020-06-12 14:34:56.633 8187-8187/com.rubarb.app.debug D/JNI: Creating new VPX encoder configuration for VP9.
4812020-06-12 14:34:56.634 8187-8187/com.rubarb.app.debug D/JNI: VPX native encoder setting config.
4822020-06-12 14:34:56.642 8187-8187/com.rubarb.app.debug D/LocalMedia: sourceInputs: {"name":"Back-Facing Camera","id":"0"}
4832020-06-12 14:34:56.642 8187-8187/com.rubarb.app.debug D/LocalMedia: sourceInputs: {"name":"Front-Facing Camera","id":"1"}
4842020-06-12 14:34:56.669 8187-8187/com.rubarb.app.debug W/AudioManager: Use of stream types is deprecated for operations other than volume control
4852020-06-12 14:34:56.669 8187-8187/com.rubarb.app.debug W/AudioManager: See the documentation of requestAudioFocus() for what to use instead with android.media.AudioAttributes to qualify your playback use case
4862020-06-12 14:34:56.671 8187-8187/com.rubarb.app.debug D/AudioManager: requestAudioFocus status : 1
4872020-06-12 14:34:56.671 8187-8187/com.rubarb.app.debug I/IDNOW_ICELINK: Focus request granted
4882020-06-12 14:34:56.671 8187-8187/com.rubarb.app.debug I/IDNOW_ICELINK3: START !
4892020-06-12 14:34:56.671 8187-8187/com.rubarb.app.debug I/IDNOW_ICELINK3: START !
4902020-06-12 14:34:56.709 8187-8187/com.rubarb.app.debug D/SensorManager: registerListener :: 1937338482, Samsung Orientation Sensor, 20000, 0,
4912020-06-12 14:34:56.709 8187-8187/com.rubarb.app.debug I/IDNOW_ICELINK: Found and enabled orientation sensor
4922020-06-12 14:34:56.715 8187-8187/com.rubarb.app.debug I/Connectivity VideoLivestream Activity: onResume
4932020-06-12 14:34:56.717 8187-8716/com.rubarb.app.debug V/FA: Activity resumed, time: 1474387812
4942020-06-12 14:34:56.718 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: setupWaitingQueueInformation - Showing default waiting position as it seems that the information has not been fetched yet
4952020-06-12 14:34:56.718 8187-8187/com.rubarb.app.debug I/IDNOW_UTILSTRINGS: Messages key null not found, falling back to default.
4962020-06-12 14:34:56.718 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: setupWaitingQueueInformation - starting poller
4972020-06-12 14:34:56.752 8187-8755/com.rubarb.app.debug I/LocalMedia: local media state: Starting
4982020-06-12 14:34:56.752 8187-8755/com.rubarb.app.debug I/LocalMedia: addOnAudioStarted
4992020-06-12 14:34:56.752 8187-8755/com.rubarb.app.debug I/LocalMedia: local media state: Starting
5002020-06-12 14:34:56.752 8187-8755/com.rubarb.app.debug I/LocalMedia: local audio track started
5012020-06-12 14:34:56.755 8187-8845/com.rubarb.app.debug D/SensorManager: registerListener :: 1, LSM6DSL Accelerometer, 200000, 0,
5022020-06-12 14:34:56.813 8187-8187/com.rubarb.app.debug D/InputTransport: Input channel constructed: fd=164
5032020-06-12 14:34:56.814 8187-8187/com.rubarb.app.debug D/ViewRootImpl@d2e1f92[Activities_VideoLiveStreamActivity_IceLink]: setView = DecorView@72e1d63[Activities_VideoLiveStreamActivity_IceLink] TM=true MM=false
5042020-06-12 14:34:56.816 8187-8716/com.rubarb.app.debug V/FA: Connection attempt already in progress
5052020-06-12 14:34:56.819 8187-8716/com.rubarb.app.debug V/FA: Connection attempt already in progress
5062020-06-12 14:34:56.826 8187-8187/com.rubarb.app.debug D/IDNOW_ICELINK: deltaX 27.85065 > 0.1
5072020-06-12 14:34:56.827 8187-8187/com.rubarb.app.debug E/IDNOW_ICELINK: autoFocus failed
5082020-06-12 14:34:56.829 8187-8187/com.rubarb.app.debug D/IDNOW_ICELINK: deltaX 20.939434 > 0.1
5092020-06-12 14:34:56.830 8187-8187/com.rubarb.app.debug E/IDNOW_ICELINK: autoFocus failed
5102020-06-12 14:34:56.830 8187-8845/com.rubarb.app.debug I/LocalMedia: local media state: Starting
5112020-06-12 14:34:56.830 8187-8845/com.rubarb.app.debug I/LocalMedia: addOnVideoStarted
5122020-06-12 14:34:56.830 8187-8845/com.rubarb.app.debug I/LocalMedia: local media state: Starting
5132020-06-12 14:34:56.831 8187-8845/com.rubarb.app.debug I/LocalMedia: local video track started
5142020-06-12 14:34:56.831 8187-8845/com.rubarb.app.debug I/IDNOW_WEBSOCKETSERVICE: Create
5152020-06-12 14:34:56.832 8187-8187/com.rubarb.app.debug D/IDNOW_ICELINK: deltaX 34.445946 > 0.1
5162020-06-12 14:34:56.832 8187-8845/com.rubarb.app.debug I/Network_OkHttpWebSocket: Set sink for video live stream
5172020-06-12 14:34:56.832 8187-8845/com.rubarb.app.debug I/IDNOW_WEBSOCKETSERVICE: Run
5182020-06-12 14:34:56.832 8187-8845/com.rubarb.app.debug I/IDNOW_OKHTTP_FACTORY: API LEVEL26
5192020-06-12 14:34:56.833 8187-8187/com.rubarb.app.debug E/IDNOW_ICELINK: autoFocus failed
5202020-06-12 14:34:56.835 8187-8845/com.rubarb.app.debug I/Network_OkHttpWebSocket: Using webSocket
5212020-06-12 14:34:56.837 8187-8187/com.rubarb.app.debug D/IDNOW_ICELINK: deltaX 26.648048 > 0.1
5222020-06-12 14:34:56.838 8187-8187/com.rubarb.app.debug E/IDNOW_ICELINK: autoFocus failed
5232020-06-12 14:34:56.840 8187-8187/com.rubarb.app.debug D/IDNOW_ICELINK: deltaX 1.1702423 > 0.1
5242020-06-12 14:34:56.840 8187-8187/com.rubarb.app.debug E/IDNOW_ICELINK: autoFocus failed
5252020-06-12 14:34:56.842 8187-8187/com.rubarb.app.debug D/ViewRootImpl@df8af47[Activities_VideoLiveStreamActivity_CallQualityCheck]: MSG_WINDOW_FOCUS_CHANGED 0
5262020-06-12 14:34:56.850 8187-8746/com.rubarb.app.debug W/FM: 2020-06-12T11:34:56.846Z Could not unset local view. A view does not exist.
5272020-06-12 14:34:56.856 8187-8187/com.rubarb.app.debug D/JNI: Opusfm decoder destroyed.
5282020-06-12 14:34:56.869 8187-8187/com.rubarb.app.debug D/IDNOW_ICELINK: deltaX 0.30996704 > 0.1
5292020-06-12 14:34:56.870 8187-8187/com.rubarb.app.debug E/IDNOW_ICELINK: autoFocus failed
5302020-06-12 14:34:56.876 8187-8187/com.rubarb.app.debug D/IDNOW_ICELINK: deltaY 0.2049942 > 0.1
5312020-06-12 14:34:56.876 8187-8187/com.rubarb.app.debug E/IDNOW_ICELINK: autoFocus failed
5322020-06-12 14:34:56.883 8187-8187/com.rubarb.app.debug D/ConnecationChangeDialogObservable: notifying observers
5332020-06-12 14:34:56.883 8187-8187/com.rubarb.app.debug D/LiveStreamActivity: update Observer
5342020-06-12 14:34:56.884 8187-8187/com.rubarb.app.debug I/IDNOW_RESTCLIENT: getRestClient()
5352020-06-12 14:34:56.884 8187-8192/com.rubarb.app.debug I/zygote64: Do full code cache collection, code=1511KB, data=982KB
5362020-06-12 14:34:56.886 8187-8187/com.rubarb.app.debug I/IDNOW_RESTCLIENT: SYSTEM-LANGUAGE: en
5372020-06-12 14:34:56.888 8187-8192/com.rubarb.app.debug I/zygote64: After code cache collection, code=1278KB, data=771KB
5382020-06-12 14:34:56.889 8187-8717/com.rubarb.app.debug I/IDNOW_RESTCLIENT: ---> HTTP GET https://api.test.idnow.de/api/v1/rubarb/identifications/TST-VNHHW
5392020-06-12 14:34:56.901 8187-8187/com.rubarb.app.debug V/InputMethodManager: Not IME target window, ignoring
5402020-06-12 14:34:56.940 8187-8187/com.rubarb.app.debug D/ViewRootImpl@d2e1f92[Activities_VideoLiveStreamActivity_IceLink]: dispatchAttachedToWindow
5412020-06-12 14:34:56.965 8187-8187/com.rubarb.app.debug V/Surface: sf_framedrop debug : 0x4f4c, game : false, logging : 0
5422020-06-12 14:34:56.965 8187-8187/com.rubarb.app.debug D/ViewRootImpl@d2e1f92[Activities_VideoLiveStreamActivity_IceLink]: Relayout returned: old=[0,0][0,0] new=[0,0][1080,2076] result=0x7 surface={valid=true 542630875136} changed=true
5432020-06-12 14:34:56.973 8187-8252/com.rubarb.app.debug D/mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, egl_color_buffer_format *, EGLBoolean) returns 0x3000, [1080x2076]-format:1
5442020-06-12 14:34:56.973 8187-8252/com.rubarb.app.debug D/OpenGLRenderer: eglCreateWindowSurface = 0x7e6f3e4760, 0x7e57521010
5452020-06-12 14:34:56.977 8187-8187/com.rubarb.app.debug W/View: requestLayout() improperly called by android.widget.RelativeLayout{e18a567 V.E...... ......I. 0,0-0,0} during layout: running second layout pass
5462020-06-12 14:34:56.978 8187-8187/com.rubarb.app.debug I/ViewRootImpl@d2e1f92[Activities_VideoLiveStreamActivity_IceLink]: requestLayout is already in process
5472020-06-12 14:34:56.978 8187-8187/com.rubarb.app.debug W/View: requestLayout() improperly called by android.widget.FrameLayout{78dff14 V.E...... ......I. 0,0-0,0} during layout: running second layout pass
5482020-06-12 14:34:56.978 8187-8187/com.rubarb.app.debug W/View: requestLayout() improperly called by android.widget.RelativeLayout{8a5e3bd V.E...... ......I. 0,0-0,0} during layout: running second layout pass
5492020-06-12 14:34:56.982 8187-8187/com.rubarb.app.debug I/ViewRootImpl@d2e1f92[Activities_VideoLiveStreamActivity_IceLink]: requestLayoutDuringLayout is already in process
5502020-06-12 14:34:56.994 8187-8187/com.rubarb.app.debug D/IDNOW_ICELINK: deltaX 0.7931366 > 0.1
5512020-06-12 14:34:56.994 8187-8187/com.rubarb.app.debug E/IDNOW_ICELINK: autoFocus failed
5522020-06-12 14:34:56.996 8187-8187/com.rubarb.app.debug D/IDNOW_ICELINK: deltaY 0.39052963 > 0.1
5532020-06-12 14:34:56.996 8187-8187/com.rubarb.app.debug E/IDNOW_ICELINK: autoFocus failed
5542020-06-12 14:34:56.997 8187-8187/com.rubarb.app.debug D/IDNOW_ICELINK: deltaX 0.10092163 > 0.1
5552020-06-12 14:34:56.998 8187-8187/com.rubarb.app.debug E/IDNOW_ICELINK: autoFocus failed
5562020-06-12 14:34:57.000 8187-8187/com.rubarb.app.debug D/IDNOW_ICELINK: deltaX 0.5998993 > 0.1
5572020-06-12 14:34:57.001 8187-8187/com.rubarb.app.debug E/IDNOW_ICELINK: autoFocus failed
5582020-06-12 14:34:57.002 8187-8187/com.rubarb.app.debug D/IDNOW_ICELINK: deltaX 0.42074585 > 0.1
5592020-06-12 14:34:57.003 8187-8187/com.rubarb.app.debug E/IDNOW_ICELINK: autoFocus failed
5602020-06-12 14:34:57.004 8187-8187/com.rubarb.app.debug D/IDNOW_ICELINK: deltaX 0.5380249 > 0.1
5612020-06-12 14:34:57.005 8187-8187/com.rubarb.app.debug E/IDNOW_ICELINK: autoFocus failed
5622020-06-12 14:34:57.019 8187-8187/com.rubarb.app.debug D/IDNOW_ICELINK: deltaX 0.23036194 > 0.1
5632020-06-12 14:34:57.020 8187-8187/com.rubarb.app.debug E/IDNOW_ICELINK: autoFocus failed
5642020-06-12 14:34:57.029 8187-8717/com.rubarb.app.debug I/IDNOW_RESTCLIENT: <--- HTTP 200 https://api.test.idnow.de/api/v1/rubarb/identifications/TST-VNHHW (139ms)
5652020-06-12 14:34:57.031 8187-8187/com.rubarb.app.debug V/Surface: sf_framedrop debug : 0x4f4c, game : false, logging : 0
5662020-06-12 14:34:57.140 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: OPEN SOCKET
5672020-06-12 14:34:57.143 8187-8958/com.rubarb.app.debug I/IDNOW_RESTCLIENT: getRestClient()
5682020-06-12 14:34:57.146 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: onMessage{"command":"ping","data":null}
5692020-06-12 14:34:57.152 8187-8958/com.rubarb.app.debug I/IDNOW_RESTCLIENT: SYSTEM-LANGUAGE: en
5702020-06-12 14:34:57.161 8187-8717/com.rubarb.app.debug I/IDNOW_RESTCLIENT: ---> HTTP POST https://api.test.idnow.de/api/v1/rubarb/identifications/TST-VNHHW/requestVideoChat
5712020-06-12 14:34:57.167 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: response: ping
5722020-06-12 14:34:57.314 8187-8717/com.rubarb.app.debug I/IDNOW_RESTCLIENT: <--- HTTP 200 https://api.test.idnow.de/api/v1/rubarb/identifications/TST-VNHHW/requestVideoChat (152ms)
5732020-06-12 14:34:57.438 8187-8187/com.rubarb.app.debug D/IDNOW_ICELINK: deltaX 1.1280975 > 0.1
5742020-06-12 14:34:57.477 8187-8187/com.rubarb.app.debug D/ViewRootImpl@d2e1f92[Activities_VideoLiveStreamActivity_IceLink]: MSG_RESIZED_REPORT: frame=Rect(0, 0 - 1080, 2076) ci=Rect(0, 72 - 0, 0) vi=Rect(0, 72 - 0, 0) or=1
5752020-06-12 14:34:57.478 8187-8187/com.rubarb.app.debug D/ViewRootImpl@d2e1f92[Activities_VideoLiveStreamActivity_IceLink]: MSG_WINDOW_FOCUS_CHANGED 1
5762020-06-12 14:34:57.517 8187-8187/com.rubarb.app.debug I/IDNOW_RESTCLIENT: getRestClient()
5772020-06-12 14:34:57.526 8187-8187/com.rubarb.app.debug I/IDNOW_RESTCLIENT: SYSTEM-LANGUAGE: en
5782020-06-12 14:34:57.559 8187-8187/com.rubarb.app.debug V/InputMethodManager: Starting input: tba=android.view.inputmethod.EditorInfo@567e86 nm : com.rubarb.app.debug ic=null
5792020-06-12 14:34:57.560 8187-8187/com.rubarb.app.debug I/InputMethodManager: startInputInner - mService.startInputOrWindowGainedFocus
5802020-06-12 14:34:57.576 8187-8717/com.rubarb.app.debug I/IDNOW_RESTCLIENT: ---> HTTP POST https://api.test.idnow.de/api/v1/rubarb/identifications/TST-VNHHW/appEnteredForeground
5812020-06-12 14:34:57.584 8187-8187/com.rubarb.app.debug D/InputTransport: Input channel constructed: fd=167
5822020-06-12 14:34:57.585 8187-8187/com.rubarb.app.debug D/InputTransport: Input channel destroyed: fd=106
5832020-06-12 14:34:57.605 8187-8187/com.rubarb.app.debug W/View: requestLayout() improperly called by android.widget.FrameLayout{78dff14 V.E...... ......I. 0,0-1080,1524} during second layout pass: posting in next frame
5842020-06-12 14:34:57.606 8187-8187/com.rubarb.app.debug W/View: requestLayout() improperly called by android.view.TextureView{104e347 V.ED..... ......I. 0,0-1524,1524} during second layout pass: posting in next frame
5852020-06-12 14:34:57.609 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: fetching waiting information successful
5862020-06-12 14:34:57.609 8187-8716/com.rubarb.app.debug D/FA: Connected to remote service
5872020-06-12 14:34:57.610 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: positionInQueue: 0 - waitingTime: 0 - isPositionInitializedByResponse: false
5882020-06-12 14:34:57.610 8187-8187/com.rubarb.app.debug D/IDNOW_LIVESTREAM: Waitingpos - updateWaitingInformation - update based on resultObject
5892020-06-12 14:34:57.610 8187-8187/com.rubarb.app.debug D/IDNOW_LIVESTREAM: Waitingpos - updateWaitingInformation - skipping update as the response was not yet having proper value
5902020-06-12 14:34:57.612 8187-8716/com.rubarb.app.debug V/FA: Processing queued up service tasks: 4
5912020-06-12 14:34:57.613 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: requestVideoChat REST Call was successful
5922020-06-12 14:34:57.695 8187-8252/com.rubarb.app.debug D/OpenGLRenderer: eglDestroySurface = 0x7e580a7be0, 0x7e6c522000
5932020-06-12 14:34:57.713 8187-8717/com.rubarb.app.debug I/IDNOW_RESTCLIENT: <--- HTTP 200 https://api.test.idnow.de/api/v1/rubarb/identifications/TST-VNHHW/appEnteredForeground (136ms)
5942020-06-12 14:34:57.714 8187-8187/com.rubarb.app.debug D/ViewRootImpl@df8af47[Activities_VideoLiveStreamActivity_CallQualityCheck]: Relayout returned: old=[0,0][1080,2076] new=[0,0][1080,2076] result=0x5 surface={valid=false 0} changed=true
5952020-06-12 14:34:57.726 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: appEnteredBackground REST Call was successful
5962020-06-12 14:34:57.982 8187-8187/com.rubarb.app.debug D/ViewRootImpl@df8af47[Activities_VideoLiveStreamActivity_CallQualityCheck]: dispatchDetachedFromWindow
5972020-06-12 14:34:57.982 8187-8187/com.rubarb.app.debug D/InputEventReceiver: channel '520074e com.rubarb.app.debug/de.idnow.sdk.Activities.Activities_VideoLiveStreamActivity_CallQualityCheck (client)' ~ Disposing input event receiver.
5982020-06-12 14:34:57.982 8187-8187/com.rubarb.app.debug D/InputEventReceiver: channel '520074e com.rubarb.app.debug/de.idnow.sdk.Activities.Activities_VideoLiveStreamActivity_CallQualityCheck (client)' ~NativeInputEventReceiver.
5992020-06-12 14:34:57.987 8187-8187/com.rubarb.app.debug D/InputTransport: Input channel destroyed: fd=100
6002020-06-12 14:34:59.446 8187-8187/com.rubarb.app.debug I/IDNOW_ICELINK: Samsung: myAutoFocusCallback
6012020-06-12 14:34:59.465 8187-8187/com.rubarb.app.debug D/IDNOW_ICELINK: deltaX 1.3894196 > 0.1
6022020-06-12 14:35:01.466 8187-8187/com.rubarb.app.debug I/IDNOW_ICELINK: Samsung: myAutoFocusCallback
6032020-06-12 14:35:01.512 8187-8187/com.rubarb.app.debug D/IDNOW_ICELINK: deltaX 0.23058319 > 0.1
6042020-06-12 14:35:02.156 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: onMessage{"command":"ping","data":null}
6052020-06-12 14:35:02.157 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: response: ping
6062020-06-12 14:35:02.716 8187-8716/com.rubarb.app.debug V/FA: Inactivity, disconnecting from the service
6072020-06-12 14:35:03.514 8187-8187/com.rubarb.app.debug I/IDNOW_ICELINK: Samsung: myAutoFocusCallback
6082020-06-12 14:35:04.823 8187-8199/com.rubarb.app.debug I/zygote64: Background concurrent copying GC freed 3124(128KB) AllocSpace objects, 14(23MB) LOS objects, 49% free, 19MB/38MB, paused 7.378ms total 97.125ms
6092020-06-12 14:35:05.990 8187-8199/com.rubarb.app.debug I/zygote64: Background concurrent copying GC freed 3070(128KB) AllocSpace objects, 14(23MB) LOS objects, 50% free, 19MB/38MB, paused 3.069ms total 100.214ms
6102020-06-12 14:35:06.579 8187-8199/com.rubarb.app.debug I/zygote64: Background concurrent copying GC freed 2909(112KB) AllocSpace objects, 14(23MB) LOS objects, 50% free, 19MB/38MB, paused 2.518ms total 104.502ms
6112020-06-12 14:35:06.889 8187-8187/com.rubarb.app.debug I/IDNOW_RESTCLIENT: getRestClient()
6122020-06-12 14:35:06.892 8187-8187/com.rubarb.app.debug I/IDNOW_RESTCLIENT: SYSTEM-LANGUAGE: en
6132020-06-12 14:35:06.896 8187-8717/com.rubarb.app.debug I/IDNOW_RESTCLIENT: ---> HTTP GET https://api.test.idnow.de/api/v1/rubarb/identifications/TST-VNHHW
6142020-06-12 14:35:07.700 8187-8199/com.rubarb.app.debug I/zygote64: Background concurrent copying GC freed 2911(111KB) AllocSpace objects, 14(23MB) LOS objects, 49% free, 19MB/38MB, paused 3.002ms total 103.254ms
6152020-06-12 14:35:08.713 8187-8717/com.rubarb.app.debug I/IDNOW_RESTCLIENT: <--- HTTP 200 https://api.test.idnow.de/api/v1/rubarb/identifications/TST-VNHHW (1816ms)
6162020-06-12 14:35:08.742 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: fetching waiting information successful
6172020-06-12 14:35:08.743 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: positionInQueue: 0 - waitingTime: 0 - isPositionInitializedByResponse: false
6182020-06-12 14:35:08.743 8187-8187/com.rubarb.app.debug D/IDNOW_LIVESTREAM: Waitingpos - updateWaitingInformation - update based on resultObject
6192020-06-12 14:35:08.744 8187-8187/com.rubarb.app.debug D/IDNOW_LIVESTREAM: Waitingpos - updateWaitingInformation - skipping update as the response was not yet having proper value
6202020-06-12 14:35:09.407 8187-8199/com.rubarb.app.debug I/zygote64: Background concurrent copying GC freed 3267(162KB) AllocSpace objects, 14(23MB) LOS objects, 50% free, 19MB/38MB, paused 2.845ms total 102.637ms
6212020-06-12 14:35:09.730 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: onMessage{"command":"agentConnected","data":null,"nextStep":null,"employee":{"firstname":"Test","lastname":"Robot"},"requestId":623137}
6222020-06-12 14:35:09.736 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: response: agentConnected
6232020-06-12 14:35:09.740 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: Push notification panel closed.
6242020-06-12 14:35:09.741 8187-8187/com.rubarb.app.debug I/IDNOW_ICELINK3: START !
6252020-06-12 14:35:09.751 8187-8187/com.rubarb.app.debug I/IDNOW_ICELINK3: Connection state: Initializing
6262020-06-12 14:35:09.777 8187-8746/com.rubarb.app.debug E/FM: 2020-06-12T11:35:09.745Z Could not set local view.
627 java.lang.RuntimeException: java.lang.IllegalStateException: The specified child already has a parent. You must call removeView() on the child's parent first.
628 at fm.icelink.android.Utility.dispatchToMainThread(Utility.java:93)
629 at fm.icelink.android.Utility.dispatchToMainThread(Utility.java:14)
630 at fm.icelink.android.LayoutManager.dispatchToMainThread(LayoutManager.java:91)
631 at fm.icelink.LayoutManager.setLocalView(LayoutManager.java:589)
632 at de.idnow.sdk.icelink3.Conference$3.run(Conference.java:268)
633 at android.app.Activity.runOnUiThread(Activity.java:6281)
634 at de.idnow.sdk.icelink3.Conference.start(Conference.java:257)
635 at de.idnow.sdk.Activities.Activities_VideoLiveStreamActivity_IceLink$7.run(Activities_VideoLiveStreamActivity_IceLink.java:510)
636 at android.os.Handler.handleCallback(Handler.java:789)
637 at android.os.Handler.dispatchMessage(Handler.java:98)
638 at android.os.Looper.loop(Looper.java:164)
639 at android.app.ActivityThread.main(ActivityThread.java:6944)
640 at java.lang.reflect.Method.invoke(Native Method)
641 at com.android.internal.os.Zygote$MethodAndArgsCaller.run(Zygote.java:327)
642 at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:1374)
643 Caused by: java.lang.IllegalStateException: The specified child already has a parent. You must call removeView() on the child's parent first.
644 at android.view.ViewGroup.addViewInner(ViewGroup.java:5122)
645 at android.view.ViewGroup.addView(ViewGroup.java:4953)
646 at android.view.ViewGroup.addView(ViewGroup.java:4893)
647 at android.view.ViewGroup.addView(ViewGroup.java:4866)
648 at fm.icelink.android.LayoutManager.addView(LayoutManager.java:71)
649 at fm.icelink.android.LayoutManager.addView(LayoutManager.java:15)
650 at fm.icelink.LayoutManager.setLocalViewUI(LayoutManager.java:613)
651 at fm.icelink.LayoutManager.access$600(LayoutManager.java:7)
652 at fm.icelink.LayoutManager$9.invoke(LayoutManager.java:594)
653 at fm.icelink.android.LayoutManager$2.invoke(LayoutManager.java:95)
654 at fm.icelink.android.Utility$1.run(Utility.java:43)
655 at fm.icelink.android.Utility.dispatchToMainThread(Utility.java:64)
656 at fm.icelink.android.Utility.dispatchToMainThread(Utility.java:14)
657 at fm.icelink.android.LayoutManager.dispatchToMainThread(LayoutManager.java:91)
658 at fm.icelink.LayoutManager.setLocalView(LayoutManager.java:589)
659 at de.idnow.sdk.icelink3.Conference$3.run(Conference.java:268)
660 at android.app.Activity.runOnUiThread(Activity.java:6281)
661 at de.idnow.sdk.icelink3.Conference.start(Conference.java:257)
662 at de.idnow.sdk.Activities.Activities_VideoLiveStreamActivity_IceLink$7.run(Activities_VideoLiveStreamActivity_IceLink.java:510)
663 at android.os.Handler.handleCallback(Handler.java:789)
664 at android.os.Handler.dispatchMessage(Handler.java:98)
665 at android.os.Looper.loop(Looper.java:164)
666 at android.app.ActivityThread.main(ActivityThread.java:6944)
667 at java.lang.reflect.Method.invoke(Native Method)
668 at com.android.internal.os.Zygote$MethodAndArgsCaller.run(Zygote.java:327)
669 at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:1374)
6702020-06-12 14:35:10.034 8187-8187/com.rubarb.app.debug I/IDNOW_RESTCLIENT: getRestClient()
6712020-06-12 14:35:10.035 8187-8187/com.rubarb.app.debug I/IDNOW_ICELINK: Using session: 8d3f5ed3-9fef-4e4e-91eb-ac6fc8226d34
6722020-06-12 14:35:10.035 8187-8187/com.rubarb.app.debug I/IDNOW_ICELINK: Using session user token: 02b83893-2ae7-41db-b38f-fb7b5977244f
6732020-06-12 14:35:10.036 8187-8187/com.rubarb.app.debug I/IDNOW_ICELINK: sendSdpOffer() IceLink
6742020-06-12 14:35:10.039 8187-8187/com.rubarb.app.debug I/IDNOW_RESTCLIENT: SYSTEM-LANGUAGE: en
6752020-06-12 14:35:10.041 8187-8187/com.rubarb.app.debug I/IDNOW_UTILSTRINGS: Messages key null not found, falling back to default.
6762020-06-12 14:35:10.042 8187-8187/com.rubarb.app.debug I/IDNOW_UTILSTRINGS: Messages key null not found, falling back to default.
6772020-06-12 14:35:10.043 8187-8187/com.rubarb.app.debug I/IDNOW_RESTCLIENT: getRestClient()
6782020-06-12 14:35:10.045 8187-8187/com.rubarb.app.debug I/IDNOW_RESTCLIENT: SYSTEM-LANGUAGE: en
6792020-06-12 14:35:10.051 8187-8826/com.rubarb.app.debug I/IDNOW_RESTCLIENT: ---> HTTP POST https://video.test.idnow.de/api/v1/conferences/8d3f5ed3-9fef-4e4e-91eb-ac6fc8226d34/USER/02b83893-2ae7-41db-b38f-fb7b5977244f/sendSdpOffer
6802020-06-12 14:35:10.052 8187-8717/com.rubarb.app.debug I/IDNOW_RESTCLIENT: ---> HTTP POST https://api.test.idnow.de/api/v1/rubarb/identifications/TST-VNHHW/setupComplete
6812020-06-12 14:35:10.185 8187-8826/com.rubarb.app.debug I/IDNOW_RESTCLIENT: <--- HTTP 200 https://video.test.idnow.de/api/v1/conferences/8d3f5ed3-9fef-4e4e-91eb-ac6fc8226d34/USER/02b83893-2ae7-41db-b38f-fb7b5977244f/sendSdpOffer (133ms)
6822020-06-12 14:35:10.187 8187-8717/com.rubarb.app.debug I/IDNOW_RESTCLIENT: <--- HTTP 200 https://api.test.idnow.de/api/v1/rubarb/identifications/TST-VNHHW/setupComplete (133ms)
6832020-06-12 14:35:10.192 8187-8187/com.rubarb.app.debug I/IDNOW_ICELINK: Sent SDP: success
6842020-06-12 14:35:10.236 8187-8187/com.rubarb.app.debug I/IDNOW_ICELINK: RECEIVED SDP: {"isOffer":false,"sdpMessage":"v=0\r\no=IceLink-3.8.1.24993 6113955011414854656 1 IN IP4 127.0.0.1\r\ns=Frozen Mountain\r\nt=0 0\r\na=ice-options:trickle\r\na=group:BUNDLE audio video\r\nm=audio 6400 UDP\/TLS\/RTP\/SAVPF 96 9 0 8 97 98\r\nc=IN IP4 52.30.27.5\r\na=mid:audio\r\na=candidate:7a1866505ad133b4e93ea4d6ed03292b 1 udp 1686086911 52.30.27.5 6400 typ srflx raddr 52.30.27.5 rport 6400\r\na=ssrc:2725191903 cname:3236665921ef4572844b0fbf3d9474da\r\na=ssrc:2725191903 msid:3236665921ef4572844b0fbf3d9474da 5007205085e641bea046feafac6bd050\r\na=ssrc:2725191903 mslabel:3236665921ef4572844b0fbf3d9474da\r\na=ssrc:2725191903 label:5007205085e641bea046feafac6bd050\r\na=ssrc:2725191903 max-br:64000\r\na=ice-pwd:b7b94ccd4ffc4afc980009859a2189f3\r\na=rtcp-mux\r\na=rtpmap:96 opus\/48000\/2\r\na=fmtp:96 useinbandfec=1\r\na=rtpmap:9 G722\/8000\r\na=rtpmap:0 PCMU\/8000\r\na=rtpmap:8 PCMA\/8000\r\na=rtpmap:97 telephone-event\/48000\r\na=rtpmap:98 telephone-event\/8000\r\na=setup:active\r\na=fingerprint:sha-256 35:CA:15:FE:14:7D:9E:71:6F:34:C3:C4:37:16:75:DF:32:6E:EF:4B:B5:F0:64:1D:CD:94:AD:84:E0:44:49:62\r\na=sendrecv\r\na=ice-ufrag:4c357d61\r\na=extmap:2\/sendrecv urn:ietf:params:rtp-hdrext:sdes:mid\r\na=rtcp:6400 IN IP4 52.30.27.5\r\nm=video 6400 UDP\/TLS\/RTP\/SAVPF 100\r\nc=IN IP4 0.0.0.0\r\nb=AS:800\r\na=mid:video\r\na=ssrc:1360517561 cname:3236665921ef4572844b0fbf3d9474da\r\na=ssrc:1360517561 msid:3236665921ef4572844b0fbf3d9474da e7f6d7a79c8a47e69902f9d4c919d257\r\na=ssrc:1360517561 mslabel:3236665921ef4572844b0fbf3d9474da\r\na=ssrc:1360517561 label:e7f6d7a79c8a47e69902f9d4c919d257\r\na=ssrc:1360517561 max-br:768000\r\na=rtcp-mux\r\na=ice-pwd:b7b94ccd4ffc4afc980009859a2189f3\r\na=rtpmap:100 VP9\/90000\r\na=rtcp-fb:100 nack pli\r\na=rtcp-fb:100 goog-remb\r\na=rtcp-fb:100 ccm fir\r\na=rtcp-fb:100 nack\r\na=setup:active\r\na=fingerprint:sha-256 35:CA:15:FE:14:7D:9E:71:6F:34:C3:C4:37:16:75:DF:32:6E:EF:4B:B5:F0:64:1D:CD:94:AD:84:E0:44:49:62\r\na=sendrecv\r\na=ice-ufrag:4c357d61\r\na=extmap:2\/sendrecv urn:ietf:params:rtp-hdrext:sdes:mid\r\n","tieBreaker":"aa51fe21f61e4f80be97da0945e29a64"}
6852020-06-12 14:35:10.237 8187-8187/com.rubarb.app.debug I/IDNOW_ICELINK3: Setting targetBitrate for VPX encoder 800
6862020-06-12 14:35:10.238 8187-8187/com.rubarb.app.debug I/IDNOW_ICELINK3: Setting targetBitrate for VPX encoder 800
6872020-06-12 14:35:10.264 8187-8187/com.rubarb.app.debug I/IDNOW_ICELINK3: Connection state: Connecting
6882020-06-12 14:35:10.279 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: setupComplete REST Call was successful
6892020-06-12 14:35:10.283 8187-8920/com.rubarb.app.debug D/JNI: Creating Opus Encoder...
6902020-06-12 14:35:10.283 8187-8920/com.rubarb.app.debug D/JNI: Opusfm encoder initialized (ClockRate: 48000, Channels: 2, PacketTime: 20.00).
6912020-06-12 14:35:10.283 8187-8920/com.rubarb.app.debug D/JNI: Opusfm decoder initialized (ClockRate: 48000, Channels: 2, PacketTime: 20.00).
6922020-06-12 14:35:10.284 8187-8920/com.rubarb.app.debug D/JNI: Setting Opus bitrate to 6 kbps in native encoder.
6932020-06-12 14:35:10.285 8187-8920/com.rubarb.app.debug D/JNI: Setting Opus bitrate to 32 kbps in native encoder.
6942020-06-12 14:35:10.287 8187-8187/com.rubarb.app.debug D/IDNOW_ICELINK: deltaZ 1.2989745 > 0.1
6952020-06-12 14:35:10.319 8187-8982/com.rubarb.app.debug D/JNI: Creating and configuring VPX encoder.
6962020-06-12 14:35:10.350 8187-8187/com.rubarb.app.debug D/ViewRootImpl@d2e1f92[Activities_VideoLiveStreamActivity_IceLink]: ViewPostIme pointer 0
6972020-06-12 14:35:10.358 8187-8187/com.rubarb.app.debug I/IDNOW_UTIL_CAMERA: Select FOCUS_MODE_AUTO
6982020-06-12 14:35:10.364 8187-8982/com.rubarb.app.debug D/JNI: VPX encoder configured in VP9 mode.
6992020-06-12 14:35:10.364 8187-8982/com.rubarb.app.debug D/JNI: Forcing VPX encoder to generate keyframe
7002020-06-12 14:35:10.365 8187-8187/com.rubarb.app.debug E/IDNOW_UTIL_CAMERA: setParameters failed
7012020-06-12 14:35:10.419 8187-8187/com.rubarb.app.debug D/ViewRootImpl@d2e1f92[Activities_VideoLiveStreamActivity_IceLink]: ViewPostIme pointer 1
7022020-06-12 14:35:10.805 8187-8187/com.rubarb.app.debug D/ViewRootImpl@d2e1f92[Activities_VideoLiveStreamActivity_IceLink]: ViewPostIme pointer 0
7032020-06-12 14:35:10.811 8187-8187/com.rubarb.app.debug I/IDNOW_UTIL_CAMERA: Select FOCUS_MODE_AUTO
7042020-06-12 14:35:10.817 8187-8187/com.rubarb.app.debug E/IDNOW_UTIL_CAMERA: setParameters failed
7052020-06-12 14:35:11.008 8187-8996/com.rubarb.app.debug I/IDNOW_ICELINK3: Connection state: Connected
7062020-06-12 14:35:11.045 8187-8187/com.rubarb.app.debug D/SurfaceView: BG show() Surface(name=Background for - SurfaceView - com.rubarb.app.debug/de.idnow.sdk.Activities.Activities_VideoLiveStreamActivity_IceLink@e857735@0) fm.icelink.android.OpenGLView{e857735 V.E...... ......ID 0,0-360,480}
7072020-06-12 14:35:11.053 8187-8187/com.rubarb.app.debug V/Surface: sf_framedrop debug : 0x4f4c, game : false, logging : 0
7082020-06-12 14:35:11.053 8187-8187/com.rubarb.app.debug D/SurfaceView: surfaceCreated 1 #8 fm.icelink.android.OpenGLView{e857735 V.E...... ......ID 0,0-360,480}
7092020-06-12 14:35:11.053 8187-8187/com.rubarb.app.debug D/SurfaceView: surfaceChanged (360,480) 1 #8 fm.icelink.android.OpenGLView{e857735 V.E...... ......ID 0,0-360,480}
7102020-06-12 14:35:11.057 8187-8910/com.rubarb.app.debug D/mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, egl_color_buffer_format *, EGLBoolean) returns 0x3000, [360x480]-format:2
7112020-06-12 14:35:11.082 8187-8187/com.rubarb.app.debug D/ViewRootImpl@d2e1f92[Activities_VideoLiveStreamActivity_IceLink]: Relayout returned: old=[0,0][1080,2076] new=[0,0][1080,2076] result=0x1 surface={valid=true 542630875136} changed=false
7122020-06-12 14:35:11.346 8187-8982/com.rubarb.app.debug D/JNI: Forcing VPX encoder to generate keyframe
7132020-06-12 14:35:11.449 8187-8982/com.rubarb.app.debug D/JNI: Forcing VPX encoder to generate keyframe
7142020-06-12 14:35:11.701 8187-8187/com.rubarb.app.debug D/ViewRootImpl@d2e1f92[Activities_VideoLiveStreamActivity_IceLink]: ViewPostIme pointer 1
7152020-06-12 14:35:11.876 8187-8187/com.rubarb.app.debug D/ViewRootImpl@d2e1f92[Activities_VideoLiveStreamActivity_IceLink]: ViewPostIme pointer 0
7162020-06-12 14:35:11.888 8187-8187/com.rubarb.app.debug I/IDNOW_UTIL_CAMERA: Select FOCUS_MODE_AUTO
7172020-06-12 14:35:11.893 8187-8187/com.rubarb.app.debug E/IDNOW_UTIL_CAMERA: setParameters failed
7182020-06-12 14:35:11.974 8187-8187/com.rubarb.app.debug D/ViewRootImpl@d2e1f92[Activities_VideoLiveStreamActivity_IceLink]: ViewPostIme pointer 1
7192020-06-12 14:35:12.125 8187-8187/com.rubarb.app.debug D/ViewRootImpl@d2e1f92[Activities_VideoLiveStreamActivity_IceLink]: ViewPostIme pointer 0
7202020-06-12 14:35:12.135 8187-8187/com.rubarb.app.debug I/IDNOW_UTIL_CAMERA: Select FOCUS_MODE_AUTO
7212020-06-12 14:35:12.141 8187-8187/com.rubarb.app.debug E/IDNOW_UTIL_CAMERA: setParameters failed
7222020-06-12 14:35:12.144 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: onMessage{"command":"ping","data":null}
7232020-06-12 14:35:12.144 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: response: ping
7242020-06-12 14:35:12.217 8187-8187/com.rubarb.app.debug D/ViewRootImpl@d2e1f92[Activities_VideoLiveStreamActivity_IceLink]: ViewPostIme pointer 1
7252020-06-12 14:35:12.288 8187-8187/com.rubarb.app.debug I/IDNOW_ICELINK: Samsung: myAutoFocusCallback
7262020-06-12 14:35:12.435 8187-8187/com.rubarb.app.debug D/IDNOW_ICELINK: deltaX 0.21580124 > 0.1
7272020-06-12 14:35:13.123 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: onMessage{"command":"setupComplete","data":null,"nextStep":null,"employee":{"firstname":"Test","lastname":"Robot"},"requestId":623137}
7282020-06-12 14:35:13.125 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: response: setupComplete
7292020-06-12 14:35:14.437 8187-8187/com.rubarb.app.debug I/IDNOW_ICELINK: Samsung: myAutoFocusCallback
7302020-06-12 14:35:14.447 8187-8187/com.rubarb.app.debug D/IDNOW_ICELINK: deltaX 0.20210648 > 0.1
7312020-06-12 14:35:14.520 8187-8199/com.rubarb.app.debug I/zygote64: Background concurrent copying GC freed 30074(719KB) AllocSpace objects, 15(25MB) LOS objects, 50% free, 21MB/43MB, paused 2.666ms total 100.436ms
7322020-06-12 14:35:16.448 8187-8187/com.rubarb.app.debug I/IDNOW_ICELINK: Samsung: myAutoFocusCallback
7332020-06-12 14:35:16.895 8187-8187/com.rubarb.app.debug I/IDNOW_RESTCLIENT: getRestClient()
7342020-06-12 14:35:16.897 8187-8187/com.rubarb.app.debug I/IDNOW_RESTCLIENT: SYSTEM-LANGUAGE: en
7352020-06-12 14:35:16.900 8187-8717/com.rubarb.app.debug I/IDNOW_RESTCLIENT: ---> HTTP GET https://api.test.idnow.de/api/v1/rubarb/identifications/TST-VNHHW
7362020-06-12 14:35:17.045 8187-8717/com.rubarb.app.debug I/IDNOW_RESTCLIENT: <--- HTTP 200 https://api.test.idnow.de/api/v1/rubarb/identifications/TST-VNHHW (144ms)
7372020-06-12 14:35:17.055 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: fetching waiting information successful
7382020-06-12 14:35:18.270 8187-8199/com.rubarb.app.debug I/zygote64: Background concurrent copying GC freed 49527(1008KB) AllocSpace objects, 13(22MB) LOS objects, 50% free, 21MB/43MB, paused 2.905ms total 102.663ms
7392020-06-12 14:35:19.500 8187-8199/com.rubarb.app.debug I/zygote64: Background concurrent copying GC freed 29029(672KB) AllocSpace objects, 15(25MB) LOS objects, 49% free, 21MB/43MB, paused 5.979ms total 83.911ms
7402020-06-12 14:35:19.647 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: onMessage{"command":"initialComparisonDone","data":null,"nextStep":{"stepName":"identification.face-picture-security"},"employee":{"firstname":"Test","lastname":"Robot"},"requestId":623137}
7412020-06-12 14:35:19.649 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: response: initialComparisonDone
7422020-06-12 14:35:19.650 8187-8933/com.rubarb.app.debug I/IDNOW_ICELINK: swapCamera 1
7432020-06-12 14:35:19.650 8187-8187/com.rubarb.app.debug I/IDNOW_UTILSTRINGS: Messages key null not found, falling back to default.
7442020-06-12 14:35:19.653 8187-8187/com.rubarb.app.debug I/IDNOW_UTILSTRINGS: Messages key null not found, falling back to default.
7452020-06-12 14:35:19.654 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: step: 1
7462020-06-12 14:35:19.658 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: resetting the position of the subscriberLayout
7472020-06-12 14:35:19.717 8187-8933/com.rubarb.app.debug I/IDNOW_ICELINK: setTorchMode: turnFlashlightOff
7482020-06-12 14:35:19.906 8187-8933/com.rubarb.app.debug E/IDNOW_ICELINK: Camera is being used after Camera.release() was called
7492020-06-12 14:35:19.907 8187-8933/com.rubarb.app.debug I/IDNOW_ICELINK: enableAutoFocus
7502020-06-12 14:35:19.908 8187-8933/com.rubarb.app.debug E/IDNOW_UTIL_CAMERA: Camera is being used after Camera.release() was called
7512020-06-12 14:35:19.991 8187-8845/com.rubarb.app.debug D/SensorManager: unregisterListener ::
7522020-06-12 14:35:19.996 8187-8187/com.rubarb.app.debug W/IDNOW_ICELINK: Unable to access camera
7532020-06-12 14:35:19.997 8187-8845/com.rubarb.app.debug I/LocalMedia: local media state: Started
7542020-06-12 14:35:19.997 8187-8845/com.rubarb.app.debug I/LocalMedia: local video track stopped
7552020-06-12 14:35:20.009 8187-8755/com.rubarb.app.debug D/SensorManager: registerListener :: 1, LSM6DSL Accelerometer, 200000, 0,
7562020-06-12 14:35:20.018 8187-8187/com.rubarb.app.debug W/IDNOW_ICELINK: Unable to access camera
7572020-06-12 14:35:20.034 8187-8187/com.rubarb.app.debug W/IDNOW_ICELINK: Unable to access camera
7582020-06-12 14:35:20.428 8187-8755/com.rubarb.app.debug I/LocalMedia: local media state: Started
7592020-06-12 14:35:20.428 8187-8755/com.rubarb.app.debug I/LocalMedia: addOnVideoStarted
7602020-06-12 14:35:20.428 8187-8755/com.rubarb.app.debug I/LocalMedia: local media state: Started
7612020-06-12 14:35:20.428 8187-8755/com.rubarb.app.debug I/LocalMedia: local video track started
7622020-06-12 14:35:21.375 8187-8199/com.rubarb.app.debug I/zygote64: Background concurrent copying GC freed 26830(636KB) AllocSpace objects, 13(22MB) LOS objects, 50% free, 21MB/43MB, paused 2.885ms total 103.216ms
7632020-06-12 14:35:22.147 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: onMessage{"command":"ping","data":null}
7642020-06-12 14:35:22.148 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: response: ping
7652020-06-12 14:35:28.392 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: onMessage{"command":"takeScreenshot","data":{"type":"face"},"nextStep":null,"employee":{"firstname":"Test","lastname":"Robot"},"requestId":623137}
7662020-06-12 14:35:28.395 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: response: takeScreenshot
7672020-06-12 14:35:28.395 8187-8933/com.rubarb.app.debug I/IDNOW_ICELINK: Starting to take screenshot
7682020-06-12 14:35:28.476 8187-8982/com.rubarb.app.debug I/IDNOW_ICELINK: Took screenshot 1088x1088 Orientation: 270
7692020-06-12 14:35:28.476 8187-8982/com.rubarb.app.debug D/skia: onFlyCompress
7702020-06-12 14:35:28.545 8187-8982/com.rubarb.app.debug I/IDNOW_WEBSOCKET: Converted bitmap
7712020-06-12 14:35:28.574 8187-8982/com.rubarb.app.debug I/IDNOW_WEBSOCKET: picture saved
7722020-06-12 14:35:28.576 8187-8982/com.rubarb.app.debug I/IDNOW_LIVESTREAM: started upload
7732020-06-12 14:35:28.577 8187-9062/com.rubarb.app.debug I/IDNOW_RESTCLIENT: getRestClient()
7742020-06-12 14:35:28.718 8187-9062/com.rubarb.app.debug I/IDNOW_RESTCLIENT: SYSTEM-LANGUAGE: en
7752020-06-12 14:35:28.719 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: finished upload
7762020-06-12 14:35:28.732 8187-8717/com.rubarb.app.debug I/IDNOW_RESTCLIENT: ---> HTTP POST https://api.test.idnow.de/api/v1/rubarb/identifications/TST-VNHHW/uploadScreenshot/face
7772020-06-12 14:35:28.988 8187-8717/com.rubarb.app.debug I/IDNOW_RESTCLIENT: <--- HTTP 200 https://api.test.idnow.de/api/v1/rubarb/identifications/TST-VNHHW/uploadScreenshot/face (255ms)
7782020-06-12 14:35:28.996 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: sendScreenshot REST Call was successful
7792020-06-12 14:35:29.428 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: onMessage{"command":"finishedFace","data":null,"nextStep":{"stepName":"identification.id-front-type"},"employee":{"firstname":"Test","lastname":"Robot"},"requestId":623137}
7802020-06-12 14:35:29.430 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: response: finishedFace
7812020-06-12 14:35:29.432 8187-8933/com.rubarb.app.debug I/IDNOW_ICELINK: swapCamera 0
7822020-06-12 14:35:29.434 8187-8187/com.rubarb.app.debug I/IDNOW_UTILSTRINGS: Messages key js.mobile.videoident.step.front not found, falling back to default.
7832020-06-12 14:35:29.440 8187-8187/com.rubarb.app.debug I/IDNOW_UTILSTRINGS: Messages key js.mobile.videoident.step.front.title not found, falling back to default.
7842020-06-12 14:35:29.440 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: step: 2
7852020-06-12 14:35:29.441 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: resetting the position of the subscriberLayout
7862020-06-12 14:35:29.449 8187-8933/com.rubarb.app.debug I/IDNOW_ICELINK: setTorchMode: turnFlashlightOff
7872020-06-12 14:35:29.666 8187-8933/com.rubarb.app.debug E/IDNOW_ICELINK: Camera is being used after Camera.release() was called
7882020-06-12 14:35:29.667 8187-8933/com.rubarb.app.debug I/IDNOW_ICELINK: enableAutoFocus
7892020-06-12 14:35:29.667 8187-8933/com.rubarb.app.debug E/IDNOW_UTIL_CAMERA: Camera is being used after Camera.release() was called
7902020-06-12 14:35:29.748 8187-8187/com.rubarb.app.debug W/IDNOW_ICELINK: Unable to access camera
7912020-06-12 14:35:29.754 8187-8840/com.rubarb.app.debug D/SensorManager: unregisterListener ::
7922020-06-12 14:35:29.757 8187-8840/com.rubarb.app.debug I/LocalMedia: local media state: Started
7932020-06-12 14:35:29.757 8187-8840/com.rubarb.app.debug I/LocalMedia: local video track stopped
7942020-06-12 14:35:29.768 8187-8755/com.rubarb.app.debug D/SensorManager: registerListener :: 1, LSM6DSL Accelerometer, 200000, 0,
7952020-06-12 14:35:29.769 8187-8187/com.rubarb.app.debug W/IDNOW_ICELINK: Unable to access camera
7962020-06-12 14:35:29.784 8187-8187/com.rubarb.app.debug W/IDNOW_ICELINK: Unable to access camera
7972020-06-12 14:35:30.148 8187-8755/com.rubarb.app.debug I/LocalMedia: local media state: Started
7982020-06-12 14:35:30.148 8187-8755/com.rubarb.app.debug I/LocalMedia: addOnVideoStarted
7992020-06-12 14:35:30.148 8187-8755/com.rubarb.app.debug I/LocalMedia: local media state: Started
8002020-06-12 14:35:30.148 8187-8755/com.rubarb.app.debug I/LocalMedia: local video track started
8012020-06-12 14:35:32.149 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: onMessage{"command":"ping","data":null}
8022020-06-12 14:35:32.150 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: response: ping
8032020-06-12 14:35:33.168 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: onMessage{"command":"takeScreenshot","data":{"type":"idFrontside"},"nextStep":null,"employee":{"firstname":"Test","lastname":"Robot"},"requestId":623137}
8042020-06-12 14:35:33.170 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: response: takeScreenshot
8052020-06-12 14:35:33.172 8187-8933/com.rubarb.app.debug I/IDNOW_ICELINK: Starting to take screenshot
8062020-06-12 14:35:33.262 8187-8982/com.rubarb.app.debug I/IDNOW_ICELINK: Took screenshot 1088x1088 Orientation: 90
8072020-06-12 14:35:33.262 8187-8982/com.rubarb.app.debug D/skia: onFlyCompress
8082020-06-12 14:35:33.328 8187-8982/com.rubarb.app.debug I/IDNOW_WEBSOCKET: Converted bitmap
8092020-06-12 14:35:33.348 8187-8982/com.rubarb.app.debug I/IDNOW_WEBSOCKET: picture saved
8102020-06-12 14:35:33.348 8187-8982/com.rubarb.app.debug I/IDNOW_LIVESTREAM: started upload
8112020-06-12 14:35:33.349 8187-9111/com.rubarb.app.debug I/IDNOW_RESTCLIENT: getRestClient()
8122020-06-12 14:35:33.353 8187-9111/com.rubarb.app.debug I/IDNOW_RESTCLIENT: SYSTEM-LANGUAGE: en
8132020-06-12 14:35:33.357 8187-8717/com.rubarb.app.debug I/IDNOW_RESTCLIENT: ---> HTTP POST https://api.test.idnow.de/api/v1/rubarb/identifications/TST-VNHHW/uploadScreenshot/idFrontside
8142020-06-12 14:35:33.362 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: finished upload
8152020-06-12 14:35:34.022 8187-8717/com.rubarb.app.debug I/IDNOW_RESTCLIENT: <--- HTTP 200 https://api.test.idnow.de/api/v1/rubarb/identifications/TST-VNHHW/uploadScreenshot/idFrontside (664ms)
8162020-06-12 14:35:34.032 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: sendScreenshot REST Call was successful
8172020-06-12 14:35:34.726 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: onMessage{"command":"showHelp","data":{"type":"turnFlashlightOff"},"nextStep":null,"employee":{"firstname":"Test","lastname":"Robot"},"requestId":623137}
8182020-06-12 14:35:34.727 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: response: showHelp
8192020-06-12 14:35:34.727 8187-8933/com.rubarb.app.debug I/IDNOW_ICELINK: setTorchMode: turnFlashlightOff
8202020-06-12 14:35:34.740 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: onMessage{"command":"showHelp","data":{"type":"turnFlashlightOn"},"nextStep":null,"employee":{"firstname":"Test","lastname":"Robot"},"requestId":623137}
8212020-06-12 14:35:34.742 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: response: showHelp
8222020-06-12 14:35:34.742 8187-8933/com.rubarb.app.debug I/IDNOW_ICELINK: setTorchMode: turnFlashlightOn
8232020-06-12 14:35:34.826 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: onMessage{"command":"showHelp","data":{"type":"turnFlashlightOff"},"nextStep":null,"employee":{"firstname":"Test","lastname":"Robot"},"requestId":623137}
8242020-06-12 14:35:34.829 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: response: showHelp
8252020-06-12 14:35:34.829 8187-8933/com.rubarb.app.debug I/IDNOW_ICELINK: setTorchMode: turnFlashlightOff
8262020-06-12 14:35:34.847 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: onMessage{"command":"showHelp","data":{"type":"turnFlashlightOn"},"nextStep":null,"employee":{"firstname":"Test","lastname":"Robot"},"requestId":623137}
8272020-06-12 14:35:34.849 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: response: showHelp
8282020-06-12 14:35:34.849 8187-8933/com.rubarb.app.debug I/IDNOW_ICELINK: setTorchMode: turnFlashlightOn
8292020-06-12 14:35:37.942 8187-8199/com.rubarb.app.debug I/zygote64: Background concurrent copying GC freed 23943(535KB) AllocSpace objects, 15(25MB) LOS objects, 50% free, 22MB/44MB, paused 4.019ms total 102.946ms
8302020-06-12 14:35:38.568 8187-8199/com.rubarb.app.debug I/zygote64: Background concurrent copying GC freed 26250(612KB) AllocSpace objects, 15(25MB) LOS objects, 49% free, 22MB/44MB, paused 3.454ms total 102.781ms
8312020-06-12 14:35:38.604 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: onMessage{"command":"takeScreenshot","data":{"type":"idSecurityFeature-1"},"nextStep":null,"employee":{"firstname":"Test","lastname":"Robot"},"requestId":623137}
8322020-06-12 14:35:38.605 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: response: takeScreenshot
8332020-06-12 14:35:38.606 8187-8933/com.rubarb.app.debug I/IDNOW_ICELINK: Starting to take screenshot
8342020-06-12 14:35:38.685 8187-8982/com.rubarb.app.debug I/IDNOW_ICELINK: Took screenshot 1088x1088 Orientation: 90
8352020-06-12 14:35:38.685 8187-8982/com.rubarb.app.debug D/skia: onFlyCompress
8362020-06-12 14:35:38.777 8187-8982/com.rubarb.app.debug I/IDNOW_WEBSOCKET: Converted bitmap
8372020-06-12 14:35:38.797 8187-8982/com.rubarb.app.debug I/IDNOW_WEBSOCKET: picture saved
8382020-06-12 14:35:38.798 8187-8982/com.rubarb.app.debug I/IDNOW_LIVESTREAM: started upload
8392020-06-12 14:35:38.799 8187-9112/com.rubarb.app.debug I/IDNOW_RESTCLIENT: getRestClient()
8402020-06-12 14:35:38.806 8187-9112/com.rubarb.app.debug I/IDNOW_RESTCLIENT: SYSTEM-LANGUAGE: en
8412020-06-12 14:35:38.807 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: finished upload
8422020-06-12 14:35:38.810 8187-8717/com.rubarb.app.debug I/IDNOW_RESTCLIENT: ---> HTTP POST https://api.test.idnow.de/api/v1/rubarb/identifications/TST-VNHHW/uploadScreenshot/idSecurityFeature-1
8432020-06-12 14:35:39.056 8187-8717/com.rubarb.app.debug I/IDNOW_RESTCLIENT: <--- HTTP 200 https://api.test.idnow.de/api/v1/rubarb/identifications/TST-VNHHW/uploadScreenshot/idSecurityFeature-1 (245ms)
8442020-06-12 14:35:39.064 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: sendScreenshot REST Call was successful
8452020-06-12 14:35:42.153 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: onMessage{"command":"ping","data":null}
8462020-06-12 14:35:42.154 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: response: ping
8472020-06-12 14:35:52.159 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: onMessage{"command":"ping","data":null}
8482020-06-12 14:35:52.160 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: response: ping
8492020-06-12 14:35:54.511 8187-8199/com.rubarb.app.debug I/zygote64: Background concurrent copying GC freed 26239(585KB) AllocSpace objects, 13(22MB) LOS objects, 50% free, 22MB/44MB, paused 4.267ms total 104.315ms
8502020-06-12 14:35:55.062 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: onMessage{"command":"wiggleDone","data":null,"nextStep":{"stepName":"identification.id-back"},"employee":{"firstname":"Test","lastname":"Robot"},"requestId":623137}
8512020-06-12 14:35:55.067 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: response: wiggleDone
8522020-06-12 14:35:55.069 8187-8187/com.rubarb.app.debug I/IDNOW_UTILSTRINGS: Messages key js.mobile.videoident.step.back not found, falling back to default.
8532020-06-12 14:35:55.072 8187-8933/com.rubarb.app.debug I/IDNOW_ICELINK: swapCamera 0
8542020-06-12 14:35:55.072 8187-8933/com.rubarb.app.debug I/IDNOW_ICELINK: setTorchMode: turnFlashlightOff
8552020-06-12 14:35:55.073 8187-8187/com.rubarb.app.debug I/IDNOW_UTILSTRINGS: Messages key js.mobile.videoident.step.back.title not found, falling back to default.
8562020-06-12 14:35:55.074 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: step: 5
8572020-06-12 14:35:55.074 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: resetting the position of the subscriberLayout
8582020-06-12 14:35:55.093 8187-8933/com.rubarb.app.debug I/IDNOW_ICELINK: enableAutoFocus
8592020-06-12 14:35:55.112 8187-8933/com.rubarb.app.debug I/IDNOW_UTIL_CAMERA: Select FOCUS_MODE_CONTINUOUS_PICTURE
8602020-06-12 14:35:55.126 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: onMessage{"command":"showHelp","data":{"type":"turnFlashlightOff"},"nextStep":null,"employee":{"firstname":"Test","lastname":"Robot"},"requestId":623137}
8612020-06-12 14:35:55.127 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: response: showHelp
8622020-06-12 14:35:55.127 8187-8933/com.rubarb.app.debug I/IDNOW_ICELINK: setTorchMode: turnFlashlightOff
8632020-06-12 14:35:55.451 8187-8192/com.rubarb.app.debug I/zygote64: Do partial code cache collection, code=1507KB, data=974KB
8642020-06-12 14:35:55.454 8187-8192/com.rubarb.app.debug I/zygote64: After code cache collection, code=1504KB, data=972KB
8652020-06-12 14:35:55.454 8187-8192/com.rubarb.app.debug I/zygote64: Increasing code cache capacity to 4MB
8662020-06-12 14:35:56.214 8187-8199/com.rubarb.app.debug I/zygote64: Background concurrent copying GC freed 23705(547KB) AllocSpace objects, 11(18MB) LOS objects, 49% free, 22MB/44MB, paused 3.075ms total 100.491ms
8672020-06-12 14:35:56.841 8187-8199/com.rubarb.app.debug I/zygote64: Background concurrent copying GC freed 26286(556KB) AllocSpace objects, 15(25MB) LOS objects, 50% free, 22MB/45MB, paused 3.821ms total 103.484ms
8682020-06-12 14:35:58.658 8187-8187/com.rubarb.app.debug D/ViewRootImpl@d2e1f92[Activities_VideoLiveStreamActivity_IceLink]: ViewPostIme pointer 0
8692020-06-12 14:35:58.665 8187-8187/com.rubarb.app.debug I/IDNOW_UTIL_CAMERA: Select FOCUS_MODE_MACRO
8702020-06-12 14:35:58.679 8187-8187/com.rubarb.app.debug D/IDNOW_ICELINK: deltaZ 0.1607244 > 0.1
8712020-06-12 14:35:58.760 8187-8187/com.rubarb.app.debug D/ViewRootImpl@d2e1f92[Activities_VideoLiveStreamActivity_IceLink]: ViewPostIme pointer 1
8722020-06-12 14:35:58.774 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: onMessage{"command":"takeScreenshot","data":{"type":"idBackside"},"nextStep":null,"employee":{"firstname":"Test","lastname":"Robot"},"requestId":623137}
8732020-06-12 14:35:58.775 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: response: takeScreenshot
8742020-06-12 14:35:58.776 8187-8933/com.rubarb.app.debug I/IDNOW_ICELINK: Starting to take screenshot
8752020-06-12 14:35:58.819 8187-8982/com.rubarb.app.debug I/IDNOW_ICELINK: Took screenshot 1088x1088 Orientation: 90
8762020-06-12 14:35:58.819 8187-8982/com.rubarb.app.debug D/skia: onFlyCompress
8772020-06-12 14:35:58.887 8187-8982/com.rubarb.app.debug I/IDNOW_WEBSOCKET: Converted bitmap
8782020-06-12 14:35:58.906 8187-8982/com.rubarb.app.debug I/IDNOW_WEBSOCKET: picture saved
8792020-06-12 14:35:58.906 8187-8982/com.rubarb.app.debug I/IDNOW_LIVESTREAM: started upload
8802020-06-12 14:35:58.907 8187-9136/com.rubarb.app.debug I/IDNOW_RESTCLIENT: getRestClient()
8812020-06-12 14:35:58.910 8187-9136/com.rubarb.app.debug I/IDNOW_RESTCLIENT: SYSTEM-LANGUAGE: en
8822020-06-12 14:35:58.912 8187-8717/com.rubarb.app.debug I/IDNOW_RESTCLIENT: ---> HTTP POST https://api.test.idnow.de/api/v1/rubarb/identifications/TST-VNHHW/uploadScreenshot/idBackside
8832020-06-12 14:35:58.917 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: finished upload
8842020-06-12 14:35:59.552 8187-8717/com.rubarb.app.debug I/IDNOW_RESTCLIENT: <--- HTTP 200 https://api.test.idnow.de/api/v1/rubarb/identifications/TST-VNHHW/uploadScreenshot/idBackside (640ms)
8852020-06-12 14:35:59.555 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: sendScreenshot REST Call was successful
8862020-06-12 14:35:59.984 8187-8187/com.rubarb.app.debug I/IDNOW_UTIL_CAMERA: Select FOCUS_MODE_CONTINUOUS_PICTURE
8872020-06-12 14:36:00.120 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: onMessage{"command":"finishedIdBackside","data":null,"nextStep":{"stepName":"identification.id-number"},"employee":{"firstname":"Test","lastname":"Robot"},"requestId":623137}
8882020-06-12 14:36:00.123 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: response: finishedIdBackside
8892020-06-12 14:36:00.125 8187-8933/com.rubarb.app.debug I/IDNOW_ICELINK: swapCamera 1
8902020-06-12 14:36:00.127 8187-8187/com.rubarb.app.debug I/IDNOW_UTILSTRINGS: Messages key js.mobile.videoident.step.read.no not found, falling back to default.
8912020-06-12 14:36:00.133 8187-8187/com.rubarb.app.debug I/IDNOW_UTILSTRINGS: Messages key js.mobile.videoident.step.front.title not found, falling back to default.
8922020-06-12 14:36:00.134 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: step: 4
8932020-06-12 14:36:00.134 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: resetting the position of the subscriberLayout
8942020-06-12 14:36:00.218 8187-8933/com.rubarb.app.debug I/IDNOW_ICELINK: setTorchMode: turnFlashlightOff
8952020-06-12 14:36:00.445 8187-8933/com.rubarb.app.debug E/IDNOW_ICELINK: Camera is being used after Camera.release() was called
8962020-06-12 14:36:00.446 8187-8933/com.rubarb.app.debug I/IDNOW_ICELINK: enableAutoFocus
8972020-06-12 14:36:00.447 8187-8933/com.rubarb.app.debug E/IDNOW_UTIL_CAMERA: Camera is being used after Camera.release() was called
8982020-06-12 14:36:00.504 8187-8755/com.rubarb.app.debug D/SensorManager: unregisterListener ::
8992020-06-12 14:36:00.506 8187-8755/com.rubarb.app.debug I/LocalMedia: local media state: Started
9002020-06-12 14:36:00.507 8187-8755/com.rubarb.app.debug I/LocalMedia: local video track stopped
9012020-06-12 14:36:00.507 8187-8187/com.rubarb.app.debug W/IDNOW_ICELINK: Unable to access camera
9022020-06-12 14:36:00.518 8187-8840/com.rubarb.app.debug D/SensorManager: registerListener :: 1, LSM6DSL Accelerometer, 200000, 0,
9032020-06-12 14:36:00.526 8187-8187/com.rubarb.app.debug W/IDNOW_ICELINK: Unable to access camera
9042020-06-12 14:36:00.546 8187-8187/com.rubarb.app.debug W/IDNOW_ICELINK: Unable to access camera
9052020-06-12 14:36:00.681 8187-8187/com.rubarb.app.debug I/IDNOW_ICELINK: Samsung: myAutoFocusCallback
9062020-06-12 14:36:00.688 8187-8187/com.rubarb.app.debug D/IDNOW_ICELINK: deltaX 0.4059105 > 0.1
9072020-06-12 14:36:00.975 8187-8840/com.rubarb.app.debug I/LocalMedia: local media state: Started
9082020-06-12 14:36:00.975 8187-8840/com.rubarb.app.debug I/LocalMedia: addOnVideoStarted
9092020-06-12 14:36:00.975 8187-8840/com.rubarb.app.debug I/LocalMedia: local media state: Started
9102020-06-12 14:36:00.975 8187-8840/com.rubarb.app.debug I/LocalMedia: local video track started
9112020-06-12 14:36:02.161 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: onMessage{"command":"ping","data":null}
9122020-06-12 14:36:02.162 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: response: ping
9132020-06-12 14:36:02.962 8187-8187/com.rubarb.app.debug I/IDNOW_ICELINK: Samsung: myAutoFocusCallback
9142020-06-12 14:36:03.863 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: onMessage{"command":"idNumberDone","data":null,"nextStep":{"stepName":"identification.censoring-front"},"employee":{"firstname":"Test","lastname":"Robot"},"requestId":623137}
9152020-06-12 14:36:03.865 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: response: idNumberDone
9162020-06-12 14:36:03.866 8187-8933/com.rubarb.app.debug I/IDNOW_ICELINK: swapCamera 1
9172020-06-12 14:36:03.867 8187-8933/com.rubarb.app.debug I/IDNOW_ICELINK: setTorchMode: turnFlashlightOff
9182020-06-12 14:36:03.885 8187-8187/com.rubarb.app.debug I/IDNOW_UTILSTRINGS: Messages key null not found, falling back to default.
9192020-06-12 14:36:03.886 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: step: 7
9202020-06-12 14:36:03.887 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: resetting the position of the subscriberLayout
9212020-06-12 14:36:03.896 8187-8933/com.rubarb.app.debug I/IDNOW_ICELINK: enableAutoFocus
9222020-06-12 14:36:03.915 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: onMessage{"command":"showHelp","data":{"type":"turnFlashlightOff"},"nextStep":null,"employee":{"firstname":"Test","lastname":"Robot"},"requestId":623137}
9232020-06-12 14:36:03.916 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: response: showHelp
9242020-06-12 14:36:03.917 8187-8933/com.rubarb.app.debug I/IDNOW_ICELINK: setTorchMode: turnFlashlightOff
9252020-06-12 14:36:03.925 8187-8187/com.rubarb.app.debug D/ScrollView: onsize change changed
9262020-06-12 14:36:03.926 8187-8187/com.rubarb.app.debug W/View: requestLayout() improperly called by android.widget.RelativeLayout{e18a567 V.E...... ......ID 0,0-1080,1524} during layout: running second layout pass
9272020-06-12 14:36:03.926 8187-8187/com.rubarb.app.debug I/ViewRootImpl@d2e1f92[Activities_VideoLiveStreamActivity_IceLink]: requestLayout is already in process
9282020-06-12 14:36:03.926 8187-8187/com.rubarb.app.debug W/View: requestLayout() improperly called by android.widget.FrameLayout{78dff14 V.E...... ......I. 0,0-1080,1524} during layout: running second layout pass
9292020-06-12 14:36:03.926 8187-8187/com.rubarb.app.debug W/View: requestLayout() improperly called by android.widget.RelativeLayout{bcfd073 V.E...... ......ID 0,0-1080,1524} during layout: running second layout pass
9302020-06-12 14:36:03.938 8187-8187/com.rubarb.app.debug I/ViewRootImpl@d2e1f92[Activities_VideoLiveStreamActivity_IceLink]: requestLayoutDuringLayout is already in process
9312020-06-12 14:36:03.938 8187-8187/com.rubarb.app.debug I/ViewRootImpl@d2e1f92[Activities_VideoLiveStreamActivity_IceLink]: requestLayoutDuringLayout is already in process
9322020-06-12 14:36:03.961 8187-8187/com.rubarb.app.debug W/View: requestLayout() improperly called by android.widget.FrameLayout{78dff14 V.E...... .......D 0,0-1080,2004} during second layout pass: posting in next frame
9332020-06-12 14:36:03.962 8187-8187/com.rubarb.app.debug W/View: requestLayout() improperly called by android.view.TextureView{104e347 V.ED..... ......ID 0,0-1524,1524} during second layout pass: posting in next frame
9342020-06-12 14:36:05.918 8187-8199/com.rubarb.app.debug I/zygote64: Background concurrent copying GC freed 25434(553KB) AllocSpace objects, 13(22MB) LOS objects, 49% free, 22MB/44MB, paused 3.915ms total 109.464ms
9352020-06-12 14:36:06.534 8187-8199/com.rubarb.app.debug I/zygote64: Background concurrent copying GC freed 26644(601KB) AllocSpace objects, 16(27MB) LOS objects, 50% free, 20MB/41MB, paused 4.273ms total 101.534ms
9362020-06-12 14:36:09.672 8187-8187/com.rubarb.app.debug D/ViewRootImpl@d2e1f92[Activities_VideoLiveStreamActivity_IceLink]: ViewPostIme pointer 0
9372020-06-12 14:36:09.771 8187-8187/com.rubarb.app.debug D/ViewRootImpl@d2e1f92[Activities_VideoLiveStreamActivity_IceLink]: ViewPostIme pointer 1
9382020-06-12 14:36:09.789 8187-8192/com.rubarb.app.debug I/zygote64: Method exceeds compiler instruction limit: 25337 in void org.ccil.cowan.tagsoup.HTMLSchema.<init>()
9392020-06-12 14:36:09.806 8187-8187/com.rubarb.app.debug D/InputMethodManager: HSIFW - flag : 0 Pid : 8187
9402020-06-12 14:36:09.807 8187-8187/com.rubarb.app.debug I/IDNOW_RESTCLIENT: getRestClient()
9412020-06-12 14:36:09.809 8187-8187/com.rubarb.app.debug I/IDNOW_RESTCLIENT: SYSTEM-LANGUAGE: en
9422020-06-12 14:36:09.824 8187-8717/com.rubarb.app.debug I/IDNOW_RESTCLIENT: ---> HTTP POST https://api.test.idnow.de/api/v1/rubarb/identifications/TST-VNHHW/resendConfirmationToken
9432020-06-12 14:36:09.954 8187-8717/com.rubarb.app.debug I/IDNOW_RESTCLIENT: <--- HTTP 200 https://api.test.idnow.de/api/v1/rubarb/identifications/TST-VNHHW/resendConfirmationToken (129ms)
9442020-06-12 14:36:09.957 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: sendIdentCode REST Call was successful
9452020-06-12 14:36:12.164 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: onMessage{"command":"ping","data":null}
9462020-06-12 14:36:12.166 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: response: ping
9472020-06-12 14:36:13.525 8187-8199/com.rubarb.app.debug I/zygote64: Background concurrent copying GC freed 26834(581KB) AllocSpace objects, 13(22MB) LOS objects, 50% free, 22MB/45MB, paused 2.745ms total 104.359ms
9482020-06-12 14:36:15.356 8187-8199/com.rubarb.app.debug I/zygote64: Background concurrent copying GC freed 28235(616KB) AllocSpace objects, 15(25MB) LOS objects, 49% free, 22MB/44MB, paused 3.566ms total 100.371ms
9492020-06-12 14:36:16.610 8187-8199/com.rubarb.app.debug I/zygote64: Background concurrent copying GC freed 29843(656KB) AllocSpace objects, 15(25MB) LOS objects, 49% free, 22MB/45MB, paused 3.727ms total 105.016ms
9502020-06-12 14:36:20.587 8187-8199/com.rubarb.app.debug I/zygote64: Background concurrent copying GC freed 22822(526KB) AllocSpace objects, 12(20MB) LOS objects, 50% free, 22MB/45MB, paused 317us total 110.111ms
9512020-06-12 14:36:22.167 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: onMessage{"command":"ping","data":null}
9522020-06-12 14:36:22.168 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: response: ping
9532020-06-12 14:36:24.850 8187-8199/com.rubarb.app.debug I/zygote64: Background concurrent copying GC freed 24790(539KB) AllocSpace objects, 15(25MB) LOS objects, 50% free, 22MB/45MB, paused 3.865ms total 103.091ms
9542020-06-12 14:36:28.926 8187-8199/com.rubarb.app.debug I/zygote64: Background concurrent copying GC freed 25962(578KB) AllocSpace objects, 13(22MB) LOS objects, 50% free, 22MB/44MB, paused 2.959ms total 103.354ms
9552020-06-12 14:36:30.717 8187-8199/com.rubarb.app.debug I/zygote64: Background concurrent copying GC freed 23818(524KB) AllocSpace objects, 13(22MB) LOS objects, 50% free, 22MB/44MB, paused 3.518ms total 104.449ms
9562020-06-12 14:36:31.341 8187-8199/com.rubarb.app.debug I/zygote64: Background concurrent copying GC freed 25902(574KB) AllocSpace objects, 15(25MB) LOS objects, 50% free, 22MB/44MB, paused 4.152ms total 102.602ms
9572020-06-12 14:36:32.166 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: onMessage{"command":"ping","data":null}
9582020-06-12 14:36:32.167 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: response: ping
9592020-06-12 14:36:33.920 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: onMessage{"command":"finishedIntegrityIdData","data":null,"nextStep":{"stepName":null},"employee":{"firstname":"Test","lastname":"Robot"},"requestId":623137}
9602020-06-12 14:36:33.923 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: response: finishedIntegrityIdData
9612020-06-12 14:36:40.098 8187-8199/com.rubarb.app.debug I/zygote64: Background concurrent copying GC freed 21433(458KB) AllocSpace objects, 11(18MB) LOS objects, 50% free, 20MB/41MB, paused 5.436ms total 79.967ms
9622020-06-12 14:36:41.828 8187-8199/com.rubarb.app.debug I/zygote64: Background concurrent copying GC freed 25369(594KB) AllocSpace objects, 13(22MB) LOS objects, 49% free, 22MB/44MB, paused 3.180ms total 104.909ms
9632020-06-12 14:36:42.169 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: onMessage{"command":"ping","data":null}
9642020-06-12 14:36:42.170 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: response: ping
9652020-06-12 14:36:43.063 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: onMessage{"command":"tanDone","data":null,"nextStep":{"stepName":"identification.goodbye"},"employee":{"firstname":"Test","lastname":"Robot"},"requestId":623137}
9662020-06-12 14:36:43.064 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: response: tanDone
9672020-06-12 14:36:43.065 8187-8933/com.rubarb.app.debug I/IDNOW_ICELINK: swapCamera 1
9682020-06-12 14:36:43.066 8187-8933/com.rubarb.app.debug I/IDNOW_ICELINK: setTorchMode: turnFlashlightOff
9692020-06-12 14:36:43.080 8187-8187/com.rubarb.app.debug I/IDNOW_UTILSTRINGS: Messages key null not found, falling back to default.
9702020-06-12 14:36:43.080 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: step: 8
9712020-06-12 14:36:43.081 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: resetting the position of the subscriberLayout
9722020-06-12 14:36:43.093 8187-8187/com.rubarb.app.debug W/View: requestLayout() improperly called by android.widget.FrameLayout{78dff14 V.E...... ......ID 0,0-1080,1524} during layout: running second layout pass
9732020-06-12 14:36:43.094 8187-8187/com.rubarb.app.debug I/ViewRootImpl@d2e1f92[Activities_VideoLiveStreamActivity_IceLink]: requestLayout is already in process
9742020-06-12 14:36:43.094 8187-8187/com.rubarb.app.debug W/View: requestLayout() improperly called by android.view.TextureView{104e347 V.ED..... ......I. 0,0-2004,2004} during layout: running second layout pass
9752020-06-12 14:36:43.094 8187-8187/com.rubarb.app.debug W/View: requestLayout() improperly called by android.widget.RelativeLayout{e18a567 V.E...... ......ID 0,0-1080,1524} during layout: running second layout pass
9762020-06-12 14:36:43.094 8187-8187/com.rubarb.app.debug W/View: requestLayout() improperly called by android.widget.RelativeLayout{bcfd073 V.E...... ......ID 0,0-1080,1524} during layout: running second layout pass
9772020-06-12 14:36:46.957 8187-8199/com.rubarb.app.debug I/zygote64: Background concurrent copying GC freed 22203(524KB) AllocSpace objects, 11(18MB) LOS objects, 49% free, 22MB/44MB, paused 3.612ms total 111.543ms
9782020-06-12 14:36:47.450 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: onMessage{"command":"finished","data":null,"nextStep":null,"employee":{"firstname":"Test","lastname":"Robot"},"requestId":623137}
9792020-06-12 14:36:47.451 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: response: finished
9802020-06-12 14:36:47.452 8187-8933/com.rubarb.app.debug I/IDNOW_RESTCLIENT: getRestClient()
9812020-06-12 14:36:47.454 8187-8933/com.rubarb.app.debug I/IDNOW_RESTCLIENT: SYSTEM-LANGUAGE: en
9822020-06-12 14:36:47.457 8187-8933/com.rubarb.app.debug I/IDNOW_ICELINK: onEndCall
9832020-06-12 14:36:47.457 8187-8933/com.rubarb.app.debug I/IDNOW_ICELINK: stop Icelink
9842020-06-12 14:36:47.458 8187-8717/com.rubarb.app.debug I/IDNOW_RESTCLIENT: ---> HTTP GET https://api.test.idnow.de/api/v1/rubarb/identifications/TST-VNHHW
9852020-06-12 14:36:47.486 8187-8933/com.rubarb.app.debug D/SensorManager: unregisterListener ::
9862020-06-12 14:36:47.487 8187-8933/com.rubarb.app.debug I/IDNOW_ICELINK: stopConference
9872020-06-12 14:36:47.487 8187-8933/com.rubarb.app.debug I/IDNOW_ICELINK3: Stopping conference=Conference{mode=AGENT_CONFERENCE, activity=Activities_VideoLiveStreamActivity_IceLink}
9882020-06-12 14:36:47.489 8187-8933/com.rubarb.app.debug I/IDNOW_ICELINK3: Connection state: Closing
9892020-06-12 14:36:47.490 8187-8187/com.rubarb.app.debug D/SurfaceView: BG show() Surface(name=Background for - SurfaceView - com.rubarb.app.debug/de.idnow.sdk.Activities.Activities_VideoLiveStreamActivity_IceLink@e857735@0) fm.icelink.android.OpenGLView{e857735 V.E...... ........ 0,0-360,480}
9902020-06-12 14:36:47.492 8187-8187/com.rubarb.app.debug D/SurfaceView: surfaceDestroyed 1 #2 fm.icelink.android.OpenGLView{e857735 V.E...... ........ 0,0-360,480}
9912020-06-12 14:36:47.500 8187-8187/com.rubarb.app.debug D/SurfaceView: BG destroy() Surface(name=Background for - SurfaceView - com.rubarb.app.debug/de.idnow.sdk.Activities.Activities_VideoLiveStreamActivity_IceLink@e857735@0) fm.icelink.android.OpenGLView{e857735 V.E...... ........ 0,0-360,480}
9922020-06-12 14:36:47.584 8187-8903/com.rubarb.app.debug D/AudioTrack: stop() called with 5327556 frames delivered
9932020-06-12 14:36:47.696 8187-8717/com.rubarb.app.debug I/IDNOW_RESTCLIENT: <--- HTTP 200 https://api.test.idnow.de/api/v1/rubarb/identifications/TST-VNHHW (236ms)
9942020-06-12 14:36:47.704 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: fetching waiting information successful
9952020-06-12 14:36:48.821 8187-8199/com.rubarb.app.debug I/zygote64: Background concurrent copying GC freed 24667(556KB) AllocSpace objects, 15(25MB) LOS objects, 50% free, 22MB/44MB, paused 3.734ms total 103.566ms
9962020-06-12 14:36:48.821 8187-8905/com.rubarb.app.debug D/AudioTrack: stop() called with 1796256 frames delivered
9972020-06-12 14:36:48.842 8187-8907/com.rubarb.app.debug D/AudioTrack: stop() called with 898064 frames delivered
9982020-06-12 14:36:48.886 8187-8909/com.rubarb.app.debug D/AudioTrack: stop() called with 898392 frames delivered
9992020-06-12 14:36:48.925 8187-8933/com.rubarb.app.debug I/System.out: !@#
10002020-06-12 14:36:48.954 8187-8989/com.rubarb.app.debug I/IDNOW_ICELINK3: Connection state: Closed
10012020-06-12 14:36:48.979 8187-8933/com.rubarb.app.debug I/IDNOW_ICELINK3: Stopping conference=Conference{mode=AGENT_CONFERENCE, activity=Activities_VideoLiveStreamActivity_IceLink}
10022020-06-12 14:36:49.025 8187-8755/com.rubarb.app.debug I/LocalMedia: local media state: Stopping
10032020-06-12 14:36:49.025 8187-8755/com.rubarb.app.debug I/LocalMedia: local audio track stopped
10042020-06-12 14:36:49.033 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: handleReportActivityLinking: successful=true
10052020-06-12 14:36:49.206 8187-8187/com.rubarb.app.debug I/Connectivity VideoLivestream Activity: onPause
10062020-06-12 14:36:49.246 8187-9241/com.rubarb.app.debug V/FA: Recording user engagement, ms: 112508
10072020-06-12 14:36:49.259 8187-9241/com.rubarb.app.debug V/FA: Connecting to remote service
10082020-06-12 14:36:49.292 8187-9241/com.rubarb.app.debug V/FA: Activity paused, time: 1474500321
10092020-06-12 14:36:49.329 8187-8840/com.rubarb.app.debug D/SensorManager: unregisterListener ::
10102020-06-12 14:36:49.331 8187-8840/com.rubarb.app.debug I/LocalMedia: local media state: Stopping
10112020-06-12 14:36:49.331 8187-8840/com.rubarb.app.debug I/LocalMedia: local video track stopped
10122020-06-12 14:36:49.366 8187-8746/com.rubarb.app.debug W/FM: 2020-06-12T11:36:49.363Z Could not unset local view. A view does not exist.
10132020-06-12 14:36:49.372 8187-9241/com.rubarb.app.debug V/FA: Connection attempt already in progress
10142020-06-12 14:36:49.372 8187-8187/com.rubarb.app.debug D/JNI: Opusfm decoder destroyed.
10152020-06-12 14:36:49.386 8187-8187/com.rubarb.app.debug D/ViewRootImpl@d2e1f92[Activities_VideoLiveStreamActivity_IceLink]: MSG_WINDOW_FOCUS_CHANGED 0
10162020-06-12 14:36:49.386 8187-8187/com.rubarb.app.debug I/IDNOW_RESTCLIENT: getRestClient()
10172020-06-12 14:36:49.389 8187-8187/com.rubarb.app.debug I/IDNOW_RESTCLIENT: SYSTEM-LANGUAGE: en
10182020-06-12 14:36:49.392 8187-8717/com.rubarb.app.debug I/IDNOW_RESTCLIENT: ---> HTTP POST https://api.test.idnow.de/api/v1/rubarb/identifications/TST-VNHHW/appEnteredBackground
10192020-06-12 14:36:49.398 8187-8187/com.rubarb.app.debug I/IDNOW_ENTRY: onActivityResult called
10202020-06-12 14:36:49.437 8187-8187/com.rubarb.app.debug D/ViewRootImpl@581d6c1[Activities_EntryActivity]: Relayout returned: old=[0,0][1080,2076] new=[0,0][1080,2076] result=0x1 surface={valid=false 0} changed=false
10212020-06-12 14:36:49.450 8187-9241/com.rubarb.app.debug D/FA: Connected to remote service
10222020-06-12 14:36:49.451 8187-9241/com.rubarb.app.debug V/FA: Processing queued up service tasks: 2
10232020-06-12 14:36:49.489 8187-8717/com.rubarb.app.debug I/IDNOW_RESTCLIENT: <--- HTTP 400 https://api.test.idnow.de/api/v1/rubarb/identifications/TST-VNHHW/appEnteredBackground (96ms)
10242020-06-12 14:36:52.234 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: onMessage{"command":"ping","data":null}
10252020-06-12 14:36:52.240 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: response: ping
10262020-06-12 14:37:02.372 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: onMessage{"command":"ping","data":null}
10272020-06-12 14:37:02.374 8187-8933/com.rubarb.app.debug I/IDNOW_WEBSOCKET: response: ping
10282020-06-12 14:37:08.101 8187-8187/com.rubarb.app.debug D/IDNow result: success, transaction token: TST-VNHHW
10292020-06-12 14:37:09.763 8187-8187/com.rubarb.app.debug D/EventBus: No subscribers registered for event class com.upnetix.presentation.navigation.NavigationEvent
10302020-06-12 14:37:09.765 8187-8187/com.rubarb.app.debug D/EventBus: No subscribers registered for event class org.greenrobot.eventbus.NoSubscriberEvent
10312020-06-12 14:37:09.797 8187-9241/com.rubarb.app.debug V/FA: Activity resumed, time: 1474520891
10322020-06-12 14:37:09.817 8187-8187/com.rubarb.app.debug I/Choreographer: Skipped 1221 frames! The application may be doing too much work on its main thread.
10332020-06-12 14:37:09.856 8187-8187/com.rubarb.app.debug V/Surface: sf_framedrop debug : 0x4f4c, game : false, logging : 0
10342020-06-12 14:37:09.857 8187-8187/com.rubarb.app.debug D/ViewRootImpl@c2c383c[ModalActivity]: Relayout returned: old=[0,0][1080,2220] new=[0,0][1080,2220] result=0x7 surface={valid=true 543279255552} changed=true
10352020-06-12 14:37:09.870 8187-8252/com.rubarb.app.debug D/mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, egl_color_buffer_format *, EGLBoolean) returns 0x3000, [1080x2220]-format:1
10362020-06-12 14:37:09.871 8187-8252/com.rubarb.app.debug D/OpenGLRenderer: eglCreateWindowSurface = 0x7e85a22af0, 0x7e7df79010
10372020-06-12 14:37:09.875 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: appEnteredBackground REST Call failed
10382020-06-12 14:37:09.875 8187-8187/com.rubarb.app.debug E/IDNOW: RETROFIT ERROR: 400 Bad Request
10392020-06-12 14:37:09.880 8187-8187/com.rubarb.app.debug I/UtilRetrofit: {"errors":[{"cause":"BAD_REQUEST","errorType":null,"id":"02145160","key":null,"message":null,"translationKey":null}]}
10402020-06-12 14:37:09.950 8187-8252/com.rubarb.app.debug D/OpenGLRenderer: eglDestroySurface = 0x7e6f3e4760, 0x7e57521000
10412020-06-12 14:37:09.971 8187-8187/com.rubarb.app.debug D/ViewRootImpl@d2e1f92[Activities_VideoLiveStreamActivity_IceLink]: Relayout returned: old=[0,0][1080,2076] new=[0,0][1080,2076] result=0x5 surface={valid=false 0} changed=true
10422020-06-12 14:37:09.980 8187-9241/com.rubarb.app.debug V/FA: Inactivity, disconnecting from the service
10432020-06-12 14:37:10.001 8187-8187/com.rubarb.app.debug D/ViewRootImpl@581d6c1[Activities_EntryActivity]: Relayout returned: old=[0,0][1080,2076] new=[0,0][1080,2076] result=0x1 surface={valid=false 0} changed=false
10442020-06-12 14:37:10.002 8187-8187/com.rubarb.app.debug D/ViewRootImpl@c2c383c[ModalActivity]: MSG_WINDOW_FOCUS_CHANGED 1
10452020-06-12 14:37:10.006 8187-8187/com.rubarb.app.debug V/InputMethodManager: Starting input: tba=android.view.inputmethod.EditorInfo@1523c13 nm : com.rubarb.app.debug ic=null
10462020-06-12 14:37:10.006 8187-8187/com.rubarb.app.debug I/InputMethodManager: startInputInner - mService.startInputOrWindowGainedFocus
10472020-06-12 14:37:10.014 8187-8187/com.rubarb.app.debug D/InputTransport: Input channel constructed: fd=100
10482020-06-12 14:37:10.015 8187-8187/com.rubarb.app.debug D/InputTransport: Input channel destroyed: fd=167
10492020-06-12 14:37:10.025 8187-8187/com.rubarb.app.debug D/ViewRootImpl@581d6c1[Activities_EntryActivity]: dispatchDetachedFromWindow
10502020-06-12 14:37:10.026 8187-8187/com.rubarb.app.debug D/InputEventReceiver: channel 'b91a525 com.rubarb.app.debug/de.idnow.sdk.Activities.Activities_EntryActivity (client)' ~ Disposing input event receiver.
10512020-06-12 14:37:10.026 8187-8187/com.rubarb.app.debug D/InputEventReceiver: channel 'b91a525 com.rubarb.app.debug/de.idnow.sdk.Activities.Activities_EntryActivity (client)' ~NativeInputEventReceiver.
10522020-06-12 14:37:10.037 8187-8187/com.rubarb.app.debug D/InputTransport: Input channel destroyed: fd=95
10532020-06-12 14:37:10.043 8187-8187/com.rubarb.app.debug I/IDNOW_ICELINK: onStop
10542020-06-12 14:37:10.044 8187-8187/com.rubarb.app.debug I/IDNOW_LIVESTREAM: Stopped
10552020-06-12 14:37:10.045 8187-8187/com.rubarb.app.debug I/Network_OkHttpWebSocket: Remove sink for video live stream
10562020-06-12 14:37:10.046 8187-8187/com.rubarb.app.debug I/IDNOW_ICELINK: stop Icelink
10572020-06-12 14:37:10.050 8187-8187/com.rubarb.app.debug I/IDNOW_ICELINK: onDestroy
10582020-06-12 14:37:10.050 8187-8187/com.rubarb.app.debug I/IDNOW_WEBSOCKETSERVICE: Close
10592020-06-12 14:37:10.052 8187-9254/com.rubarb.app.debug I/Network_OkHttpWebSocket: Closing for socket
10602020-06-12 14:37:10.052 8187-9254/com.rubarb.app.debug I/Network_OkHttpWebSocket: Closing socket
10612020-06-12 14:37:10.054 8187-9254/com.rubarb.app.debug I/Network_OkHttpWebSocket: Gracefully closed socket
10622020-06-12 14:37:10.122 8187-8933/com.rubarb.app.debug I/Network_OkHttpWebSocket: CLOSE: 1001
10632020-06-12 14:37:10.146 8187-8187/com.rubarb.app.debug D/ViewRootImpl@d2e1f92[Activities_VideoLiveStreamActivity_IceLink]: dispatchDetachedFromWindow
10642020-06-12 14:37:10.146 8187-8187/com.rubarb.app.debug D/InputEventReceiver: channel '495863b com.rubarb.app.debug/de.idnow.sdk.Activities.Activities_VideoLiveStreamActivity_IceLink (client)' ~ Disposing input event receiver.
10652020-06-12 14:37:10.146 8187-8187/com.rubarb.app.debug D/InputEventReceiver: channel '495863b com.rubarb.app.debug/de.idnow.sdk.Activities.Activities_VideoLiveStreamActivity_IceLink (client)' ~NativeInputEventReceiver.
10662020-06-12 14:37:10.157 8187-8187/com.rubarb.app.debug D/InputTransport: Input channel destroyed: fd=164