search

Pulse-Eight / libcec

USB CEC Adapter communication Library http://libcec.pulse-eight.com/
Other
714 stars 287 forks source link

Cec + lg tv problem #545

Open Ph0bos99 opened 3 years ago

Ph0bos99 commented 3 years ago

Hardware¨

Software

Bug description Problem is, that the CEC (control Vero via tv remote) works for a couple of seconds then it does not for a while and then again it works. Since I have no problem with CEC on my previous tv (old plasma panasonic) I was thinking I did something to the HDMI cable when switching to the new tv, so I bought a new one, but that did not help. I have also tried numerous restarts and unpluggings of tv, vero 4k+ from HDMI and from the power, nothing helps.

Here is a log from echo scan | cec-client (from vero via ssh)

No device type given. Using recording device CEC Parser created - libCEC version 4.0.4 no serial port given. trying autodetect: path: /dev/aocec com port: AOCEC

opening a connection to the CEC adapter...

DEBUG:   [             156]     Broadcast (F): osd name set to 'Broadcast' NOTICE:  [             157]     connection opened DEBUG:   [             157]     processor thread started DEBUG:   [             157]     << Broadcast (F) -> TV (0): POLL TRAFFIC: [             157]     << f0 DEBUG:   [             219]     >> POLL sent DEBUG:   [             219]     TV (0): device status changed into 'present' DEBUG:   [             219]     << requesting vendor ID of 'TV' (0) TRAFFIC: [             219]     << f0:8c TRAFFIC: [             436]     >> 0f:87:00:e0:91 DEBUG:   [             437]     >> TV (0) -> Broadcast (F): device vendor id (87) DEBUG:   [             437]     TV (0): vendor = LG (00e091) DEBUG:   [             437]     expected response received (87: device vendor id) DEBUG:   [             437]     replacing the command handler for device 'TV' (0) DEBUG:   [             437]     TV (0): CEC version 1.3a DEBUG:   [             437]     TV (0): menu language set to 'eng' NOTICE:  [             437]     registering new CEC client - v4.0.4 DEBUG:   [             437]     detecting logical address for type 'recording device' DEBUG:   [             437]     trying logical address 'Recorder 1' DEBUG:   [             437]     << Recorder 1 (1) -> Recorder 1 (1): POLL TRAFFIC: [             437]     << 11 WARNING: [             649]     Write: write failed TRAFFIC: [             649]     << 11 WARNING: [             849]     Write: write failed DEBUG:   [             849]     >> POLL not sent DEBUG:   [             849]     using logical address 'Recorder 1' DEBUG:   [             849]     Recorder 1 (1): device status changed into 'handled by libCEC' DEBUG:   [             849]     Recorder 1 (1): power status changed from 'unknown' to 'on' DEBUG:   [             849]     Recorder 1 (1): vendor = Pulse Eight (001582) DEBUG:   [             849]     Recorder 1 (1): CEC version 1.4 DEBUG:   [             849]     AllocateLogicalAddresses - device '0', type 'recording device', LA '1' DEBUG:   [             850]     Recorder 1 (1): osd name set to 'CECTester' DEBUG:   [             850]     Recorder 1 (1): menu language set to 'eng' DEBUG:   [             850]     AutodetectPhysicalAddress - autodetected physical address '1000' DEBUG:   [             850]     Recorder 1 (1): physical address changed from ffff to 1000 DEBUG:   [             850]     << Recorder 1 (1) -> broadcast (F): physical address 1000 TRAFFIC: [             850]     << 1f:84:10:00:01 NOTICE:  [            1009]     CEC client registered: libCEC version = 4.0.4, client version = 4.0.4, firmware version = 5, logical address(es) = Recorder 1 (1) , physical address: 1.0.0.0,  compiled on Thu Jul  2 21:53:58 UTC 2020 by root@compiler2 on Linux 4.19.0-9-amd64 (armv7l), features: P8_USB, DRM, P8_detect, AOCEC DEBUG:   [            1009]     Recorder 1 (1): vendor = LG (00e091) DEBUG:   [            1009]     replacing the command handler for device 'Recorder 1' (1) DEBUG:   [            1009]     Recorder 1 (1): CEC version 1.3a DEBUG:   [            1009]     << Recorder 1 (1) -> TV (0): OSD name 'CECTester' TRAFFIC: [            1009]     << 10:47:43:45:43:54:65:73:74:65:72 DEBUG:   [            1339]     << requesting power status of 'TV' (0) TRAFFIC: [            1339]     << 10:8f DEBUG:   [            2479]     expected response not received (90: report power status) TRAFFIC: [            2479]     << 10:8f TRAFFIC: [            2648]     >> 01:90:00 DEBUG:   [            2648]     TV (0): power status changed from 'unknown' to 'on' DEBUG:   [            2648]     >> TV (0) -> Recorder 1 (1): report power status (90) waiting for input requesting CEC bus information ... DEBUG:   [            2648]     expected response received (90: report power status) DEBUG:   [            2648]     << Recorder 1 (1) -> Recorder 2 (2): POLL TRAFFIC: [            2648]     << 12 WARNING: [            2859]     Write: write failed TRAFFIC: [            2859]     << 12 WARNING: [            3179]     Write: write failed DEBUG:   [            3179]     >> POLL not sent DEBUG:   [            3179]     Recorder 2 (2): device status changed into 'not present' DEBUG:   [            3179]     << Recorder 1 (1) -> Tuner 1 (3): POLL TRAFFIC: [            3179]     << 13 WARNING: [            3379]     Write: write failed TRAFFIC: [            3379]     << 13 WARNING: [            3579]     Write: write failed DEBUG:   [            3579]     >> POLL not sent DEBUG:   [            3579]     Tuner 1 (3): device status changed into 'not present' DEBUG:   [            3579]     << Recorder 1 (1) -> Playback 1 (4): POLL TRAFFIC: [            3579]     << 14 WARNING: [            3779]     Write: write failed TRAFFIC: [            3779]     << 14 WARNING: [            3979]     Write: write failed DEBUG:   [            3979]     >> POLL not sent DEBUG:   [            3979]     Playback 1 (4): device status changed into 'not present' DEBUG:   [            3979]     << Recorder 1 (1) -> Audio (5): POLL TRAFFIC: [            3979]     << 15 WARNING: [            4189]     Write: write failed TRAFFIC: [            4189]     << 15 WARNING: [            4389]     Write: write failed DEBUG:   [            4389]     >> POLL not sent DEBUG:   [            4389]     Audio (5): device status changed into 'not present' DEBUG:   [            4389]     << Recorder 1 (1) -> Tuner 2 (6): POLL TRAFFIC: [            4389]     << 16 WARNING: [            4589]     Write: write failed TRAFFIC: [            4589]     << 16 WARNING: [            4789]     Write: write failed DEBUG:   [            4789]     >> POLL not sent DEBUG:   [            4789]     Tuner 2 (6): device status changed into 'not present' DEBUG:   [            4789]     << Recorder 1 (1) -> Tuner 3 (7): POLL TRAFFIC: [            4789]     << 17 DEBUG:   [            6829]     >> POLL sent DEBUG:   [            6829]     Tuner 3 (7): device status changed into 'present' DEBUG:   [            6829]     << Recorder 1 (1) -> Playback 2 (8): POLL TRAFFIC: [            6829]     << 18 TRAFFIC: [            6829]     >> 01:44:02 DEBUG:   [            6829]     >> TV (0) -> Recorder 1 (1): user control pressed (44) WARNING: [            7029]     Write: write failed TRAFFIC: [            7029]     << 18 WARNING: [            7229]     Write: write failed DEBUG:   [            7229]     >> POLL not sent DEBUG:   [            7229]     Playback 2 (8): device status changed into 'not present' DEBUG:   [            7229]     << Recorder 1 (1) -> Recorder 3 (9): POLL TRAFFIC: [            7229]     << 19 WARNING: [            7949]     Write: write failed TRAFFIC: [            7949]     << 19 WARNING: [            8149]     Write: write failed DEBUG:   [            8149]     >> POLL not sent DEBUG:   [            8149]     Recorder 3 (9): device status changed into 'not present' DEBUG:   [            8149]     << Recorder 1 (1) -> Tuner 4 (A): POLL TRAFFIC: [            8149]     << 1a DEBUG:   [           10189]     >> POLL sent DEBUG:   [           10189]     Tuner 4 (A): device status changed into 'present' DEBUG:   [           10189]     SetCurrentButton down (2) D:0ms cur:2 DEBUG:   [           10189]     key pressed: down (2) current(ff) duration(0) DEBUG:   [           10189]     Changed key down (2) D:0ms cur:ff DEBUG:   [           10189]     << Recorder 1 (1) -> Playback 3 (B): POLL TRAFFIC: [           10189]     << 1b DEBUG:   [           10189]     key pressed: down (2, 0) DEBUG:   [           10189]     making Recorder 1 (1) the active source WARNING: [           10649]     Write: write failed NOTICE:  [           10649]     >> source activated: Recorder 1 (1) DEBUG:   [           10649]     CheckKeypressTimeout T:129.870 DEBUG:   [           10649]     Key down: idle (duration:0) (2) timeout:-170926648ms (rel:40,rep:0,prs:40,rel:0) TRAFFIC: [           10649]     >> 01:44:02 DEBUG:   [           10649]     SetCurrentButton down (2) D:0ms cur:2 DEBUG:   [           10649]     key pressed: down (2) current(2) duration(0) DEBUG:   [           10649]     key pressed: down (2, 0) DEBUG:   [           10649]     CheckKeypressTimeout T:129.870 DEBUG:   [           10649]     Key down: idle (duration:0) (2) timeout:-170926648ms (rel:500,rep:0,prs:500,rel:0) TRAFFIC: [           10649]     >> 01:45 DEBUG:   [           10649]     key released: down (2) D:460ms TRAFFIC: [           10649]     >> 01:45 TRAFFIC: [           10649]     >> 01:45 TRAFFIC: [           10649]     >> 01 DEBUG:   [           10649]     << POLL: TV (0) -> Recorder 1 (1) TRAFFIC: [           10649]     >> 01:89:0b DEBUG:   [           10649]     Recorder 1 (1): power status changed from 'on' to 'in transition from standby to on' DEBUG:   [           10649]     << Recorder 1 (1) -> TV (0): in transition from standby to on TRAFFIC: [           10649]     << 10:90:02 DEBUG:   [           10649]     >> TV (0) -> Recorder 1 (1): user control pressed (44) DEBUG:   [           10649]     >> TV (0) -> Recorder 1 (1): user control release (45) DEBUG:   [           10649]     >> TV (0) -> Recorder 1 (1): user control release (45) DEBUG:   [           10649]     >> TV (0) -> Recorder 1 (1): user control release (45) DEBUG:   [           10649]     >> TV (0) -> Recorder 1 (1): vendor command (89) DEBUG:   [           10839]     Recorder 1 (1): power status changed from 'in transition from standby to on' to 'on' TRAFFIC: [           10839]     << 1b WARNING: [           11159]     Write: write failed DEBUG:   [           11159]     >> POLL not sent DEBUG:   [           11159]     Playback 3 (B): device status changed into 'not present' DEBUG:   [           11159]     << Recorder 1 (1) -> Reserved 1 (C): POLL TRAFFIC: [           11159]     << 1c WARNING: [           11359]     Write: write failed TRAFFIC: [           11359]     << 1c WARNING: [           11559]     Write: write failed DEBUG:   [           11559]     >> POLL not sent DEBUG:   [           11559]     Reserved 1 (C): device status changed into 'not present' DEBUG:   [           11559]     << Recorder 1 (1) -> Reserved 2 (D): POLL TRAFFIC: [           11559]     << 1d WARNING: [           11759]     Write: write failed TRAFFIC: [           11759]     << 1d WARNING: [           11959]     Write: write failed DEBUG:   [           11959]     >> POLL not sent DEBUG:   [           11959]     Reserved 2 (D): device status changed into 'not present' DEBUG:   [           11959]     << Recorder 1 (1) -> Free use (E): POLL TRAFFIC: [           11959]     << 1e WARNING: [           12169]     Write: write failed TRAFFIC: [           12169]     << 1e WARNING: [           12369]     Write: write failed DEBUG:   [           12369]     >> POLL not sent DEBUG:   [           12369]     Free use (E): device status changed into 'not present' DEBUG:   [           12369]     << requesting vendor ID of 'Tuner 3' (7) TRAFFIC: [           12369]     << 17:8c WARNING: [           12549]     Write: write failed TRAFFIC: [           12549]     << 17:8c WARNING: [           12729]     Write: write failed DEBUG:   [           12729]     << requesting vendor ID of 'Tuner 3' (7) TRAFFIC: [           12729]     << 17:8c WARNING: [           12909]     Write: write failed TRAFFIC: [           12909]     << 17:8c WARNING: [           13089]     Write: write failed DEBUG:   [           13089]     << requesting physical address of 'Tuner 3' (7) TRAFFIC: [           13089]     << 17:83 WARNING: [           13269]     Write: write failed TRAFFIC: [           13269]     << 17:83 WARNING: [           13449]     Write: write failed ERROR:   [           13449]     failed to request the physical address DEBUG:   [           13450]     << requesting CEC version of 'Tuner 3' (7) TRAFFIC: [           13450]     << 17:9f WARNING: [           13629]     Write: write failed TRAFFIC: [           13629]     << 17:9f WARNING: [           13809]     Write: write failed DEBUG:   [           13809]     << requesting power status of 'Tuner 3' (7) TRAFFIC: [           13809]     << 17:8f WARNING: [           13989]     Write: write failed TRAFFIC: [           13989]     << 17:8f WARNING: [           14169]     Write: write failed DEBUG:   [           14169]     << requesting OSD name of 'Tuner 3' (7) TRAFFIC: [           14169]     << 17:46 WARNING: [           14349]     Write: write failed TRAFFIC: [           14349]     << 17:46 WARNING: [           14529]     Write: write failed DEBUG:   [           14529]     << requesting menu language of 'Tuner 3' (7) TRAFFIC: [           14529]     << 17:91 WARNING: [           14709]     Write: write failed TRAFFIC: [           14709]     << 17:91 WARNING: [           14889]     Write: write failed DEBUG:   [           14889]     << requesting vendor ID of 'Tuner 4' (A) TRAFFIC: [           14889]     << 1a:8c WARNING: [           15069]     Write: write failed TRAFFIC: [           15069]     << 1a:8c WARNING: [           15249]     Write: write failed DEBUG:   [           15249]     << requesting vendor ID of 'Tuner 4' (A) TRAFFIC: [           15249]     << 1a:8c WARNING: [           15429]     Write: write failed TRAFFIC: [           15429]     << 1a:8c WARNING: [           15609]     Write: write failed DEBUG:   [           15609]     << requesting physical address of 'Tuner 4' (A) TRAFFIC: [           15609]     << 1a:83 WARNING: [           15789]     Write: write failed TRAFFIC: [           15789]     << 1a:83 WARNING: [           15969]     Write: write failed ERROR:   [           15969]     failed to request the physical address DEBUG:   [           15969]     << requesting CEC version of 'Tuner 4' (A) TRAFFIC: [           15969]     << 1a:9f WARNING: [           16149]     Write: write failed TRAFFIC: [           16149]     << 1a:9f WARNING: [           16329]     Write: write failed DEBUG:   [           16329]     << requesting power status of 'Tuner 4' (A) TRAFFIC: [           16329]     << 1a:8f WARNING: [           16509]     Write: write failed TRAFFIC: [           16509]     << 1a:8f WARNING: [           16689]     Write: write failed DEBUG:   [           16689]     << requesting OSD name of 'Tuner 4' (A) TRAFFIC: [           16689]     << 1a:46 WARNING: [           16869]     Write: write failed TRAFFIC: [           16869]     << 1a:46 WARNING: [           17049]     Write: write failed DEBUG:   [           17049]     << requesting menu language of 'Tuner 4' (A) TRAFFIC: [           17049]     << 1a:91 WARNING: [           17230]     Write: write failed TRAFFIC: [           17230]     << 1a:91 WARNING: [           17409]     Write: write failed CEC bus information =================== device #0: TV address:       0.0.0.0 active source: no vendor:        LG osd string:    TV CEC version:   1.3a power status:  on language:      eng

