search

home-assistant / android

:iphone: Home Assistant Companion for Android
https://companion.home-assistant.io/
Apache License 2.0
2.35k stars 655 forks source link

Can't connect Wear OS #3441

Closed AnderssonPeter closed 1 year ago

AnderssonPeter commented 1 year ago

Home Assistant Android app version(s):

Android version(s): Phone: 13 WearOS: 2.41 Device model(s): Phone: Pixel 6 Pro WearOS: TicWatch Pro 3 Ultra GPS

Home Assistant version: 2023.3

Last working Home Assistant release (if known): I have never had this working

Description of problem, include YAML if issue is related to notifications: When I start the home assistant app on my watch I get 2 options

  1. Connect to the same address that my phone successfully connects to using the home assistant app
  2. Connect to a new adress

When I select the one my phone uses, it tells me to connect on my phone. Here I enter my credentials, then it shows a connect watch to Wear OS screen where I can assign a id and has a continue button. I click continue and it throws me back to the "Settings for Wear-devices" screen. When I wake my watch again it's still at the screen i was at when i first started the Home Assistant app on it.

Companion App Logs:

Logs collected from Wear OS using adb logcat:

03-29 16:36:49.202   749  1453 I ActivityManager: START u0 {act=android.intent.action.MAIN cat=[android.intent.category.LAUNCHER] flg=0x10200000 cmp=io.homeassistant.companion.android/.splash.SplashActivity} from uid 10057
03-29 16:36:49.258  5102  5255 D OnboardingActivity: findExistingInstances
03-29 16:36:49.261  5102  5257 D OnboardingActivity: requestPhoneSignIn
03-29 16:36:49.264  5102  5143 I Adreno  : QUALCOMM build                   : 96e1ab4, I22091d40c2
03-29 16:36:49.264  5102  5143 I Adreno  : Build Date                       : 10/10/19
03-29 16:36:49.264  5102  5143 I Adreno  : OpenGL ES Shader Compiler Version: EV031.25.03.07
03-29 16:36:49.264  5102  5143 I Adreno  : Local Branch                     : gfx-adreno.lnx.1.0.c30
03-29 16:36:49.264  5102  5143 I Adreno  : Remote Branch                    :
03-29 16:36:49.264  5102  5143 I Adreno  : Remote Branch                    :
03-29 16:36:49.264  5102  5143 I Adreno  : Reconstruct Branch               :
03-29 16:36:49.264  5102  5143 I Adreno  : Build Config                     : S L 6.0.2 AArch32
03-29 16:36:49.269  5102  5143 I Adreno  : PFP: 0x005ff113, ME: 0x005ff066
03-29 16:36:49.271  5102  5143 I ConfigStore: android::hardware::configstore::V1_0::ISurfaceFlingerConfigs::hasWideColorDisplay retrieved: 0
03-29 16:36:49.271  5102  5143 I ConfigStore: android::hardware::configstore::V1_0::ISurfaceFlingerConfigs::hasHDRDisplay retrieved: 0
03-29 16:36:49.272  5102  5143 I OpenGLRenderer: Initialized EGL, version 1.4
03-29 16:36:49.272  5102  5143 D OpenGLRenderer: Swap behavior 2
03-29 16:36:49.273  5102  5256 D OnboardingActivity: requestInstances
03-29 16:36:49.289  5102  5255 D OnboardingActivity: findExistingInstances: success, found 1
03-29 16:36:49.290  5102  5257 D OnboardingActivity: requestPhoneSignIn: found 1 nodes
03-29 16:36:49.320   877   877 I WearInputMethodService: WearInputMethodService.onFinishInput():1945
03-29 16:36:49.320  5102  5102 D OnboardingActivity: onInstanceFound: homeassistant.domain.com
03-29 16:36:49.320   877   877 I WearInputMethodService: WearInputMethodService.onStartInput():1614
03-29 16:36:49.320  5102  5102 D OnboardingActivity: requestInstances: request home assistant instances from Node{Pixel 6 Pro, id=ada5a99c, hops=1, isNearby=true}.id: Pixel 6 Pro
03-29 16:36:50.692  1180  1285 I HOME    : [HomeSafeServiceStarter]startWakefulService: Trying to start wakeful service - ComponentInfo{com.google.android.wearable.app/com.google.android.clockwork.wcs.remoteintent.OpenRemoteIntentService}
03-29 16:36:50.918  1409  1409 I WorkerManager: Unloading disused workers
03-29 16:36:50.927   749  1453 I ActivityManager: START u0 {cmp=io.homeassistant.companion.android/androidx.wear.activity.ConfirmationActivity (has extras)} from uid 10067
03-29 16:36:50.966  5102  5102 W ActivityThread: handleWindowVisibility: no activity for token android.os.BinderProxy@ae931ff
03-29 16:36:50.990   749  3788 E WindowManager: App trying to use insecure INPUT_FEATURE_NO_INPUT_CHANNEL flag. Ignoring
03-29 16:36:51.035   877   877 I WearInputMethodService: WearInputMethodService.onFinishInput():1945
03-29 16:36:51.036   877   877 I WearInputMethodService: WearInputMethodService.onStartInput():1614
03-29 16:36:51.040   749   771 I ActivityManager: Displayed io.homeassistant.companion.android/androidx.wear.activity.ConfirmationActivity: +69ms
03-29 16:36:51.971   604   698 E storaged: getDiskStats failed with result NOT_SUPPORTED and size 0
03-29 16:36:52.847   749   860 E TaskPersister: File error accessing recents directory (directory doesn't exist?).
03-29 16:36:52.902   749   749 D DefaultUngazeDetector: Ungaze event occurred; emitting gesture event!
03-29 16:36:52.902   749   749 D WristGestureCtrl: Gesture:GESTURE UNGAZE, timestamp(ms): 32832549, confidence: 0.0, latency(ms): 0, duration(ms): 6404
03-29 16:36:52.903   749   749 I PowerManagerService: Going to sleep due to screen timeout (uid 1000)...
03-29 16:36:52.904   749   749 W UsageStatsService: Event reported without a package name
03-29 16:36:52.906   749   773 I PowerManagerService: Sleeping (uid 1000)...
03-29 16:36:52.907   749   773 I DisplayPowerController: Blocking screen off
03-29 16:36:52.907   749   773 I DisplayPowerController: Unblocked screen off after 0 ms
03-29 16:36:52.951   877   877 I WearInputMethodService: WearInputMethodService.onFinishInput():1945
03-29 16:36:52.951   877   877 I WearInputMethodService: WearInputMethodService.onStartInput():1614
03-29 16:36:52.975   749   771 I DisplayManagerService: Display device changed state: "Inbyggd skärm", OFF
03-29 16:36:52.980  1180  1180 W ProxyAndroidLoggerBackend: Too many Flogger logs received before configuration. Dropping old logs.
03-29 16:36:52.982   888   888 E ViewRootImpl[]: Error on detecting ambient animation
03-29 16:36:52.989  4347  4347 E ViewRootImpl[MainSettingsActivity]: Error on detecting ambient animation
03-29 16:36:52.991  4347  4347 E ViewRootImpl[WearablePreferenceActivity]: Error on detecting ambient animation
03-29 16:36:52.992  1409  1409 E ViewRootImpl[AssistantActivity]: Error on detecting ambient animation
03-29 16:36:52.995  5102  5102 E ViewRootImpl[OnboardingActivity]: Error on detecting ambient animation
03-29 16:36:52.998   548   548 D SurfaceFlinger: Set power mode=0, type=0 flinger=0xaefb6000
03-29 16:36:53.001   519  1127 I SDM     : DisplayBase::SetDisplayState: Set state = 0, display 0
03-29 16:36:53.005   749   822 I InputReader: Reconfiguring input devices.  changes=0x00000004
03-29 16:36:53.014  1180  1180 E ViewRootImpl[HomeActivity2]: Error on detecting ambient animation
03-29 16:36:53.223   548   548 D SurfaceFlinger: Finished set power mode=0, type=0
03-29 16:36:53.224   749   859 D SurfaceControl: Excessive delay in setPowerMode()
03-29 16:36:53.242   510   510 D audio_hw_primary: adev_set_parameters: enter: screen_state=off
03-29 16:36:53.243   510   510 D audio_hw_extn: audio_extn_set_anc_parameters: anc_enabled:0
03-29 16:36:53.243   510   510 D audio_hw_spkr_prot: audio_extn_fbsp_set_parameters: Speaker protection disabled
03-29 16:36:53.263   877   877 I DeviceStatusMonitor: DeviceStatusMonitor$1.onReceive():57 onReceive() : Action = android.intent.action.SCREEN_OFF
03-29 16:36:53.264   877   877 I DeviceStatusMonitor: DeviceStatusMonitor.updateCountryInfo():117 updateCountryInfo(), notifyAnyway = false
03-29 16:36:53.273   749   749 I WearPower: [WearTouchMediator] changing touch input to enabled (ON_AUTO)
03-29 16:36:53.274   749   822 I InputReader: Reconfiguring input devices.  changes=0x00000200
03-29 16:36:53.276  1163  1163 D NfcService: BroadcastReceiver - SCREEN_STATE_OFF_UNLOCKED
03-29 16:36:53.277  1163  1163 D NfcService: NfcServiceHandler - handleMessage(MSG_APPLY_SCREEN_STATE)
03-29 16:36:53.285   749   749 D WristGestureCtrl: Stopping detectors: GesturesEnabled-false gestureDetector-false ungazeEnabled-true ungaze-true
03-29 16:36:53.285   749   749 D DefaultUngazeDetector: stopping
03-29 16:36:53.286   749   749 I AmbientService: [86ffd24] Setting alarm for auto-resume expiry.
03-29 16:36:53.289  1163  1163 E libnfc_nci: [ERROR:StNativeNfcTag.cpp(1075)] nativeNfcTag_doDisconnect: tag already deactivated
03-29 16:36:53.329   749   822 I InputReader: Reconfiguring input devices.  changes=0x00000004
03-29 16:36:53.346  5102  5102 D SensorReceiver: Received intent: android.intent.action.SCREEN_OFF
03-29 16:36:53.348  5102  5102 D SensorReceiver: Sensor is_interactive corresponding to received event android.intent.action.SCREEN_OFF is disabled, skipping sensors update
03-29 16:36:54.199  5102  5261 D PhoneSettingsListener: Message received: MessageEventParcelable[17894,/requestConfig, size=0]
03-29 16:36:54.218  5102  5102 D PhoneSettingsListener: Successfully sent /config to device
03-29 16:36:54.302   961   972 I .gms.persisten: Background concurrent copying GC freed 163313(7MB) AllocSpace objects, 16(640KB) LOS objects, 49% free, 9MB/19MB, paused 189us total 146.351ms
03-29 16:37:04.618  5102  5110 W System  : A resource failed to call close.
03-29 16:37:04.619  5102  5110 E DataBuffer: Internal data leak within a DataBuffer object detected!  Be sure to explicitly call release() on all DataBuffer extending objects when you are done with them. (internal object: com.google.android.gms.common.data.DataHolder@d1154b5)
03-29 16:37:06.938  5102  5264 D PhoneSettingsListener: onDataChanged 1
03-29 16:37:06.941  5102  5102 W DataMap : Key Notifications expected String but value was a java.lang.Boolean.  The default value <null> was returned.
03-29 16:37:06.942  5102  5102 W DataMap : Attempt to cast generated internal exception:
03-29 16:37:06.942  5102  5102 W DataMap : java.lang.ClassCastException: java.lang.Boolean cannot be cast to java.lang.String
03-29 16:37:06.942  5102  5102 W DataMap :      at com.google.android.gms.wearable.DataMap.getString(com.google.android.gms:play-services-wearable@@18.0.0:2)
03-29 16:37:06.942  5102  5102 W DataMap :      at io.homeassistant.companion.android.phone.PhoneSettingsListener$login$1.invokeSuspend(PhoneSettingsListener.kt:125)
03-29 16:37:06.942  5102  5102 W DataMap :      at kotlin.coroutines.jvm.internal.BaseContinuationImpl.resumeWith(ContinuationImpl.kt:33)
03-29 16:37:06.942  5102  5102 W DataMap :      at kotlinx.coroutines.DispatchedTask.run(DispatchedTask.kt:106)
03-29 16:37:06.942  5102  5102 W DataMap :      at android.os.Handler.handleCallback(Handler.java:873)
03-29 16:37:06.942  5102  5102 W DataMap :      at android.os.Handler.dispatchMessage(Handler.java:99)
03-29 16:37:06.942  5102  5102 W DataMap :      at android.os.Looper.loop(Looper.java:193)
03-29 16:37:06.942  5102  5102 W DataMap :      at android.app.ActivityThread.main(ActivityThread.java:6680)
03-29 16:37:06.942  5102  5102 W DataMap :      at java.lang.reflect.Method.invoke(Native Method)
03-29 16:37:06.942  5102  5102 W DataMap :      at com.android.internal.os.RuntimeInit$MethodAndArgsCaller.run(RuntimeInit.java:493)
03-29 16:37:06.942  5102  5102 W DataMap :      at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:858)
03-29 16:37:06.949  5102  5102 D UrlRepository: localUrl is: false, usesInternalSsid is: false, usesWifi is: false
03-29 16:37:06.950  5102  5102 D UrlRepository: localUrl is: false, usesInternalSsid is: false, usesWifi is: false
03-29 16:37:06.951  5102  5102 D UrlRepository: Using external URL
03-29 16:37:06.961   453  5265 I /system/bin/netd: gethostby*.getanswer: asked for "homeassistant.domain.com IN A", got type "RRSIG"
03-29 16:37:06.961   453  5265 I /system/bin/netd: gethostby*.getanswer: asked for "homeassistant.domain.com IN A", got type "RRSIG"
03-29 16:37:06.973  1302  1302 D sysproxy: [T:113] Establishing a new TCP stream to: 85.24.217.92:443 (uid=10067) (package=io.homeassistant.companion.android)
03-29 16:37:07.243  1302  1302 D sysproxy: [T:113] Closed stream. RX/TX: 191/7
03-29 16:37:07.249  5102  5102 E PhoneSettingsListener: Unable to login to Home Assistant
03-29 16:37:07.249  5102  5102 E PhoneSettingsListener: javax.net.ssl.SSLHandshakeException: Handshake failed
03-29 16:37:07.249  5102  5102 E PhoneSettingsListener:         at com.android.org.conscrypt.ConscryptFileDescriptorSocket.startHandshake(ConscryptFileDescriptorSocket.java:286)
03-29 16:37:07.249  5102  5102 E PhoneSettingsListener:         at okhttp3.internal.connection.RealConnection.connectTls(RealConnection.kt:379)
03-29 16:37:07.249  5102  5102 E PhoneSettingsListener:         at okhttp3.internal.connection.RealConnection.establishProtocol(RealConnection.kt:337)
03-29 16:37:07.249  5102  5102 E PhoneSettingsListener:         at okhttp3.internal.connection.RealConnection.connect(RealConnection.kt:209)
03-29 16:37:07.249  5102  5102 E PhoneSettingsListener:         at okhttp3.internal.connection.ExchangeFinder.findConnection(ExchangeFinder.kt:226)
03-29 16:37:07.249  5102  5102 E PhoneSettingsListener:         at okhttp3.internal.connection.ExchangeFinder.findHealthyConnection(ExchangeFinder.kt:106)
03-29 16:37:07.249  5102  5102 E PhoneSettingsListener:         at okhttp3.internal.connection.ExchangeFinder.find(ExchangeFinder.kt:74)
03-29 16:37:07.249  5102  5102 E PhoneSettingsListener:         at okhttp3.internal.connection.RealCall.initExchange$okhttp(RealCall.kt:255)
03-29 16:37:07.249  5102  5102 E PhoneSettingsListener:         at okhttp3.internal.connection.ConnectInterceptor.intercept(ConnectInterceptor.kt:32)
03-29 16:37:07.249  5102  5102 E PhoneSettingsListener:         at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.kt:109)
03-29 16:37:07.249  5102  5102 E PhoneSettingsListener:         at okhttp3.internal.cache.CacheInterceptor.intercept(CacheInterceptor.kt:95)
03-29 16:37:07.249  5102  5102 E PhoneSettingsListener:         at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.kt:109)
03-29 16:37:07.249  5102  5102 E PhoneSettingsListener:         at okhttp3.internal.http.BridgeInterceptor.intercept(BridgeInterceptor.kt:83)
03-29 16:37:07.249  5102  5102 E PhoneSettingsListener:         at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.kt:109)
03-29 16:37:07.249  5102  5102 E PhoneSettingsListener:         at okhttp3.internal.http.RetryAndFollowUpInterceptor.intercept(RetryAndFollowUpInterceptor.kt:76)
03-29 16:37:07.249  5102  5102 E PhoneSettingsListener:         at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.kt:109)
03-29 16:37:07.249  5102  5102 E PhoneSettingsListener:         at okhttp3.internal.connection.RealCall.getResponseWithInterceptorChain$okhttp(RealCall.kt:201)
03-29 16:37:07.249  5102  5102 E PhoneSettingsListener:         at okhttp3.internal.connection.RealCall$AsyncCall.run(RealCall.kt:517)
03-29 16:37:07.249  5102  5102 E PhoneSettingsListener:         at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167)
03-29 16:37:07.249  5102  5102 E PhoneSettingsListener:         at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641)
03-29 16:37:07.249  5102  5102 E PhoneSettingsListener:         at java.lang.Thread.run(Thread.java:764)
03-29 16:37:07.249  5102  5102 E PhoneSettingsListener: Caused by: javax.net.ssl.SSLProtocolException: SSL handshake aborted: ssl=0xa9571988: Failure in SSL library, usually a protocol error
03-29 16:37:07.249  5102  5102 E PhoneSettingsListener: error:1000042e:SSL routines:OPENSSL_internal:TLSV1_ALERT_PROTOCOL_VERSION (external/boringssl/src/ssl/tls_record.cc:592 0x9675cf08:0x00000001)
03-29 16:37:07.249  5102  5102 E PhoneSettingsListener:         at com.android.org.conscrypt.NativeCrypto.SSL_do_handshake(Native Method)
03-29 16:37:07.249  5102  5102 E PhoneSettingsListener:         at com.android.org.conscrypt.NativeSsl.doHandshake(NativeSsl.java:375)
03-29 16:37:07.249  5102  5102 E PhoneSettingsListener:         at com.android.org.conscrypt.ConscryptFileDescriptorSocket.startHandshake(ConscryptFileDescriptorSocket.java:224)
03-29 16:37:07.249  5102  5102 E PhoneSettingsListener:         ... 20 more
03-29 16:37:07.268  5102  5102 D PhoneSettingsListener: Successfully sent /config to device
03-29 16:37:10.320   749   822 D WindowManager: interceptKeyTq keycode=26 interactive=false keyguardActive=false policyFlags=2000000
03-29 16:37:10.323   749   822 I PowerManagerService: Waking up from sleep (uid=1000 reason=android.policy:POWER)...
03-29 16:37:10.325   749   749 W UsageStatsService: Event reported without a package name
03-29 16:37:10.361   749   773 I DisplayPowerController: Blocking screen on until initial contents have been drawn.
03-29 16:37:10.392   749   822 W InputDispatcher: Excessive delay in interceptKeyBeforeQueueing; took 72 ms
03-29 16:37:10.430   749   763 W BroadcastQueue: Background execution not allowed: receiving Intent { act=android.intent.action.USER_PRESENT flg=0x10 } to com.google.android.gms/.auth.setup.devicesignals.LockScreenReceiver
03-29 16:37:10.430   749   763 W BroadcastQueue: Background execution not allowed: receiving Intent { act=android.intent.action.USER_PRESENT flg=0x10 } to com.google.android.gms/.chimera.GmsIntentOperationService$PersistentTrustedReceiver
03-29 16:37:10.433   877   877 I WearInputMethodService: WearInputMethodService.onFinishInput():1945
03-29 16:37:10.434  1180  1180 W ProxyAndroidLoggerBackend: Too many Flogger logs received before configuration. Dropping old logs.
03-29 16:37:10.434   877   877 I WearInputMethodService: WearInputMethodService.onStartInput():1614
03-29 16:37:10.436  1163  1163 D NfcService: BroadcastReceiver - SCREEN_STATE_ON_UNLOCKED
03-29 16:37:10.436  1163  1163 D NfcService: NfcServiceHandler - handleMessage(MSG_APPLY_SCREEN_STATE)
03-29 16:37:10.437  1163  1163 D NfcDiscoveryParameters: Builder.build(): mTechMask: 0
03-29 16:37:10.437  1163  1163 D NfcDiscoveryParameters: mEnableReader: false
03-29 16:37:10.437  1163  1163 D NfcDiscoveryParameters: mEnableHostRouting: true
03-29 16:37:10.437  1163  1163 D NfcDiscoveryParameters: mEnableP2p: false
03-29 16:37:10.437  1163  1163 D NfcDiscoveryParameters: mEnableCeSCreenOff: true
03-29 16:37:10.437  1163  1163 D NfcDiscoveryParameters: mEnableSERouting: false
03-29 16:37:10.437  1163  1163 D NfcDiscoveryParameters: shouldEnableCeScreenOff() mEnableCeSCreenOff: true
03-29 16:37:10.451   548   548 D SurfaceFlinger: Set power mode=2, type=0 flinger=0xaefb6000
03-29 16:37:10.451   519  1127 I SDM     : DisplayBase::SetDisplayState: Set state = 1, display 0
03-29 16:37:10.453   749   771 I DisplayManagerService: Display device changed state: "Inbyggd skärm", ON
03-29 16:37:10.455   510   510 D audio_hw_primary: adev_set_parameters: enter: screen_state=on
03-29 16:37:10.455   510   510 D audio_hw_extn: audio_extn_set_anc_parameters: anc_enabled:0
03-29 16:37:10.455   510   510 D audio_hw_spkr_prot: audio_extn_fbsp_set_parameters: Speaker protection disabled
03-29 16:37:10.465   749   822 I InputReader: Reconfiguring input devices.  changes=0x00000004
03-29 16:37:10.477   877   877 I DeviceStatusMonitor: DeviceStatusMonitor$1.onReceive():57 onReceive() : Action = android.intent.action.SCREEN_ON
03-29 16:37:10.478   877   877 I DeviceStatusMonitor: DeviceStatusMonitor.updateCountryInfo():117 updateCountryInfo(), notifyAnyway = false
03-29 16:37:10.481   749   822 D WindowManager: interceptKeyTq keycode=26 interactive=true keyguardActive=false policyFlags=22000000
03-29 16:37:10.483   749   749 I WearPower: [WearTouchMediator] changing touch input to enabled (ON_AUTO)
03-29 16:37:10.483   749   822 I InputReader: Reconfiguring input devices.  changes=0x00000200
03-29 16:37:10.493  1163  1163 D NfcService: BroadcastReceiver - SCREEN_STATE_ON_UNLOCKED
03-29 16:37:10.494  1163  1163 D NfcService: NfcServiceHandler - handleMessage(MSG_APPLY_SCREEN_STATE)
03-29 16:37:10.494  1163  1163 D NfcDiscoveryParameters: Builder.build(): mTechMask: 0
03-29 16:37:10.494  1163  1163 D NfcDiscoveryParameters: mEnableReader: false
03-29 16:37:10.494  1163  1163 D NfcDiscoveryParameters: mEnableHostRouting: true
03-29 16:37:10.494  1163  1163 D NfcDiscoveryParameters: mEnableP2p: false
03-29 16:37:10.494  1163  1163 D NfcDiscoveryParameters: mEnableCeSCreenOff: true
03-29 16:37:10.494  1163  1163 D NfcDiscoveryParameters: mEnableSERouting: false
03-29 16:37:10.494  1163  1163 D NfcDiscoveryParameters: shouldEnableCeScreenOff() mEnableCeSCreenOff: true
03-29 16:37:10.726   548   548 D SurfaceFlinger: Finished set power mode=2, type=0
03-29 16:37:10.738   749   859 D SurfaceControl: Excessive delay in setPowerMode()
03-29 16:37:10.740   749   822 I InputReader: Reconfiguring input devices.  changes=0x00000004
03-29 16:37:10.743   749   749 D WristGestureCtrl: Starting: GesturesEnabled-false UngazeEnabled-true
03-29 16:37:10.743   749   749 D DefaultUngazeDetector: starting
03-29 16:37:10.743   749   749 D DefaultUngazeDetector: startUngazeStateEstimation(). startTime = 32856794
03-29 16:37:10.751   749   749 W DefaultSettingsContentR: Value for ambient_low_bit_enabled not stored as number. Attempting parse as boolean.
03-29 16:37:10.753   749   764 W Looper  : Slow dispatch took 218ms android.ui h=com.android.server.am.ActivityManagerService$UiHandler c=null m=30
03-29 16:37:10.756   749   764 W Looper  : Slow delivery took 217ms android.ui h=android.hardware.display.DisplayManagerGlobal$DisplayListenerDelegate c=null m=2
03-29 16:37:10.757   877   877 I WearInputMethodService: WearInputMethodService.onFinishInput():1945
03-29 16:37:10.757   877   877 I WearInputMethodService: WearInputMethodService.onStartInput():1614
03-29 16:37:10.773   749   764 W Looper  : Drained
03-29 16:37:10.781   749   764 I WindowManager: Suppressed redundant power key press while already in the process of turning the screen on.
03-29 16:37:10.788  3801  3801 I BndSvcConfigHelper: No bound-service is registered for action: com.google.android.gms.auth.cryptauth.cryptauthservice.START
03-29 16:37:10.789  3801  3801 I BoundBrokerSvc: Bound service not available for: Intent { act=com.google.android.gms.auth.cryptauth.cryptauthservice.START pkg=com.google.android.gms }
03-29 16:37:10.789  3801  3801 I ChimeraSrvcProxy: com.google.android.gms.chimera.GmsBoundBrokerService returning NullBinder for action com.google.android.gms.auth.cryptauth.cryptauthservice.START
03-29 16:37:10.790  5102  5276 D OnboardingActivity: findExistingInstances
03-29 16:37:10.793   749   773 I DisplayPowerController: Unblocked screen on after 432 ms
03-29 16:37:10.795   749   773 W PowerManagerService: Screen on took 476 ms
03-29 16:37:10.800  5102  5278 D OnboardingActivity: requestPhoneSignIn
03-29 16:37:10.800  5102  5277 D OnboardingActivity: requestInstances
03-29 16:37:10.810  3801  3832 I ChimeraSrvcProxy: NullBinder for com.google.android.gms.auth.cryptauth.cryptauthservice.START throwing RemoteException due to Service without Chimera impl
03-29 16:37:10.810  3801  3832 W GmsClient: IGmsServiceBroker.getService failed
03-29 16:37:10.810  3801  3832 W GmsClient: android.os.RemoteException: Service without Chimera impl
03-29 16:37:10.810  3801  3832 W GmsClient:     at eua.onTransact(:com.google.android.gms@231015073@23.10.15 (050300-517566699):2)
03-29 16:37:10.810  3801  3832 W GmsClient:     at android.os.Binder.transact(Binder.java:667)
03-29 16:37:10.810  3801  3832 W GmsClient:     at maf.eQ(:com.google.android.gms@231015073@23.10.15 (050300-517566699):5)
03-29 16:37:10.810  3801  3832 W GmsClient:     at lym.s(:com.google.android.gms@231015073@23.10.15 (050300-517566699):11)
03-29 16:37:10.810  3801  3832 W GmsClient:     at lhy.run(:com.google.android.gms@231015073@23.10.15 (050300-517566699):5)
03-29 16:37:10.810  3801  3832 W GmsClient:     at android.os.Handler.handleCallback(Handler.java:873)
03-29 16:37:10.810  3801  3832 W GmsClient:     at android.os.Handler.dispatchMessage(Handler.java:99)
03-29 16:37:10.810  3801  3832 W GmsClient:     at uaz.hW(:com.google.android.gms@231015073@23.10.15 (050300-517566699):0)
03-29 16:37:10.810  3801  3832 W GmsClient:     at uaz.dispatchMessage(:com.google.android.gms@231015073@23.10.15 (050300-517566699):14)
03-29 16:37:10.810  3801  3832 W GmsClient:     at android.os.Looper.loop(Looper.java:193)
03-29 16:37:10.810  3801  3832 W GmsClient:     at android.os.HandlerThread.run(HandlerThread.java:65)
03-29 16:37:10.822  5102  5276 D OnboardingActivity: findExistingInstances: success, found 1
03-29 16:37:10.823  5102  5102 D SensorReceiver: Received intent: android.intent.action.SCREEN_ON
03-29 16:37:10.824  5102  5102 D SensorReceiver: Sensor is_interactive corresponding to received event android.intent.action.SCREEN_ON is disabled, skipping sensors update
03-29 16:37:10.825  5102  5102 D OnboardingActivity: onInstanceFound: homeassistant.domain.com
03-29 16:37:10.827  5102  5278 D OnboardingActivity: requestPhoneSignIn: found 1 nodes
03-29 16:37:10.839  5102  5102 D OnboardingActivity: requestInstances: request home assistant instances from Node{Pixel 6 Pro, id=ada5a99c, hops=1, isNearby=true}.id: Pixel 6 Pro

