AndroidTV Binding [3.2.0;4.2.0)

I have a DirecTV Stream Box C71KW-400. I thought I would see if I could connect to it through this binding. I’m running openHAB 3.4.2 on a Pi 4B running openhabian. I installed the binding from the Marketplace. I tried to add a Thing. I click on Scan, but nothing every shows up in the inbox. The Pi and the box are on the same network.

After reading through this thread, I restarted openhab, and it found the device.
I tried sending the REFRESH to the PIN CODE channel, and nothing happened. I rebooted the Pi and tried again. The PIN Code appeared on the screen and I sent it to the same channel.

The Thing is now online. I will play with it and follow it and see what I learn. From what I have read above, there are potential issues with the DirecTV Stream boxes.

I’m glad to hear it’s working. We have had some issues reported where the DirecTV boxes go offline randomly that we aren’t 100% sure of the root cause. Otherwise they do seem to be working well. Glad to hear you had success so far!

My luck ran out.
I believe it was after a restart of openHAB for an unrelated issue, but regardless, the Thing was Offline and reported the the PIN process was incomplete. I tried cycling the Thing off and back on, but it wouldn’t change. I ended up deleting the Thing and creating a new one. But now I am unable to complete the PIN process. I have tried restarting the DirecTV Stream device, and rebooting the openHAB Pi.

Here is some TRACE level logging of the binding:

