How to troubleshoot CEC issues

rosede · January 17, 2021 at 10:27 PM

I have an RPi4 which is connected to a Samsung Smart TV.

A couple of day's ago, I made a change to my WIFI environment and had to put the Pi back on the network. After doing so, I started having issues with my TV connecting to the Pi. At first it was just the CEC connectivity. I was using a micro-HDMI adaptor to connect the Pi to the TV. Thinking that the cheap adaptor was causing signal lose, I changed out the adaptor and then finally a Micro-HDMI to HDMI cable. I was pretty confident that it was a cable issue because for a while, I lost all video due to the adaptors. Once I got the actual cable, I got video back, however, I still can't get the TV to connect to the Pi.

Samsung's CEC is called Anynet+. In Samsung's menu, I can scan for CEC devices, and when I do, I get "No device found". I turned on debugging and for specifically the CEC Library. This is what I see in the log.

Quote

grep -i cec kodi.log

hdmi_force_cec_address:0=65535

hdmi_force_cec_address:1=65535

hdmi_ignore_cec_init:0=1

2021-01-17 16:12:01.563 T:3011355232 DEBUG: LoadMappings - loaded node "CEC Adapter"

2021-01-17 16:12:01.563 T:3011355232 DEBUG: LoadMappings - loaded node "Pulse-Eight CEC Adapter"

2021-01-17 16:12:01.578 T:2803880816 DEBUG: Thread PeripBusCEC start, auto delete: false

2021-01-17 16:12:02.119 T:2803880816 DEBUG: GetMappingForDevice - device (2708:1001) mapped to CEC Adapter (type = cec)

2021-01-17 16:12:02.127 T:2803880816 DEBUG: InitialiseFeature - using libCEC v4.0.4

2021-01-17 16:12:02.127 T:2609423216 DEBUG: Thread CECAdapter start, auto delete: false

2021-01-17 16:12:02.127 T:2609423216 DEBUG: OpenConnection - opening a connection to the CEC adapter: RPI

2021-01-17 16:12:02.127 T:2803880816 NOTICE: Register - new cec device registered on cec->RPI: CEC Adapter (2708:1001)

2021-01-17 16:12:02.128 T:2617893744 DEBUG: CecLogMessage - Broadcast (F): osd name set to 'Broadcast'

2021-01-17 16:12:02.128 T:2803880816 DEBUG: Thread PeripBusCEC 2803880816 terminating

2021-01-17 16:12:02.128 T:2617893744 DEBUG: CecLogMessage - logical address changed to Free use (e)

2021-01-17 16:12:02.129 T:2617893744 DEBUG: CecLogMessage - Open - vc_cec initialised

2021-01-17 16:12:02.129 T:2617893744 DEBUG: CecLogMessage - connection opened

2021-01-17 16:12:02.129 T:2617893744 DEBUG: CecLogMessage - << Broadcast (F) -> TV (0): POLL

2021-01-17 16:12:02.129 T:2617893744 DEBUG: CecLogMessage - initiator 'Broadcast' is not supported by the CEC adapter. using 'Free use' instead

2021-01-17 16:12:02.130 T:2617893744 DEBUG: CecLogMessage - << e0

2021-01-17 16:12:02.130 T:2617893744 DEBUG: CecLogMessage - processor thread started

2021-01-17 16:12:03.129 T:2617893744 DEBUG: CecLogMessage - command 'feature abort' timeout

2021-01-17 16:12:03.629 T:2617893744 DEBUG: CecLogMessage - initiator 'Broadcast' is not supported by the CEC adapter. using 'Free use' instead

2021-01-17 16:12:03.759 T:2617893744 DEBUG: CecLogMessage - << e0

2021-01-17 16:12:03.759 T:2617893744 DEBUG: CecLogMessage - >> POLL sent

2021-01-17 16:12:03.759 T:2617893744 DEBUG: CecLogMessage - TV (0): device status changed into 'present'

2021-01-17 16:12:03.759 T:2617893744 DEBUG: CecLogMessage - << requesting vendor ID of 'TV' (0)