device #1: Recorder 1 address:       1.0.0.0 active source: yes vendor:        LG osd string:    CECTester CEC version:   1.3a power status:  on language:      eng device #7: Tuner 3 address:       f.f.f.f active source: no vendor:        Unknown osd string:    Tuner 3 CEC version:   unknown power status:  unknown language:      ??? device #A: Tuner 4 address:       f.f.f.f active source: no vendor:        Unknown osd string:    Tuner 4 CEC version:   unknown power status:  unknown language:      ??? currently active source: Recorder 1 (1) TRAFFIC: [           23229]     >> 01 DEBUG:   [           23229]     << POLL: TV (0) -> Recorder 1 (1) TRAFFIC: [           28219]     >> 01:44:02 DEBUG:   [           28219]     SetCurrentButton down (2) D:0ms cur:2 DEBUG:   [           28219]     key pressed: down (2) current(ff) duration(0) DEBUG:   [           28219]     Changed key down (2) D:0ms cur:ff DEBUG:   [           28219]     key pressed: down (2, 0) DEBUG:   [           28219]     CheckKeypressTimeout T:147.440 DEBUG:   [           28219]     Key down: idle (duration:0) (2) timeout:-170926648ms (rel:500,rep:0,prs:500,rel:0) DEBUG:   [           28219]     >> TV (0) -> Recorder 1 (1): user control pressed (44) TRAFFIC: [           28481]     >> 01:44:02 DEBUG:   [           28481]     SetCurrentButton down (2) D:0ms cur:2 DEBUG:   [           28481]     key pressed: down (2) current(2) duration(0) DEBUG:   [           28481]     key pressed: down (2, 0) DEBUG:   [           28481]     CheckKeypressTimeout T:147.702 DEBUG:   [           28481]     Key down: idle (duration:0) (2) timeout:-170926648ms (rel:500,rep:0,prs:500,rel:0) DEBUG:   [           28482]     >> TV (0) -> Recorder 1 (1): user control pressed (44) TRAFFIC: [           28870]     >> 01:44:02 DEBUG:   [           28870]     SetCurrentButton down (2) D:0ms cur:2 DEBUG:   [           28870]     key pressed: down (2) current(2) duration(0) DEBUG:   [           28870]     key pressed: down (2, 0) DEBUG:   [           28870]     CheckKeypressTimeout T:148.091 DEBUG:   [           28870]     Key down: idle (duration:0) (2) timeout:-170926648ms (rel:500,rep:0,prs:500,rel:0) DEBUG:   [           28870]     >> TV (0) -> Recorder 1 (1): user control pressed (44) TRAFFIC: [           29269]     >> 01:44:02 DEBUG:   [           29269]     SetCurrentButton down (2) D:0ms cur:2 DEBUG:   [           29269]     key pressed: down (2) current(2) duration(0) DEBUG:   [           29269]     key pressed: down (2, 0) DEBUG:   [           29269]     CheckKeypressTimeout T:148.490 DEBUG:   [           29269]     Key down: idle (duration:0) (2) timeout:-170926648ms (rel:500,rep:0,prs:500,rel:0) DEBUG:   [           29269]     >> TV (0) -> Recorder 1 (1): user control pressed (44) TRAFFIC: [           29759]     >> 01:45 DEBUG:   [           29759]     key released: down (2) D:1540ms DEBUG:   [           29759]     >> TV (0) -> Recorder 1 (1): user control release (45) TRAFFIC: [           32638]     >> 01:45 DEBUG:   [           32639]     >> TV (0) -> Recorder 1 (1): user control release (45) TRAFFIC: [           37230]     >> 01 DEBUG:   [           37230]     << POLL: TV (0) -> Recorder 1 (1)