2023-05-09 11:55:45.334 [TRACE] [tocol.googletv.GoogleTVMessageParser] - 44E4EED40B56 - Received GoogleTV message - Length: 9 Message: 4207089001109eff2e
2023-05-09 11:55:45.334 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Canceling GoogleTV scheduled reconnect job.
2023-05-09 11:55:45.335 [DEBUG] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Sending GoogleTV keepalive - request 4207089001109eff2e - response 4a03089001
2023-05-09 11:55:45.336 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Raw GoogleTV command decodes as: 054a03089001
2023-05-09 11:55:45.336 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Scheduling Reconnect Job for 30
2023-05-09 11:55:45.787 [DEBUG] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Device Health - Online: true - Logged In: true
2023-05-09 11:55:50.349 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - readerThreadJob message length 9
2023-05-09 11:55:50.351 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - GoogleTV Message: 9 09420708910110b9a62f
2023-05-09 11:55:50.352 [TRACE] [tocol.googletv.GoogleTVMessageParser] - 44E4EED40B56 - Received GoogleTV message - Length: 9 Message: 420708910110b9a62f
2023-05-09 11:55:50.353 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Canceling GoogleTV scheduled reconnect job.
2023-05-09 11:55:50.354 [DEBUG] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Sending GoogleTV keepalive - request 420708910110b9a62f - response 4a03089101
2023-05-09 11:55:50.356 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Raw GoogleTV command decodes as: 054a03089101
2023-05-09 11:55:50.356 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Scheduling Reconnect Job for 30
2023-05-09 11:55:50.788 [DEBUG] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Device Health - Online: true - Logged In: true
2023-05-09 11:55:55.369 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - readerThreadJob message length 9
2023-05-09 11:55:55.372 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - GoogleTV Message: 9 09420708920110d4cd2f
2023-05-09 11:55:55.373 [TRACE] [tocol.googletv.GoogleTVMessageParser] - 44E4EED40B56 - Received GoogleTV message - Length: 9 Message: 420708920110d4cd2f
2023-05-09 11:55:55.375 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Canceling GoogleTV scheduled reconnect job.
2023-05-09 11:55:55.377 [DEBUG] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Sending GoogleTV keepalive - request 420708920110d4cd2f - response 4a03089201
2023-05-09 11:55:55.378 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Scheduling Reconnect Job for 30
2023-05-09 11:55:55.378 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Raw GoogleTV command decodes as: 054a03089201
2023-05-09 11:55:55.790 [DEBUG] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Device Health - Online: true - Logged In: true
2023-05-09 11:55:56.182 [DEBUG] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Command received: pincode
2023-05-09 11:55:56.183 [DEBUG] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Child Connection Manager unavailable.
2023-05-09 11:56:00.392 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - readerThreadJob message length 9
2023-05-09 11:56:00.395 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - GoogleTV Message: 9 09420708930110f4f42f
2023-05-09 11:56:00.395 [TRACE] [tocol.googletv.GoogleTVMessageParser] - 44E4EED40B56 - Received GoogleTV message - Length: 9 Message: 420708930110f4f42f
2023-05-09 11:56:00.396 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Canceling GoogleTV scheduled reconnect job.
2023-05-09 11:56:00.397 [DEBUG] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Sending GoogleTV keepalive - request 420708930110f4f42f - response 4a03089301
2023-05-09 11:56:00.398 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Scheduling Reconnect Job for 30
2023-05-09 11:56:00.398 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Raw GoogleTV command decodes as: 054a03089301
2023-05-09 11:56:01.743 [DEBUG] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Device Health - Online: true - Logged In: true
2023-05-09 11:56:05.412 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - readerThreadJob message length 9
2023-05-09 11:56:05.413 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - GoogleTV Message: 9 094207089401108e9c30
2023-05-09 11:56:05.414 [TRACE] [tocol.googletv.GoogleTVMessageParser] - 44E4EED40B56 - Received GoogleTV message - Length: 9 Message: 4207089401108e9c30
2023-05-09 11:56:05.415 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Canceling GoogleTV scheduled reconnect job.
2023-05-09 11:56:05.416 [DEBUG] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Sending GoogleTV keepalive - request 4207089401108e9c30 - response 4a03089401
2023-05-09 11:56:05.417 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Raw GoogleTV command decodes as: 054a03089401
2023-05-09 11:56:05.417 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Scheduling Reconnect Job for 30
2023-05-09 11:56:07.571 [DEBUG] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Device Health - Online: true - Logged In: true
2023-05-09 11:56:10.773 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - readerThreadJob message length 9
2023-05-09 11:56:10.775 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - GoogleTV Message: 9 09420708950110a6c330
2023-05-09 11:56:10.778 [TRACE] [tocol.googletv.GoogleTVMessageParser] - 44E4EED40B56 - Received GoogleTV message - Length: 9 Message: 420708950110a6c330
2023-05-09 11:56:10.779 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Canceling GoogleTV scheduled reconnect job.
2023-05-09 11:56:10.781 [DEBUG] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Sending GoogleTV keepalive - request 420708950110a6c330 - response 4a03089501
2023-05-09 11:56:10.782 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Raw GoogleTV command decodes as: 054a03089501
2023-05-09 11:56:10.782 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Scheduling Reconnect Job for 30
2023-05-09 11:56:12.577 [DEBUG] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Device Health - Online: true - Logged In: true
2023-05-09 11:56:15.796 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - readerThreadJob message length 9
2023-05-09 11:56:15.798 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - GoogleTV Message: 9 094207089601109fed30
2023-05-09 11:56:15.799 [TRACE] [tocol.googletv.GoogleTVMessageParser] - 44E4EED40B56 - Received GoogleTV message - Length: 9 Message: 4207089601109fed30
2023-05-09 11:56:15.800 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Canceling GoogleTV scheduled reconnect job.
2023-05-09 11:56:15.802 [DEBUG] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Sending GoogleTV keepalive - request 4207089601109fed30 - response 4a03089601
2023-05-09 11:56:15.803 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Raw GoogleTV command decodes as: 054a03089601
2023-05-09 11:56:15.803 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Scheduling Reconnect Job for 30
2023-05-09 11:56:17.578 [DEBUG] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Device Health - Online: true - Logged In: true
2023-05-09 11:56:20.816 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - readerThreadJob message length 9
2023-05-09 11:56:20.818 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - GoogleTV Message: 9 09420708970110bb9431
2023-05-09 11:56:20.819 [TRACE] [tocol.googletv.GoogleTVMessageParser] - 44E4EED40B56 - Received GoogleTV message - Length: 9 Message: 420708970110bb9431
2023-05-09 11:56:20.821 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Canceling GoogleTV scheduled reconnect job.
2023-05-09 11:56:20.822 [DEBUG] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Sending GoogleTV keepalive - request 420708970110bb9431 - response 4a03089701
2023-05-09 11:56:20.824 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Raw GoogleTV command decodes as: 054a03089701
2023-05-09 11:56:20.824 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Scheduling Reconnect Job for 30
2023-05-09 11:56:22.024 [DEBUG] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS discovery notified of GoogleTV mDNS service: \024bt=44:E4:EE:D4:0B:56
2023-05-09 11:56:22.024 [DEBUG] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS discovery notified of GoogleTV mDNS service: \024bt=44:E4:EE:D4:0B:56
2023-05-09 11:56:22.026 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service qualifiedName: Family Room._androidtvremote2._tcp.local.
2023-05-09 11:56:22.026 [DEBUG] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS discovery notified of GoogleTV mDNS service: \024bt=44:E4:EE:D4:0B:56
2023-05-09 11:56:22.026 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service qualifiedName: Family Room._androidtvremote2._tcp.local.
2023-05-09 11:56:22.027 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service qualifiedName: Family Room._androidtvremote2._tcp.local.
2023-05-09 11:56:22.027 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service ipAddresses: [/192.168.1.134] (1)
2023-05-09 11:56:22.027 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service ipAddresses: [/192.168.1.134] (1)
2023-05-09 11:56:22.029 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service selected ipAddress: 192.168.1.134
2023-05-09 11:56:22.029 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service selected ipAddress: 192.168.1.134
2023-05-09 11:56:22.029 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service ipAddresses: [/192.168.1.134] (1)
2023-05-09 11:56:22.030 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service property macAddress: 44:E4:EE:D4:0B:56
2023-05-09 11:56:22.030 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service selected ipAddress: 192.168.1.134
2023-05-09 11:56:22.030 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service property macAddress: 44:E4:EE:D4:0B:56
2023-05-09 11:56:22.031 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service property macAddress: 44:E4:EE:D4:0B:56
2023-05-09 11:56:22.050 [DEBUG] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS discovery notified of GoogleTV mDNS service: \024bt=44:E4:EE:D4:0B:56
2023-05-09 11:56:22.051 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service qualifiedName: Family Room._androidtvremote2._tcp.local.
2023-05-09 11:56:22.052 [DEBUG] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS discovery notified of GoogleTV mDNS service: \024bt=44:E4:EE:D4:0B:56
2023-05-09 11:56:22.052 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service ipAddresses: [/192.168.1.134] (1)
2023-05-09 11:56:22.053 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service qualifiedName: Family Room._androidtvremote2._tcp.local.
2023-05-09 11:56:22.053 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service selected ipAddress: 192.168.1.134
2023-05-09 11:56:22.054 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service property macAddress: 44:E4:EE:D4:0B:56
2023-05-09 11:56:22.054 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service ipAddresses: [/192.168.1.134] (1)
2023-05-09 11:56:22.054 [DEBUG] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS discovery notified of GoogleTV mDNS service: \024bt=44:E4:EE:D4:0B:56
2023-05-09 11:56:22.055 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service selected ipAddress: 192.168.1.134
2023-05-09 11:56:22.055 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service qualifiedName: Family Room._androidtvremote2._tcp.local.
2023-05-09 11:56:22.057 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service property macAddress: 44:E4:EE:D4:0B:56
2023-05-09 11:56:22.057 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service ipAddresses: [/192.168.1.134] (1)
2023-05-09 11:56:22.059 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service selected ipAddress: 192.168.1.134
2023-05-09 11:56:22.060 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service property macAddress: 44:E4:EE:D4:0B:56
2023-05-09 11:56:22.580 [DEBUG] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Device Health - Online: true - Logged In: true
2023-05-09 11:56:25.551 [DEBUG] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS discovery notified of GoogleTV mDNS service: \024bt=44:E4:EE:D4:0B:56
2023-05-09 11:56:25.552 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service qualifiedName: Family Room._androidtvremote2._tcp.local.
2023-05-09 11:56:25.553 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service ipAddresses: [/192.168.1.134] (1)
2023-05-09 11:56:25.557 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service selected ipAddress: 192.168.1.134
2023-05-09 11:56:25.558 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service property macAddress: 44:E4:EE:D4:0B:56
2023-05-09 11:56:25.565 [DEBUG] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS discovery notified of GoogleTV mDNS service: \024bt=44:E4:EE:D4:0B:56
2023-05-09 11:56:25.565 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service qualifiedName: Family Room._androidtvremote2._tcp.local.
2023-05-09 11:56:25.567 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service ipAddresses: [/192.168.1.134] (1)
2023-05-09 11:56:25.568 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service selected ipAddress: 192.168.1.134
2023-05-09 11:56:25.569 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service property macAddress: 44:E4:EE:D4:0B:56
2023-05-09 11:56:25.837 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - readerThreadJob message length 9
2023-05-09 11:56:25.839 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - GoogleTV Message: 9 09420708980110d8bb31
2023-05-09 11:56:25.840 [TRACE] [tocol.googletv.GoogleTVMessageParser] - 44E4EED40B56 - Received GoogleTV message - Length: 9 Message: 420708980110d8bb31
2023-05-09 11:56:25.841 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Canceling GoogleTV scheduled reconnect job.
2023-05-09 11:56:25.843 [DEBUG] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Sending GoogleTV keepalive - request 420708980110d8bb31 - response 4a03089801
2023-05-09 11:56:25.844 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Scheduling Reconnect Job for 30
2023-05-09 11:56:25.844 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Raw GoogleTV command decodes as: 054a03089801
2023-05-09 11:56:27.945 [DEBUG] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Device Health - Online: true - Logged In: true
2023-05-09 11:56:32.094 [DEBUG] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS discovery notified of GoogleTV mDNS service: \024bt=44:E4:EE:D4:0B:56
2023-05-09 11:56:32.095 [DEBUG] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS discovery notified of GoogleTV mDNS service: \024bt=44:E4:EE:D4:0B:56
2023-05-09 11:56:32.095 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service qualifiedName: Family Room._androidtvremote2._tcp.local.
2023-05-09 11:56:32.096 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service qualifiedName: Family Room._androidtvremote2._tcp.local.
2023-05-09 11:56:32.096 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service ipAddresses: [/192.168.1.134] (1)
2023-05-09 11:56:32.096 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service ipAddresses: [/192.168.1.134] (1)
2023-05-09 11:56:32.097 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service selected ipAddress: 192.168.1.134
2023-05-09 11:56:32.097 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service selected ipAddress: 192.168.1.134
2023-05-09 11:56:32.098 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service property macAddress: 44:E4:EE:D4:0B:56
2023-05-09 11:56:32.099 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service property macAddress: 44:E4:EE:D4:0B:56
2023-05-09 11:56:32.100 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - readerThreadJob message length 9
2023-05-09 11:56:32.101 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - GoogleTV Message: 9 09420708990110f4e231
2023-05-09 11:56:32.102 [TRACE] [tocol.googletv.GoogleTVMessageParser] - 44E4EED40B56 - Received GoogleTV message - Length: 9 Message: 420708990110f4e231
2023-05-09 11:56:32.102 [DEBUG] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS discovery notified of GoogleTV mDNS service: \024bt=44:E4:EE:D4:0B:56
2023-05-09 11:56:32.103 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Canceling GoogleTV scheduled reconnect job.
2023-05-09 11:56:32.103 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service qualifiedName: Family Room._androidtvremote2._tcp.local.
2023-05-09 11:56:32.104 [DEBUG] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS discovery notified of GoogleTV mDNS service: \024bt=44:E4:EE:D4:0B:56
2023-05-09 11:56:32.105 [DEBUG] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Sending GoogleTV keepalive - request 420708990110f4e231 - response 4a03089901
2023-05-09 11:56:32.105 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service ipAddresses: [/192.168.1.134] (1)
2023-05-09 11:56:32.105 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service qualifiedName: Family Room._androidtvremote2._tcp.local.
2023-05-09 11:56:32.105 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Scheduling Reconnect Job for 30
2023-05-09 11:56:32.105 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service ipAddresses: [/192.168.1.134] (1)
2023-05-09 11:56:32.105 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Raw GoogleTV command decodes as: 054a03089901
2023-05-09 11:56:32.106 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service selected ipAddress: 192.168.1.134
2023-05-09 11:56:32.106 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service selected ipAddress: 192.168.1.134
2023-05-09 11:56:32.106 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service property macAddress: 44:E4:EE:D4:0B:56
2023-05-09 11:56:32.107 [TRACE] [scovery.GoogleTVDiscoveryParticipant] - GoogleTV mDNS service property macAddress: 44:E4:EE:D4:0B:56
2023-05-09 11:56:32.946 [DEBUG] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Device Health - Online: true - Logged In: true
2023-05-09 11:56:37.117 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - readerThreadJob message length 9
2023-05-09 11:56:37.118 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - GoogleTV Message: 9 094207089a0110e89332
2023-05-09 11:56:37.119 [TRACE] [tocol.googletv.GoogleTVMessageParser] - 44E4EED40B56 - Received GoogleTV message - Length: 9 Message: 4207089a0110e89332
2023-05-09 11:56:37.121 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Canceling GoogleTV scheduled reconnect job.
2023-05-09 11:56:37.122 [DEBUG] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Sending GoogleTV keepalive - request 4207089a0110e89332 - response 4a03089a01
2023-05-09 11:56:37.123 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Scheduling Reconnect Job for 30
2023-05-09 11:56:37.123 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Raw GoogleTV command decodes as: 054a03089a01
2023-05-09 11:56:37.947 [DEBUG] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Device Health - Online: true - Logged In: true
2023-05-09 11:56:42.138 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - readerThreadJob message length 9
2023-05-09 11:56:42.140 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - GoogleTV Message: 9 094207089b011082bb32
2023-05-09 11:56:42.141 [TRACE] [tocol.googletv.GoogleTVMessageParser] - 44E4EED40B56 - Received GoogleTV message - Length: 9 Message: 4207089b011082bb32
2023-05-09 11:56:42.142 [TRACE] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Canceling GoogleTV scheduled reconnect job.
2023-05-0