2021-01-17 16:12:03.759 T:2617893744 DEBUG: CecLogMessage - << e0:8c

2021-01-17 16:12:04.659 T:2617893744 DEBUG: CecLogMessage - command 'give device vendor id' timeout

2021-01-17 16:12:05.160 T:2617893744 DEBUG: CecLogMessage - << e0:8c

2021-01-17 16:12:05.191 T:2617893744 WARNING: CecLogMessage - unhandled response received: opcode=0 initiator=e destination=0 response=0

2021-01-17 16:12:06.160 T:2617893744 DEBUG: CecLogMessage - command 'give device vendor id' timeout

2021-01-17 16:12:06.661 T:2617893744 DEBUG: CecLogMessage - registering new CEC client - v4.0.0

2021-01-17 16:12:06.661 T:2617893744 DEBUG: CecLogMessage - detecting logical address for type 'recording device'

2021-01-17 16:12:06.661 T:2617893744 DEBUG: CecLogMessage - trying logical address 'Recorder 1'

2021-01-17 16:12:06.661 T:2617893744 DEBUG: CecLogMessage - << Recorder 1 (1) -> Recorder 1 (1): POLL

2021-01-17 16:12:06.661 T:2617893744 DEBUG: CecLogMessage - << 11

2021-01-17 16:12:11.450 T:2617893744 DEBUG: CecLogMessage - << 11

2021-01-17 16:12:15.911 T:2617893744 DEBUG: CecLogMessage - >> POLL not sent

2021-01-17 16:12:15.911 T:2617893744 DEBUG: CecLogMessage - using logical address 'Recorder 1'

2021-01-17 16:12:15.911 T:2617893744 DEBUG: CecLogMessage - Recorder 1 (1): device status changed into 'handled by libCEC'

2021-01-17 16:12:15.911 T:2617893744 DEBUG: CecLogMessage - Recorder 1 (1): power status changed from 'unknown' to 'on'

2021-01-17 16:12:15.911 T:2617893744 DEBUG: CecLogMessage - Recorder 1 (1): vendor = Pulse Eight (001582)

2021-01-17 16:12:15.911 T:2617893744 DEBUG: CecLogMessage - Recorder 1 (1): CEC version 1.4

2021-01-17 16:12:15.911 T:2617893744 DEBUG: CecLogMessage - AllocateLogicalAddresses - device '0', type 'recording device', LA '1'

2021-01-17 16:12:15.911 T:2617893744 DEBUG: CecLogMessage - logical address changed to Recorder 1 (1)

2021-01-17 16:12:15.911 T:2617893744 DEBUG: CecLogMessage - Recorder 1 (1): osd name set to 'Kodi'

2021-01-17 16:12:15.911 T:2617893744 DEBUG: CecLogMessage - Recorder 1 (1): menu language set to 'eng'

2021-01-17 16:12:15.911 T:2617893744 DEBUG: CecLogMessage - GetPhysicalAddress - physical address = 1000

2021-01-17 16:12:15.912 T:2617893744 DEBUG: CecLogMessage - Recorder 1 (1): physical address changed from ffff to 1000

2021-01-17 16:12:15.912 T:2617893744 DEBUG: CecLogMessage - << Recorder 1 (1) -> broadcast (F): physical address 1000

2021-01-17 16:12:15.912 T:2617893744 DEBUG: CecLogMessage - << 1f:84:10:00:01

2021-01-17 16:12:16.912 T:2617893744 DEBUG: CecLogMessage - command 'report physical address' timeout

2021-01-17 16:12:17.412 T:2617893744 DEBUG: CecLogMessage - << 1f:84:10:00:01

2021-01-17 16:12:17.442 T:2617893744 DEBUG: CecLogMessage - making Recorder 1 (1) the active source

2021-01-17 16:12:17.442 T:2617893744 DEBUG: CecLogMessage - TV (0): power status changed from 'unknown' to 'in transition from standby to on'

2021-01-17 16:12:17.442 T:2617893744 DEBUG: CecLogMessage - >> source activated: Recorder 1 (1)

