11:07:21.112 T:1962214512 NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM" 11:07:21.112 T:1962214512 NOTICE: Enabled debug logging due to GUI setting. Level 2. 11:07:21.113 T:1962214512 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 11:07:21.114 T:1962214512 DEBUG: ------ Window Init () ------ 11:07:31.145 T:1796207520 DEBUG: CecLogMessage - >> 0f:36 11:07:31.146 T:1796207520 ERROR: OnTvStandby - Unexpected [standby_pc_on_tv_standby] setting value 11:07:31.146 T:1796207520 DEBUG: CecLogMessage - TV (0): power status changed from 'on' to 'standby' 11:07:31.146 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Broadcast (F): standby (36) 11:07:31.373 T:1796207520 DEBUG: CecLogMessage - >> 0f:a0:08:00:46:00:09:00:01 11:07:31.373 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Broadcast (F): vendor command with id (A0) 11:07:36.856 T:1495974816 DEBUG: JSONRPC Server: New connection detected 11:07:36.857 T:1495974816 INFO: JSONRPC Server: New connection added 11:07:36.858 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:07:37.145 T:1315959712 DEBUG: Previous line repeats 4 times. 11:07:37.146 T:1315959712 DEBUG: Thread JobWorker start, auto delete: true 11:07:37.174 T:1437254560 DEBUG: GetSongsFullByWhere query = SELECT songview.* FROM songview LIMIT 1 11:07:37.176 T:1437254560 DEBUG: GetSongsFullByWhere() - took 118 ms 11:07:37.457 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:07:46.745 T:1962214512 DEBUG: Previous line repeats 8 times. 11:07:46.746 T:1962214512 DEBUG: ToggleDeviceState - waking up CEC device... 11:07:46.752 T:1796207520 DEBUG: CecLogMessage - Recorder 1 (1) was already marked as active source 11:07:46.753 T:1796207520 DEBUG: CecLogMessage - TV (0): power status changed from 'standby' to 'in transition from standby to on' 11:07:46.753 T:1796207520 DEBUG: CecLogMessage - >> source activated: Recorder 1 (1) 11:07:46.753 T:1796207520 DEBUG: CecLogMessage - sending active source message for 'Recorder 1' 11:07:46.753 T:1796207520 DEBUG: CecLogMessage - << powering on 'TV' (0) 11:07:46.753 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:07:46.812 T:1796207520 DEBUG: CecLogMessage - << Recorder 1 (1) -> broadcast (F): active source (4000) 11:07:46.813 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:07:47.813 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:07:47.867 T:1796207520 DEBUG: CecLogMessage - logical address changed to Broadcast (f) 11:07:47.895 T:1796207520 DEBUG: CecLogMessage - GetPhysicalAddress - physical address = 4000 11:07:48.106 T:1796207520 DEBUG: CecLogMessage - logical Broadcast (f) address lost 11:07:48.106 T:1796207520 DEBUG: CecLogMessage - logical address f was taken by another device, allocating a new address 11:07:48.106 T:1796207520 DEBUG: CecLogMessage - TV (0): power status changed from 'in transition from standby to on' to 'unknown' 11:07:48.106 T:1796207520 DEBUG: CecLogMessage - TV (0): vendor = Unknown (000000) 11:07:48.122 T:1796207520 DEBUG: CecLogMessage - TV (0): device status changed into 'unknown' 11:07:48.263 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:07:48.314 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:07:48.314 T:1796207520 DEBUG: CecLogMessage - physical address unchanged (4000) 11:07:48.314 T:1796207520 DEBUG: CecLogMessage - << Recorder 1 (1) -> TV (0): POLL 11:07:48.314 T:1796207520 DEBUG: CecLogMessage - << 10 11:07:49.314 T:1796207520 DEBUG: CecLogMessage - command 'feature abort' timeout 11:07:49.805 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:07:49.815 T:1796207520 DEBUG: CecLogMessage - << 10 11:07:50.816 T:1796207520 DEBUG: CecLogMessage - command 'feature abort' timeout 11:07:51.316 T:1796207520 DEBUG: CecLogMessage - >> POLL not sent 11:07:51.316 T:1796207520 DEBUG: CecLogMessage - TV (0): device status changed into 'not present' 11:07:51.324 T:1796207520 DEBUG: CecLogMessage - detecting logical address for type 'recording device' 11:07:51.325 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=0 initiator=1 destination=0 response=0 11:07:51.325 T:1796207520 DEBUG: CecLogMessage - trying logical address 'Recorder 2' 11:07:51.325 T:1796207520 DEBUG: CecLogMessage - << Recorder 2 (2) -> Recorder 2 (2): POLL 11:07:51.325 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=0 initiator=1 destination=0 response=4 11:07:51.325 T:1796207520 DEBUG: CecLogMessage - << 22 11:07:51.350 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:07:51.505 T:1796207520 DEBUG: CecLogMessage - << 22 11:07:51.686 T:1796207520 DEBUG: CecLogMessage - >> POLL not sent 11:07:51.686 T:1796207520 DEBUG: CecLogMessage - using logical address 'Recorder 2' 11:07:51.686 T:1796207520 DEBUG: CecLogMessage - Recorder 2 (2): device status changed into 'handled by libCEC' 11:07:51.687 T:1796207520 DEBUG: CecLogMessage - Recorder 2 (2): power status changed from 'unknown' to 'on' 11:07:51.687 T:1796207520 DEBUG: CecLogMessage - Recorder 2 (2): vendor = Pulse Eight (001582) 11:07:51.687 T:1796207520 DEBUG: CecLogMessage - Recorder 2 (2): CEC version 1.4 11:07:51.687 T:1796207520 DEBUG: CecLogMessage - AllocateLogicalAddresses - device '0', type 'recording device', LA '2' 11:07:51.687 T:1796207520 DEBUG: CecLogMessage - GetPhysicalAddress - physical address = 4000 11:07:51.687 T:1796207520 DEBUG: CecLogMessage - AutodetectPhysicalAddress - autodetected physical address '4000' 11:07:51.687 T:1796207520 DEBUG: CecLogMessage - Recorder 2 (2): physical address changed from ffff to 4000 11:07:51.688 T:1796207520 DEBUG: CecLogMessage - logical address changed to Recorder 2 (2) 11:07:51.808 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:07:51.925 T:1796207520 DEBUG: CecLogMessage - >> 0f:36 11:07:51.926 T:1796207520 ERROR: OnTvStandby - Unexpected [standby_pc_on_tv_standby] setting value 11:07:51.926 T:1796207520 DEBUG: CecLogMessage - TV (0): power status changed from 'unknown' to 'standby' 11:07:51.926 T:1796207520 DEBUG: CecLogMessage - device TV (0) status changed to present after command standby 11:07:51.926 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Broadcast (F): standby (36) 11:07:52.688 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:07:52.899 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:07:53.189 T:1796207520 DEBUG: CecLogMessage - failed to make 'Recorder 1' the active source. will retry later 11:07:53.189 T:1796207520 DEBUG: CecLogMessage - >> 0f:a0:08:00:46:00:09:00:01 11:07:53.189 T:1796207520 DEBUG: CecLogMessage - TV (0): vendor = Sony (080046) 11:07:53.189 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Broadcast (F): vendor command with id (A0) 11:07:54.189 T:1796207520 DEBUG: CecLogMessage - << powering on 'TV' (0) 11:07:54.190 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:07:54.250 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:07:54.319 T:1796207520 DEBUG: CecLogMessage - logical address changed to Broadcast (f) 11:07:54.527 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:07:54.997 T:1796207520 DEBUG: CecLogMessage - GetPhysicalAddress - physical address = 4000 11:07:55.190 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:07:55.237 T:1796207520 DEBUG: CecLogMessage - logical address changed to Recorder 2 (2) 11:07:55.690 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:07:55.751 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:07:56.069 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:07:56.691 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:07:57.191 T:1796207520 DEBUG: CecLogMessage - physical address unchanged (4000) 11:07:57.192 T:1796207520 DEBUG: CecLogMessage - << Recorder 1 (1) -> broadcast (F): active source (4000) 11:07:57.195 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:07:57.372 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:07:57.613 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:07:58.192 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:07:58.693 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:07:58.813 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:07:59.150 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:07:59.693 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:08:00.194 T:1796207520 DEBUG: CecLogMessage - failed to make 'Recorder 1' the active source. will retry later 11:08:00.194 T:1796207520 DEBUG: CecLogMessage - >> 0f:a0:08:00:46:00:13:00:10:00:10:10:00:00:00:00 11:08:00.194 T:1796207520 DEBUG: CecLogMessage - >> 0f:a0:08:00:46:00:08:00:00 11:08:00.194 T:1796207520 DEBUG: CecLogMessage - >> 02:46 11:08:00.194 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Broadcast (F): vendor command with id (A0) 11:08:00.195 T:1796207520 DEBUG: CecLogMessage - << Recorder 2 (2) -> TV (0): OSD name 'Recorder 2' 11:08:00.195 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Broadcast (F): vendor command with id (A0) 11:08:00.195 T:1796207520 DEBUG: CecLogMessage - << 20:47:52:65:63:6f:72:64:65:72:20:32 11:08:00.195 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Recorder 2 (2): give osd name (46) 11:08:00.495 T:1796207520 DEBUG: CecLogMessage - >> 02:8c 11:08:00.495 T:1796207520 DEBUG: CecLogMessage - << Recorder 2 (2) -> TV (0): vendor id Pulse Eight (1582) 11:08:00.496 T:1796207520 DEBUG: CecLogMessage - << 2f:87:00:15:82 11:08:00.496 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Recorder 2 (2): give device vendor id (8C) 11:08:00.689 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:00.766 T:1796207520 DEBUG: CecLogMessage - >> 02:46 11:08:00.766 T:1796207520 DEBUG: CecLogMessage - << Recorder 2 (2) -> TV (0): OSD name 'Recorder 2' 11:08:00.766 T:1796207520 DEBUG: CecLogMessage - << 20:47:52:65:63:6f:72:64:65:72:20:32 11:08:00.767 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Recorder 2 (2): give osd name (46) 11:08:01.067 T:1796207520 DEBUG: CecLogMessage - >> 0f:36 11:08:01.067 T:1796207520 DEBUG: CecLogMessage - >> 0f:a0:08:00:46:00:09:00:01 11:08:01.067 T:1796207520 DEBUG: CecLogMessage - >> 02:00:47:01 11:08:01.068 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Broadcast (F): vendor command with id (A0) 11:08:01.068 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Recorder 2 (2): feature abort ( 0) 11:08:01.171 T:1796207520 DEBUG: CecLogMessage - >> 02:00:47:01 11:08:01.172 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Recorder 2 (2): feature abort ( 0) 11:08:02.172 T:1796207520 DEBUG: CecLogMessage - << powering on 'TV' (0) 11:08:02.172 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:08:02.229 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:02.232 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:08:02.272 T:1796207520 DEBUG: CecLogMessage - logical address changed to Broadcast (f) 11:08:02.950 T:1796207520 DEBUG: CecLogMessage - GetPhysicalAddress - physical address = 4000 11:08:03.172 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:08:03.253 T:1796207520 DEBUG: CecLogMessage - logical address changed to Recorder 2 (2) 11:08:03.673 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:08:03.772 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:03.793 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:08:04.673 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:08:05.174 T:1796207520 DEBUG: CecLogMessage - << Recorder 1 (1) -> broadcast (F): active source (4000) 11:08:05.174 T:1796207520 DEBUG: CecLogMessage - physical address unchanged (4000) 11:08:05.174 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:08:05.294 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:08:05.309 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:06.174 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:08:06.675 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:08:06.795 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:08:06.845 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:07.146 T:1315959712 DEBUG: Thread JobWorker 1315959712 terminating (autodelete) 11:08:07.675 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:08:08.175 T:1796207520 DEBUG: CecLogMessage - failed to make 'Recorder 1' the active source. will retry later 11:08:08.175 T:1796207520 DEBUG: CecLogMessage - >> 0f:a0:08:00:46:00:13:00:10:00:10:10:00:00:00:00 11:08:08.176 T:1796207520 DEBUG: CecLogMessage - >> 0f:a0:08:00:46:00:08:00:00 11:08:08.176 T:1796207520 DEBUG: CecLogMessage - >> 02:46 11:08:08.176 T:1796207520 DEBUG: CecLogMessage - << Recorder 2 (2) -> TV (0): OSD name 'Recorder 2' 11:08:08.176 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Broadcast (F): vendor command with id (A0) 11:08:08.176 T:1796207520 DEBUG: CecLogMessage - << 20:47:52:65:63:6f:72:64:65:72:20:32 11:08:08.176 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Broadcast (F): vendor command with id (A0) 11:08:08.176 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Recorder 2 (2): give osd name (46) 11:08:08.389 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:08.477 T:1796207520 DEBUG: CecLogMessage - >> 02:8c 11:08:08.477 T:1796207520 DEBUG: CecLogMessage - << Recorder 2 (2) -> TV (0): vendor id Pulse Eight (1582) 11:08:08.477 T:1796207520 DEBUG: CecLogMessage - << 2f:87:00:15:82 11:08:08.477 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Recorder 2 (2): give device vendor id (8C) 11:08:08.627 T:1796207520 DEBUG: CecLogMessage - >> 02:46 11:08:08.628 T:1796207520 DEBUG: CecLogMessage - << Recorder 2 (2) -> TV (0): OSD name 'Recorder 2' 11:08:08.628 T:1796207520 DEBUG: CecLogMessage - << 20:47:52:65:63:6f:72:64:65:72:20:32 11:08:08.628 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Recorder 2 (2): give osd name (46) 11:08:08.958 T:1796207520 DEBUG: CecLogMessage - >> 02:8c 11:08:08.959 T:1796207520 DEBUG: CecLogMessage - << Recorder 2 (2) -> TV (0): vendor id Pulse Eight (1582) 11:08:08.959 T:1796207520 DEBUG: CecLogMessage - << 2f:87:00:15:82 11:08:08.959 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Recorder 2 (2): give device vendor id (8C) 11:08:09.306 T:1796207520 DEBUG: CecLogMessage - >> 0f:36 11:08:09.306 T:1796207520 ERROR: OnTvStandby - Unexpected [standby_pc_on_tv_standby] setting value 11:08:09.306 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Broadcast (F): standby (36) 11:08:09.536 T:1796207520 DEBUG: CecLogMessage - >> 0f:a0:08:00:46:00:09:00:01 11:08:09.537 T:1796207520 DEBUG: CecLogMessage - << powering on 'TV' (0) 11:08:09.537 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:08:09.537 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Broadcast (F): vendor command with id (A0) 11:08:09.627 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:08:09.675 T:1796207520 DEBUG: CecLogMessage - logical address changed to Broadcast (f) 11:08:09.942 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:10.353 T:1796207520 DEBUG: CecLogMessage - GetPhysicalAddress - physical address = 4000 11:08:10.473 T:1796207520 DEBUG: CecLogMessage - logical address changed to Recorder 2 (2) 11:08:10.537 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:08:11.038 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:08:11.159 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:08:11.479 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:12.039 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:08:12.540 T:1796207520 DEBUG: CecLogMessage - << Recorder 1 (1) -> broadcast (F): active source (4000) 11:08:12.540 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:08:12.720 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:08:13.027 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:13.540 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:08:14.042 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:08:14.162 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:08:14.572 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:15.043 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:08:15.544 T:1796207520 DEBUG: CecLogMessage - failed to make 'Recorder 1' the active source. will retry later 11:08:15.544 T:1796207520 DEBUG: CecLogMessage - >> 0f:87:08:00:46 11:08:15.544 T:1796207520 DEBUG: CecLogMessage - << Recorder 2 (2) -> Broadcast (F): vendor id Pulse Eight (1582) 11:08:15.544 T:1796207520 DEBUG: CecLogMessage - << 2f:87:00:15:82 11:08:15.544 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Broadcast (F): device vendor id (87) 11:08:15.695 T:1796207520 DEBUG: CecLogMessage - >> 0f:a0:08:00:46:00:04:00:01 11:08:15.695 T:1796207520 DEBUG: CecLogMessage - >> 02:83 11:08:15.695 T:1796207520 DEBUG: CecLogMessage - << Recorder 2 (2) -> broadcast (F): physical address 4000 11:08:15.695 T:1796207520 DEBUG: CecLogMessage - << 2f:84:40:00:01 11:08:15.696 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Broadcast (F): vendor command with id (A0) 11:08:15.696 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Recorder 2 (2): give physical address (83) 11:08:15.846 T:1796207520 DEBUG: CecLogMessage - >> 0f:a0:08:00:46:00:13:00:10:00:10:10:00:00:00:00 11:08:15.846 T:1796207520 DEBUG: CecLogMessage - physical address unchanged (4000) 11:08:15.846 T:1796207520 DEBUG: CecLogMessage - >> 02:46 11:08:15.847 T:1796207520 DEBUG: CecLogMessage - << Recorder 2 (2) -> TV (0): OSD name 'Recorder 2' 11:08:15.847 T:1796207520 DEBUG: CecLogMessage - << 20:47:52:65:63:6f:72:64:65:72:20:32 11:08:15.847 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Broadcast (F): vendor command with id (A0) 11:08:15.847 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Recorder 2 (2): give osd name (46) 11:08:16.178 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:16.207 T:1796207520 DEBUG: CecLogMessage - >> 02:8c 11:08:16.207 T:1796207520 DEBUG: CecLogMessage - << Recorder 2 (2) -> TV (0): vendor id Pulse Eight (1582) 11:08:16.208 T:1796207520 DEBUG: CecLogMessage - << 2f:87:00:15:82 11:08:16.208 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Recorder 2 (2): give device vendor id (8C) 11:08:16.418 T:1796207520 DEBUG: CecLogMessage - >> 0f:a0:08:00:46:00:08:00:00 11:08:16.418 T:1796207520 DEBUG: CecLogMessage - >> 02:46 11:08:16.419 T:1796207520 DEBUG: CecLogMessage - << Recorder 2 (2) -> TV (0): OSD name 'Recorder 2' 11:08:16.419 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Broadcast (F): vendor command with id (A0) 11:08:16.419 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Recorder 2 (2): give osd name (46) 11:08:16.419 T:1796207520 DEBUG: CecLogMessage - << 20:47:52:65:63:6f:72:64:65:72:20:32 11:08:16.930 T:1796207520 DEBUG: CecLogMessage - << powering on 'TV' (0) 11:08:16.931 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:08:16.991 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:08:17.730 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:17.931 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:08:18.432 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:08:18.492 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:08:19.265 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:19.432 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:08:19.932 T:1796207520 DEBUG: CecLogMessage - << Recorder 1 (1) -> broadcast (F): active source (4000) 11:08:19.933 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:08:20.053 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:08:20.810 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:20.933 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:08:21.434 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:08:21.554 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:08:22.350 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:22.435 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:08:22.936 T:1796207520 DEBUG: CecLogMessage - failed to make 'Recorder 1' the active source. will retry later 11:08:22.936 T:1796207520 DEBUG: CecLogMessage - >> 02:46 11:08:22.936 T:1796207520 DEBUG: CecLogMessage - << Recorder 2 (2) -> TV (0): OSD name 'Recorder 2' 11:08:22.936 T:1796207520 DEBUG: CecLogMessage - << 20:47:52:65:63:6f:72:64:65:72:20:32 11:08:22.936 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Recorder 2 (2): give osd name (46) 11:08:23.237 T:1796207520 DEBUG: CecLogMessage - >> 02:8c 11:08:23.237 T:1796207520 DEBUG: CecLogMessage - << Recorder 2 (2) -> TV (0): vendor id Pulse Eight (1582) 11:08:23.237 T:1796207520 DEBUG: CecLogMessage - << 2f:87:00:15:82 11:08:23.237 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Recorder 2 (2): give device vendor id (8C) 11:08:23.507 T:1796207520 DEBUG: CecLogMessage - >> 0f:36 11:08:23.508 T:1796207520 ERROR: OnTvStandby - Unexpected [standby_pc_on_tv_standby] setting value 11:08:23.508 T:1796207520 DEBUG: CecLogMessage - >> 0f:a0:08:00:46:00:09:00:01 11:08:23.508 T:1796207520 DEBUG: CecLogMessage - >> 02:00:47:01 11:08:23.508 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Broadcast (F): standby (36) 11:08:23.508 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Broadcast (F): vendor command with id (A0) 11:08:23.508 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Recorder 2 (2): feature abort ( 0) 11:08:23.890 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:24.508 T:1796207520 DEBUG: CecLogMessage - << powering on 'TV' (0) 11:08:24.512 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:08:24.569 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:08:24.630 T:1796207520 DEBUG: CecLogMessage - logical address changed to Broadcast (f) 11:08:25.308 T:1796207520 DEBUG: CecLogMessage - GetPhysicalAddress - physical address = 4000 11:08:25.430 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:25.510 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:08:25.518 T:1796207520 DEBUG: CecLogMessage - logical address changed to Recorder 2 (2) 11:08:26.010 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:08:26.071 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:08:26.969 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:27.011 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:08:27.512 T:1796207520 DEBUG: CecLogMessage - << Recorder 1 (1) -> broadcast (F): active source (4000) 11:08:27.512 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:08:27.662 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:08:28.507 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:28.513 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:08:29.013 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:08:29.134 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:08:30.014 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:08:30.044 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:30.514 T:1796207520 DEBUG: CecLogMessage - failed to make 'Recorder 1' the active source. will retry later 11:08:30.514 T:1796207520 DEBUG: CecLogMessage - physical address unchanged (4000) 11:08:30.515 T:1796207520 DEBUG: CecLogMessage - >> 0f:a0:08:00:46:00:13:00:10:00:10:10:00:00:00:00 11:08:30.515 T:1796207520 DEBUG: CecLogMessage - >> 0f:a0:08:00:46:00:08:00:00 11:08:30.515 T:1796207520 DEBUG: CecLogMessage - >> 02:46 11:08:30.515 T:1796207520 DEBUG: CecLogMessage - << Recorder 2 (2) -> TV (0): OSD name 'Recorder 2' 11:08:30.515 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Broadcast (F): vendor command with id (A0) 11:08:30.515 T:1796207520 DEBUG: CecLogMessage - << 20:47:52:65:63:6f:72:64:65:72:20:32 11:08:30.515 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Broadcast (F): vendor command with id (A0) 11:08:30.516 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Recorder 2 (2): give osd name (46) 11:08:30.816 T:1796207520 DEBUG: CecLogMessage - >> 02:8c 11:08:30.816 T:1796207520 DEBUG: CecLogMessage - << Recorder 2 (2) -> TV (0): vendor id Pulse Eight (1582) 11:08:30.816 T:1796207520 DEBUG: CecLogMessage - << 2f:87:00:15:82 11:08:30.816 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Recorder 2 (2): give device vendor id (8C) 11:08:30.966 T:1796207520 DEBUG: CecLogMessage - >> 02:46 11:08:30.967 T:1796207520 DEBUG: CecLogMessage - << Recorder 2 (2) -> TV (0): OSD name 'Recorder 2' 11:08:30.967 T:1796207520 DEBUG: CecLogMessage - << 20:47:52:65:63:6f:72:64:65:72:20:32 11:08:30.967 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Recorder 2 (2): give osd name (46) 11:08:31.095 T:1962214512 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 11:08:31.096 T:1962214512 DEBUG: OnKey: down (0xf081) pressed, action is Down 11:08:31.508 T:1796207520 DEBUG: CecLogMessage - >> 02:8c 11:08:31.508 T:1796207520 DEBUG: CecLogMessage - << Recorder 2 (2) -> TV (0): vendor id Pulse Eight (1582) 11:08:31.508 T:1796207520 DEBUG: CecLogMessage - << 2f:87:00:15:82 11:08:31.508 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Recorder 2 (2): give device vendor id (8C) 11:08:31.529 T:1962214512 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 11:08:31.529 T:1962214512 DEBUG: OnKey: long-down (0x100f081) pressed, action is Down 11:08:31.545 T:1962214512 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 11:08:31.591 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:32.719 T:1796207520 DEBUG: CecLogMessage - << powering on 'TV' (0) 11:08:32.719 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:08:32.779 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:08:33.120 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:33.720 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:08:33.895 T:1962214512 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0000, modifier: 0x0 11:08:33.896 T:1962214512 DEBUG: OnKey: up (0xf080) pressed, action is Up 11:08:34.179 T:1962214512 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0000, modifier: 0x0 11:08:34.220 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:08:34.229 T:1962214512 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0000, modifier: 0x0 11:08:34.229 T:1962214512 DEBUG: OnKey: up (0xf080) pressed, action is Up 11:08:34.280 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:08:34.660 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:34.662 T:1962214512 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0000, modifier: 0x0 11:08:34.662 T:1962214512 DEBUG: OnKey: long-up (0x100f080) pressed, action is Up 11:08:34.679 T:1962214512 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0000, modifier: 0x0 11:08:35.221 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:08:35.721 T:1796207520 DEBUG: CecLogMessage - << Recorder 1 (1) -> broadcast (F): active source (4000) 11:08:35.722 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:08:35.842 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:08:36.200 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:36.612 T:1962214512 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 11:08:36.612 T:1962214512 DEBUG: OnKey: down (0xf081) pressed, action is Down 11:08:36.722 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:08:36.895 T:1962214512 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 11:08:37.223 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:08:37.344 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:08:37.739 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:38.224 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:08:38.724 T:1796207520 DEBUG: CecLogMessage - failed to make 'Recorder 1' the active source. will retry later 11:08:39.285 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:39.725 T:1796207520 DEBUG: CecLogMessage - << powering on 'TV' (0) 11:08:39.726 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:08:39.786 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:08:40.726 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:08:40.830 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:41.227 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:08:41.287 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:08:42.228 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:08:42.355 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:42.728 T:1796207520 DEBUG: CecLogMessage - << Recorder 1 (1) -> broadcast (F): active source (4000) 11:08:42.729 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:08:42.849 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:08:43.729 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:08:43.904 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:44.230 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:08:44.350 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:08:45.230 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:08:45.437 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:45.730 T:1796207520 DEBUG: CecLogMessage - failed to make 'Recorder 1' the active source. will retry later 11:08:46.731 T:1796207520 DEBUG: CecLogMessage - << powering on 'TV' (0) 11:08:46.731 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:08:46.791 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:08:46.978 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:47.731 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:08:47.749 T:1504363424 NOTICE: ES: Client from ::ffff:192.168.0.5 timed out 11:08:48.232 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:08:48.292 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:08:48.514 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:49.232 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:08:49.733 T:1796207520 DEBUG: CecLogMessage - << Recorder 1 (1) -> broadcast (F): active source (4000) 11:08:49.734 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:08:49.854 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:08:50.058 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:50.734 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:08:51.235 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:08:51.385 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:08:51.595 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:52.235 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:08:52.736 T:1796207520 DEBUG: CecLogMessage - failed to make 'Recorder 1' the active source. will retry later 11:08:53.118 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:53.240 T:1796207520 DEBUG: CecLogMessage - >> 0f:36 11:08:53.241 T:1796207520 ERROR: OnTvStandby - Unexpected [standby_pc_on_tv_standby] setting value 11:08:53.241 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Broadcast (F): standby (36) 11:08:53.480 T:1796207520 DEBUG: CecLogMessage - >> 0f:a0:08:00:46:00:09:00:01 11:08:53.480 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Broadcast (F): vendor command with id (A0) 11:08:54.480 T:1796207520 DEBUG: CecLogMessage - << powering on 'TV' (0) 11:08:54.480 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:08:54.540 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:08:54.639 T:1796207520 DEBUG: CecLogMessage - logical address changed to Broadcast (f) 11:08:54.654 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:55.317 T:1796207520 DEBUG: CecLogMessage - GetPhysicalAddress - physical address = 4000 11:08:55.480 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:08:55.617 T:1796207520 DEBUG: CecLogMessage - logical address changed to Recorder 2 (2) 11:08:55.711 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:55.981 T:1796207520 DEBUG: Previous line repeats 1 times. 11:08:55.981 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:08:56.102 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:08:56.981 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:08:57.289 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:57.482 T:1796207520 DEBUG: CecLogMessage - << Recorder 1 (1) -> broadcast (F): active source (4000) 11:08:57.482 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:08:57.602 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:08:58.482 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:08:58.831 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:08:58.983 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:08:59.103 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:08:59.983 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:09:00.369 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:09:00.483 T:1796207520 DEBUG: CecLogMessage - failed to make 'Recorder 1' the active source. will retry later 11:09:00.484 T:1796207520 DEBUG: CecLogMessage - physical address unchanged (4000) 11:09:00.484 T:1796207520 DEBUG: CecLogMessage - >> 0f:a0:08:00:46:00:13:00:10:00:10:10:00:00:00:00 11:09:00.484 T:1796207520 DEBUG: CecLogMessage - >> 0f:a0:08:00:46:00:08:00:00 11:09:00.484 T:1796207520 DEBUG: CecLogMessage - >> 02:46 11:09:00.484 T:1796207520 DEBUG: CecLogMessage - << Recorder 2 (2) -> TV (0): OSD name 'Recorder 2' 11:09:00.484 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Broadcast (F): vendor command with id (A0) 11:09:00.485 T:1796207520 DEBUG: CecLogMessage - << 20:47:52:65:63:6f:72:64:65:72:20:32 11:09:00.485 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Broadcast (F): vendor command with id (A0) 11:09:00.485 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Recorder 2 (2): give osd name (46) 11:09:00.785 T:1796207520 DEBUG: CecLogMessage - >> 02:8c 11:09:00.785 T:1796207520 DEBUG: CecLogMessage - << Recorder 2 (2) -> TV (0): vendor id Pulse Eight (1582) 11:09:00.785 T:1796207520 DEBUG: CecLogMessage - << 2f:87:00:15:82 11:09:00.786 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Recorder 2 (2): give device vendor id (8C) 11:09:00.936 T:1796207520 DEBUG: CecLogMessage - >> 02:46 11:09:00.936 T:1796207520 DEBUG: CecLogMessage - << Recorder 2 (2) -> TV (0): OSD name 'Recorder 2' 11:09:00.936 T:1796207520 DEBUG: CecLogMessage - << 20:47:52:65:63:6f:72:64:65:72:20:32 11:09:00.936 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Recorder 2 (2): give osd name (46) 11:09:01.327 T:1796207520 DEBUG: CecLogMessage - >> 02:8c 11:09:01.327 T:1796207520 DEBUG: CecLogMessage - << Recorder 2 (2) -> TV (0): vendor id Pulse Eight (1582) 11:09:01.327 T:1796207520 DEBUG: CecLogMessage - << 2f:87:00:15:82 11:09:01.328 T:1796207520 DEBUG: CecLogMessage - >> TV (0) -> Recorder 2 (2): give device vendor id (8C) 11:09:01.909 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:09:02.478 T:1796207520 DEBUG: CecLogMessage - << powering on 'TV' (0) 11:09:02.478 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:09:02.539 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:09:03.450 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:09:03.479 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:09:03.979 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:09:04.039 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:09:04.979 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:09:05.002 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:09:05.480 T:1796207520 DEBUG: CecLogMessage - << Recorder 1 (1) -> broadcast (F): active source (4000) 11:09:05.480 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:09:05.600 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:09:06.481 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:09:06.534 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:09:06.982 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:09:07.162 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:09:07.982 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:09:08.085 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:09:08.483 T:1796207520 DEBUG: CecLogMessage - failed to make 'Recorder 1' the active source. will retry later 11:09:09.079 T:1962214512 DEBUG: Keyboard: scancode: 0x69, sym: 0x0114, unicode: 0x0000, modifier: 0x0 11:09:09.079 T:1962214512 DEBUG: OnKey: left (0xf082) pressed, action is Left 11:09:09.430 T:1962214512 DEBUG: Keyboard: scancode: 0x69, sym: 0x0114, unicode: 0x0000, modifier: 0x0 11:09:09.483 T:1796207520 DEBUG: CecLogMessage - << powering on 'TV' (0) 11:09:09.483 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:09:09.543 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:09:09.635 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:09:10.484 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:09:10.984 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:09:11.045 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:09:11.105 T:1962214512 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0000, modifier: 0x0 11:09:11.105 T:1962214512 DEBUG: OnKey: up (0xf080) pressed, action is Up 11:09:11.167 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:09:11.335 T:1962214512 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0000, modifier: 0x0 11:09:11.391 T:1962214512 DEBUG: Previous line repeats 1 times. 11:09:11.392 T:1962214512 DEBUG: OnKey: up (0xf080) pressed, action is Up 11:09:11.632 T:1962214512 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0000, modifier: 0x0 11:09:11.985 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:09:12.485 T:1796207520 DEBUG: CecLogMessage - << Recorder 1 (1) -> broadcast (F): active source (4000) 11:09:12.485 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:09:12.605 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:09:12.693 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:09:12.933 T:1962214512 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 11:09:12.933 T:1962214512 DEBUG: OnKey: down (0xf081) pressed, action is Down 11:09:13.148 T:1962214512 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 11:09:13.446 T:1962214512 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 11:09:13.486 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:09:13.682 T:1962214512 DEBUG: OnKey: return (0xf00d) pressed, action is Select 11:09:13.682 T:1962214512 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 11:09:13.987 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:09:14.107 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:09:14.226 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:09:14.987 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:09:15.488 T:1796207520 DEBUG: CecLogMessage - failed to make 'Recorder 1' the active source. will retry later 11:09:15.826 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:09:16.155 T:1962214512 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 11:09:16.155 T:1962214512 DEBUG: OnKey: backspace (0xf008) pressed, action is Back 11:09:16.189 T:1962214512 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 11:09:16.416 T:1962214512 DEBUG: ------ Window Deinit (SettingsCategory.xml) ------ 11:09:16.418 T:1962214512 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 11:09:16.418 T:1962214512 DEBUG: ------ Window Init (Settings.xml) ------ 11:09:16.420 T:1962214512 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 11:09:16.423 T:1347535776 DEBUG: Thread JobWorker start, auto delete: true 11:09:16.438 T:1347535776 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x726692d0 11:09:16.439 T:1347535776 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(402672), nBufferAlignmen(16) 11:09:16.446 T:1347535776 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x531c8820 11:09:16.448 T:1347535776 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 11:09:16.485 T:1347535776 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x726692d0 11:09:16.486 T:1347535776 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x531c8820 11:09:16.487 T:1347535776 DEBUG: DecodeJpegToTexture: decoded special://skin/backgrounds/settings.jpg 1024x576 11:09:16.489 T:1796207520 DEBUG: CecLogMessage - << powering on 'TV' (0) 11:09:16.489 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:09:16.549 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:09:17.333 T:1962214512 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 11:09:17.369 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:09:17.489 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:09:17.589 T:1962214512 DEBUG: OnKey: backspace (0xf008) pressed, action is Back 11:09:17.589 T:1962214512 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 11:09:17.839 T:1962214512 DEBUG: ------ Window Deinit (Settings.xml) ------ 11:09:17.845 T:1962214512 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 11:09:17.845 T:1962214512 DEBUG: ------ Window Init (Home.xml) ------ 11:09:17.858 T:1962214512 DEBUG: Keyboard: scancode: 0x0e, sym: 0x0008, unicode: 0x0008, modifier: 0x0 11:09:17.990 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:09:18.050 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:09:18.915 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:09:18.942 T:1962214512 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 11:09:18.942 T:1962214512 DEBUG: OnKey: down (0xf081) pressed, action is Down 11:09:18.990 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:09:19.162 T:1962214512 DEBUG: Keyboard: scancode: 0x6c, sym: 0x0112, unicode: 0x0000, modifier: 0x0 11:09:19.491 T:1796207520 DEBUG: CecLogMessage - << Recorder 1 (1) -> broadcast (F): active source (4000) 11:09:19.491 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:09:19.611 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:09:20.459 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:09:20.491 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:09:20.992 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:09:21.142 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:09:21.992 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:09:21.994 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:09:22.493 T:1796207520 DEBUG: CecLogMessage - failed to make 'Recorder 1' the active source. will retry later 11:09:23.494 T:1796207520 DEBUG: CecLogMessage - << powering on 'TV' (0) 11:09:23.494 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:09:23.529 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:09:23.554 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:09:24.494 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:09:24.995 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:09:25.055 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:09:25.469 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:09:25.471 T:1962214512 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 11:09:25.512 T:1962214512 DEBUG: OnKey: return (0xf00d) pressed, action is Select 11:09:25.512 T:1962214512 DEBUG: Activating window ID: 10004 11:09:25.773 T:1962214512 DEBUG: ------ Window Deinit (Home.xml) ------ 11:09:25.778 T:1962214512 DEBUG: ------ Window Init (Settings.xml) ------ 11:09:25.780 T:1962214512 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 11:09:25.833 T:1347535776 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x726692d0 11:09:25.834 T:1347535776 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(402672), nBufferAlignmen(16) 11:09:25.852 T:1347535776 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x6310e068 11:09:25.853 T:1347535776 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 11:09:25.892 T:1347535776 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x726692d0 11:09:25.894 T:1347535776 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x6310e068 11:09:25.894 T:1347535776 DEBUG: DecodeJpegToTexture: decoded special://skin/backgrounds/settings.jpg 1024x576 11:09:25.995 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:09:26.495 T:1796207520 DEBUG: CecLogMessage - << Recorder 1 (1) -> broadcast (F): active source (4000) 11:09:26.496 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:09:26.616 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:09:27.029 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:09:27.496 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:09:27.997 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:09:28.117 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:09:28.565 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:09:28.997 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:09:29.498 T:1796207520 DEBUG: CecLogMessage - failed to make 'Recorder 1' the active source. will retry later 11:09:29.943 T:1962214512 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 11:09:30.109 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:09:30.136 T:1962214512 DEBUG: OnKey: return (0xf00d) pressed, action is Select 11:09:30.136 T:1962214512 DEBUG: Activating window ID: 10016 11:09:30.389 T:1962214512 DEBUG: ------ Window Deinit (Settings.xml) ------ 11:09:30.395 T:1962214512 DEBUG: ------ Window Init (SettingsCategory.xml) ------ 11:09:30.414 T:1962214512 DEBUG: Keyboard: scancode: 0x1c, sym: 0x000d, unicode: 0x0000, modifier: 0x0 11:09:30.498 T:1796207520 DEBUG: CecLogMessage - << powering on 'TV' (0) 11:09:30.498 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:09:30.558 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:09:31.498 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:09:31.653 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:09:31.999 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:09:32.059 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:09:32.999 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:09:33.184 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:09:33.500 T:1796207520 DEBUG: CecLogMessage - << Recorder 1 (1) -> broadcast (F): active source (4000) 11:09:33.500 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:09:33.620 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:09:33.864 T:1962214512 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0000, modifier: 0x0 11:09:33.865 T:1962214512 DEBUG: OnKey: up (0xf080) pressed, action is Up 11:09:34.079 T:1962214512 DEBUG: Keyboard: scancode: 0x67, sym: 0x0111, unicode: 0x0000, modifier: 0x0 11:09:34.500 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:09:34.720 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:09:35.001 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:09:35.121 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:09:36.002 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:09:36.269 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:09:36.503 T:1796207520 DEBUG: CecLogMessage - failed to make 'Recorder 1' the active source. will retry later 11:09:37.503 T:1796207520 DEBUG: CecLogMessage - << powering on 'TV' (0) 11:09:37.504 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:09:37.624 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:09:37.801 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:09:38.503 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:09:39.004 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:09:39.064 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:09:39.340 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:09:40.004 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:09:40.505 T:1796207520 DEBUG: CecLogMessage - << Recorder 1 (1) -> broadcast (F): active source (4000) 11:09:40.505 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:09:40.625 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:09:40.888 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:09:41.506 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:09:42.007 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:09:42.127 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:09:42.430 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:09:43.007 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:09:43.508 T:1796207520 DEBUG: CecLogMessage - failed to make 'Recorder 1' the active source. will retry later 11:09:43.962 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:09:44.509 T:1796207520 DEBUG: CecLogMessage - << powering on 'TV' (0) 11:09:44.509 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:09:44.569 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:09:45.501 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:09:45.509 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:09:46.010 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:09:46.070 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:09:47.011 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:09:47.049 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:09:47.512 T:1796207520 DEBUG: CecLogMessage - << Recorder 1 (1) -> broadcast (F): active source (4000) 11:09:47.512 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:09:47.633 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:09:48.513 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:09:48.583 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:09:49.013 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:09:49.134 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:09:50.014 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:09:50.514 T:1796207520 DEBUG: CecLogMessage - failed to make 'Recorder 1' the active source. will retry later 11:09:51.515 T:1796207520 DEBUG: CecLogMessage - << powering on 'TV' (0) 11:09:51.515 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:09:51.636 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:09:52.516 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:09:53.017 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:09:53.077 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:09:53.166 T:1437254560 DEBUG: CWebServer[80]: request received for /jsonrpc 11:09:54.017 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:09:54.518 T:1796207520 DEBUG: CecLogMessage - << Recorder 1 (1) -> broadcast (F): active source (4000) 11:09:54.518 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:09:54.638 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:09:55.519 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:09:55.895 T:1347535776 DEBUG: Thread JobWorker 1347535776 terminating (autodelete) 11:09:56.020 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:09:56.140 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:09:57.020 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:09:57.521 T:1796207520 DEBUG: CecLogMessage - failed to make 'Recorder 1' the active source. will retry later 11:09:58.522 T:1796207520 DEBUG: CecLogMessage - << powering on 'TV' (0) 11:09:58.523 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:09:58.583 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:09:59.523 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:10:00.024 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:10:00.085 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:10:01.025 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:10:01.525 T:1796207520 DEBUG: CecLogMessage - << Recorder 1 (1) -> broadcast (F): active source (4000) 11:10:01.526 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:10:01.646 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:10:02.526 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:10:03.027 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:10:03.147 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:10:04.027 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:10:04.528 T:1796207520 DEBUG: CecLogMessage - failed to make 'Recorder 1' the active source. will retry later 11:10:05.529 T:1796207520 DEBUG: CecLogMessage - << powering on 'TV' (0) 11:10:05.529 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:10:05.589 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:10:06.530 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:10:07.030 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:10:07.121 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:10:08.031 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:10:08.232 T:1495974816 INFO: JSONRPC Server: Disconnection detected 11:10:08.532 T:1796207520 DEBUG: CecLogMessage - << Recorder 1 (1) -> broadcast (F): active source (4000) 11:10:08.532 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:10:08.652 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:10:09.533 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:10:10.034 T:1796207520 DEBUG: CecLogMessage - << 1f:82:40:00 11:10:10.154 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=82 initiator=2 destination=f response=0 11:10:11.034 T:1796207520 DEBUG: CecLogMessage - command 'active source' timeout 11:10:11.535 T:1796207520 DEBUG: CecLogMessage - failed to make 'Recorder 1' the active source. will retry later 11:10:12.536 T:1796207520 DEBUG: CecLogMessage - << powering on 'TV' (0) 11:10:12.536 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:10:12.596 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:10:13.536 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout 11:10:14.037 T:1796207520 DEBUG: CecLogMessage - << 10:04 11:10:14.097 T:1796207520 WARNING: CecLogMessage - unhandled response received: opcode=4 initiator=2 destination=0 response=0 11:10:15.038 T:1796207520 DEBUG: CecLogMessage - command 'image view on' timeout