The only thing that jumped out at me is the

2023-05-09 11:55:56.183 [DEBUG] [l.googletv.GoogleTVConnectionManager] - 44E4EED40B56 - Child Connection Manager unavailable.

Not sure what that is, but sounds like something that might be needed.
Anything I can do to help troubleshoot this, I’m happy to do.

Any ideas?

So good news is, I don’t think you actually have to redo the PIN process. Where you see:

Notice it says Logged In: true. This means that PIN should be good. I’m confused that you have the thing offline if that says true. What is the thing status message being produced?

You are correct. I never tested any commands. I just ASSUMED I would have to do a PIN process with the new Thing. But it works. Sorry for the confusion.

Not sure why I had to create a new Thing in the first place, but I definitely should have tested it.

Not sure why you had to create a new thing either. The reason you didn’t have to do the PIN again is because we don’t regenerate the certificates unless they are actually missing. Otherwise they are stored in the userdata folder. Once the certificate is accepted by the device, it’s reused indefinitely (as long as the thing maintains the same name), unless the certificate is deleted. The moment that we get a successful login the PIN functions are locked out to prevent issues.

If it happens again, please grab a trace log and DM it to me and I can see where it’s failing. Those DirecTV boxes seem to be a headache for no real reason we can find yet.

Has anyone made a widget remote for this?