2021-01-17 16:12:17.442 T:2617893744 DEBUG: CecLogMessage - scheduling active source message for 'Recorder 1'

2021-01-17 16:12:17.446 T:2617893744 DEBUG: CecLogMessage - CEC client registered: libCEC version = 4.0.4, client version = 4.0.0, firmware version = 1, logical address(es) = Recorder 1 (1

) , physical address: 1.0.0.0, compiled on Sat Oct 24 20:14:00 UTC 2020 by jenkins@prometheus on Linux 4.15.0-118-generic (x86_64), features: P8_USB, DRM, P8_detect, RPi

2021-01-17 16:12:17.446 T:2617893744 DEBUG: CecLogMessage - << Recorder 1 (1) -> TV (0): OSD name 'Kodi'

2021-01-17 16:12:17.446 T:2617893744 DEBUG: CecLogMessage - << 10:47:4b:6f:64:69

2021-01-17 16:12:18.443 T:2617893744 DEBUG: CecLogMessage - command 'set osd name' timeout

2021-01-17 16:12:18.943 T:2617893744 DEBUG: CecLogMessage - << 10:47:4b:6f:64:69

2021-01-17 16:12:18.972 T:2617893744 WARNING: CecLogMessage - unhandled response received: opcode=84 initiator=1 destination=f response=0

2021-01-17 16:12:19.943 T:2617893744 DEBUG: CecLogMessage - command 'set osd name' timeout

2021-01-17 16:12:20.443 T:2617893744 DEBUG: CecLogMessage - << requesting power status of 'TV' (0)

2021-01-17 16:12:20.443 T:2617893744 DEBUG: CecLogMessage - << 10:8f

2021-01-17 16:12:20.504 T:2617893744 WARNING: CecLogMessage - unhandled response received: opcode=47 initiator=1 destination=0 response=0

2021-01-17 16:12:21.443 T:2617893744 DEBUG: CecLogMessage - command 'give device power status' timeout

2021-01-17 16:12:21.944 T:2617893744 DEBUG: CecLogMessage - << 10:8f

2021-01-17 16:12:22.035 T:2617893744 WARNING: CecLogMessage - unhandled response received: opcode=47 initiator=1 destination=0 response=0

2021-01-17 16:12:22.944 T:2617893744 DEBUG: CecLogMessage - command 'give device power status' timeout

2021-01-17 16:12:23.444 T:2609423216 DEBUG: OpenConnection - connection to the CEC adapter opened

2021-01-17 16:12:23.444 T:2617893744 DEBUG: CecLogMessage - TV (0): power status changed from 'in transition from standby to on' to 'unknown'

2021-01-17 16:12:23.444 T:2609423216 DEBUG: SetConfigurationFromLibCEC - settings updated by libCEC

2021-01-17 16:12:23.444 T:2617893744 DEBUG: CecLogMessage - << requesting vendor ID of 'TV' (0)

2021-01-17 16:12:23.444 T:2617893744 DEBUG: CecLogMessage - << 10:8c

2021-01-17 16:12:23.444 T:2490348400 DEBUG: Thread CECAdapterUpdate start, auto delete: false

2021-01-17 16:12:23.565 T:2617893744 WARNING: CecLogMessage - unhandled response received: opcode=8f initiator=1 destination=0 response=0

2021-01-17 16:12:24.445 T:2617893744 DEBUG: CecLogMessage - command 'give device vendor id' timeout

2021-01-17 16:12:24.945 T:2617893744 DEBUG: CecLogMessage - << 10:8c

2021-01-17 16:12:25.098 T:2617893744 WARNING: CecLogMessage - unhandled response received: opcode=8f initiator=1 destination=0 response=0

2021-01-17 16:12:25.945 T:2617893744 DEBUG: CecLogMessage - command 'give device vendor id' timeout

2021-01-17 16:12:26.445 T:2617893744 DEBUG: CecLogMessage - << powering on 'TV' (0)

2021-01-17 16:12:26.445 T:2617893744 DEBUG: CecLogMessage - Recorder 1 (1) was already marked as active source

