Vero is OSMC's new flagship device. Find out more here.

Post Reply 
 
Thread Rating:
  • 0 Vote(s) - 0 Average
  • 1
  • 2
  • 3
  • 4
  • 5
Please Help - HDMI CEC with Sony KDL 40X3000 + Sony STR-DN 1030
11-08-2012, 01:17 PM
Post: #1
Please Help - HDMI CEC with Sony KDL 40X3000 + Sony STR-DN 1030
I'm hoping someone on this forum will be able to assist me.

I've been trying to get my Raspbmc Pi to accept commands from either of my 2 Sony remotes (Sony RM-ED010 for the Sony KDL 40X3000 & Sony RM-AAP079 for the Sony STR-DN 1030) but after many attempts at checking the settings in XBMC have not been able to do so.

I can use either remote to control the features of either device so the TV and AMP are at least talking to each other correctly.

I am running the RC5 version of Raspbmc on a 512MB Pi.

I should add that the TV is showing XBMC as a HDMI connected device (Recorder 1 XBMC) as well as the AVR, both are detected on input 5 which is my first HDMI input (6 and 8 are the others but they are not connected to anything) and that the Pulse Eight CEC adaptor is detecting the TV and the AVR.

As a temporary solution to the issue I am using 'Yatse' on an android phone (this solution has a very low wife acceptance factor) and if I adjust the volume using the app, the volume changes on the AMP so it would appear that the CEC signal is going in at least one direction.

I have variously tried everything that I can think of, I have changed the HDMI cables, tried different inputs on the TV & tried bypassing the AMP and connecting the Raspberry Pi directly to the TV, but none of these have made any difference.

I have read as much as I could in this forum that looked relevant to my issue and have searched using Google but can't seem to find out how to systematically debug this issue.

Has anyone got any suggestions as to how I should start debugging this so that I can discover where the issue lies and fix it?
Find all posts by this user
Quote this message in a reply
11-08-2012, 07:56 PM
Post: #2
RE: Please Help - HDMI CEC with Sony KDL 40X3000 + Sony STR-DN 1030
You said that both AVR and RPi are connected to input 5.... can you (temporarily) connect the RPi directly to the TV (with no intermediate switch) and see what happens?
Find all posts by this user
Quote this message in a reply
11-08-2012, 08:45 PM
Post: #3
RE: Please Help - HDMI CEC with Sony KDL 40X3000 + Sony STR-DN 1030
(11-08-2012 01:17 PM)initctl Wrote:  I have variously tried everything that I can think of, I have changed the HDMI cables, tried different inputs on the TV & tried bypassing the AMP and connecting the Raspberry Pi directly to the TV, but none of these have made any difference.

(11-08-2012 07:56 PM)Paul Webster Wrote:  You said that both AVR and RPi are connected to input 5.... can you (temporarily) connect the RPi directly to the TV (with no intermediate switch) and see what happens?

I think he did that already...

How to SSH into your pi
Info Required For Support
Visit this user's website Find all posts by this user
Quote this message in a reply
11-08-2012, 09:01 PM
Post: #4
RE: Please Help - HDMI CEC with Sony KDL 40X3000 + Sony STR-DN 1030
This may or may not help you, but I have a somewhat similar setup and will share my experience.