I’ve not heard of a specific one.

Universal Remote Widget or Harmony Hub Remote should work.

1 Like

This is working well for me.
I started with the key press Item/channel, but changed to using key code, which let me use more commands.

hi! i try to connect my googletv, but no success. bindind version 0.10.1 (a777e94) from marketplace. OH 3.2.0
after pin paring. debug log:
12:05:44.692 [DEBUG] [l.googletv.GoogleTVConnectionManager] - AABBCCDDEEFF - Opening GoogleTV SSL connection to 192.168.1.24:6466
12:05:44.798 [DEBUG] [l.googletv.GoogleTVConnectionManager] - Assuming server certificate is valid
12:05:44.799 [DEBUG] [l.googletv.GoogleTVConnectionManager] - Returning empty certificate for getAcceptedIssuers
12:05:44.827 [DEBUG] [l.googletv.GoogleTVConnectionManager] - AABBCCDDEEFF - Message reader thread started 6466
12:05:44.827 [DEBUG] [l.googletv.GoogleTVConnectionManager] - AABBCCDDEEFF - Command sender thread started 6466
12:05:44.833 [DEBUG] [tocol.googletv.GoogleTVMessageParser] - AABBCCDDEEFF - “SWTV-20AE” “skyworth” 10 com.google.android.tv.remote.service 5.2.473254133
12:05:44.840 [WARN ] [tocol.googletv.GoogleTVMessageParser] - AABBCCDDEEFF - GoogleTV Error Message: 1a47080312430a41087e123d0a08534d2d4739393855120773616d73756e671801220231332a19636f6d2e676f6f676c652e616e64726f69642e766964656f733207342e33382e3138
12:05:44.842 [DEBUG] [l.googletv.GoogleTVConnectionManager] - AABBCCDDEEFF - readerThreadJob received ffffffff. Disconnecting hard.
12:05:44.843 [DEBUG] [l.googletv.GoogleTVConnectionManager] - AABBCCDDEEFF - Attempting to reconnect to the GoogleTV
12:05:44.845 [DEBUG] [l.googletv.GoogleTVConnectionManager] - AABBCCDDEEFF - Disconnecting GoogleTV
12:05:44.847 [DEBUG] [l.googletv.GoogleTVConnectionManager] - AABBCCDDEEFF - Command sender thread exiting 6466
12:05:44.854 [DEBUG] [l.googletv.GoogleTVConnectionManager] - AABBCCDDEEFF - Opening GoogleTV SSL connection to 192.168.1.24:6466
12:05:44.927 [DEBUG] [l.googletv.GoogleTVConnectionManager] - Assuming server certificate is valid