2021-01-17 16:12:26.445 T:2617893744 DEBUG: CecLogMessage - TV (0): power status changed from 'unknown' to 'in transition from standby to on'

2021-01-17 16:12:26.445 T:2617893744 DEBUG: CecLogMessage - << 10:04

2021-01-17 16:12:26.632 T:2617893744 WARNING: CecLogMessage - unhandled response received: opcode=8c initiator=1 destination=0 response=0

2021-01-17 16:12:27.445 T:2617893744 DEBUG: CecLogMessage - command 'image view on' timeout

2021-01-17 16:12:27.945 T:2617893744 DEBUG: CecLogMessage - << 10:04

2021-01-17 16:12:28.163 T:2617893744 WARNING: CecLogMessage - unhandled response received: opcode=8c initiator=1 destination=0 response=0

2021-01-17 16:12:28.946 T:2617893744 DEBUG: CecLogMessage - command 'image view on' timeout

2021-01-17 16:12:29.446 T:2617893744 DEBUG: CecLogMessage - << Recorder 1 (1) -> broadcast (F): active source (1000)

2021-01-17 16:12:29.446 T:2617893744 DEBUG: CecLogMessage - >> source activated: Recorder 1 (1)

2021-01-17 16:12:29.446 T:2617893744 DEBUG: CecLogMessage - sending active source message for 'Recorder 1'

2021-01-17 16:12:29.446 T:2617893744 DEBUG: CecLogMessage - << 1f:82:10:00

2021-01-17 16:12:29.446 T:2617893744 DEBUG: CecLogMessage - << requesting vendor ID of 'TV' (0)

2021-01-17 16:12:29.695 T:2617893744 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=1 destination=0 response=0

2021-01-17 16:12:30.446 T:2617893744 DEBUG: CecLogMessage - command 'active source' timeout

2021-01-17 16:12:30.946 T:2617893744 DEBUG: CecLogMessage - << 1f:82:10:00

2021-01-17 16:12:31.231 T:2617893744 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=1 destination=0 response=0

2021-01-17 16:12:31.947 T:2617893744 DEBUG: CecLogMessage - command 'active source' timeout

Display More

Nothing really jumps out at me as an issue.

How can I troubleshoot this issue? I've ruled out the cable. I've tried both video ports. I even rebuilt the Pi. Any other suggestions?

Thank you

Daryl

**Klojum** · January 17, 2021 at 11:59 PM Official Post

Quote from rosede

This is what I see in the log.

We prefer it if you would use a pastebin service for providing logs, as we like to keep our forum server as tidy as possible.

Also provide the full log file, and not just one or two puzzle pieces relating to CEC.

Wifi + HDMI problems on a RPi4 seem not to be that uncommon, unfortunately. Any chance you can use cabled connection instead?

rosede · January 18, 2021 at 12:22 AM

Quote from Klojum

We prefer it if you would use a pastebin service for providing logs, as we like to keep our forum server as tidy as possible.
Also provide the full log file, and not just one or two puzzle pieces relating to CEC.
Wifi + HDMI problems on a RPi4 seem not to be that uncommon, unfortunately. Any chance you can use cabled connection instead?

I'll see what I can do about posting to pastebin.

No, no chance of using a cable.

Thanks

Daryl

rosede · January 18, 2021 at 12:57 AM

I posted my logs to Pastbin as requested.

https://pastebin.com/b6HhGGQA

Thank you.

Daryl

I found a post on kodi.log of someone having similar issues. The suggestion was to unplug both the Pi and the TV, plug them back in and SHAZAAM, CEC started working again.

Guess I was looking to hard and I could have saved myself some grief. Next time I'll remember the Windoz motto, "Reboot IT!!"

Daryl

How to troubleshoot CEC issues

Similar Threads

Browsing library slow or unresponsive in Kodi on Pi3

Raspberry Pi 4 LibreELEC - advancedsettings.xml that comes with the build seems to have obsolete parameters

Add-on updates fail with 404 and 403 errors