My Pi is connected to a Sony AV receiver (from memory, an STR DG820) on its Video1 Recorder HDMI input. The receiver is connected to my Sony Bravia TV (40W?000 - can't remember what number the '?' is) via HDMI. They recognise each other - using BraviaLink I assume - and we only ever use the TV control, e.g. for changing volume on the receiver.

Now, when I boot up the Pi WITH THE RECEIVER SWITCHED TO THE Pi's INPUT, then I can control the Pi using the TV remote. The buttons that work are: the up/down/left/right/select rocker switch, the Return button beside it acts like 'Back', and the play/pause, stop, Ffwd etc. media control buttons near the top.

If I switch the receiver to another input such as my Sky+ satellite receiver and then switch back to the Pi, the buttons on the TV remote no longer seem to work.

Hope this helps describe what the expected behaviour should be.
Find all posts by this user
Quote this message in a reply
11-08-2012, 10:14 PM (This post was last modified: 11-08-2012 10:41 PM by initctl.)
Post: #5
RE: Please Help - HDMI CEC with Sony KDL 40X3000 + Sony STR-DN 1030
(11-08-2012 08:45 PM)ActionA Wrote:  
(11-08-2012 01:17 PM)initctl Wrote:  I have variously tried everything that I can think of, I have changed the HDMI cables, tried different inputs on the TV & tried bypassing the AMP and connecting the Raspberry Pi directly to the TV, but none of these have made any difference.

(11-08-2012 07:56 PM)Paul Webster Wrote:  You said that both AVR and RPi are connected to input 5.... can you (temporarily) connect the RPi directly to the TV (with no intermediate switch) and see what happens?

I think he did that already...

Hi ActionA & Paul Webster, thanks for your input. I have tried that, and I have tried it with three different HDMI cables all of which allow communication between the AVR and the TV but I can't control the Raspberry Pi via CEC Sad

(11-08-2012 09:01 PM)brandycmc Wrote:  This may or may not help you, but I have a somewhat similar setup and will share my experience.

My Pi is connected to a Sony AV receiver (from memory, an STR DG820) on its Video1 Recorder HDMI input. The receiver is connected to my Sony Bravia TV (40W?000 - can't remember what number the '?' is) via HDMI. They recognise each other - using BraviaLink I assume - and we only ever use the TV control, e.g. for changing volume on the receiver.

Now, when I boot up the Pi WITH THE RECEIVER SWITCHED TO THE Pi's INPUT, then I can control the Pi using the TV remote. The buttons that work are: the up/down/left/right/select rocker switch, the Return button beside it acts like 'Back', and the play/pause, stop, Ffwd etc. media control buttons near the top.

If I switch the receiver to another input such as my Sky+ satellite receiver and then switch back to the Pi, the buttons on the TV remote no longer seem to work.

Hope this helps describe what the expected behaviour should be.

Hi brandycmc, that is very encouraging news.

I have just tried to doing that by rebooting the Pi whilst the AVR is on and the input is set to Video 1 but it hasn't made a difference Sad, I will attempt a hard boot (shutdown, unplug, replug) and will see what happens. I will post a follow up afterwards with my results.

Thanks for your feedback Smile

Hi brandycmc, I've tried from a cold boot but it doesn't work Sad

Does your TV register the Pi as Player 1 (RASPBERRYPI LI) and then switch to Recorder 1 (XBMC) when booting the Pi?

On another more general question does anyone know how to turn on the debug output for the pulse eight CEC add-on? At the moment there doesn't appear to be any useful info being logged by my Pi.
Find all posts by this user
Quote this message in a reply
11-09-2012, 09:27 AM (This post was last modified: 11-09-2012 10:07 AM by initctl.)
Post: #6
RE: Please Help - HDMI CEC with Sony KDL 40X3000 + Sony STR-DN 1030
I have discovered that when I power off XBMC the TV and AVR also switch off, so that means that the vol-, vol+, and power off signals are being sent from the Pi (using Yatse as the remote) over HDMI to the AVR and TV.

I have once again tried connecting the Pi to the TV (bypassing the AVR) and XBMC is definetly not receiving any input from the remote.

As the signals are being sent in one direction I don't think there is an issue with the HDMI cables (I even tried reversing the cables) so I think there must be an issue on the PI end either with receiving the signals or in processing them.

I found the following in my xbmc.log file

21:38:35 T:1074679808 NOTICE: Register - new cec device registered on rpi->RPI: Raspberry Pi CEC Adapter (2708:1001)
21:38:35 T:1120191552 NOTICE: Thread CEC Adapter start, auto delete: false
21:38:35 T:1128580160 NOTICE: Thread XBMC Peripherals start, auto delete: false
21:38:38 T:1074679808 NOTICE: Raspberry PI firmware version: Oct 19 2012 23:40:40
Copyright © 2012 Broadcom
version 345130 (release)
21:38:40 T:1074679808 NOTICE: InitWindowSystem: Using EGL Implementation: raspberrypi
21:38:40 T:1120191552 ERROR: CecLogMessage - failed to release the previous LA
21:38:40 T:1120191552 ERROR: CecLogMessage - could not open a connection (try 1)

... and ...

21:38:47 T:1247802432 NOTICE: Thread CEC Adapter Update Thread start, auto delete: false

Could this have something to do with the issues I am experiencing?

There are no other CEC related entries in the log file.
Find all posts by this user
Quote this message in a reply
11-09-2012, 10:59 AM
Post: #7
RE: Please Help - HDMI CEC with Sony KDL 40X3000 + Sony STR-DN 1030
Discovered how to cange the logging level to include debug output.

Here is everything related to CEC that I could find in the log file (I've stripped the rest out or it would be a very long post), I don't know if anyone will recognise anything in the logs that will shed light on my issue but I thought it may prove useful to someone more technical than I am who is willing to assist me.

09:46:19 T:1102217216 DEBUG: LoadMappings - loaded node "Raspberry Pi CEC Adapter"
09:46:19 T:1102217216 DEBUG: LoadMappings - loaded node "Pulse-Eight CEC Adapter"
09:46:19 T:1102217216 DEBUG: GetMappingForDevice - device (2708:1001) mapped to Raspberry Pi CEC Adapter (type = cec)
09:46:19 T:1102217216 DEBUG: SECTION:LoadDLL(libcec.so.2)
09:46:19 T:1102217216 DEBUG: Loading: /opt/xbmc-bcm/xbmc-bin/lib/xbmc/system/libcec.so.2
09:46:19 T:1102217216 DEBUG: InitialiseFeature - using libCEC v2.0.2
09:46:19 T:1102217216 DEBUG: Initialise - initialised peripheral on 'RPI' with 2 features and 0 sub devices
09:46:19 T:1102217216 NOTICE: Register - new cec device registered on rpi->RPI: Raspberry Pi CEC Adapter (2708:1001)
09:46:19 T:1119790144 NOTICE: Thread CEC Adapter start, auto delete: false
09:46:20 T:1119790144 DEBUG: GetComPort - autodetect com port 'RPI'
09:46:20 T:1128178752 NOTICE: Thread XBMC Peripherals start, auto delete: false
09:46:20 T:1102217216 INFO: LIRC Initialize: using: /var/run/lirc/lircd
09:46:20 T:1102217216 INFO: LIRC Initialize: sucessfully started
09:46:20 T:1119790144 DEBUG: OpenConnection - opening a connection to the CEC adapter: RPI
09:46:20 T:1119790144 DEBUG: CecLogMessage - unregistering all CEC clients
09:46:20 T:1119790144 DEBUG: CecLogMessage - Broadcast (F): osd name set to 'Broadcast'
09:46:20 T:1119790144 DEBUG: CecLogMessage - InitHostCEC - vchiq_initialise succeeded
09:46:20 T:1119790144 DEBUG: CecLogMessage - InitHostCEC - vchi_initialise succeeded
09:46:20 T:1119790144 DEBUG: CecLogMessage - InitHostCEC - vchi_connect succeeded
09:46:23 T:1119790144 ERROR: CecLogMessage - failed to release the previous LA
09:46:26 T:1119790144 ERROR: CecLogMessage - could not open a connection (try 1)
09:46:27 T:1119790144 DEBUG: CecLogMessage - InitHostCEC - vchiq_initialise succeeded
09:46:27 T:1119790144 DEBUG: CecLogMessage - InitHostCEC - vchi_initialise succeeded
09:46:27 T:1119790144 DEBUG: CecLogMessage - InitHostCEC - vchi_connect succeeded
09:46:27 T:1154839616 DEBUG: CecLogMessage - logical address changed to Broadcast (f)
09:46:28 T:1119790144 DEBUG: CecLogMessage - RegisterLogicalAddress - registering address e
09:46:28 T:1154839616 DEBUG: CecLogMessage - logical address changed to Recorder 1 (1)
09:46:28 T:1154839616 DEBUG: CecLogMessage - logical address changed to Free use (e)
09:46:28 T:1119790144 DEBUG: CecLogMessage - Open - vc_cec initialised
09:46:28 T:1119790144 DEBUG: CecLogMessage - connection opened
09:46:28 T:1119790144 DEBUG: CecLogMessage - << Broadcast (F) -> TV (0): POLL
09:46:28 T:1119790144 DEBUG: CecLogMessage - initiator 'Broadcast' is not supported by the CEC adapter. using 'Free use' instead
09:46:28 T:1119790144 DEBUG: CecLogMessage - << e0
09:46:28 T:1196422208 DEBUG: CecLogMessage - processor thread started
09:46:28 T:1119790144 DEBUG: CecLogMessage - >> POLL sent
09:46:28 T:1119790144 DEBUG: CecLogMessage - TV (0): device status changed into 'present'
09:46:28 T:1119790144 DEBUG: CecLogMessage - << requesting vendor ID of 'TV' (0)
09:46:28 T:1119790144 DEBUG: CecLogMessage - << e0:8c
09:46:28 T:1196422208 DEBUG: CecLogMessage - >> 0f:87:08:00:46
09:46:28 T:1196422208 DEBUG: CecLogMessage - >> TV (0) -> Broadcast (F): device vendor id (87)
09:46:28 T:1196422208 DEBUG: CecLogMessage - TV (0): vendor = Sony (080046)
09:46:28 T:1119790144 DEBUG: CecLogMessage - expected response received (87: device vendor id)
09:46:28 T:1119790144 DEBUG: CecLogMessage - registering new CEC client - v2.0.0
09:46:28 T:1119790144 DEBUG: CecLogMessage - detecting logical address for type 'recording device'
09:46:28 T:1119790144 DEBUG: CecLogMessage - trying logical address 'Recorder 1'
09:46:28 T:1119790144 DEBUG: CecLogMessage - << Recorder 1 (1) -> Recorder 1 (1): POLL
09:46:28 T:1119790144 DEBUG: CecLogMessage - << 11
09:46:28 T:1119790144 DEBUG: CecLogMessage - UnregisterLogicalAddress - releasing previous logical address
09:46:28 T:1154839616 DEBUG: CecLogMessage - logical address changed to Broadcast (f)
09:46:28 T:1119790144 DEBUG: CecLogMessage - RegisterLogicalAddress - registering address 1
09:46:28 T:1154839616 DEBUG: CecLogMessage - logical address changed to Free use (e)
09:46:28 T:1154839616 DEBUG: CecLogMessage - logical address changed to Recorder 1 (1)
09:46:28 T:1119790144 DEBUG: CecLogMessage - >> POLL not sent
09:46:28 T:1119790144 DEBUG: CecLogMessage - using logical address 'Recorder 1'
09:46:28 T:1119790144 DEBUG: CecLogMessage - Recorder 1 (1): device status changed into 'handled by libCEC'
09:46:28 T:1119790144 DEBUG: CecLogMessage - Recorder 1 (1): power status changed from 'unknown' to 'on'
09:46:28 T:1119790144 DEBUG: CecLogMessage - Recorder 1 (1): CEC version 1.4
09:46:28 T:1119790144 DEBUG: CecLogMessage - AllocateLogicalAddresses - device '0', type 'recording device', LA '1'
09:46:28 T:1119790144 DEBUG: CecLogMessage - Recorder 1 (1): osd name set to 'XBMC'
09:46:28 T:1119790144 DEBUG: CecLogMessage - Recorder 1 (1): menu language set to 'eng'
09:46:28 T:1119790144 DEBUG: CecLogMessage - GetPhysicalAddress - physical address = 1200
09:46:28 T:1119790144 DEBUG: CecLogMessage - AutodetectPhysicalAddress - autodetected physical address '1200'
09:46:28 T:1119790144 DEBUG: CecLogMessage - Recorder 1 (1): physical address changed from ffff to 1200
09:46:28 T:1119790144 DEBUG: CecLogMessage - << Recorder 1 (1) -> broadcast (F): physical adddress 1200
09:46:28 T:1119790144 DEBUG: CecLogMessage - << 1f:84:12:00:01
09:46:28 T:1119790144 DEBUG: CecLogMessage - making Recorder 1 (1) the active source
09:46:28 T:1119790144 DEBUG: CecLogMessage - >> source activated: Recorder 1 (1)
09:46:28 T:1119790144 DEBUG: CecLogMessage - scheduling active source message for 'Recorder 1'
09:46:28 T:1119790144 DEBUG: CecLogMessage - CEC client registered: libCEC version = 2.0.2, client version = 2.0.0, firmware version = 1, logical address(es) = Recorder 1 (1) , physical address: 1.2.0.0, host: arm-bcm2708hardfp-linux-gnueabi, features: 'P8 USB' 'P8 USB detect' 'RPi', git revision: a9ac151, compiled on: Thu Oct 18 20:01:19 UTC 2012 by root@ on Linux 3.2.0-31-generic (x86_64)
09:46:28 T:1119790144 DEBUG: CecLogMessage - << requesting power status of 'TV' (0)
09:46:28 T:1119790144 DEBUG: CecLogMessage - << 10:8f
09:46:29 T:1196422208 DEBUG: CecLogMessage - >> 01:90:00
09:46:29 T:1196422208 DEBUG: CecLogMessage - >> TV (0) -> Recorder 1 (1): report power status (90)
09:46:29 T:1196422208 DEBUG: CecLogMessage - TV (0): power status changed from 'unknown' to 'on'
09:46:29 T:1119790144 DEBUG: CecLogMessage - expected response received (90: report power status)
09:46:29 T:1119790144 DEBUG: OpenConnection - connection to the CEC adapter opened
09:46:29 T:1119790144 DEBUG: CecLogMessage - << powering on 'TV' (0)
09:46:29 T:1119790144 DEBUG: CecLogMessage - << 10:04
09:46:29 T:1119790144 DEBUG: CecLogMessage - << Recorder 1 (1) -> Audio (5): POLL
09:46:29 T:1119790144 DEBUG: CecLogMessage - << 15
09:46:29 T:1119790144 DEBUG: CecLogMessage - >> POLL sent
09:46:29 T:1119790144 DEBUG: CecLogMessage - Audio (5): device status changed into 'present'
09:46:29 T:1119790144 DEBUG: CecLogMessage - << requesting vendor ID of 'Audio' (5)
09:46:29 T:1119790144 DEBUG: CecLogMessage - << 15:8c
09:46:29 T:1196422208 DEBUG: CecLogMessage - >> 01:46
09:46:29 T:1196422208 DEBUG: CecLogMessage - >> TV (0) -> Recorder 1 (1): give osd name (46)
09:46:29 T:1196422208 DEBUG: CecLogMessage - << Recorder 1 (1) -> TV (0): OSD name 'XBMC'
09:46:29 T:1196422208 DEBUG: CecLogMessage - << 10:47:58:42:4d:43
09:46:29 T:1196422208 DEBUG: CecLogMessage - << 10:04
09:46:29 T:1196422208 DEBUG: CecLogMessage - << Recorder 1 (1) -> broadcast (F): active source (1200)
09:46:29 T:1196422208 DEBUG: CecLogMessage - << 1f:82:12:00
09:46:30 T:1196422208 DEBUG: CecLogMessage - << Recorder 1 (1) -> TV (0): menu state 'activated'
09:46:30 T:1196422208 DEBUG: CecLogMessage - << 10:8e:00
09:46:30 T:1196422208 DEBUG: CecLogMessage - >> 01:8c
09:46:30 T:1196422208 DEBUG: CecLogMessage - >> TV (0) -> Recorder 1 (1): give device vendor id (8C)
09:46:30 T:1196422208 DEBUG: CecLogMessage - << Recorder 1 (1) -> TV (0): vendor id feature abort
09:46:30 T:1196422208 DEBUG: CecLogMessage - << transmitting abort message
09:46:30 T:1196422208 DEBUG: CecLogMessage - << 10:00:8c:00
09:46:30 T:1196422208 DEBUG: CecLogMessage - >> 5f:87:08:00:46
09:46:30 T:1196422208 DEBUG: CecLogMessage - >> Audio (5) -> Broadcast (F): device vendor id (87)
09:46:30 T:1196422208 DEBUG: CecLogMessage - Audio (5): vendor = Sony (080046)
09:46:30 T:1119790144 DEBUG: CecLogMessage - expected response received (87: device vendor id)
09:46:30 T:1119790144 DEBUG: CecLogMessage - << requesting power status of 'Audio' (5)
09:46:30 T:1119790144 DEBUG: CecLogMessage - << 15:8f
09:46:30 T:1196422208 DEBUG: CecLogMessage - >> 01:00:8e:00
09:46:30 T:1196422208 DEBUG: CecLogMessage - >> TV (0) -> Recorder 1 (1): feature abort ( 0)
09:46:30 T:1196422208 DEBUG: CecLogMessage - marking opcode 'menu status' as unsupported feature for device 'TV'
09:46:30 T:1196422208 DEBUG: CecLogMessage - >> 51:90:00
09:46:30 T:1196422208 DEBUG: CecLogMessage - >> Audio (5) -> Recorder 1 (1): report power status (90)
09:46:30 T:1196422208 DEBUG: CecLogMessage - Audio (5): power status changed from 'unknown' to 'on'
09:46:30 T:1119790144 DEBUG: CecLogMessage - expected response received (90: report power status)
09:46:30 T:1119790144 DEBUG: CecLogMessage - 'Audio' (5) is already 'on'
09:46:30 T:1119790144 DEBUG: CecLogMessage - Recorder 1 (1) was already marked as active source
09:46:30 T:1119790144 DEBUG: CecLogMessage - sending active source message for 'Recorder 1'
09:46:30 T:1119790144 DEBUG: CecLogMessage - << 10:04
09:46:30 T:1119790144 DEBUG: CecLogMessage - << Recorder 1 (1) -> broadcast (F): active source (1200)
09:46:30 T:1119790144 DEBUG: CecLogMessage - << 1f:82:12:00
09:46:30 T:1119790144 DEBUG: CecLogMessage - << Recorder 1 (1) -> TV (0): menu state 'activated'
09:46:30 T:1119790144 DEBUG: CecLogMessage - << 10:8e:00
09:46:30 T:1196422208 DEBUG: CecLogMessage - >> 01:00:8e:00
09:46:30 T:1196422208 DEBUG: CecLogMessage - >> TV (0) -> Recorder 1 (1): feature abort ( 0)
09:46:31 T:1251996736 NOTICE: Thread CEC Adapter Update Thread start, auto delete: false
09:46:31 T:1251996736 DEBUG: CecLogMessage - << powering on 'TV' (0)
09:46:31 T:1251996736 DEBUG: CecLogMessage - << 10:04
09:46:31 T:1251996736 DEBUG: CecLogMessage - 'Audio' (5) is already 'on'
09:46:31 T:1251996736 DEBUG: CecLogMessage - Recorder 1 (1) was already marked as active source
09:46:31 T:1251996736 DEBUG: CecLogMessage - sending active source message for 'Recorder 1'
09:46:31 T:1251996736 DEBUG: CecLogMessage - << 10:04
09:46:31 T:1251996736 DEBUG: CecLogMessage - << Recorder 1 (1) -> broadcast (F): active source (1200)
09:46:31 T:1251996736 DEBUG: CecLogMessage - << 1f:82:12:00
09:46:32 T:1251996736 DEBUG: CecLogMessage - << Recorder 1 (1) -> TV (0): menu state 'activated'
09:46:32 T:1251996736 DEBUG: CecLogMessage - << 10:8e:00
09:46:32 T:1251996736 DEBUG: UpdateMenuLanguage - requesting the menu language of the TV
09:46:32 T:1251996736 DEBUG: CecLogMessage - << requesting menu language of 'TV' (0)
09:46:32 T:1251996736 DEBUG: CecLogMessage - << 10:91
09:46:32 T:1196422208 DEBUG: CecLogMessage - >> 01:00:8e:00
09:46:32 T:1196422208 DEBUG: CecLogMessage - >> TV (0) -> Recorder 1 (1): feature abort ( 0)
09:46:32 T:1196422208 DEBUG: CecLogMessage - >> 0f:32:65:6e:67
09:46:32 T:1196422208 DEBUG: CecLogMessage - >> TV (0) -> Broadcast (F): set menu language (32)
09:46:32 T:1196422208 DEBUG: CecLogMessage - TV (0): menu language set to 'eng'
09:46:32 T:1251996736 DEBUG: CecLogMessage - expected response received (32: set menu language)
09:46:32 T:1251996736 DEBUG: SetMenuLanguage - language set to 'English'
09:46:32 T:1251996736 DEBUG: CecLogMessage - << Recorder 1 (1) -> Recorder 2 (2): POLL
09:46:32 T:1251996736 DEBUG: CecLogMessage - << 12
09:46:32 T:1251996736 DEBUG: CecLogMessage - command 'POLL' was not acked by the controller
09:46:32 T:1251996736 DEBUG: CecLogMessage - >> POLL not sent
09:46:32 T:1251996736 DEBUG: CecLogMessage - Recorder 2 (2): device status changed into 'not present'
09:46:32 T:1251996736 DEBUG: CecLogMessage - << Recorder 1 (1) -> Tuner 1 (3): POLL
09:46:32 T:1251996736 DEBUG: CecLogMessage - << 13
09:46:32 T:1251996736 DEBUG: CecLogMessage - command 'POLL' was not acked by the controller
09:46:32 T:1251996736 DEBUG: CecLogMessage - >> POLL not sent
09:46:32 T:1251996736 DEBUG: CecLogMessage - Tuner 1 (3): device status changed into 'not present'
09:46:32 T:1251996736 DEBUG: CecLogMessage - << Recorder 1 (1) -> Playback 1 (4): POLL
09:46:32 T:1251996736 DEBUG: CecLogMessage - << 14
09:46:32 T:1251996736 DEBUG: CecLogMessage - command 'POLL' was not acked by the controller
09:46:32 T:1251996736 DEBUG: CecLogMessage - >> POLL not sent
09:46:32 T:1251996736 DEBUG: CecLogMessage - Playback 1 (4): device status changed into 'not present'
09:46:32 T:1251996736 DEBUG: CecLogMessage - Tuner 2 (6): device status changed into 'not present'
09:46:32 T:1251996736 DEBUG: CecLogMessage - Tuner 3 (7): device status changed into 'not present'
09:46:32 T:1251996736 DEBUG: CecLogMessage - Playback 2 (8): device status changed into 'not present'
09:46:32 T:1251996736 DEBUG: CecLogMessage - Recorder 3 (9): device status changed into 'not present'
09:46:32 T:1251996736 DEBUG: CecLogMessage - Tuner 4 (A): device status changed into 'not present'
09:46:32 T:1251996736 DEBUG: CecLogMessage - Playback 3 (B): device status changed into 'not present'
09:46:32 T:1251996736 DEBUG: CecLogMessage - Reserved 1 ©: device status changed into 'not present'
09:46:32 T:1251996736 DEBUG: CecLogMessage - Reserved 2 (D): device status changed into 'not present'
09:46:32 T:1251996736 DEBUG: CecLogMessage - Free use (E): device status changed into 'not present'
09:46:32 T:1251996736 DEBUG: CecLogMessage - << requesting OSD name of 'Audio' (5)
09:46:32 T:1251996736 DEBUG: CecLogMessage - << 15:46
09:46:33 T:1196422208 DEBUG: CecLogMessage - >> 51:47:41:56:20:41:4d:50
09:46:33 T:1196422208 DEBUG: CecLogMessage - >> Audio (5) -> Recorder 1 (1): set osd name (47)
09:46:33 T:1196422208 DEBUG: CecLogMessage - Audio (5): osd name set to 'AV AMP'
09:46:33 T:1251996736 DEBUG: CecLogMessage - expected response received (47: set osd name)
09:46:33 T:1251996736 DEBUG: UpdateAudioSystemStatus - CEC capable amplifier found (AV AMP). volume will be controlled on the amp
09:46:33 T:1251996736 DEBUG: CecLogMessage - << Recorder 1 (1) -> TV (0): display OSD message 'Connected'
09:46:33 T:1251996736 DEBUG: CecLogMessage - << 10:64:00:43:6f:6e:6e:65:63:74:65:64
09:46:33 T:1196422208 DEBUG: CecLogMessage - >> 01:00:64:00
09:46:33 T:1196422208 DEBUG: CecLogMessage - >> TV (0) -> Recorder 1 (1): feature abort ( 0)
09:46:33 T:1196422208 DEBUG: CecCommand - processing command: initiator=0 destination=1 opcode=00
09:46:33 T:1196422208 DEBUG: CecLogMessage - marking opcode 'set osd string' as unsupported feature for device 'TV'
Find all posts by this user
Quote this message in a reply
11-09-2012, 01:00 PM
Post: #8
RE: Please Help - HDMI CEC with Sony KDL 40X3000 + Sony STR-DN 1030
If it would help, I'd be happy to share my log with you to compare with yours, to see if/how they differ.
Youd need to tell me how to turn on the verbose logging.
Find all posts by this user
Quote this message in a reply
11-09-2012, 03:08 PM
Post: #9
RE: Please Help - HDMI CEC with Sony KDL 40X3000 + Sony STR-DN 1030
I coudn't find a way to do it via the GUI so I followed the instructions at vatious web pages, primarily http://thexbmcguide.com/general-knowledg...-xml-file/ & http://wiki.xbmc.org/index.php?title=Adv...ttings.xml & http://forum.stmlabs.com/showthread.php?tid=3554

Basically I used WinSCP to create a FTP session to the Pi and I created a file called 'advancedsettings.xml' in '/home/pi/.xbmc/userdata'.

Then using the edit function in WinSCP I added the following to the 'advancedsettings.xml' file.

Code:
<advancedsettings>
        <loglevel hide="false">1</loglevel>
</advancedsettings>

I then saved the file and restarted XBMC, I did it from a shell session using putty but restarting it from the XBMC gui should do the same thing. If you can find your way around a SSH session you can do the following:

Code:
sudo initctl stop xbmc
cd .xbmc/userdata/
ls -l |grep advancedsettings.xml
and check if file is present. if not (default not there)
touch advancedsettings.xml
nano advancedsettings.xml
and paste the code into it. press ctrl+x and say yes to save the file
sudo initctl start xbmc
settings are active

The log file is located at '/home/pi/.xbmc/temp' and is called 'xbmc.log', and you will have to wait a minute or two after rebooting for all the entries to be added.
Find all posts by this user
Quote this message in a reply
11-09-2012, 05:06 PM
Post: #10
RE: Please Help - HDMI CEC with Sony KDL 40X3000 + Sony STR-DN 1030
(11-09-2012 03:08 PM)initctl Wrote:  The log file is located at '/home/pi/.xbmc/temp' and is called 'xbmc.log', and you will have to wait a minute or two after rebooting for all the entries to be added.

I was quite chuffed with myself that I managed to do all this, using jusy my ipad, and being 200miles away from my Pi. Tongue

Code:
14:59:51 T:1076031488   DEBUG: LoadMappings - loaded node "Raspberry Pi CEC Adapter"
14:59:51 T:1076031488   DEBUG: LoadMappings - loaded node "Pulse-Eight CEC Adapter"
14:59:51 T:1076031488   DEBUG: LoadMappings - loaded node "iMON HID device"
14:59:51 T:1076031488   DEBUG: CPeripheralBusUSB - initialised udev monitor,
14:59:51 T:1076031488   DEBUG: GetMappingForDevice - device (2708:1001) mapped to Raspberry Pi CEC Adapter (type = cec)
14:59:51 T:1076031488   DEBUG: SECTION:LoadDLL(libcec.so.2)
14:59:51 T:1076031488   DEBUG: Loading: /home/pi/.upgrade/xbmc-rbp-20121105/xbmc-bcm/xbmc-bin/lib/xbmc/system/libcec.so.2
14:59:52 T:1076031488   DEBUG: InitialiseFeature - using libCEC v2.0.2
14:59:52 T:1076031488   DEBUG: Initialise - initialised peripheral on 'RPI' with 2 features and 0 sub devices
14:59:52 T:1076031488  NOTICE: Register - new cec device registered on rpi->RPI: Raspberry Pi CEC Adapter (2708:1001)
14:59:52 T:1121489984  NOTICE: Thread CEC Adapter start, auto delete: false
14:59:52 T:1121489984   DEBUG: GetComPort - autodetect com port 'RPI'
14:59:52 T:1121489984   DEBUG: OpenConnection - opening a connection to the CEC adapter: RPI
14:59:52 T:1121489984   DEBUG: CecLogMessage - unregistering all CEC clients
14:59:52 T:1121489984   DEBUG: CecLogMessage - Broadcast (F): osd name set to 'Broadcast'
14:59:52 T:1121489984   DEBUG: CecLogMessage - InitHostCEC - vchiq_initialise succeeded
14:59:52 T:1121489984   DEBUG: CecLogMessage - InitHostCEC - vchi_initialise succeeded
14:59:52 T:1121489984   DEBUG: CecLogMessage - InitHostCEC - vchi_connect succeeded
...

...
14:59:56 T:1121489984   DEBUG: CecLogMessage - InitHostCEC - vchiq_initialise succeeded
14:59:56 T:1121489984   DEBUG: CecLogMessage - InitHostCEC - vchi_initialise succeeded
14:59:56 T:1121489984   DEBUG: CecLogMessage - InitHostCEC - vchi_connect succeeded
14:59:56 T:1155765312   DEBUG: CecLogMessage - logical address changed to Broadcast (f)
14:59:56 T:1121489984   DEBUG: CecLogMessage - RegisterLogicalAddress - registering address e
14:59:56 T:1121489984   ERROR: CecLogMessage - RegisterLogicalAddress - vc_cec_set_logical_address(E) returned invalid arg (8)
14:59:56 T:1121489984   ERROR: CecLogMessage - Open - vc_cec could not be initialised
14:59:56 T:1121489984   DEBUG: CecLogMessage - connection opened
14:59:56 T:1121489984   DEBUG: CecLogMessage - << Broadcast (F) -> TV (0): POLL
14:59:56 T:1121489984   DEBUG: CecLogMessage - initiator 'Broadcast' is not supported by the CEC adapter. using 'Free use' instead
14:59:56 T:1121489984   DEBUG: CecLogMessage - << e0
14:59:56 T:1121489984   DEBUG: CecLogMessage - >> POLL not sent
14:59:56 T:1121489984   DEBUG: CecLogMessage - TV (0): device status changed into 'not present'
14:59:56 T:1121489984   DEBUG: CecLogMessage - registering new CEC client - v2.0.0
14:59:56 T:1121489984   DEBUG: CecLogMessage - detecting logical address for type 'recording device'
14:59:56 T:1121489984   DEBUG: CecLogMessage - trying logical address 'Recorder 1'
14:59:56 T:1121489984   DEBUG: CecLogMessage - << Recorder 1 (1) -> Recorder 1 (1): POLL
14:59:56 T:1121489984   DEBUG: CecLogMessage - << 11
14:59:56 T:1121489984   DEBUG: CecLogMessage - >> POLL not sent
14:59:56 T:1121489984   DEBUG: CecLogMessage - using logical address 'Recorder 1'
14:59:56 T:1121489984   DEBUG: CecLogMessage - Recorder 1 (1): device status changed into 'handled by libCEC'
14:59:56 T:1121489984   DEBUG: CecLogMessage - Recorder 1 (1): power status changed from 'unknown' to 'on'
14:59:56 T:1121489984   DEBUG: CecLogMessage - Recorder 1 (1): CEC version 1.4
14:59:56 T:1121489984   DEBUG: CecLogMessage - AllocateLogicalAddresses - device '0', type 'recording device', LA '1'
14:59:56 T:1121489984   DEBUG: CecLogMessage - RegisterLogicalAddress - registering address 1
14:59:56 T:1194177600   DEBUG: CecLogMessage - processor thread started
14:59:56 T:1121489984   ERROR: CecLogMessage - RegisterLogicalAddress - vc_cec_set_logical_address(1) returned invalid arg (8)
14:59:56 T:1121489984   DEBUG: CecLogMessage - Recorder 1 (1): osd name set to 'XBMC'
14:59:56 T:1121489984   DEBUG: CecLogMessage - Recorder 1 (1): menu language set to 'eng'
14:59:56 T:1121489984   DEBUG: CecLogMessage - SetDevicePhysicalAddress - not setting invalid physical address ffff
14:59:56 T:1121489984   DEBUG: CecLogMessage - setting HDMI port to 1 on device TV (0)
14:59:56 T:1121489984   DEBUG: CecLogMessage - Recorder 1 (1): physical address changed from ffff to 1000
14:59:56 T:1121489984   DEBUG: CecLogMessage - << Recorder 1 (1) -> broadcast (F): physical adddress 1000
14:59:56 T:1121489984   DEBUG: CecLogMessage - << 1f:84:10:00:01
14:59:57 T:1076031488   DEBUG: Previous line repeats 1 times.
...

...
14:59:57 T:1121489984   DEBUG: CecLogMessage - making Recorder 1 (1) the active source
14:59:57 T:1121489984   DEBUG: CecLogMessage - >> source activated: Recorder 1 (1)
14:59:57 T:1121489984   DEBUG: CecLogMessage - scheduling active source message for 'Recorder 1'
14:59:57 T:1121489984   DEBUG: CecLogMessage - CEC client registered: libCEC version = 2.0.2, client version = 2.0.0, firmware version = 1, logical address(es) = Recorder 1 (1) , base device: TV (0), HDMI port number: 1, physical address: 1.0.0.0, host: arm-bcm2708hardfp-linux-gnueabi, features: 'P8 USB' 'P8 USB detect' 'RPi', git revision: a9ac151, compiled on: Thu Oct 18 20:01:19 UTC 2012 by root@ on Linux 3.2.0-31-generic (x86_64)
14:59:57 T:1121489984   DEBUG: CecLogMessage - << requesting power status of 'TV' (0)
14:59:57 T:1121489984   DEBUG: CecLogMessage - not sending command 'give device power status': destination device 'TV' marked as not present
14:59:57 T:1121489984   DEBUG: OpenConnection - connection to the CEC adapter opened
14:59:57 T:1121489984   DEBUG: CecLogMessage - << powering on 'TV' (0)
14:59:57 T:1121489984   DEBUG: CecLogMessage - not sending command 'image view on': destination device 'TV' marked as not present
14:59:57 T:1121489984   DEBUG: CecLogMessage - Recorder 1 (1) was already marked as active source
14:59:57 T:1121489984   DEBUG: CecLogMessage - sending active source message for 'Recorder 1'
14:59:57 T:1121489984   DEBUG: CecLogMessage - TV not present, not sending 'image view on'
14:59:57 T:1121489984   DEBUG: CecLogMessage - << Recorder 1 (1) -> broadcast (F): active source (1000)
14:59:57 T:1121489984   DEBUG: CecLogMessage - << 1f:82:10:00
14:59:57 T:1121489984   DEBUG: Previous line repeats 1 times.
14:59:57 T:1121489984   DEBUG: CecLogMessage - failed to make 'Recorder 1' the active source. will retry later
14:59:57 T:1202566208  NOTICE: Thread CEC Adapter Update Thread start, auto delete: false
14:59:57 T:1202566208   DEBUG: CecLogMessage - << powering on 'TV' (0)
14:59:57 T:1202566208   DEBUG: CecLogMessage - not sending command 'image view on': destination device 'TV' marked as not present
14:59:57 T:1202566208   DEBUG: CecLogMessage - Recorder 1 (1) was already marked as active source
14:59:57 T:1202566208   DEBUG: CecLogMessage - sending active source message for 'Recorder 1'
14:59:57 T:1202566208   DEBUG: CecLogMessage - TV not present, not sending 'image view on'
14:59:57 T:1202566208   DEBUG: CecLogMessage - << Recorder 1 (1) -> broadcast (F): active source (1000)
14:59:57 T:1202566208   DEBUG: CecLogMessage - << 1f:82:10:00
14:59:57 T:1202566208   DEBUG: Previous line repeats 1 times.
14:59:57 T:1202566208   DEBUG: CecLogMessage - failed to make 'Recorder 1' the active source. will retry later
14:59:58 T:1076031488    INFO: JSONRPC: Successfully initialized
Find all posts by this user
Quote this message in a reply
Post Reply 


Forum Jump:


User(s) browsing this thread: 1 Guest(s)

Sponsored Advertisement