and all repeat again…

what can i do to resolve the problem?

What kind of device is this that you are connecting to?

The error message you are getting:

Seems to indicate that it’s rejecting the login. The good news is, the fact that you’re getting that far means that PIN was successful. If it wasn’t, you wouldn’t even be allowed to connect and send the login message. We’ve seen this on a few random occasions and are not sure why it happens. Have you tried to power cycle your device or restart openhab?

yes, i have tried to reboot OH and TV, nothing changes

my device is skyworth tv - its Android TV 10.0
http://www.skyworth.net/global/android-tv.html

is it possible to see connection log on TV side? may be it will help debug why TV rejecting the login

If you would like to put the binding into trace and send the longer log to me via DM you are welcome to. We have seen this error message a few times before and it usually clears out as things are rebooted. You can also try to remove the thing, delete the files in userdata/androidtv/ (these are the certificates that were accepted during PIN), and recreate the thing, and redo the PIN process.

i tried remove/install binding, things, rebooted all. nothing new. switched log to trace

log is too big, where can i send it to you?

You should be able to put it in a text file and attach to a DM

I sent you a DM so you could reply to it.

Hello. First of all thanks for providing this!

I am having trouble, though, initially connecting to the TV. I wired the Pin channel to a new String-item “PIN” and then used this command in the console:

openhab:send PIN REQUEST

Although Openhab tells me that the command was successfully sent, nothing appears on the TV screen. Do I have to install anything on the TV, too? (GoogleTV is installed, I checked, and auto-discovery also worked.)

That should work. What kind of device is it? What does your log look like? What is the current status of the thing?

Hi there. The Thing shows “OFFLINE” - GoogleTV: PIN Process Incomplete". The device is a current Philipps Smart-TV, Model 65OLED707.

