2019-06-08 10:07:23.047 T:3768525680 DEBUG: CecLogMessage - Broadcast (F): osd name set to 'Broadcast' 2019-06-08 10:07:23.047 T:3768525680 DEBUG: CecLogMessage - connection opened 2019-06-08 10:07:23.047 T:3768525680 DEBUG: CecLogMessage - processor thread started 2019-06-08 10:07:23.047 T:3768525680 DEBUG: CecLogMessage - << Broadcast (F) -> TV (0): POLL 2019-06-08 10:07:23.047 T:3768525680 DEBUG: CecLogMessage - << f0 2019-06-08 10:07:23.101 T:3768525680 DEBUG: CecLogMessage - >> POLL sent 2019-06-08 10:07:23.101 T:3768525680 DEBUG: CecLogMessage - TV (0): device status changed into 'present' 2019-06-08 10:07:23.101 T:3768525680 DEBUG: CecLogMessage - << requesting vendor ID of 'TV' (0) 2019-06-08 10:07:23.101 T:3768525680 DEBUG: CecLogMessage - << f0:8c 2019-06-08 10:07:24.182 T:3768525680 DEBUG: CecLogMessage - expected response not received (87: device vendor id) 2019-06-08 10:07:24.182 T:3768525680 DEBUG: CecLogMessage - << f0:8c 2019-06-08 10:07:25.262 T:3768525680 DEBUG: CecLogMessage - expected response not received (87: device vendor id) 2019-06-08 10:07:25.262 T:3768525680 DEBUG: CecLogMessage - registering new CEC client - v4.0.0 2019-06-08 10:07:25.262 T:3768525680 DEBUG: CecLogMessage - detecting logical address for type 'recording device' 2019-06-08 10:07:25.262 T:3768525680 DEBUG: CecLogMessage - trying logical address 'Recorder 1' 2019-06-08 10:07:25.262 T:3768525680 DEBUG: CecLogMessage - << Recorder 1 (1) -> Recorder 1 (1): POLL 2019-06-08 10:07:25.262 T:3768525680 DEBUG: CecLogMessage - << 11 2019-06-08 10:07:25.322 T:3768525680 WARNING: CecLogMessage - Write: write failed 2019-06-08 10:07:25.322 T:3768525680 DEBUG: CecLogMessage - << 11 2019-06-08 10:07:25.381 T:3768525680 WARNING: CecLogMessage - Write: write failed 2019-06-08 10:07:25.381 T:3768525680 DEBUG: CecLogMessage - >> POLL not sent 2019-06-08 10:07:25.381 T:3768525680 DEBUG: CecLogMessage - using logical address 'Recorder 1' 2019-06-08 10:07:25.381 T:3768525680 DEBUG: CecLogMessage - Recorder 1 (1): device status changed into 'handled by libCEC' 2019-06-08 10:07:25.381 T:3768525680 DEBUG: CecLogMessage - Recorder 1 (1): power status changed from 'unknown' to 'on' 2019-06-08 10:07:25.381 T:3768525680 DEBUG: CecLogMessage - Recorder 1 (1): vendor = Pulse Eight (001582) 2019-06-08 10:07:25.382 T:3768525680 DEBUG: CecLogMessage - Recorder 1 (1): CEC version 1.4 2019-06-08 10:07:25.382 T:3768525680 DEBUG: CecLogMessage - AllocateLogicalAddresses - device '0', type 'recording device', LA '1' 2019-06-08 10:07:25.382 T:3768525680 DEBUG: CecLogMessage - Recorder 1 (1): osd name set to 'Kodi' 2019-06-08 10:07:25.382 T:3768525680 DEBUG: CecLogMessage - Recorder 1 (1): menu language set to 'eng' 2019-06-08 10:07:25.382 T:3768525680 DEBUG: CecLogMessage - AutodetectPhysicalAddress - autodetected physical address '2500' 2019-06-08 10:07:25.382 T:3768525680 DEBUG: CecLogMessage - Recorder 1 (1): physical address changed from ffff to 2500 2019-06-08 10:07:25.382 T:3768525680 DEBUG: CecLogMessage - << Recorder 1 (1) -> broadcast (F): physical address 2500 2019-06-08 10:07:25.382 T:3768525680 DEBUG: CecLogMessage - << 1f:84:25:00:01 2019-06-08 10:07:25.535 T:3768525680 DEBUG: CecLogMessage - CEC client registered: libCEC version = 4.0.4, client version = 4.0.0, firmware version = 5, logical address(es) = Recorder 1 (1) , physical address: 2.5.0.0, compiled on Fri Jun 7 23:08:52 UTC 2019 by relkai@hammbwcor01 on Linux 4.15.0-48-generic (x86_64), features: P8_USB, DRM, P8_detect, AOCEC 2019-06-08 10:07:25.535 T:3768525680 DEBUG: CecLogMessage - << Recorder 1 (1) -> TV (0): OSD name 'Kodi' 2019-06-08 10:07:25.535 T:3768525680 DEBUG: CecLogMessage - << 10:47:4b:6f:64:69 2019-06-08 10:07:25.715 T:3768525680 DEBUG: CecLogMessage - << requesting power status of 'TV' (0) 2019-06-08 10:07:25.715 T:3768525680 DEBUG: CecLogMessage - << 10:8f 2019-06-08 10:07:25.839 T:3768525680 DEBUG: CecLogMessage - >> 01:00:47:00 2019-06-08 10:07:25.839 T:3768525680 DEBUG: CecLogMessage - marking opcode 'set osd name' as unsupported feature for device 'TV' 2019-06-08 10:07:25.839 T:3768525680 DEBUG: CecLogMessage - >> TV (0) -> Recorder 1 (1): feature abort ( 0) 2019-06-08 10:07:26.042 T:3768525680 DEBUG: CecLogMessage - >> 01:90:00 2019-06-08 10:07:26.042 T:3768525680 DEBUG: CecLogMessage - TV (0): power status changed from 'unknown' to 'on' 2019-06-08 10:07:26.042 T:3768525680 DEBUG: CecLogMessage - >> TV (0) -> Recorder 1 (1): report power status (90) 2019-06-08 10:07:26.042 T:3768525680 DEBUG: CecLogMessage - expected response received (90: report power status) 2019-06-08 10:07:26.043 T:3768525680 DEBUG: CecLogMessage - << Recorder 1 (1) -> Recorder 2 (2): POLL 2019-06-08 10:07:26.043 T:3768525680 DEBUG: CecLogMessage - << 12 2019-06-08 10:07:26.101 T:3768525680 WARNING: CecLogMessage - Write: write failed 2019-06-08 10:07:26.101 T:3768525680 DEBUG: CecLogMessage - << 12 2019-06-08 10:07:26.168 T:3768525680 DEBUG: CecLogMessage - >> 01:8c 2019-06-08 10:07:26.168 T:3768525680 DEBUG: CecLogMessage - >> TV (0) -> Recorder 1 (1): give device vendor id (8C) 2019-06-08 10:07:26.245 T:3768525680 WARNING: CecLogMessage - Write: write failed 2019-06-08 10:07:26.245 T:3768525680 DEBUG: CecLogMessage - >> POLL not sent 2019-06-08 10:07:26.245 T:3768525680 DEBUG: CecLogMessage - Recorder 2 (2): device status changed into 'not present' 2019-06-08 10:07:26.245 T:3768525680 DEBUG: CecLogMessage - << Recorder 1 (1) -> Tuner 1 (3): POLL 2019-06-08 10:07:26.245 T:3768525680 DEBUG: CecLogMessage - << 13 2019-06-08 10:07:26.301 T:3768525680 DEBUG: CecLogMessage - >> POLL sent 2019-06-08 10:07:26.301 T:3768525680 DEBUG: CecLogMessage - Tuner 1 (3): device status changed into 'present' 2019-06-08 10:07:26.301 T:3768525680 DEBUG: CecLogMessage - << Recorder 1 (1) -> Playback 1 (4): POLL 2019-06-08 10:07:26.301 T:3768525680 DEBUG: CecLogMessage - << 14 2019-06-08 10:07:26.357 T:3768525680 WARNING: CecLogMessage - Write: write failed 2019-06-08 10:07:26.357 T:3768525680 DEBUG: CecLogMessage - << 14 2019-06-08 10:07:26.413 T:3768525680 WARNING: CecLogMessage - Write: write failed 2019-06-08 10:07:26.413 T:3768525680 DEBUG: CecLogMessage - >> POLL not sent 2019-06-08 10:07:26.413 T:3768525680 DEBUG: CecLogMessage - Playback 1 (4): device status changed into 'not present' 2019-06-08 10:07:26.414 T:3768525680 DEBUG: CecLogMessage - << Recorder 1 (1) -> Audio (5): POLL 2019-06-08 10:07:26.414 T:3768525680 DEBUG: CecLogMessage - << 15 2019-06-08 10:07:26.469 T:3768525680 DEBUG: CecLogMessage - >> POLL sent 2019-06-08 10:07:26.469 T:3768525680 DEBUG: CecLogMessage - Audio (5): device status changed into 'present' 2019-06-08 10:07:26.469 T:3768525680 DEBUG: CecLogMessage - << Recorder 1 (1) -> Tuner 2 (6): POLL 2019-06-08 10:07:26.469 T:3768525680 DEBUG: CecLogMessage - << 16 2019-06-08 10:07:26.529 T:3768525680 WARNING: CecLogMessage - Write: write failed 2019-06-08 10:07:26.529 T:3768525680 DEBUG: CecLogMessage - << 16 2019-06-08 10:07:26.585 T:3768525680 WARNING: CecLogMessage - Write: write failed 2019-06-08 10:07:26.585 T:3768525680 DEBUG: CecLogMessage - >> POLL not sent 2019-06-08 10:07:26.585 T:3768525680 DEBUG: CecLogMessage - Tuner 2 (6): device status changed into 'not present' 2019-06-08 10:07:26.585 T:3768525680 DEBUG: CecLogMessage - << Recorder 1 (1) -> Tuner 3 (7): POLL 2019-06-08 10:07:26.585 T:3768525680 DEBUG: CecLogMessage - << 17 2019-06-08 10:07:26.641 T:3768525680 WARNING: CecLogMessage - Write: write failed 2019-06-08 10:07:26.642 T:3768525680 DEBUG: CecLogMessage - << 17 2019-06-08 10:07:26.701 T:3768525680 WARNING: CecLogMessage - Write: write failed 2019-06-08 10:07:26.701 T:3768525680 DEBUG: CecLogMessage - >> POLL not sent 2019-06-08 10:07:26.701 T:3768525680 DEBUG: CecLogMessage - Tuner 3 (7): device status changed into 'not present' 2019-06-08 10:07:26.701 T:3768525680 DEBUG: CecLogMessage - << Recorder 1 (1) -> Playback 2 (8): POLL 2019-06-08 10:07:26.701 T:3768525680 DEBUG: CecLogMessage - << 18 2019-06-08 10:07:26.757 T:3768525680 WARNING: CecLogMessage - Write: write failed 2019-06-08 10:07:26.757 T:3768525680 DEBUG: CecLogMessage - << 18 2019-06-08 10:07:26.817 T:3768525680 WARNING: CecLogMessage - Write: write failed 2019-06-08 10:07:26.817 T:3768525680 DEBUG: CecLogMessage - >> POLL not sent 2019-06-08 10:07:26.817 T:3768525680 DEBUG: CecLogMessage - Playback 2 (8): device status changed into 'not present' 2019-06-08 10:07:26.817 T:3768525680 DEBUG: CecLogMessage - << Recorder 1 (1) -> Recorder 3 (9): POLL 2019-06-08 10:07:26.817 T:3768525680 DEBUG: CecLogMessage - << 19 2019-06-08 10:07:26.877 T:3768525680 WARNING: CecLogMessage - Write: write failed 2019-06-08 10:07:26.877 T:3768525680 DEBUG: CecLogMessage - << 19 2019-06-08 10:07:26.933 T:3768525680 WARNING: CecLogMessage - Write: write failed 2019-06-08 10:07:26.933 T:3768525680 DEBUG: CecLogMessage - >> POLL not sent 2019-06-08 10:07:26.933 T:3768525680 DEBUG: CecLogMessage - Recorder 3 (9): device status changed into 'not present' 2019-06-08 10:07:26.933 T:3768525680 DEBUG: CecLogMessage - << Recorder 1 (1) -> Tuner 4 (A): POLL 2019-06-08 10:07:26.933 T:3768525680 DEBUG: CecLogMessage - << 1a 2019-06-08 10:07:26.993 T:3768525680 WARNING: CecLogMessage - Write: write failed 2019-06-08 10:07:26.993 T:3768525680 DEBUG: CecLogMessage - << 1a 2019-06-08 10:07:27.049 T:3768525680 WARNING: CecLogMessage - Write: write failed 2019-06-08 10:07:27.049 T:3768525680 DEBUG: CecLogMessage - >> POLL not sent 2019-06-08 10:07:27.049 T:3768525680 DEBUG: CecLogMessage - Tuner 4 (A): device status changed into 'not present' 2019-06-08 10:07:27.049 T:3768525680 DEBUG: CecLogMessage - << Recorder 1 (1) -> Playback 3 (B): POLL 2019-06-08 10:07:27.049 T:3768525680 DEBUG: CecLogMessage - << 1b 2019-06-08 10:07:27.105 T:3768525680 WARNING: CecLogMessage - Write: write failed 2019-06-08 10:07:27.105 T:3768525680 DEBUG: CecLogMessage - << 1b 2019-06-08 10:07:27.161 T:3768525680 WARNING: CecLogMessage - Write: write failed 2019-06-08 10:07:27.161 T:3768525680 DEBUG: CecLogMessage - >> POLL not sent 2019-06-08 10:07:27.161 T:3768525680 DEBUG: CecLogMessage - Playback 3 (B): device status changed into 'not present' 2019-06-08 10:07:27.161 T:3768525680 DEBUG: CecLogMessage - << Recorder 1 (1) -> Reserved 1 (C): POLL 2019-06-08 10:07:27.161 T:3768525680 DEBUG: CecLogMessage - << 1c 2019-06-08 10:07:27.217 T:3768525680 WARNING: CecLogMessage - Write: write failed 2019-06-08 10:07:27.217 T:3768525680 DEBUG: CecLogMessage - << 1c 2019-06-08 10:07:27.361 T:3768525680 WARNING: CecLogMessage - Write: write failed 2019-06-08 10:07:27.361 T:3768525680 DEBUG: CecLogMessage - >> POLL not sent 2019-06-08 10:07:27.361 T:3768525680 DEBUG: CecLogMessage - Reserved 1 (C): device status changed into 'not present' 2019-06-08 10:07:27.362 T:3768525680 DEBUG: CecLogMessage - << Recorder 1 (1) -> Reserved 2 (D): POLL 2019-06-08 10:07:27.362 T:3768525680 DEBUG: CecLogMessage - << 1d 2019-06-08 10:07:27.417 T:3768525680 WARNING: CecLogMessage - Write: write failed 2019-06-08 10:07:27.417 T:3768525680 DEBUG: CecLogMessage - << 1d 2019-06-08 10:07:27.478 T:3768525680 WARNING: CecLogMessage - Write: write failed 2019-06-08 10:07:27.478 T:3768525680 DEBUG: CecLogMessage - >> POLL not sent 2019-06-08 10:07:27.478 T:3768525680 DEBUG: CecLogMessage - Reserved 2 (D): device status changed into 'not present' 2019-06-08 10:07:27.478 T:3768525680 DEBUG: CecLogMessage - << Recorder 1 (1) -> TV (0): vendor id Pulse Eight (1582) 2019-06-08 10:07:27.478 T:3768525680 DEBUG: CecLogMessage - << 1f:87:00:15:82 2019-06-08 10:07:27.478 T:3768525680 DEBUG: CecLogMessage - << Recorder 1 (1) -> Free use (E): POLL 2019-06-08 10:07:27.635 T:3768525680 DEBUG: CecLogMessage - << 1e 2019-06-08 10:07:27.885 T:3768525680 WARNING: CecLogMessage - Write: write failed 2019-06-08 10:07:27.885 T:3768525680 DEBUG: CecLogMessage - << 1e 2019-06-08 10:07:27.941 T:3768525680 WARNING: CecLogMessage - Write: write failed 2019-06-08 10:07:27.941 T:3768525680 DEBUG: CecLogMessage - >> POLL not sent 2019-06-08 10:07:27.941 T:3768525680 DEBUG: CecLogMessage - Free use (E): device status changed into 'not present' 2019-06-08 10:07:27.941 T:3768525680 DEBUG: CecLogMessage - << requesting vendor ID of 'Audio' (5) 2019-06-08 10:07:27.941 T:3768525680 DEBUG: CecLogMessage - << 15:8c 2019-06-08 10:07:28.026 T:3768525680 DEBUG: CecLogMessage - >> 01:8c 2019-06-08 10:07:28.026 T:3768525680 DEBUG: CecLogMessage - << Recorder 1 (1) -> TV (0): vendor id Pulse Eight (1582) 2019-06-08 10:07:28.026 T:3768525680 DEBUG: CecLogMessage - << 1f:87:00:15:82 2019-06-08 10:07:28.026 T:3768525680 DEBUG: CecLogMessage - >> TV (0) -> Recorder 1 (1): give device vendor id (8C) 2019-06-08 10:07:28.331 T:3768525680 DEBUG: CecLogMessage - >> 01:a0:00:80:45:06:05 2019-06-08 10:07:28.331 T:3768525680 DEBUG: CecLogMessage - TV (0): vendor = Panasonic (008045) 2019-06-08 10:07:28.331 T:3768525680 DEBUG: CecLogMessage - >> process after replacing vendor handler: >> 01:a0:00:80:45:06:05 2019-06-08 10:07:28.331 T:3768525680 DEBUG: CecLogMessage - replacing the command handler for device 'TV' (0) 2019-06-08 10:07:28.331 T:3768525680 DEBUG: CecLogMessage - Recorder 1 (1): vendor = Panasonic (008045) 2019-06-08 10:07:28.331 T:3768525680 DEBUG: CecLogMessage - replacing the command handler for device 'Recorder 1' (1) 2019-06-08 10:07:28.331 T:3768525680 DEBUG: CecLogMessage - changing device type 'recording device' into 'playback device' 2019-06-08 10:07:28.331 T:3768525680 DEBUG: CecLogMessage - >> TV (0) -> Recorder 1 (1): vendor command with id (A0) 2019-06-08 10:07:28.331 T:3768525680 DEBUG: CecLogMessage - unregistering client: libCEC version = 4.0.4, client version = 4.0.0, firmware version = 5, logical address(es) = Recorder 1 (1) , physical address: 2.5.0.0, compiled on Fri Jun 7 23:08:52 UTC 2019 by relkai@hammbwcor01 on Linux 4.15.0-48-generic (x86_64), features: P8_USB, DRM, P8_detect, AOCEC 2019-06-08 10:07:28.331 T:3768525680 DEBUG: CecLogMessage - Recorder 1 (1): power status changed from 'on' to 'unknown' 2019-06-08 10:07:28.331 T:3768525680 DEBUG: CecLogMessage - Recorder 1 (1): vendor = Unknown (000000) 2019-06-08 10:07:28.331 T:3768525680 DEBUG: CecLogMessage - Recorder 1 (1): CEC version unknown 2019-06-08 10:07:28.331 T:3768525680 DEBUG: CecLogMessage - Recorder 1 (1): osd name set to 'Recorder 1' 2019-06-08 10:07:28.332 T:3768525680 DEBUG: CecLogMessage - Recorder 1 (1): device status changed into 'unknown' 2019-06-08 10:07:28.332 T:3768525680 DEBUG: CecLogMessage - registering new CEC client - v4.0.0 2019-06-08 10:07:28.332 T:3768525680 DEBUG: CecLogMessage - detecting logical address for type 'playback device' 2019-06-08 10:07:28.332 T:3768525680 DEBUG: CecLogMessage - trying logical address 'Playback 1' 2019-06-08 10:07:28.332 T:3768525680 DEBUG: CecLogMessage - << Playback 1 (4) -> Playback 1 (4): POLL 2019-06-08 10:07:28.332 T:3768525680 DEBUG: CecLogMessage - << 44 2019-06-08 10:07:28.385 T:3768525680 WARNING: CecLogMessage - Write: write failed 2019-06-08 10:07:28.385 T:3768525680 DEBUG: CecLogMessage - << 44 2019-06-08 10:07:28.553 T:3768525680 WARNING: CecLogMessage - Write: write failed 2019-06-08 10:07:28.553 T:3768525680 DEBUG: CecLogMessage - >> POLL not sent 2019-06-08 10:07:28.553 T:3768525680 DEBUG: CecLogMessage - using logical address 'Playback 1' 2019-06-08 10:07:28.553 T:3768525680 DEBUG: CecLogMessage - Playback 1 (4): device status changed into 'handled by libCEC' 2019-06-08 10:07:28.553 T:3768525680 DEBUG: CecLogMessage - Playback 1 (4): power status changed from 'unknown' to 'on' 2019-06-08 10:07:28.553 T:3768525680 DEBUG: CecLogMessage - Playback 1 (4): vendor = Pulse Eight (001582) 2019-06-08 10:07:28.553 T:3768525680 DEBUG: CecLogMessage - Playback 1 (4): CEC version 1.4 2019-06-08 10:07:28.553 T:3768525680 DEBUG: CecLogMessage - AllocateLogicalAddresses - device '0', type 'playback device', LA '4' 2019-06-08 10:07:28.553 T:3768525680 DEBUG: CecLogMessage - AutodetectPhysicalAddress - autodetected physical address '2500' 2019-06-08 10:07:28.553 T:3768525680 DEBUG: CecLogMessage - Playback 1 (4): physical address changed from ffff to 2500 2019-06-08 10:07:28.553 T:3768525680 DEBUG: CecLogMessage - Playback 1 (4): osd name set to 'Kodi' 2019-06-08 10:07:28.553 T:3768525680 DEBUG: CecLogMessage - Playback 1 (4): menu language set to 'eng' 2019-06-08 10:07:28.553 T:3768525680 DEBUG: CecLogMessage - physical address unchanged (2500) 2019-06-08 10:07:28.554 T:3768525680 DEBUG: CecLogMessage - CEC client registered: libCEC version = 4.0.4, client version = 4.0.0, firmware version = 5, logical address(es) = Playback 1 (4) , physical address: 2.5.0.0, compiled on Fri Jun 7 23:08:52 UTC 2019 by relkai@hammbwcor01 on Linux 4.15.0-48-generic (x86_64), features: P8_USB, DRM, P8_detect, AOCEC 2019-06-08 10:07:28.554 T:3768525680 DEBUG: CecLogMessage - Playback 1 (4): vendor = Panasonic (008045) 2019-06-08 10:07:28.554 T:3768525680 DEBUG: CecLogMessage - replacing the command handler for device 'Playback 1' (4) 2019-06-08 10:07:28.554 T:3768525680 DEBUG: CecLogMessage - << Playback 1 (4) -> TV (0): OSD name 'Kodi' 2019-06-08 10:07:28.554 T:3768525680 DEBUG: CecLogMessage - 'set osd name' is marked as unsupported feature for device 'TV' 2019-06-08 10:07:28.554 T:3768525680 DEBUG: CecLogMessage - << requesting power status of 'TV' (0) 2019-06-08 10:07:28.554 T:3768525680 DEBUG: CecLogMessage - << 40:8f 2019-06-08 10:07:29.027 T:3768525680 DEBUG: CecLogMessage - expected response not received (87: device vendor id) 2019-06-08 10:07:29.634 T:3768525680 DEBUG: CecLogMessage - expected response not received (90: report power status) 2019-06-08 10:07:29.634 T:3768525680 DEBUG: CecLogMessage - << 40:8f 2019-06-08 10:07:30.714 T:3768525680 DEBUG: CecLogMessage - expected response not received (90: report power status) 2019-06-08 10:07:30.714 T:3768525680 DEBUG: CecLogMessage - TV (0): power status changed from 'on' to 'unknown' 2019-06-08 10:07:30.714 T:3768525680 DEBUG: CecLogMessage - >> 01:a0:00:80:45:06:05 2019-06-08 10:07:30.714 T:3768525680 DEBUG: CecLogMessage - >> 04:90:00 2019-06-08 10:07:30.714 T:3768525680 DEBUG: CecLogMessage - TV (0): power status changed from 'unknown' to 'on' 2019-06-08 10:07:30.714 T:3768525680 DEBUG: CecLogMessage - >> 04:90:00 2019-06-08 10:07:30.714 T:3768525680 DEBUG: CecLogMessage - >> 5f:87:00:80:45 2019-06-08 10:07:30.714 T:3768525680 DEBUG: CecLogMessage - Audio (5): vendor = Panasonic (008045) 2019-06-08 10:07:30.714 T:3768525680 DEBUG: CecLogMessage - >> TV (0) -> Playback 1 (4): report power status (90) 2019-06-08 10:07:30.714 T:3768525680 DEBUG: CecLogMessage - >> Audio (5) -> Broadcast (F): device vendor id (87) 2019-06-08 10:07:30.715 T:3768525680 DEBUG: CecLogMessage - << 15:8c 2019-06-08 10:07:30.794 T:3768525680 DEBUG: CecLogMessage - expected response received (87: device vendor id) 2019-06-08 10:07:30.794 T:3768525680 DEBUG: CecLogMessage - replacing the command handler for device 'Audio' (5) 2019-06-08 10:07:30.794 T:3768525680 DEBUG: CecLogMessage - << requesting OSD name of 'Audio' (5) 2019-06-08 10:07:30.794 T:3768525680 DEBUG: CecLogMessage - << 15:46 2019-06-08 10:07:30.934 T:3768525680 DEBUG: CecLogMessage - >> 5f:87:00:80:45 2019-06-08 10:07:30.934 T:3768525680 DEBUG: CecLogMessage - >> Audio (5) -> Broadcast (F): device vendor id (87) 2019-06-08 10:07:32.014 T:3768525680 DEBUG: CecLogMessage - expected response not received (47: set osd name) 2019-06-08 10:07:32.014 T:3768525680 DEBUG: CecLogMessage - << 15:46 2019-06-08 10:07:33.094 T:3768525680 DEBUG: CecLogMessage - expected response not received (47: set osd name) 2019-06-08 10:08:07.777 T:3768525680 DEBUG: CecLogMessage - >> 0f:82:00:00 2019-06-08 10:08:07.777 T:3768525680 DEBUG: CecLogMessage - making TV (0) the active source 2019-06-08 10:08:07.778 T:3768525680 DEBUG: CecLogMessage - >> TV (0) -> Broadcast (F): active source (82) 2019-06-08 10:08:46.758 T:3768525680 DEBUG: CecLogMessage - >> 0f:80:00:00:20:00 2019-06-08 10:08:46.758 T:3768525680 DEBUG: CecLogMessage - >> TV (0) -> Broadcast (F): routing change (80) 2019-06-08 10:08:46.872 T:3768525680 DEBUG: CecLogMessage - >> 5f:81:25:00 2019-06-08 10:08:46.872 T:3768525680 DEBUG: CecLogMessage - Audio (5): power status changed from 'unknown' to 'on' 2019-06-08 10:08:46.872 T:3768525680 DEBUG: CecLogMessage - >> Audio (5) -> Broadcast (F): routing information (81) 2019-06-08 10:08:47.522 T:3768525680 DEBUG: CecLogMessage - >> 0f:86:25:00 2019-06-08 10:08:47.523 T:3768525680 DEBUG: CecLogMessage - >> TV (0) sets stream path to physical address 2500 2019-06-08 10:08:47.523 T:3768525680 DEBUG: CecLogMessage - >> TV (0) -> Broadcast (F): set stream path (86) 2019-06-08 10:09:05.764 T:3768525680 DEBUG: CecLogMessage - >> 0f:82:00:00 2019-06-08 10:09:05.764 T:3768525680 DEBUG: CecLogMessage - TV (0) was already marked as active source 2019-06-08 10:09:05.764 T:3768525680 DEBUG: CecLogMessage - >> TV (0) -> Broadcast (F): active source (82) 2019-06-08 10:10:03.269 T:3768525680 DEBUG: CecLogMessage - >> 0f:80:00:00:20:00 2019-06-08 10:10:03.269 T:3768525680 DEBUG: CecLogMessage - >> TV (0) -> Broadcast (F): routing change (80) 2019-06-08 10:10:03.384 T:3768525680 DEBUG: CecLogMessage - >> 5f:81:25:00 2019-06-08 10:10:03.384 T:3768525680 DEBUG: CecLogMessage - >> Audio (5) -> Broadcast (F): routing information (81) 2019-06-08 10:10:04.030 T:3768525680 DEBUG: CecLogMessage - >> 0f:86:25:00 2019-06-08 10:10:04.030 T:3768525680 DEBUG: CecLogMessage - >> TV (0) sets stream path to physical address 2500 2019-06-08 10:10:04.030 T:3768525680 DEBUG: CecLogMessage - >> TV (0) -> Broadcast (F): set stream path (86) 2019-06-08 10:10:20.916 T:3768525680 DEBUG: CecLogMessage - >> 0f:82:00:00 2019-06-08 10:10:20.916 T:3768525680 DEBUG: CecLogMessage - TV (0) was already marked as active source 2019-06-08 10:10:20.916 T:3768525680 DEBUG: CecLogMessage - >> TV (0) -> Broadcast (F): active source (82)