Logs from Android phone (Collected using the button in app, its not the exact pair try but gave same result)

--------- beginning of main
03-29 16:57:34.740 15863 15863 D LocBroadcastReceiver: Received location update.
03-29 16:57:34.744 15863 15863 D ForegrndServiceLauncher: Check if service HighAccuracyLocationService is running. Service running = false
03-29 16:57:34.744 15863 15863 D LocBroadcastReceiver: Last Location: 
03-29 16:57:34.744 15863 15863 D LocBroadcastReceiver: Coords:(xxx, xxx)
03-29 16:57:34.744 15863 15863 D LocBroadcastReceiver: Accuracy: 20.0
03-29 16:57:34.744 15863 15863 D LocBroadcastReceiver: Bearing: 0.0
03-29 16:57:34.747 15863 15863 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:57:34.748 15863 15863 D LocBroadcastReceiver: Begin evaluating if location update should be skipped
03-29 16:57:34.748 15863 15863 D LocBroadcastReceiver: Received location that is 272 milliseconds old, 1680101854476 compared to 1680101854748 with source fused
03-29 16:57:34.758 15863 24697 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:57:34.766 15863 24916 D TrafficStats: tagSocket(111) with statsTag=0xffffffff, statsUid=-1
03-29 16:57:34.797 15863 24697 D LocBroadcastReceiver: Location update sent successfully as exact
03-29 16:57:51.694 15863 15863 D SensorReceiver: Received intent: android.intent.action.SCREEN_OFF
03-29 16:57:51.694 15863 15863 D SensorReceiver: Sensor is_interactive corresponding to received event android.intent.action.SCREEN_OFF is disabled, skipping sensors update
03-29 16:57:51.695 15863 15863 D ButtonWidget: Broadcast received: 
03-29 16:57:51.695 15863 15863 D ButtonWidget: Broadcast action: android.intent.action.SCREEN_OFF
03-29 16:57:51.695 15863 15863 D ButtonWidget: AppWidgetId: -1
03-29 16:57:51.697 15863 15863 D MediaPlayCtrlsWidget: Broadcast received: 
03-29 16:57:51.697 15863 15863 D MediaPlayCtrlsWidget: Broadcast action: android.intent.action.SCREEN_OFF
03-29 16:57:51.697 15863 15863 D MediaPlayCtrlsWidget: AppWidgetId: -1
03-29 16:57:51.736 15863 24697 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:57:51.737 15863 15889 I WM-WorkerWrapper: Worker result SUCCESS for Work [ id=585789ec-8f17-41a2-9678-0948bf72c8a4, tags={ io.homeassistant.companion.android.websocket.WebsocketManager } ]
03-29 16:57:52.651 15863 15863 D TileExtensions: Tile: tile_1 is in view
03-29 16:57:52.651 15863 15863 D TileExtensions: Attempting to set tile data for tile ID: tile_1
03-29 16:57:52.652 15863 15863 D WebSocketRepository: Sending message 427: {type=subscribe_trigger, trigger={platform=state, entity_id=[light.living_room_towards_neighbor]}, id=427}
03-29 16:57:52.652 15863 15863 D WebSocketRepository: Message number 427 sent
03-29 16:57:52.652 15863 15863 D TileExtensions: Tile: tile_2 is in view
03-29 16:57:52.652 15863 15863 D TileExtensions: Attempting to set tile data for tile ID: tile_2
03-29 16:57:52.657 15863 23371 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:57:52.657 15863 23371 D UrlRepository: Using external URL
03-29 16:57:52.657 15863 24697 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:57:52.657 15863 24697 D UrlRepository: Using external URL
03-29 16:57:52.659 15863 23371 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:57:52.660 15863 23371 D UrlRepository: Using external URL
03-29 16:57:52.660 15863 24697 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:57:52.660 15863 24697 D UrlRepository: Using external URL
03-29 16:57:52.664 15863 15863 D SensorReceiver: Received intent: android.intent.action.SCREEN_ON
03-29 16:57:52.664 15863 15863 D SensorReceiver: Sensor is_interactive corresponding to received event android.intent.action.SCREEN_ON is disabled, skipping sensors update
03-29 16:57:52.665 15863 15863 D ButtonWidget: Broadcast received: 
03-29 16:57:52.665 15863 15863 D ButtonWidget: Broadcast action: android.intent.action.SCREEN_ON
03-29 16:57:52.665 15863 15863 D ButtonWidget: AppWidgetId: -1
03-29 16:57:52.667 15863 15863 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:57:52.667 15863 15863 D MediaPlayCtrlsWidget: Broadcast received: 
03-29 16:57:52.667 15863 15863 D MediaPlayCtrlsWidget: Broadcast action: android.intent.action.SCREEN_ON
03-29 16:57:52.667 15863 15863 D MediaPlayCtrlsWidget: AppWidgetId: -1
03-29 16:57:52.668 15863 15863 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:57:52.670 15863 15863 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:57:52.680 15863 21730 D WebSocketRepository: Websocket: onMessage (text)
03-29 16:57:52.681 15863 21730 D WebSocketRepository: Message number 427 received
03-29 16:57:52.683 15863 15863 D TileExtensions: Tile data set for tile ID: tile_2
03-29 16:57:52.685 15863 15863 D WebSocketRepository: Sending message 428: {type=subscribe_trigger, trigger={platform=state, entity_id=[switch.master_bedroom_plant_light_3]}, id=428}
03-29 16:57:52.685 15863 15863 D WebSocketRepository: Message number 428 sent
03-29 16:57:52.688 15863 15863 D TileExtensions: Tile data set for tile ID: tile_1
03-29 16:57:52.726 15863 21730 D WebSocketRepository: Websocket: onMessage (text)
03-29 16:57:52.727 15863 21730 D WebSocketRepository: Message number 428 received
03-29 16:57:52.859 15863 23371 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:57:52.860 15863 15914 I WM-WorkerWrapper: Worker result SUCCESS for Work [ id=9efd53c8-8c73-4c63-a0d8-932863436315, tags={ io.homeassistant.companion.android.websocket.WebsocketManager } ]
03-29 16:58:17.999 15863 15863 D TileExtensions: Tile: tile_1 is no longer in view
03-29 16:58:17.999 15863 15863 D TileExtensions: Tile: tile_2 is no longer in view
03-29 16:58:18.001 15863 24988 D WebSocketRepository: Unsubscribing from subscribe_trigger with data {trigger={platform=state, entity_id=[switch.master_bedroom_plant_light_3]}}
03-29 16:58:18.001 15863 23371 D WebSocketRepository: Unsubscribing from subscribe_trigger with data {trigger={platform=state, entity_id=[light.living_room_towards_neighbor]}}
03-29 16:58:18.001 15863 24988 D WebSocketRepository: Sending message 429: {type=unsubscribe_events, subscription=428, id=429}
03-29 16:58:18.001 15863 24988 D WebSocketRepository: Message number 429 sent
03-29 16:58:18.002 15863 23371 D WebSocketRepository: Sending message 430: {type=unsubscribe_events, subscription=427, id=430}
03-29 16:58:18.002 15863 23371 D WebSocketRepository: Message number 430 sent
03-29 16:58:18.016 15863 21730 D WebSocketRepository: Websocket: onMessage (text)
03-29 16:58:18.017 15863 21730 D WebSocketRepository: Message number 429 received
03-29 16:58:18.020 15863 21730 D WebSocketRepository: Websocket: onMessage (text)
03-29 16:58:18.020 15863 21730 D WebSocketRepository: Message number 430 received
03-29 16:58:18.024 15863 21730 D WebSocketRepository: Websocket: onClosing code: 1000, reason: 
03-29 16:58:18.025 15863 21730 D WebSocketRepository: Websocket: onClosed
03-29 16:58:18.151 15863 15863 D SensorReceiver: Received intent: android.intent.action.SCREEN_OFF
03-29 16:58:18.152 15863 15863 D SensorReceiver: Sensor is_interactive corresponding to received event android.intent.action.SCREEN_OFF is disabled, skipping sensors update
03-29 16:58:18.156 15863 15863 D ButtonWidget: Broadcast received: 
03-29 16:58:18.156 15863 15863 D ButtonWidget: Broadcast action: android.intent.action.SCREEN_OFF
03-29 16:58:18.156 15863 15863 D ButtonWidget: AppWidgetId: -1
03-29 16:58:18.160 15863 15863 D MediaPlayCtrlsWidget: Broadcast received: 
03-29 16:58:18.160 15863 15863 D MediaPlayCtrlsWidget: Broadcast action: android.intent.action.SCREEN_OFF
03-29 16:58:18.160 15863 15863 D MediaPlayCtrlsWidget: AppWidgetId: -1
03-29 16:58:18.199 15863 25097 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:58:18.202 15863 15897 I WM-WorkerWrapper: Worker result SUCCESS for Work [ id=a464ca55-8711-4f75-8e5e-ea076a3a9b83, tags={ io.homeassistant.companion.android.websocket.WebsocketManager } ]
03-29 16:58:19.207 15863 15863 D SensorReceiver: Received intent: android.intent.action.ACTION_POWER_CONNECTED
03-29 16:58:19.314 15863 24698 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:58:19.321 15863 24698 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:58:19.325 15863 15863 D TileExtensions: Tile: tile_1 is in view
03-29 16:58:19.325 15863 15863 D TileExtensions: Attempting to set tile data for tile ID: tile_1
03-29 16:58:19.333 15863 24698 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:58:19.333 15863 24698 D UrlRepository: Using external URL
03-29 16:58:19.334 15863 24698 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:58:19.334 15863 24698 D UrlRepository: Using external URL
03-29 16:58:19.369 15863 15863 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:58:19.369 15863 15863 D UrlRepository: Using external URL
03-29 16:58:19.374 15863 21730 D TrafficStats: tagSocket(91) with statsTag=0xffffffff, statsUid=-1
03-29 16:58:19.396 15863 15863 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:58:19.396 15863 15863 D UrlRepository: Using external URL
03-29 16:58:19.396 15863 15863 D TileExtensions: Tile: tile_2 is in view
03-29 16:58:19.398 15863 15863 D TileExtensions: Tile data set for tile ID: tile_1
03-29 16:58:19.400 15863 15863 D TileExtensions: Attempting to set tile data for tile ID: tile_2
03-29 16:58:19.405 15863 25101 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:58:19.405 15863 25101 D UrlRepository: Using external URL
03-29 16:58:19.428 15863 25101 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:58:19.428 15863 25101 D UrlRepository: Using external URL
03-29 16:58:19.440 15863 21730 D WebSocketRepository: Websocket: onOpen
03-29 16:58:19.441 15863 21730 D WebSocketRepository: Websocket: onMessage (text)
03-29 16:58:19.442 15863 21730 D WebSocketRepository: Message number null received
03-29 16:58:19.444 15863 25101 D WebSocketRepository: Auth Requested
03-29 16:58:19.452 15863 15863 D TileExtensions: Tile data set for tile ID: tile_2
03-29 16:58:19.452 15863 21730 D WebSocketRepository: Websocket: onMessage (text)
03-29 16:58:19.453 15863 21730 D WebSocketRepository: Message number null received
03-29 16:58:19.465 15863 15863 D WebSocketRepository: Sending message 431: {type=supported_features, id=431, features={coalesce_messages=1}}
03-29 16:58:19.465 15863 15863 D WebSocketRepository: Sending message 432: {type=subscribe_trigger, trigger={platform=state, entity_id=[light.living_room_towards_neighbor]}, id=432}
03-29 16:58:19.465 15863 15863 D WebSocketRepository: Message number 432 sent
03-29 16:58:19.469 15863 21730 D WebSocketRepository: Websocket: onMessage (text)
03-29 16:58:19.469 15863 21730 D WebSocketRepository: Message number 431 received
03-29 16:58:19.473 15863 21730 D WebSocketRepository: Websocket: onMessage (text)
03-29 16:58:19.474 15863 21730 D WebSocketRepository: Message number 432 received
03-29 16:58:19.475 15863 15863 D WebSocketRepository: Sending message 433: {type=subscribe_trigger, trigger={platform=state, entity_id=[switch.master_bedroom_plant_light_3]}, id=433}
03-29 16:58:19.475 15863 15863 D WebSocketRepository: Message number 433 sent
03-29 16:58:19.480 15863 21730 D WebSocketRepository: Websocket: onMessage (text)
03-29 16:58:19.480 15863 21730 D WebSocketRepository: Message number 433 received
03-29 16:58:19.608 15863 15863 D SensorReceiver: Received intent: android.os.action.POWER_SAVE_MODE_CHANGED
03-29 16:58:19.608 15863 15863 D SensorReceiver: Sensor power_save corresponding to received event android.os.action.POWER_SAVE_MODE_CHANGED is disabled, skipping sensors update
03-29 16:58:19.632 15863 15863 D SensorReceiver: Received intent: android.os.action.POWER_SAVE_MODE_CHANGED
03-29 16:58:19.633 15863 15863 D SensorReceiver: Sensor power_save corresponding to received event android.os.action.POWER_SAVE_MODE_CHANGED is disabled, skipping sensors update
03-29 16:58:19.637 15863 25097 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:58:19.664 15863 15863 D SensorReceiver: Received intent: android.intent.action.SCREEN_ON
03-29 16:58:19.665 15863 15863 D SensorReceiver: Sensor is_interactive corresponding to received event android.intent.action.SCREEN_ON is disabled, skipping sensors update
03-29 16:58:19.666 15863 15863 D ButtonWidget: Broadcast received: 
03-29 16:58:19.666 15863 15863 D ButtonWidget: Broadcast action: android.intent.action.SCREEN_ON
03-29 16:58:19.666 15863 15863 D ButtonWidget: AppWidgetId: -1
03-29 16:58:19.677 15863 25097 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:58:19.680 15863 15863 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:58:19.682 15863 15863 D MediaPlayCtrlsWidget: Broadcast received: 
03-29 16:58:19.682 15863 15863 D MediaPlayCtrlsWidget: Broadcast action: android.intent.action.SCREEN_ON
03-29 16:58:19.682 15863 15863 D MediaPlayCtrlsWidget: AppWidgetId: -1
03-29 16:58:19.687 15863 15863 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:58:19.693 15863 15897 I WM-WorkerWrapper: Work [ id=82d472d7-e45c-440d-927d-01aacfabca33, tags={ io.homeassistant.companion.android.websocket.WebsocketManager } ] was cancelled
03-29 16:58:19.693 15863 15897 I WM-WorkerWrapper: java.util.concurrent.CancellationException: Task was cancelled.
03-29 16:58:19.693 15863 15897 I WM-WorkerWrapper:  at androidx.work.impl.utils.futures.AbstractFuture.cancellationExceptionWithCause(AbstractFuture.java:1184)
03-29 16:58:19.693 15863 15897 I WM-WorkerWrapper:  at androidx.work.impl.utils.futures.AbstractFuture.getDoneValue(AbstractFuture.java:514)
03-29 16:58:19.693 15863 15897 I WM-WorkerWrapper:  at androidx.work.impl.utils.futures.AbstractFuture.get(AbstractFuture.java:475)
03-29 16:58:19.693 15863 15897 I WM-WorkerWrapper:  at androidx.work.impl.WorkerWrapper$2.run(WorkerWrapper.java:311)
03-29 16:58:19.693 15863 15897 I WM-WorkerWrapper:  at androidx.work.impl.utils.SerialExecutor$Task.run(SerialExecutor.java:91)
03-29 16:58:19.693 15863 15897 I WM-WorkerWrapper:  at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1137)
03-29 16:58:19.693 15863 15897 I WM-WorkerWrapper:  at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:637)
03-29 16:58:19.693 15863 15897 I WM-WorkerWrapper:  at java.lang.Thread.run(Thread.java:1012)
03-29 16:58:19.695 15863 15863 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:58:19.702 15863 25102 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:58:19.703 15863 15889 I WM-WorkerWrapper: Worker result SUCCESS for Work [ id=bf107019-91f0-465b-8df9-086c4db708bd, tags={ io.homeassistant.companion.android.websocket.WebsocketManager } ]
03-29 16:58:24.654 15863 25102 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:58:24.655 15863 25102 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:58:24.828 15863 25102 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:58:34.740 15863 15863 D LocBroadcastReceiver: Received location update.
03-29 16:58:34.742 15863 15863 D ForegrndServiceLauncher: Check if service HighAccuracyLocationService is running. Service running = false
03-29 16:58:34.743 15863 15863 D LocBroadcastReceiver: Last Location: 
03-29 16:58:34.743 15863 15863 D LocBroadcastReceiver: Coords:(xxx, xxx)
03-29 16:58:34.743 15863 15863 D LocBroadcastReceiver: Accuracy: 20.0
03-29 16:58:34.743 15863 15863 D LocBroadcastReceiver: Bearing: 0.0
03-29 16:58:34.745 15863 15863 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:58:34.746 15863 15863 D LocBroadcastReceiver: Begin evaluating if location update should be skipped
03-29 16:58:34.746 15863 15863 D LocBroadcastReceiver: Received location that is 17 milliseconds old, 1680101914729 compared to 1680101914746 with source fused
03-29 16:58:34.746 15863 15863 D LocBroadcastReceiver: Duplicate location received, not sending to HA
03-29 16:58:44.884 15863 15863 D TileExtensions: Tile: tile_1 is no longer in view
03-29 16:58:44.884 15863 15863 D TileExtensions: Tile: tile_2 is no longer in view
03-29 16:58:44.885 15863 24699 D WebSocketRepository: Unsubscribing from subscribe_trigger with data {trigger={platform=state, entity_id=[light.living_room_towards_neighbor]}}
03-29 16:58:44.885 15863 25098 D WebSocketRepository: Unsubscribing from subscribe_trigger with data {trigger={platform=state, entity_id=[switch.master_bedroom_plant_light_3]}}
03-29 16:58:44.886 15863 25098 D WebSocketRepository: Sending message 434: {type=unsubscribe_events, subscription=433, id=434}
03-29 16:58:44.886 15863 25098 D WebSocketRepository: Message number 434 sent
03-29 16:58:44.887 15863 24699 D WebSocketRepository: Sending message 435: {type=unsubscribe_events, subscription=432, id=435}
03-29 16:58:44.887 15863 24699 D WebSocketRepository: Message number 435 sent
03-29 16:58:44.896 15863 21730 D WebSocketRepository: Websocket: onMessage (text)
03-29 16:58:44.897 15863 21730 D WebSocketRepository: Message number 434 received
03-29 16:58:44.900 15863 21730 D WebSocketRepository: Websocket: onMessage (text)
03-29 16:58:44.900 15863 21730 D WebSocketRepository: Message number 435 received
03-29 16:58:44.910 15863 21730 D WebSocketRepository: Websocket: onClosing code: 1000, reason: 
03-29 16:58:44.910 15863 21730 D WebSocketRepository: Websocket: onClosed
03-29 16:58:45.044 15863 15863 D SensorReceiver: Received intent: android.intent.action.SCREEN_OFF
03-29 16:58:45.044 15863 15863 D SensorReceiver: Sensor is_interactive corresponding to received event android.intent.action.SCREEN_OFF is disabled, skipping sensors update
03-29 16:58:45.046 15863 15863 D ButtonWidget: Broadcast received: 
03-29 16:58:45.046 15863 15863 D ButtonWidget: Broadcast action: android.intent.action.SCREEN_OFF
03-29 16:58:45.046 15863 15863 D ButtonWidget: AppWidgetId: -1
03-29 16:58:45.053 15863 15863 D MediaPlayCtrlsWidget: Broadcast received: 
03-29 16:58:45.053 15863 15863 D MediaPlayCtrlsWidget: Broadcast action: android.intent.action.SCREEN_OFF
03-29 16:58:45.053 15863 15863 D MediaPlayCtrlsWidget: AppWidgetId: -1
03-29 16:58:45.092 15863 25390 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:58:45.094 15863 15889 I WM-WorkerWrapper: Worker result SUCCESS for Work [ id=25858a61-baf2-41e0-9d8f-fd81415e5922, tags={ io.homeassistant.companion.android.websocket.WebsocketManager } ]
03-29 16:59:00.417 15863 15863 D SensorReceiver: Received intent: android.intent.action.SCREEN_ON
03-29 16:59:00.417 15863 15863 D SensorReceiver: Sensor is_interactive corresponding to received event android.intent.action.SCREEN_ON is disabled, skipping sensors update
03-29 16:59:00.418 15863 15863 D ButtonWidget: Broadcast received: 
03-29 16:59:00.418 15863 15863 D ButtonWidget: Broadcast action: android.intent.action.SCREEN_ON
03-29 16:59:00.418 15863 15863 D ButtonWidget: AppWidgetId: -1
03-29 16:59:00.420 15863 15863 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:59:00.421 15863 15863 D MediaPlayCtrlsWidget: Broadcast received: 
03-29 16:59:00.421 15863 15863 D MediaPlayCtrlsWidget: Broadcast action: android.intent.action.SCREEN_ON
03-29 16:59:00.421 15863 15863 D MediaPlayCtrlsWidget: AppWidgetId: -1
03-29 16:59:00.423 15863 15863 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:59:00.426 15863 15863 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:59:00.457 15863 25098 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:59:00.458 15863 15897 I WM-WorkerWrapper: Worker result SUCCESS for Work [ id=ca3ab3f7-ff81-450a-807a-0f94ad21aef2, tags={ io.homeassistant.companion.android.websocket.WebsocketManager } ]
03-29 16:59:01.736 15863 15863 D TileExtensions: Tile: tile_1 is in view
03-29 16:59:01.736 15863 15863 D TileExtensions: Attempting to set tile data for tile ID: tile_1
03-29 16:59:01.748 15863 24699 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:59:01.749 15863 24699 D UrlRepository: Using external URL
03-29 16:59:01.750 15863 15863 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:59:01.750 15863 15863 D UrlRepository: Using external URL
03-29 16:59:01.751 15863 24699 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:59:01.751 15863 24699 D UrlRepository: Using external URL
03-29 16:59:01.753 15863 15863 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:59:01.753 15863 15863 D UrlRepository: Using external URL
03-29 16:59:01.753 15863 15863 D TileExtensions: Tile: tile_2 is in view
03-29 16:59:01.753 15863 15863 D TileExtensions: Attempting to set tile data for tile ID: tile_2
03-29 16:59:01.755 15863 24699 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:59:01.755 15863 24699 D UrlRepository: Using external URL
03-29 16:59:01.756 15863 21730 D TrafficStats: tagSocket(91) with statsTag=0xffffffff, statsUid=-1
03-29 16:59:01.756 15863 24699 D UrlRepository: localUrl is: false, usesInternalSsid is: true, usesWifi is: true
03-29 16:59:01.756 15863 24699 D UrlRepository: Using external URL
03-29 16:59:01.818 15863 15863 D TileExtensions: Tile data set for tile ID: tile_1
03-29 16:59:01.833 15863 15863 D TileExtensions: Tile data set for tile ID: tile_2
03-29 16:59:01.883 15863 21730 D WebSocketRepository: Websocket: onOpen
03-29 16:59:01.883 15863 21730 D WebSocketRepository: Websocket: onMessage (text)
03-29 16:59:01.883 15863 21730 D WebSocketRepository: Message number null received
03-29 16:59:01.884 15863 24699 D WebSocketRepository: Auth Requested
03-29 16:59:01.893 15863 21730 D WebSocketRepository: Websocket: onMessage (text)
03-29 16:59:01.894 15863 21730 D WebSocketRepository: Message number null received
03-29 16:59:01.894 15863 15863 D WebSocketRepository: Sending message 436: {type=supported_features, id=436, features={coalesce_messages=1}}
03-29 16:59:01.894 15863 15863 D WebSocketRepository: Sending message 437: {type=subscribe_trigger, trigger={platform=state, entity_id=[light.living_room_towards_neighbor]}, id=437}
03-29 16:59:01.894 15863 15863 D WebSocketRepository: Message number 437 sent
03-29 16:59:01.897 15863 21730 D WebSocketRepository: Websocket: onMessage (text)
03-29 16:59:01.898 15863 21730 D WebSocketRepository: Message number 436 received
03-29 16:59:01.900 15863 21730 D WebSocketRepository: Websocket: onMessage (text)
03-29 16:59:01.900 15863 21730 D WebSocketRepository: Message number 437 received
03-29 16:59:01.901 15863 15863 D WebSocketRepository: Sending message 438: {type=subscribe_trigger, trigger={platform=state, entity_id=[switch.master_bedroom_plant_light_3]}, id=438}
03-29 16:59:01.901 15863 15863 D WebSocketRepository: Message number 438 sent
03-29 16:59:01.928 15863 21730 D WebSocketRepository: Websocket: onMessage (text)
03-29 16:59:01.928 15863 21730 D WebSocketRepository: Message number 438 received
03-29 16:59:16.908 15863 25562 D WearOnboardingListener: onMessageReceived: MessageEventParcelable[18801,/request_home_assistant_instance, size=0]
03-29 16:59:16.908 15863 25562 D WearOnboardingListener: sendHomeAssistantInstance: 9518ab64
03-29 16:59:16.908 15863 25562 D UrlRepository: Using external URL
03-29 16:59:16.921 15863 15863 D WearOnboardingListener: sendHomeAssistantInstance: success
03-29 16:59:17.893 15863 15863 D SettingsWearAct: Waiting on Results for both connected nodes and nodes with app
03-29 16:59:17.898 15863 15863 D SettingsWearAct: Waiting on Results for both connected nodes and nodes with app
03-29 16:59:17.898 15863 15863 D SettingsWearAct: Capable Nodes: [Node{TicWatch Pro 3 Ultra  P067, id=9518ab64, hops=1, isNearby=true}]
03-29 16:59:17.898 15863 15863 D SettingsWearAct: Installed on all devices
03-29 16:59:17.924 15863 15863 D WebSocketRepository: Sending message 439: {type=get_states, id=439}
03-29 16:59:17.924 15863 15863 D WebSocketRepository: Message number 439 sent
03-29 16:59:17.942 15863 15863 D SettingsWearViewModel: Requesting config from node 9518ab64
03-29 16:59:17.948 15863 15863 D SettingsWearViewModel: Request for config sent successfully
03-29 16:59:17.987 15863 21730 D WebSocketRepository: Websocket: onMessage (text)
03-29 16:59:17.990 15863 21730 D WebSocketRepository: Message number 439 received
03-29 16:59:18.168 15863 15863 D SettingsWearViewModel: onDataChanged 1
03-29 16:59:18.170 15863 15863 D SettingsWearViewModel: onDataChanged 1
03-29 16:59:18.180 15863 15863 D SettingsWearViewModel: onDataChanged 1
03-29 16:59:18.181 15863 15863 D SettingsWearViewModel: onDataChanged 1
03-29 16:59:19.670 15863 15863 D InputMethodManager: showSoftInput() view=android.webkit.WebView{7b155df VFEDHVC.. .F...... 0,0-1440,2906 aid=1073741824} flags=0 reason=SHOW_SOFT_INPUT
03-29 16:59:19.708 15863 15863 D InsetsController: show(ime(), fromIme=true)
03-29 16:59:20.187 15863 25577 D WearOnboardingListener: onMessageReceived: MessageEventParcelable[18803,/request_home_assistant_instance, size=0]
03-29 16:59:20.187 15863 25577 D WearOnboardingListener: sendHomeAssistantInstance: 9518ab64
03-29 16:59:20.187 15863 25577 D UrlRepository: Using external URL
03-29 16:59:20.196 15863 15863 D WearOnboardingListener: sendHomeAssistantInstance: success
03-29 16:59:22.925 15863 15863 D InputMethodManager: showSoftInput() view=android.webkit.WebView{7b155df VFEDHVC.. .F...... 0,0-1440,1814 aid=1073741824} flags=0 reason=SHOW_SOFT_INPUT
03-29 16:59:23.017 15863 15863 D InsetsController: show(ime(), fromIme=true)
03-29 16:59:24.514 15863 15863 E DecorView[]: Destroying unexpected ActionMode instance of TYPE_FLOATING; com.android.internal.view.FloatingActionMode@8c2c7e9 was not the current floating action mode! Expected null
03-29 16:59:24.765 15863  7701 D OpenGLRenderer: endAllActiveAnimators on 0xb4000072af026ad0 (RippleDrawable) with handle 0xb4000071bee96330
03-29 16:59:26.485 15863 15863 D SettingsWearViewModel: Successfully sent auth to wear
03-29 16:59:26.485 15863 15863 D SettingsWearViewModel: onDataChanged 1
03-29 16:59:26.485 15863 15863 D SettingsWearViewModel: onDataChanged 1
03-29 16:59:26.485 15863 15863 D SettingsWearViewModel: onDataChanged 1
03-29 16:59:26.485 15863 15863 D SettingsWearViewModel: onDataChanged 1
03-29 16:59:26.947 15863 15863 D SettingsWearViewModel: onDataChanged 1
03-29 16:59:26.948 15863 15863 D SettingsWearViewModel: onDataChanged 1
03-29 16:59:26.949 15863 15863 D SettingsWearViewModel: onDataChanged 1
03-29 16:59:26.950 15863 15863 D SettingsWearViewModel: onDataChanged 1
03-29 16:59:26.985 15863  7701 D OpenGLRenderer: endAllActiveAnimators on 0xb4000072af02c4f0 (UnprojectedRipple) with handle 0xb4000071beeb2aa0
03-29 16:59:29.372 15863 25598 D WearOnboardingListener: onMessageReceived: MessageEventParcelable[18804,/request_home_assistant_instance, size=0]
03-29 16:59:29.372 15863 25598 D WearOnboardingListener: sendHomeAssistantInstance: 9518ab64
03-29 16:59:29.372 15863 25598 D UrlRepository: Using external URL
03-29 16:59:29.379 15863 15863 D WearOnboardingListener: sendHomeAssistantInstance: success
03-29 16:59:32.644 15863  7701 D OpenGLRenderer: endAllActiveAnimators on 0xb4000072af00ef00 (UnprojectedRipple) with handle 0xb4000071bee1ec90
03-29 16:59:33.611 15863  7701 D OpenGLRenderer: endAllActiveAnimators on 0xb4000072af003450 (UnprojectedRipple) with handle 0xb4000071beebb980
03-29 16:59:34.205 15863  7701 D OpenGLRenderer: endAllActiveAnimators on 0xb4000072af0277b0 (UnprojectedRipple) with handle 0xb4000071beebb980
03-29 16:59:34.349 15863 15863 D IntegrationRepository: isAppLocked(): false. (LockEnabled: false, appActive: false, expireMillis: 1680100531053, currentMillis: 1680101974349)
03-29 16:59:34.428 15863 15863 D IntegrationRepository: isAppLocked(): false. (LockEnabled: false, appActive: false, expireMillis: 1680100531053, currentMillis: 1680101974428)
03-29 16:59:34.864 15863  7701 D OpenGLRenderer: endAllActiveAnimators on 0xb4000072aefe8500 (UnprojectedRipple) with handle 0xb4000071beeb3d60
03-29 16:59:35.992 15863 21693 E BLASTBufferQueue: [VRI[SettingsActivity]#97](f:0,a:4) Faking releaseBufferCallback from transactionCompleteCallback
03-29 16:59:35.997 15863 21693 E BLASTBufferQueue: [VRI[SettingsActivity]#97](f:0,a:5) Faking releaseBufferCallback from transactionCompleteCallback
03-29 16:59:35.997 15863 21693 E BLASTBufferQueue: [VRI[SettingsActivity]#97](f:0,a:5) Faking releaseBufferCallback from transactionCompleteCallback
03-29 16:59:46.845 15863 25098 D LogcatReader: Read logcat for pid 15863

Additional information:

I'm 99% sure that my watch was using wifi as I was collecting logs from it using adb over wifi while trying to connect.

Setup: Debian GNU/Linux 11 Docker version 23.0.2, build 569dd73 Docker Compose version v2.17.2

Seems like more than me have this problem found the following threads: https://community.home-assistant.io/t/cannot-log-in-from-home-assistant-wear-os-app/477273/13

jpelgrom commented 1 year ago

Reverse proxies are not supported, especially for Wear OS (there's no web browser on there).

AnderssonPeter commented 1 year ago

@jpelgrom Somewhat confused why would a reverse proxy be a problem? (It just forwards the request to another server or process)? Also it's fairly common to have a reverse proxy infront of you services otherwise you could only have one service per ip/port? edit: but just to be sure I will try without a reverse proxy!

jpelgrom commented 1 year ago

Sorry, I should have clarified reverse proxies with an authentication layer and looked at the logs before responding.

There appears to be an SSL issue:

03-29 16:37:07.249  5102  5102 E PhoneSettingsListener: Unable to login to Home Assistant
03-29 16:37:07.249  5102  5102 E PhoneSettingsListener: javax.net.ssl.SSLHandshakeException: Handshake failed
(...)
03-29 16:37:07.249  5102  5102 E PhoneSettingsListener: Caused by: javax.net.ssl.SSLProtocolException: SSL handshake aborted: ssl=0xa9571988: Failure in SSL library, usually a protocol error
03-29 16:37:07.249  5102  5102 E PhoneSettingsListener: error:1000042e:SSL routines:OPENSSL_internal:TLSV1_ALERT_PROTOCOL_VERSION (external/boringssl/src/ssl/tls_record.cc:592 0x9675cf08:0x00000001)

Your watch appears to use Android 9 so it may not support the latest versions. I'm assuming for your requirements you intended to refer to TLS 1.3, which is only supported on Android 10+.

AnderssonPeter commented 1 year ago

@jpelgrom Thanks enabling TLS 1.2 did the job, I only enabled the following suites. TLS_ECDHE_ECDSA_WITH_AES_128_GCM_SHA256 TLS_ECDHE_RSA_WITH_AES_128_GCM_SHA256 TLS_ECDHE_ECDSA_WITH_AES_256_GCM_SHA384 TLS_ECDHE_RSA_WITH_AES_256_GCM_SHA384 TLS_ECDHE_ECDSA_WITH_CHACHA20_POLY1305 TLS_ECDHE_RSA_WITH_CHACHA20_POLY1305

AnderssonPeter commented 1 year ago

@jpelgrom It would be nice if the wear os or android app would display a error when this happens, as its right now nothing happens leaving you somewhat in the dark.

jpelgrom commented 1 year ago

I agree error handling could be improved, I do intend to work on it (some other improvements had to be made first).

Edit: first improvements in #3450

AnderssonPeter commented 1 year ago

I agree error handling could be improved, I do intend to work on it (some other improvements had to be made first).

👍 Thanks for a great project and the help identifying the issue