And here’s an excerpt of the log (through the log view on port 9001):

2023-05-23 14:54:19.345 [DEBUG] [e.osgi.LoggingCommandSessionListener] - Executing command: ‘openhab:send PIN REQUEST’

==> /var/log/openhab/events.log <==

2023-05-23 14:54:19.352 [INFO ] [openhab.event.ItemCommandEvent ] - Item ‘PIN’ received command REQUEST

==> /var/log/openhab/openhab.log <==

2023-05-23 14:54:19.358 [DEBUG] [e.osgi.LoggingCommandSessionListener] - Command: ‘openhab:send PIN REQUEST’ returned ‘null’

==> /var/log/openhab/events.log <==

2023-05-23 14:54:19.361 [INFO ] [penhab.event.ItemStatePredictedEvent] - Item ‘PIN’ predicted to become REQUEST

==> /var/log/openhab/openhab.log <==

2023-05-23 14:54:19.374 [DEBUG] [e.jetty.util.thread.QueuedThreadPool] - queue org.eclipse.jetty.server.AsyncContextState$1@3c0a496d startThread=0

2023-05-23 14:54:19.374 [DEBUG] [e.jetty.util.thread.QueuedThreadPool] - run org.eclipse.jetty.server.AsyncContextState$1@3c0a496d in QueuedThreadPool[qtp2096389068]@7cf45bcc{STARTED,2<=14<=50,i=3,r=-1,q=0}[ReservedThreadExecutor@76061b20{reserved=4/4,pending=0}]

2023-05-23 14:54:19.375 [DEBUG] [org.eclipse.jetty.server.HttpOutput ] - write(array HeapByteBuffer@7e7dae51[p=0,l=7,c=7,r=7]={<<<event: >>>})

2023-05-23 14:54:19.375 [DEBUG] [org.eclipse.jetty.server.HttpOutput ] - write(array) s=OPEN,api=BLOCKING,sc=false,e=null aggregated !flush DirectByteBuffer@5286e07b[p=0,l=7,c=32768,r=7]={<<<event: >>>alive\ndat…\x00\x00\x00\x00\x00\x00\x00}

2023-05-23 14:54:19.375 [DEBUG] [org.eclipse.jetty.server.HttpOutput ] - write(array HeapByteBuffer@1e4bd5d4[p=0,l=7,c=7,r=7]={<<>>})

