Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

Reading QR code error when commisioning Matter device #4327

Closed
barrelful opened this issue Apr 6, 2024 · 2 comments
Closed

Reading QR code error when commisioning Matter device #4327

barrelful opened this issue Apr 6, 2024 · 2 comments
Labels
bug Something isn't working question Further information is requested

Comments

@barrelful
Copy link

Home Assistant Android app version(s): 2024.3.5-FULL

Android version(s): 13

Device model(s): Fairphone 4

Home Assistant version: 2024.4.1

Last working Home Assistant release (if known): -

Description of problem, include YAML if issue is related to notifications:

  1. Install Matter and OTBR (with SkyConnect)
  2. Add Integration -> Add Matter device -> No. It's new -> Scan Matter QR code
  3. Point the camera to a new factory reset Matter device (ie. Nanoleaf bulb)

You get the error:

Something went wrong
Try again or continue without scanning

Companion App Logs:

--------- beginning of main
04-06 14:39:36.140 19846 19846 D SensorReceiver: Received intent: android.intent.action.SCREEN_OFF
04-06 14:39:36.142 19846 19846 D SensorReceiver: Sensor(s) [is_interactive] corresponding to received event android.intent.action.SCREEN_OFF are disabled, skipping sensors update
04-06 14:39:36.147 19846 19846 D ButtonWidget: Broadcast received: 
04-06 14:39:36.147 19846 19846 D ButtonWidget: Broadcast action: android.intent.action.SCREEN_OFF
04-06 14:39:36.147 19846 19846 D ButtonWidget: AppWidgetId: -1
04-06 14:39:36.151 19846 19846 D MediaPlayCtrlsWidget: Broadcast received: 
04-06 14:39:36.151 19846 19846 D MediaPlayCtrlsWidget: Broadcast action: android.intent.action.SCREEN_OFF
04-06 14:39:36.151 19846 19846 D MediaPlayCtrlsWidget: AppWidgetId: -1
04-06 14:39:36.200 19846  4358 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: false
04-06 14:39:36.203 19846 19891 I WM-WorkerWrapper: Worker result SUCCESS for Work [ id=33574daa-1c47-4492-b039-ed6db2f929fc, tags={ io.homeassistant.companion.android.websocket.WebsocketManager } ]
04-06 14:39:39.401 19846 19846 D SensorReceiver: Received intent: android.intent.action.SCREEN_ON
04-06 14:39:39.402 19846 19846 D SensorReceiver: Sensor(s) [is_interactive] corresponding to received event android.intent.action.SCREEN_ON are disabled, skipping sensors update
04-06 14:39:39.407 19846 19846 D ButtonWidget: Broadcast received: 
04-06 14:39:39.407 19846 19846 D ButtonWidget: Broadcast action: android.intent.action.SCREEN_ON
04-06 14:39:39.407 19846 19846 D ButtonWidget: AppWidgetId: -1
04-06 14:39:39.413 19846 19846 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: false
04-06 14:39:39.416 19846 19846 D MediaPlayCtrlsWidget: Broadcast received: 
04-06 14:39:39.416 19846 19846 D MediaPlayCtrlsWidget: Broadcast action: android.intent.action.SCREEN_ON
04-06 14:39:39.416 19846 19846 D MediaPlayCtrlsWidget: AppWidgetId: -1
04-06 14:39:39.416 19846 19846 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: false
04-06 14:39:39.419 19846 19846 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: false
04-06 14:39:39.449 19846  4745 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: false
04-06 14:39:39.451 19846 19891 I WM-WorkerWrapper: Worker result SUCCESS for Work [ id=ffbc2a99-e316-4a44-b685-51a0cef9e511, tags={ io.homeassistant.companion.android.websocket.WebsocketManager } ]
04-06 14:40:23.710 19846 19846 D WebviewActivity: Matter/Thread step changed to MATTER_IN_PROGRESS
04-06 14:40:23.711 19846 19846 D WebViewPresenterImpl: Matter commissioning returned with non-OK code 0
04-06 14:40:23.715 19846 19846 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:40:23.715 19846 19846 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:40:23.716 19846 19846 D IntegrationRepository: isAppLocked(): false. (LockEnabled: false, appActive: false, expireMillis: 0, currentMillis: 1712407223716)
04-06 14:40:23.813 19846 19898 E OpenGLRenderer: Unable to match the desired swap behavior.
04-06 14:40:23.837 19846 19884 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:40:23.838 19846 19891 I WM-WorkerWrapper: Worker result SUCCESS for Work [ id=bbe3a86b-d381-4e35-8992-84304120c89e, tags={ io.homeassistant.companion.android.websocket.WebsocketManager } ]
04-06 14:40:23.851 19846 19919 I WM-Processor: Moving WorkSpec (abe3fd85-ce09-4aa8-b7e6-89a80ca48935) to the foreground
04-06 14:40:23.854 19846 19846 I WM-SystemFgDispatcher: Started foreground service Intent { act=ACTION_START_FOREGROUND cmp=io.homeassistant.companion.android/androidx.work.impl.foreground.SystemForegroundService (has extras) }
04-06 14:40:23.859 19846  4745 D SensorWorker: Updating all Sensors in foreground.
04-06 14:40:23.860 19846  4745 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:40:23.916 19846 19846 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:40:23.916 19846 19846 D IntegrationRepository: isAppLocked(): false. (LockEnabled: false, appActive: false, expireMillis: 0, currentMillis: 1712407223916)
04-06 14:40:23.919 19846 19846 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:40:23.919 19846 19846 D ServerConnectionInfo: Using external URL
04-06 14:40:23.920 19846 19846 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:40:23.920 19846 19846 D ServerConnectionInfo: Using external URL
04-06 14:40:23.938 19846  4745 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:40:23.938 19846  4745 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:40:23.942 19846  7493 D TrafficStats: tagSocket(195) with statsTag=0xffffffff, statsUid=-1
04-06 14:40:24.042 19846  4745 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:40:24.070 19846  4745 I SensorReceiver: Sensor updates and sync completed
04-06 14:40:24.071 19846 19919 I WM-WorkerWrapper: Worker result SUCCESS for Work [ id=abe3fd85-ce09-4aa8-b7e6-89a80ca48935, tags={ io.homeassistant.companion.android.sensors.SensorWorker } ]
04-06 14:40:24.087 19846 19846 I WM-SystemFgDispatcher: Stopping foreground service
04-06 14:40:33.393 19846 19846 D WebviewActivity: Launching browser
04-06 14:40:33.449 19846 19846 D IntegrationRepository: setAppActive(): false
04-06 14:40:33.449 19846 19846 D IntegrationRepository: setAppActive(): false
04-06 14:40:33.469 19846 19846 D SensorReceiver: Received intent: io.homeassistant.companion.android.UPDATE_SENSORS
04-06 14:40:33.470 19846  4745 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:40:33.560 19846  4745 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:40:33.561 19846  4745 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:40:33.673 19846  4745 D SensorReceiver: Nothing to update for server 1 (Home)
04-06 14:40:33.674 19846  4745 I SensorReceiver: Sensor updates and sync completed
04-06 14:40:34.465 19846 19846 V ActivityThread: handleTrimMemory:io.homeassistant.companion.android
04-06 14:40:35.212 19846 19846 D WebviewActivity: Matter/Thread step changed to MATTER_IN_PROGRESS
04-06 14:40:35.220 19846 19846 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:40:35.230 19846 19846 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:40:35.231 19846 19846 D IntegrationRepository: isAppLocked(): false. (LockEnabled: false, appActive: false, expireMillis: 0, currentMillis: 1712407235231)
04-06 14:40:35.388 19846 19898 E OpenGLRenderer: Unable to match the desired swap behavior.
04-06 14:40:35.430 19846  4745 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:40:35.433 19846 19891 I WM-WorkerWrapper: Worker result SUCCESS for Work [ id=a3e4b4e9-292a-401e-b1a8-7987f691580b, tags={ io.homeassistant.companion.android.websocket.WebsocketManager } ]
04-06 14:40:35.447 19846 19891 I WM-Processor: Moving WorkSpec (25427287-1db1-4c1e-975f-3888d10d27f5) to the foreground
04-06 14:40:35.460 19846 19846 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:40:35.460 19846 19846 D IntegrationRepository: isAppLocked(): false. (LockEnabled: false, appActive: false, expireMillis: 0, currentMillis: 1712407235460)
04-06 14:40:35.464 19846 19846 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:40:35.464 19846 19846 D ServerConnectionInfo: Using external URL
04-06 14:40:35.465 19846 19846 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:40:35.465 19846 19846 D ServerConnectionInfo: Using external URL
04-06 14:40:35.470 19846  4745 D SensorWorker: Updating all Sensors in foreground.
04-06 14:40:35.475 19846  4745 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:40:35.479 19846 19846 I WM-SystemFgDispatcher: Started foreground service Intent { act=ACTION_START_FOREGROUND cmp=io.homeassistant.companion.android/androidx.work.impl.foreground.SystemForegroundService (has extras) }
04-06 14:40:35.581 19846  4745 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:40:35.582 19846  4745 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:40:35.688 19846  4745 D SensorReceiver: Nothing to update for server 1 (Home)
04-06 14:40:35.689 19846  4745 I SensorReceiver: Sensor updates and sync completed
04-06 14:40:35.690 19846 19919 I WM-WorkerWrapper: Worker result SUCCESS for Work [ id=25427287-1db1-4c1e-975f-3888d10d27f5, tags={ io.homeassistant.companion.android.sensors.SensorWorker } ]
04-06 14:40:35.699 19846 19846 I WM-SystemFgDispatcher: Stopping foreground service
04-06 14:40:39.958 19846 19846 D WebviewActivity: Launching browser
04-06 14:40:39.981 19846 19846 D IntegrationRepository: setAppActive(): false
04-06 14:40:39.981 19846 19846 D IntegrationRepository: setAppActive(): false
04-06 14:40:39.991 19846 19846 D SensorReceiver: Received intent: io.homeassistant.companion.android.UPDATE_SENSORS
04-06 14:40:39.993 19846  4745 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:40:40.136 19846  4745 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:40:40.137 19846  4745 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:40:40.309 19846  4745 D SensorReceiver: Nothing to update for server 1 (Home)
04-06 14:40:40.310 19846  4745 I SensorReceiver: Sensor updates and sync completed
04-06 14:40:40.777 19846 19846 V ActivityThread: handleTrimMemory:io.homeassistant.companion.android
04-06 14:40:40.917 19846 19846 D WebviewActivity: Matter/Thread step changed to MATTER_IN_PROGRESS
04-06 14:40:40.921 19846 19846 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:40:40.922 19846 19846 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:40:40.923 19846 19846 D IntegrationRepository: isAppLocked(): false. (LockEnabled: false, appActive: false, expireMillis: 0, currentMillis: 1712407240923)
04-06 14:40:40.933 19846 19860 I mpanion.android: CollectorTransition concurrent copying GC freed 108701(3846KB) AllocSpace objects, 4(208KB) LOS objects, 49% free, 12MB/25MB, paused 385us,85us total 179.564ms
04-06 14:40:41.017 19846 19898 E OpenGLRenderer: Unable to match the desired swap behavior.
04-06 14:40:41.035 19846  4745 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:40:41.041 19846 19891 I WM-WorkerWrapper: Worker result SUCCESS for Work [ id=8c2c452d-a6c2-46f6-b632-a68b35becf30, tags={ io.homeassistant.companion.android.websocket.WebsocketManager } ]
04-06 14:40:41.046 19846 19920 I WM-Processor: Moving WorkSpec (8ba394a6-4da7-4a81-be95-f609b3ad4db5) to the foreground
04-06 14:40:41.055 19846 19846 I WM-SystemFgDispatcher: Started foreground service Intent { act=ACTION_START_FOREGROUND cmp=io.homeassistant.companion.android/androidx.work.impl.foreground.SystemForegroundService (has extras) }
04-06 14:40:41.060 19846  4358 D SensorWorker: Updating all Sensors in foreground.
04-06 14:40:41.062 19846  4358 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:40:41.070 19846 19846 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:40:41.070 19846 19846 D IntegrationRepository: isAppLocked(): false. (LockEnabled: false, appActive: false, expireMillis: 0, currentMillis: 1712407241070)
04-06 14:40:41.074 19846 19846 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:40:41.074 19846 19846 D ServerConnectionInfo: Using external URL
04-06 14:40:41.076 19846 19846 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:40:41.076 19846 19846 D ServerConnectionInfo: Using external URL
04-06 14:40:41.219 19846 19884 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:40:41.221 19846 19884 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:40:41.362 19846 19884 D SensorReceiver: Nothing to update for server 1 (Home)
04-06 14:40:41.362 19846 19884 I SensorReceiver: Sensor updates and sync completed
04-06 14:40:41.363 19846 19891 I WM-WorkerWrapper: Worker result SUCCESS for Work [ id=8ba394a6-4da7-4a81-be95-f609b3ad4db5, tags={ io.homeassistant.companion.android.sensors.SensorWorker } ]
04-06 14:40:41.367 19846 19846 I WM-SystemFgDispatcher: Stopping foreground service
04-06 14:41:49.108 19846 19846 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:41:49.108 19846 19846 D ServerConnectionInfo: Using external URL
04-06 14:41:49.112 19846 19846 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:41:49.112 19846 19846 D ServerConnectionInfo: Using external URL
04-06 14:41:49.124 19846  7800 D TrafficStats: tagSocket(230) with statsTag=0xffffffff, statsUid=-1
04-06 14:43:00.489 19846  4361 D WebviewActivity: External bus {"type":"config_screen/show","id":15}
04-06 14:43:00.510 19846 19846 D IntegrationRepository: setAppActive(): false
04-06 14:43:00.511 19846 19846 D IntegrationRepository: setAppActive(): false
04-06 14:43:00.772 19846 19846 D IntegrationRepository: isAppLocked(): false. (LockEnabled: false, appActive: false, expireMillis: 0, currentMillis: 1712407380772)
04-06 14:43:00.785 19846 19846 D SensorReceiver: Received intent: io.homeassistant.companion.android.UPDATE_SENSORS
04-06 14:43:00.790 19846  4745 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:43:00.804 19846 19898 E OpenGLRenderer: Unable to match the desired swap behavior.
04-06 14:43:00.851 19846  4745 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:43:00.852 19846  4745 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:43:00.855 19846  7911 D TrafficStats: tagSocket(195) with statsTag=0xffffffff, statsUid=-1
04-06 14:43:00.895 19846 19898 W Parcel  : Expecting binder but got null!
04-06 14:43:00.899 19846  4358 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:43:00.906 19846  4745 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:43:00.925 19846  4745 I SensorReceiver: Sensor updates and sync completed
04-06 14:43:00.935 19846 19846 D SettingsWearDetection: API unavailable for discovering nodes (no Wear)
04-06 14:43:00.987 19846  7911 D TrafficStats: tagSocket(328) with statsTag=0xffffffff, statsUid=-1
04-06 14:43:01.025 19846 19846 D IntegrationRepository: isAppLocked(): false. (LockEnabled: false, appActive: false, expireMillis: 0, currentMillis: 1712407381025)
04-06 14:43:01.025 19846 19846 D IntegrationRepository: setAppActive(): true
04-06 14:43:18.454 19846  4358 D LogcatReader: Read logcat for pid 19846
04-06 14:43:18.512 19846  4358 D LogcatReader: Done reading logcat for pid 19846
04-06 14:44:08.450 19846 19846 D IntegrationRepository: setAppActive(): false
04-06 14:44:08.468 19846 19846 D WebviewActivity: Matter/Thread step changed to MATTER_IN_PROGRESS
04-06 14:44:08.471 19846 19846 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:44:08.472 19846 19846 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:44:08.473 19846 19846 D IntegrationRepository: isAppLocked(): false. (LockEnabled: false, appActive: false, expireMillis: 1712407449450, currentMillis: 1712407448473)
04-06 14:44:08.569 19846 19898 E OpenGLRenderer: Unable to match the desired swap behavior.
04-06 14:44:08.594 19846  4358 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:44:08.596 19846 19920 I WM-WorkerWrapper: Worker result SUCCESS for Work [ id=e95ba889-c8b0-47f2-a08e-8e6709937624, tags={ io.homeassistant.companion.android.websocket.WebsocketManager } ]
04-06 14:44:08.599 19846 19891 I WM-Processor: Moving WorkSpec (6a6bf39b-7db3-4513-a588-2506c1ff8ff0) to the foreground
04-06 14:44:08.606 19846  4358 D SensorWorker: Updating all Sensors in foreground.
04-06 14:44:08.607 19846  4358 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:44:08.623 19846 19846 I WM-SystemFgDispatcher: Started foreground service Intent { act=ACTION_START_FOREGROUND cmp=io.homeassistant.companion.android/androidx.work.impl.foreground.SystemForegroundService (has extras) }
04-06 14:44:08.661 19846  4358 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:44:08.662 19846  4358 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:44:08.670 19846 19846 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:44:08.670 19846 19846 D IntegrationRepository: isAppLocked(): false. (LockEnabled: false, appActive: false, expireMillis: 1712407449450, currentMillis: 1712407448670)
04-06 14:44:08.673 19846 19846 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:44:08.673 19846 19846 D ServerConnectionInfo: Using external URL
04-06 14:44:08.674 19846 19846 D ServerConnectionInfo: localUrl is: false, usesInternalSsid is: false, usesWifi is: true
04-06 14:44:08.674 19846 19846 D ServerConnectionInfo: Using external URL

Screenshot or video of problem:

ha-bug

Additional information:
@barrelful barrelful added the bug Something isn't working label Apr 6, 2024
@jpelgrom
Copy link
Member

jpelgrom commented Apr 6, 2024

This part of the Matter commissioning flow is handled by Google, including the error message, so there's not a lot HA can do here. That also means the app's log isn't of much use.

Does it work correctly if you choose the option to manually enter the pairing code?

Do you know if this previously worked, or is this your first time trying? If this is the first time: can you try leaving the device plugged in for a few hours, and try again? If the error is because Google Play Services is missing something for Matter commissioning, that'll force it to download whatever it is.

@jpelgrom jpelgrom added the question Further information is requested label Apr 8, 2024
@jpelgrom
Copy link
Member

jpelgrom commented May 6, 2024

Closing due to lack of response / error cannot be solved by the app

@jpelgrom jpelgrom closed this as not planned Won't fix, can't repro, duplicate, stale May 6, 2024
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
bug Something isn't working question Further information is requested
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
2 participants
@jpelgrom @barrelful