2023-05-23 14:54:19.376 [DEBUG] [org.eclipse.jetty.server.HttpOutput ] - write(array) s=OPEN,api=BLOCKING,sc=false,e=null aggregated !flush DirectByteBuffer@5286e07b[p=0,l=14,c=32768,r=14]={<<<event: message>>>ata: {"ty…\x00\x00\x00\x00\x00\x00\x00}

2023-05-23 14:54:19.376 [DEBUG] [org.eclipse.jetty.server.HttpOutput ] - write(array HeapByteBuffer@efd88d7[p=0,l=1,c=1,r=1]={<<<\n>>>})

2023-05-23 14:54:19.376 [DEBUG] [org.eclipse.jetty.server.HttpOutput ] - write(array) s=OPEN,api=BLOCKING,sc=false,e=null aggregated !flush DirectByteBuffer@5286e07b[p=0,l=15,c=32768,r=15]={<<<event: message\n>>>ta: {"typ…\x00\x00\x00\x00\x00\x00\x00}

2023-05-23 14:54:19.376 [DEBUG] [org.eclipse.jetty.server.HttpOutput ] - write(array HeapByteBuffer@18861e0c[p=0,l=6,c=6,r=6]={<<<data: >>>})

2023-05-23 14:54:19.377 [DEBUG] [org.eclipse.jetty.server.HttpOutput ] - write(array) s=OPEN,api=BLOCKING,sc=false,e=null aggregated !flush DirectByteBuffer@5286e07b[p=0,l=21,c=32768,r=21]={<<<event: message\ndata: >>>type":"AL…\x00\x00\x00\x00\x00\x00\x00}

2023-05-23 14:54:19.377 [DEBUG] [org.eclipse.jetty.server.HttpOutput ] - write(array HeapByteBuffer@b1a246b[p=0,l=201,c=201,r=201]={<<<{“topic”:"openhab/things/…“ThingStatusInfoEvent”}>>>})

2023-05-23 14:54:19.377 [DEBUG] [org.eclipse.jetty.server.HttpOutput ] - write(array) s=OPEN,api=BLOCKING,sc=false,e=null aggregated !flush DirectByteBuffer@5286e07b[p=0,l=222,c=32768,r=222]={<<<event: message\ndata: {“to…“ThingStatusInfoEvent”}>>>el”:"Key …\x00\x00\x00\x00\x00\x00\x00}

2023-05-23 14:54:19.377 [DEBUG] [org.eclipse.jetty.server.HttpChannel] - sendResponse info=null content=DirectByteBuffer@5286e07b[p=0,l=222,c=32768,r=222]={<<<event: message\ndata: {“to…“ThingStatusInfoEvent”}>>>el”:"Key …\x00\x00\x00\x00\x00\x00\x00} complete=false committing=false callback=Blocker@f2c1472{null}

2023-05-23 14:54:19.378 [DEBUG] [.eclipse.jetty.server.HttpConnection] - generate: NEED_CHUNK for SendCallback@802f731[PROCESSING][i=null,cb=org.eclipse.jetty.server.HttpChannel$SendCallback@4bbfb5a9] (null,[p=0,l=222,c=32768,r=222],false)@COMMITTED

2023-05-23 14:54:19.378 [DEBUG] [.eclipse.jetty.server.HttpConnection] - generate: FLUSH for SendCallback@802f731[PROCESSING][i=null,cb=org.eclipse.jetty.server.HttpChannel$SendCallback@4bbfb5a9] (null,[p=0,l=222,c=32768,r=222],false)@COMMITTED

2023-05-23 14:54:19.378 [DEBUG] [org.eclipse.jetty.io.WriteFlusher ] - write: WriteFlusher@48d38625{IDLE}->null [HeapByteBuffer@6a974b18[p=0,l=6,c=1024,r=6]={<<<\r\nDE\r\n>>>\n\x00\x00\x00\x00\x00\x00\x00\x00…\x00\x00\x00\x00\x00\x00\x00},DirectByteBuffer@5286e07b[p=0,l=222,c=32768,r=222]={<<<event: message\ndata: {“to…“ThingStatusInfoEvent”}>>>el”:"Key …\x00\x00\x00\x00\x00\x00\x00}]

2023-05-23 14:54:19.379 [DEBUG] [org.eclipse.jetty.io.WriteFlusher ] - update WriteFlusher@48d38625{WRITING}->null:IDLE–>WRITING

2023-05-23 14:54:19.379 [DEBUG] [org.eclipse.jetty.io.ChannelEndPoint] - flushed 228 SocketChannelEndPoint@26950ce{l=/192.168.178.100:80,r=/192.168.178.31:56400,OPEN,fill=-,flush=W,to=312/30000}{io=0/0,kio=0,kro=1}->HttpConnection@44b67349[p=HttpParser{s=CONTENT,0 of -1},g=HttpGenerator@497ba4f4{s=COMMITTED}]=>HttpChannelOverHttp@61876f9{s=HttpChannelState@1c1bc5f{s=WAITING rs=ASYNC os=COMMITTED is=IDLE awp=false se=false i=false al=2},r=1,c=false/false,a=WAITING,uri=//server/rest/events?topics=openhab/things//,openhab/links//,age=207224}

2023-05-23 14:54:19.379 [DEBUG] [org.eclipse.jetty.io.WriteFlusher ] - Flushed=true written=228 remaining=0 WriteFlusher@48d38625{WRITING}->null

2023-05-23 14:54:19.380 [DEBUG] [org.eclipse.jetty.io.WriteFlusher ] - update WriteFlusher@48d38625{IDLE}->null:WRITING–>IDLE

2023-05-23 14:54:19.380 [DEBUG] [.eclipse.jetty.server.HttpConnection] - generate: DONE for SendCallback@802f731[PROCESSING][i=null,cb=org.eclipse.jetty.server.HttpChannel$SendCallback@4bbfb5a9] (null,[p=222,l=222,c=32768,r=0],false)@COMMITTED

2023-05-23 14:54:19.380 [DEBUG] [org.eclipse.jetty.server.HttpOutput ] - onWriteComplete(false,null) s=OPEN,api=BLOCKED,sc=false,e=null->s=OPEN,api=BLOCKING,sc=false,e=null c=null cb=null w=false

2023-05-23 14:54:19.380 [DEBUG] [org.eclipse.jetty.server.HttpOutput ] - write(array HeapByteBuffer@29e63739[p=0,l=1,c=1,r=1]={<<<\n>>>})

2023-05-23 14:54:19.380 [DEBUG] [org.eclipse.jetty.server.HttpOutput ] - write(array) s=OPEN,api=BLOCKING,sc=false,e=null aggregated !flush DirectByteBuffer@5286e07b[p=0,l=1,c=32768,r=1]={<<<\n>>>vent: mes…\x00\x00\x00\x00\x00\x00\x00}

2023-05-23 14:54:19.381 [DEBUG] [org.eclipse.jetty.server.HttpOutput ] - write(array HeapByteBuffer@1382a77[p=0,l=1,c=1,r=1]={<<<\n>>>})

2023-05-23 14:54:19.381 [DEBUG] [org.eclipse.jetty.server.HttpOutput ] - write(array) s=OPEN,api=BLOCKING,sc=false,e=null aggregated !flush DirectByteBuffer@5286e07b[p=0,l=2,c=32768,r=2]={<<<\n\n>>>ent: mess…\x00\x00\x00\x00\x00\x00\x00}

2023-05-23 14:54:19.381 [DEBUG] [org.eclipse.jetty.server.HttpChannel] - sendResponse info=null content=DirectByteBuffer@5286e07b[p=0,l=2,c=32768,r=2]={<<<\n\n>>>ent: mess…\x00\x00\x00\x00\x00\x00\x00} complete=false committing=false callback=Blocker@f2c1472{null}

2023-05-23 14:54:19.381 [DEBUG] [.eclipse.jetty.server.HttpConnection] - generate: NEED_CHUNK for SendCallback@802f731[PROCESSING][i=null,cb=org.eclipse.jetty.server.HttpChannel$SendCallback@5bdb6f47] (null,[p=0,l=2,c=32768,r=2],false)@COMMITTED

2023-05-23 14:54:19.382 [DEBUG] [.eclipse.jetty.server.HttpConnection] - generate: FLUSH for SendCallback@802f731[PROCESSING][i=null,cb=org.eclipse.jetty.server.HttpChannel$SendCallback@5bdb6f47] (null,[p=0,l=2,c=32768,r=2],false)@COMMITTED

2023-05-23 14:54:19.382 [DEBUG] [org.eclipse.jetty.io.WriteFlusher ] - write: WriteFlusher@48d38625{IDLE}->null [HeapByteBuffer@1eb15000[p=0,l=5,c=1024,r=5]={<<<\r\n2\r\n>>>\n\n\x00\x00\x00\x00\x00\x00\x00…\x00\x00\x00\x00\x00\x00\x00},DirectByteBuffer@5286e07b[p=0,l=2,c=32768,r=2]={<<<\n\n>>>ent: mess…\x00\x00\x00\x00\x00\x00\x00}]

2023-05-23 14:54:19.382 [DEBUG] [org.eclipse.jetty.io.WriteFlusher ] - update WriteFlusher@48d38625{WRITING}->null:IDLE–>WRITING

2023-05-23 14:54:19.382 [DEBUG] [org.eclipse.jetty.io.ChannelEndPoint] - flushed 7 SocketChannelEndPoint@26950ce{l=/192.168.178.100:80,r=/192.168.178.31:56400,OPEN,fill=-,flush=W,to=3/30000}{io=0/0,kio=0,kro=1}->HttpConnection@44b67349[p=HttpParser{s=CONTENT,0 of -1},g=HttpGenerator@497ba4f4{s=COMMITTED}]=>HttpChannelOverHttp@61876f9{s=HttpChannelState@1c1bc5f{s=WAITING rs=ASYNC os=COMMITTED is=IDLE awp=false se=false i=false al=2},r=1,c=false/false,a=WAITING,uri=//server/rest/events?topics=openhab/things//,openhab/links//,age=207227}

2023-05-23 14:54:19.383 [DEBUG] [org.eclipse.jetty.io.WriteFlusher ] - Flushed=true written=7 remaining=0 WriteFlusher@48d38625{WRITING}->null

2023-05-23 14:54:19.383 [DEBUG] [org.eclipse.jetty.io.WriteFlusher ] - update WriteFlusher@48d38625{IDLE}->null:WRITING–>IDLE

2023-05-23 14:54:19.383 [DEBUG] [.eclipse.jetty.server.HttpConnection] - generate: DONE for SendCallback@802f731[PROCESSING][i=null,cb=org.eclipse.jetty.server.HttpChannel$SendCallback@5bdb6f47] (null,[p=2,l=2,c=32768,r=0],false)@COMMITTED

2023-05-23 14:54:19.383 [DEBUG] [org.eclipse.jetty.server.HttpOutput ] - onWriteComplete(false,null) s=OPEN,api=BLOCKED,sc=false,e=null->s=OPEN,api=BLOCKING,sc=false,e=null c=null cb=null w=false

2023-05-23 14:54:19.384 [DEBUG] [e.jetty.util.thread.QueuedThreadPool] - ran org.eclipse.jetty.server.AsyncContextState$1@3c0a496d in QueuedThreadPool[qtp2096389068]@7cf45bcc{STARTED,2<=14<=50,i=3,r=-1,q=0}[ReservedThreadExecutor@76061b20{reserved=4/4,pending=0}]

2023-05-23 14:54:21.576 [DEBUG] [calimero.link.192.168.178.22:3671 ] - indication 1.1.91->0/0/20 L_Data.ind, low priority hop count 6, tpdu 00 80 00 d0

2023-05-23 14:54:23.575 [DEBUG] [calimero.link.192.168.178.22:3671 ] - indication 1.1.91->0/0/11 L_Data.ind, low priority hop count 6, tpdu 00 80 4f 0c