-- Logs begin at Fri 2018-12-21 16:24:05 CET. -- Dec 22 14:00:11 dm7080 enigma2[591]: ProcessRepeated Dec 22 14:00:11 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:00:11 CET Dec 22 14:00:11 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:00:11 dm7080 enigma2[591]: [timer.py] next activation: 1545483711 (in 99160 ms) Dec 22 14:00:11 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 83 32 cd 14 eb Dec 22 14:00:11 dm7080 enigma2[591]: create buffer for widget 917 x 37 Dec 22 14:00:11 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 94 6b Dec 22 14:00:12 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:00:16 dm7080 enigma2[591]: [eFileMonitor] 1 events queued Dec 22 14:00:16 dm7080 enigma2[591]: [eFileMonitor] File {/tmp/enigma2.log} has been created Dec 22 14:00:55 dm7080 enigma2[591]: send: 'POST /ZoneGroupTopology/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:ZoneGroupTopology:1#GetZoneGroupState\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 277\r\n\r\n' Dec 22 14:00:55 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:00:55 dm7080 enigma2[591]: header: CONTENT-LENGTH: 5054 Dec 22 14:00:55 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:00:55 dm7080 enigma2[591]: header: EXT: Dec 22 14:00:55 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:00:55 dm7080 enigma2[591]: header: Connection: close Dec 22 14:00:55 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:00:55 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:00:55 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:00:55 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:00:55 dm7080 enigma2[591]: header: EXT: Dec 22 14:00:55 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:00:55 dm7080 enigma2[591]: header: Connection: close Dec 22 14:01:04 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:01:03 CET Dec 22 14:01:04 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:01:04 dm7080 enigma2[591]: [timer.py] next activation: 1545483764 (in 99999 ms) Dec 22 14:01:09 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:01:09 CET Dec 22 14:01:09 dm7080 enigma2[591]: [timer.py] next activation: 1545483769 (in 99998 ms) Dec 22 14:01:12 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:01:14 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 20 df Dec 22 14:01:14 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 83 32 cd 20 df Dec 22 14:01:14 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd a0 5f Dec 22 14:01:14 dm7080 enigma2[591]: action -> QuickButtonActions green Dec 22 14:01:14 dm7080 enigma2[591]: unknown action QuickButtonActions/green! typo in keymap? Dec 22 14:01:14 dm7080 enigma2[591]: allocating new converter! Dec 22 14:01:14 dm7080 enigma2[591]: reused converter! Dec 22 14:01:14 dm7080 enigma2[591]: reused converter! Dec 22 14:01:14 dm7080 enigma2[591]: reused converter! Dec 22 14:01:14 dm7080 enigma2[591]: create buffer for widget 900 x 1080 Dec 22 14:01:15 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 15 ea Dec 22 14:01:15 dm7080 enigma2[591]: action -> WizardActions right Dec 22 14:01:15 dm7080 enigma2[591]: unknown action WizardActions/right! typo in keymap? Dec 22 14:01:17 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 17 e8 Dec 22 14:01:17 dm7080 enigma2[591]: action -> WizardActions down Dec 22 14:01:17 dm7080 enigma2[591]: unknown action WizardActions/down! typo in keymap? Dec 22 14:01:17 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 17 e8 Dec 22 14:01:17 dm7080 enigma2[591]: action -> WizardActions down Dec 22 14:01:17 dm7080 enigma2[591]: unknown action WizardActions/down! typo in keymap? Dec 22 14:01:18 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 17 e8 Dec 22 14:01:18 dm7080 enigma2[591]: action -> WizardActions down Dec 22 14:01:18 dm7080 enigma2[591]: unknown action WizardActions/down! typo in keymap? Dec 22 14:01:18 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 14 eb Dec 22 14:01:18 dm7080 enigma2[591]: action -> WizardActions ok Dec 22 14:01:18 dm7080 enigma2[591]: ok, found sqlite3 with version number 3.11.0 Dec 22 14:01:18 dm7080 enigma2[591]: [SkyRecorder] read channellist.. Dec 22 14:01:18 dm7080 enigma2[591]: [SkyRecorder] found 2 bouquet: [('1:7:1:0:0:0:0:0:0:0:FROM BOUQUET "userbouquet.favourites.tv" ORDER BY bouquet', 'Favourites (TV)'), ('1:7:1:0:0:0:0:0:0:0:FROM BOUQUET "userbouquet.bef001.tv" ORDER BY bouquet', 'Sky Sport')] Dec 22 14:01:18 dm7080 enigma2[591]: Looking for embedded skin Dec 22 14:01:18 dm7080 enigma2[591]: allocating new converter! Dec 22 14:01:18 dm7080 enigma2[591]: reused converter! Dec 22 14:01:19 dm7080 enigma2[591]: reused converter! Dec 22 14:01:19 dm7080 enigma2[591]: reused converter! Dec 22 14:01:19 dm7080 enigma2[591]: reused converter! Dec 22 14:01:19 dm7080 enigma2[591]: create buffer for widget 1920 x 1080 Dec 22 14:01:19 dm7080 enigma2[591]: [SkyRecorder] read channellist.. Dec 22 14:01:19 dm7080 enigma2[591]: [SkyRecorder] found 2 bouquet: [('1:7:1:0:0:0:0:0:0:0:FROM BOUQUET "userbouquet.favourites.tv" ORDER BY bouquet', 'Favourites (TV)'), ('1:7:1:0:0:0:0:0:0:0:FROM BOUQUET "userbouquet.bef001.tv" ORDER BY bouquet', 'Sky Sport')] Dec 22 14:01:19 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:19 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:19 dm7080 enigma2[591]: [ePicLoad] setPara max-X=281 max-Y=400 aspectRatio=17280:17280 cache=0 resize=1 bg=#FF000000 Dec 22 14:01:19 dm7080 enigma2[591]: before: 1 Dec 22 14:01:19 dm7080 enigma2[591]: after: 1 Dec 22 14:01:19 dm7080 enigma2[591]: [ePicLoad] decode picture... /tmp/skyrecorder_tempcover.png Dec 22 14:01:19 dm7080 enigma2[591]: gPixmapPtr.__deref__() is deprecated please completely remove the ".__deref__()" call! Dec 22 14:01:19 dm7080 enigma2[591]: File "/usr/lib/enigma2/python/Plugins/Extensions/skyrecorder/SkyRecorderMainScreen.py", line 685, in ShowCover Dec 22 14:01:19 dm7080 enigma2[591]: self['image'].instance.setPixmap(ptr.__deref__()) Dec 22 14:01:19 dm7080 enigma2[591]: File "/usr/lib/enigma2/python/mytest.py", line 6, in gPixmapPtr_deref Dec 22 14:01:19 dm7080 enigma2[591]: traceback.print_stack(limit = 2) Dec 22 14:01:19 dm7080 enigma2[591]: [ePicLoad] decode thread ... got quit msg Dec 22 14:01:19 dm7080 enigma2[591]: thread joined 0 Dec 22 14:01:19 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 83 32 cd 14 eb Dec 22 14:01:19 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 94 6b Dec 22 14:01:23 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 12 ed Dec 22 14:01:23 dm7080 enigma2[591]: action -> EPGSelectActions input_date_time Dec 22 14:01:23 dm7080 enigma2[591]: unknown action EPGSelectActions/input_date_time! typo in keymap? Dec 22 14:01:23 dm7080 enigma2[591]: action -> MenuActions menu Dec 22 14:01:23 dm7080 enigma2[591]: Looking for embedded skin Dec 22 14:01:23 dm7080 enigma2[591]: Looking for embedded skin Dec 22 14:01:23 dm7080 enigma2[591]: reused converter! Dec 22 14:01:23 dm7080 enigma2[591]: reused converter! Dec 22 14:01:23 dm7080 enigma2[591]: reused converter! Dec 22 14:01:23 dm7080 enigma2[591]: reused converter! Dec 22 14:01:23 dm7080 enigma2[591]: reused converter! Dec 22 14:01:23 dm7080 enigma2[591]: create buffer for widget 1920 x 1080 Dec 22 14:01:23 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 83 32 cd 12 ed Dec 22 14:01:23 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 92 6d Dec 22 14:01:25 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 1d e2 Dec 22 14:01:25 dm7080 enigma2[591]: action -> OkCancelActions cancel Dec 22 14:01:25 dm7080 enigma2[591]: [SkyRecorder] read channellist.. Dec 22 14:01:25 dm7080 enigma2[591]: [SkyRecorder] found 2 bouquet: [('1:7:1:0:0:0:0:0:0:0:FROM BOUQUET "userbouquet.favourites.tv" ORDER BY bouquet', 'Favourites (TV)'), ('1:7:1:0:0:0:0:0:0:0:FROM BOUQUET "userbouquet.bef001.tv" ORDER BY bouquet', 'Sky Sport')] Dec 22 14:01:26 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:26 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:26 dm7080 enigma2[591]: [ePicLoad] setPara max-X=281 max-Y=400 aspectRatio=17280:17280 cache=0 resize=1 bg=#FF000000 Dec 22 14:01:26 dm7080 enigma2[591]: before: 1 Dec 22 14:01:26 dm7080 enigma2[591]: after: 1 Dec 22 14:01:26 dm7080 enigma2[591]: [ePicLoad] decode picture... /tmp/skyrecorder_tempcover.png Dec 22 14:01:26 dm7080 enigma2[591]: gPixmapPtr.__deref__() is deprecated please completely remove the ".__deref__()" call! Dec 22 14:01:26 dm7080 enigma2[591]: File "/usr/lib/enigma2/python/Plugins/Extensions/skyrecorder/SkyRecorderMainScreen.py", line 685, in ShowCover Dec 22 14:01:26 dm7080 enigma2[591]: self['image'].instance.setPixmap(ptr.__deref__()) Dec 22 14:01:26 dm7080 enigma2[591]: File "/usr/lib/enigma2/python/mytest.py", line 6, in gPixmapPtr_deref Dec 22 14:01:26 dm7080 enigma2[591]: traceback.print_stack(limit = 2) Dec 22 14:01:26 dm7080 enigma2[591]: [ePicLoad] decode thread ... got quit msg Dec 22 14:01:26 dm7080 enigma2[591]: thread joined 0 Dec 22 14:01:26 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 83 32 cd 1d e2 Dec 22 14:01:26 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 9d 62 Dec 22 14:01:27 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 1d e2 Dec 22 14:01:27 dm7080 enigma2[591]: action -> OkCancelActions cancel Dec 22 14:01:27 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 83 32 cd 1d e2 Dec 22 14:01:27 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 9d 62 Dec 22 14:01:28 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 1d e2 Dec 22 14:01:28 dm7080 enigma2[591]: action -> WizardActions back Dec 22 14:01:28 dm7080 enigma2[591]: I/ [InfoBar.__restoreState] :: Dec 22 14:01:28 dm7080 enigma2[591]: I/ [InfoBar.setPlaybackState] :: 1545483688.41 Dec 22 14:01:28 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 83 32 cd 1d e2 Dec 22 14:01:28 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 9d 62 Dec 22 14:01:33 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 15 ea Dec 22 14:01:33 dm7080 enigma2[591]: action -> QuickButtonActions right Dec 22 14:01:33 dm7080 enigma2[591]: unknown action QuickButtonActions/right! typo in keymap? Dec 22 14:01:33 dm7080 enigma2[591]: playing 1:0:19:2B66:3F3:1:C00000:0:0:0: Dec 22 14:01:33 dm7080 enigma2[591]: stopping thread. Dec 22 14:01:33 dm7080 enigma2[591]: waiting for aio thread shutdown! Dec 22 14:01:33 dm7080 enigma2[591]: record aio thread has finished Dec 22 14:01:33 dm7080 enigma2[591]: eRecordFileThread (direct io) STOP Dec 22 14:01:33 dm7080 enigma2[591]: thread joined 0 Dec 22 14:01:33 dm7080 enigma2[591]: remove timeshift file Dec 22 14:01:33 dm7080 enigma2[591]: [eDVBCAService] free slot 0 demux 0 for service 1:0:19:283D:3FB:1:C00000:0:0:0: Dec 22 14:01:33 dm7080 enigma2[591]: [eDVBCAService] don't send the same capmt twice Dec 22 14:01:33 dm7080 enigma2[591]: I/ [PhotoScreensaver.setEnabled] :: True Dec 22 14:01:33 dm7080 enigma2[591]: before: 1 Dec 22 14:01:33 dm7080 enigma2[591]: [ePicLoad] decode picture... /tmp/wallpaper Dec 22 14:01:33 dm7080 enigma2[591]: [eDBusInterface::Private::sendEvent 0 Dec 22 14:01:33 dm7080 enigma2[591]: [TeleText] service stopped Dec 22 14:01:33 dm7080 enigma2[591]: [TeleText] send array('B', [1, 0, 0, 0]) Dec 22 14:01:33 dm7080 enigma2[591]: disable dvb subtitles Dec 22 14:01:33 dm7080 enigma2[591]: disable teletext subtitles page ffffffffffffffff (und) Dec 22 14:01:33 dm7080 enigma2[591]: decoder state: play, vpid=-1, apid=-1 Dec 22 14:01:33 dm7080 enigma2[591]: DEMUX_STOP - pcr - ok Dec 22 14:01:33 dm7080 enigma2[591]: DEMUX_STOP - video - ok Dec 22 14:01:33 dm7080 enigma2[591]: VIDEO_STOP - ok Dec 22 14:01:33 dm7080 enigma2[591]: AUDIO_STOP - ok Dec 22 14:01:33 dm7080 enigma2[591]: DEMUX_STOP - audio - ok Dec 22 14:01:33 dm7080 enigma2[591]: AUDIO_CONTINUE - ok Dec 22 14:01:33 dm7080 enigma2[591]: DEMUX_STOP - ttx - ok Dec 22 14:01:33 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:33 dm7080 enigma2[591]: [TeleText] service started Dec 22 14:01:33 dm7080 enigma2[591]: [Plugins.GP4.geminiwidgets.gWidgets] <'NoneType' object has no attribute 'type'> Dec 22 14:01:33 dm7080 enigma2[591]: [Plugins.GP4.geminiwidgets.gWidgets] <'NoneType' object has no attribute 'type'> Dec 22 14:01:33 dm7080 enigma2[591]: [Plugins.GP4.geminiwidgets.gWidgets] <'NoneType' object has no attribute 'type'> Dec 22 14:01:33 dm7080 enigma2[591]: [Plugins.GP4.geminiwidgets.gWidgets] <'NoneType' object has no attribute 'type'> Dec 22 14:01:33 dm7080 enigma2[591]: not pauseable. Dec 22 14:01:33 dm7080 enigma2[591]: W/ [InfoBar.__servicePlaying] :: Dec 22 14:01:33 dm7080 enigma2[591]: I/ [InfoBar.setPlaybackState] :: None None 1545483693.18 Dec 22 14:01:33 dm7080 enigma2[591]: allocate channel.. 03f3:0001:00c00000 Dec 22 14:01:33 dm7080 enigma2[591]: available channel.. 03fb:0001:00c00000 Dec 22 14:01:33 dm7080 enigma2[591]: [ 1] opening frontend Dec 22 14:01:33 dm7080 enigma2[591]: [eDVBCAService] new channel 0x2339418! Dec 22 14:01:33 dm7080 enigma2[591]: [ 1] tune type 1 Dec 22 14:01:33 dm7080 enigma2[591]: RotorCmd ffffffff, lastRotorCmd ffffffff Dec 22 14:01:33 dm7080 enigma2[591]: [ 1] prepare_sat System DVB-S2 Freq 11361750H SR 22000000 INV Auto FEC 2/3 orbpos 192 modulation 8PSK pilot Auto, rolloff 0.35 Dec 22 14:01:33 dm7080 enigma2[591]: [ 1] tuning to 1611 mhz Dec 22 14:01:33 dm7080 enigma2[591]: OURSTATE: tuning Dec 22 14:01:33 dm7080 enigma2[591]: [SEC-1] update oparm Dec 22 14:01:33 dm7080 enigma2[591]: [SEC-1] lock 0 Dec 22 14:01:33 dm7080 enigma2[591]: [SEC-1] locked 1 Dec 22 14:01:33 dm7080 enigma2[591]: [SEC-1] set static current limiting Dec 22 14:01:33 dm7080 enigma2[591]: allocate Channel: res 0 Dec 22 14:01:33 dm7080 enigma2[591]: [SEC-1] invalidate current switch params Dec 22 14:01:33 dm7080 enigma2[591]: [SEC-1] setVoltage 18V Dec 22 14:01:33 dm7080 enigma2[591]: [SEC-1] sleep 10ms Dec 22 14:01:33 dm7080 enigma2[591]: allocate demux Dec 22 14:01:33 dm7080 enigma2[591]: setInputSource input1 to A2 Dec 22 14:01:33 dm7080 enigma2[591]: have 1 video stream(s) (17de), and 1 audio stream(s) (17ea), and the pcr pid is 17de, and the text pid is 17f2 Dec 22 14:01:33 dm7080 enigma2[591]: allocate demux Dec 22 14:01:33 dm7080 enigma2[591]: disable teletext subtitles page ffffffffffffffff (und) Dec 22 14:01:33 dm7080 enigma2[591]: decoder state: play, vpid=6110, apid=6122 Dec 22 14:01:33 dm7080 enigma2[591]: DMX_SET_PES_FILTER(0x17de) - pcr - ok Dec 22 14:01:33 dm7080 enigma2[591]: DEMUX_START - pcr - ok Dec 22 14:01:33 dm7080 enigma2[591]: DMX_SET_PES_FILTER(0x17ea) - audio - ok Dec 22 14:01:33 dm7080 enigma2[591]: DEMUX_START - audio - ok Dec 22 14:01:33 dm7080 enigma2[591]: AUDIO_SET_BYPASS(0) - [SEC-1] update current switch params Dec 22 14:01:33 dm7080 enigma2[591]: [SEC-1] startTuneTimeout 5000 Dec 22 14:01:33 dm7080 enigma2[591]: [SEC-1] setFrontend 1 Dec 22 14:01:33 dm7080 enigma2[591]: [ 1] setting frontend Dec 22 14:01:33 dm7080 enigma2[591]: [SEC-1] unlock 1 Dec 22 14:01:33 dm7080 enigma2[591]: [SEC-1] sleep 500ms Dec 22 14:01:33 dm7080 enigma2[591]: ok Dec 22 14:01:33 dm7080 enigma2[591]: AUDIO_PAUSE - ok Dec 22 14:01:33 dm7080 enigma2[591]: AUDIO_PLAY - ok Dec 22 14:01:33 dm7080 enigma2[591]: Video Device: /dev/dvb/adapter0/video0 Dec 22 14:01:33 dm7080 enigma2[591]: demux device: /dev/dvb/adapter0/demux1 Dec 22 14:01:33 dm7080 enigma2[591]: VIDEO_SET_STREAMTYPE 1 - ok Dec 22 14:01:33 dm7080 enigma2[591]: DMX_SET_PES_FILTER(0x17de) - video - ok Dec 22 14:01:33 dm7080 enigma2[591]: DEMUX_START - video - ok Dec 22 14:01:33 dm7080 enigma2[591]: VIDEO_FREEZE - ok Dec 22 14:01:33 dm7080 enigma2[591]: VIDEO_PLAY - ok Dec 22 14:01:33 dm7080 enigma2[591]: DMX_SET_PES_FILTER(0x17f2) - ttx - ok Dec 22 14:01:33 dm7080 enigma2[591]: DEMUX_START - ttx - ok Dec 22 14:01:33 dm7080 enigma2[591]: VIDEO_SLOWMOTION(0) - ok Dec 22 14:01:33 dm7080 enigma2[591]: VIDEO_FAST_FORWARD(0) - ok Dec 22 14:01:33 dm7080 enigma2[591]: VIDEO_CONTINUE - ok Dec 22 14:01:33 dm7080 enigma2[591]: AUDIO_CONTINUE - ok Dec 22 14:01:33 dm7080 enigma2[591]: W/ [InfoBar.__servicePlaying] :: Dec 22 14:01:33 dm7080 enigma2[591]: I/ [InfoBar.setPlaybackState] :: None None 1545483693.21 Dec 22 14:01:33 dm7080 enigma2[591]: I/ [ScreenSaverHandler._onEvent] :: play event, checking for video Dec 22 14:01:33 dm7080 enigma2[591]: I/ [PhotoScreensaver.setEnabled] :: False Dec 22 14:01:33 dm7080 enigma2[591]: not pauseable. Dec 22 14:01:33 dm7080 enigma2[591]: [HbbTV].aitInvalidated Dec 22 14:01:33 dm7080 enigma2[591]: create buffer for widget 917 x 37 Dec 22 14:01:33 dm7080 enigma2[591]: eBackgroundFileEraser '/media/ssd/pts//timeshift.BLhlyy' finished Dec 22 14:01:33 dm7080 enigma2[591]: [ 1] fe event: status 0, freq 1611750, inversion off, m_tuning 1 F Dec 22 14:01:33 dm7080 enigma2[591]: [ 1] fe event: status 1, freq 1611750, inversion off, m_tuning 1 N Dec 22 14:01:33 dm7080 enigma2[591]: [ 1] fe event: status 0, freq 1611750, inversion off, m_tuning 2 N Dec 22 14:01:33 dm7080 enigma2[591]: [ 1] fe event: status 1f, freq 1611750, inversion off, m_tuning 3 N Dec 22 14:01:33 dm7080 enigma2[591]: OURSTATE: ok Dec 22 14:01:33 dm7080 enigma2[591]: [eDVBCAService] channel 0x2339418 running Dec 22 14:01:33 dm7080 enigma2[591]: [eDVBLocalTimeHandler] channel 0x2339418 running Dec 22 14:01:33 dm7080 enigma2[591]: no version filtering Dec 22 14:01:33 dm7080 enigma2[591]: 0014: 70 00 00 00 00 00 Dec 22 14:01:33 dm7080 enigma2[591]: mask: fc 00 00 00 00 00 Dec 22 14:01:33 dm7080 enigma2[591]: mode: 00 00 00 00 00 00 Dec 22 14:01:33 dm7080 enigma2[591]: [EPGC] channel 0x2339418 running Dec 22 14:01:33 dm7080 enigma2[591]: [EPGC] next update in 2 sec Dec 22 14:01:33 dm7080 enigma2[591]: stop release channel timer Dec 22 14:01:33 dm7080 enigma2[591]: no version filtering Dec 22 14:01:33 dm7080 enigma2[591]: 0012: 4e 2b 66 00 00 00 Dec 22 14:01:33 dm7080 enigma2[591]: mask: ff ff ff 00 00 00 Dec 22 14:01:33 dm7080 enigma2[591]: mode: 00 00 00 00 00 00 Dec 22 14:01:33 dm7080 enigma2[591]: ok ... now we start!! Dec 22 14:01:33 dm7080 enigma2[591]: no version filtering Dec 22 14:01:33 dm7080 enigma2[591]: 0000: 00 00 00 00 00 00 Dec 22 14:01:33 dm7080 enigma2[591]: mask: ff 00 00 00 00 00 Dec 22 14:01:33 dm7080 enigma2[591]: mode: 00 00 00 00 00 00 Dec 22 14:01:33 dm7080 enigma2[591]: + 1/1 TID 00 Dec 22 14:01:33 dm7080 enigma2[591]: done! Dec 22 14:01:33 dm7080 enigma2[591]: PATready Dec 22 14:01:33 dm7080 enigma2[591]: use pmtpid 17d4 for service_id 2b66 Dec 22 14:01:33 dm7080 enigma2[591]: no version filtering Dec 22 14:01:33 dm7080 enigma2[591]: 17d4: 02 2b 66 00 00 00 Dec 22 14:01:33 dm7080 enigma2[591]: mask: ff ff ff 00 00 00 Dec 22 14:01:33 dm7080 enigma2[591]: mode: 00 00 00 00 00 00 Dec 22 14:01:33 dm7080 enigma2[591]: doing version filtering Dec 22 14:01:33 dm7080 enigma2[591]: 0000: 00 00 00 01 00 00 Dec 22 14:01:33 dm7080 enigma2[591]: mask: ff 00 00 3f 00 00 Dec 22 14:01:33 dm7080 enigma2[591]: mode: 00 00 00 3e 00 00 Dec 22 14:01:33 dm7080 enigma2[591]: [SEC-1] set dynamic current limiting Dec 22 14:01:33 dm7080 enigma2[591]: sdt update done! Dec 22 14:01:33 dm7080 enigma2[591]: + 1/1 TID 02 Dec 22 14:01:33 dm7080 enigma2[591]: done! Dec 22 14:01:33 dm7080 enigma2[591]: [eDVBCAService] new service 1:0:19:2B66:3F3:1:C00000:0:0:0: Dec 22 14:01:33 dm7080 enigma2[591]: [eDVBCAService] add demux 1 to slot 0 service 1:0:19:2B66:3F3:1:C00000:0:0:0: Dec 22 14:01:33 dm7080 enigma2[591]: [eDVBCAService] demux 1 mask 02 Dec 22 14:01:33 dm7080 enigma2[591]: [eDVBCAServiceConn] send 82 bytes to '/tmp/camd.socket' Dec 22 14:01:33 dm7080 enigma2[591]: 9f 80 32 4e 03 2b 66 01 00 1b 01 81 08 00 c0 00 00 03 f3 00 01 82 02 02 01 84 02 17 d4 85 03 01 41 32 86 01 01 1b 17 de 00 00 03 17 e8 00 00 03 17 e9 00 00 06 17 ea 00 00 03 17 eb 00 00 06 17 f2 00 00 06 17 f3 00 00 06 17 f4 00 00 05 18 1a 00 00 Dec 22 14:01:33 dm7080 enigma2[591]: [eDVBCIInterfaces] addPMTHandler 1:0:19:2B66:3F3:1:C00000:0:0:0: Dec 22 14:01:33 dm7080 enigma2[591]: [eDVBCIInterfaces] gotPMT Dec 22 14:01:33 dm7080 enigma2[591]: eventNewProgramInfo 0 0 Dec 22 14:01:33 dm7080 enigma2[591]: start ait on pid 181a Dec 22 14:01:33 dm7080 enigma2[591]: no version filtering Dec 22 14:01:33 dm7080 enigma2[591]: 181a: 74 00 00 00 00 00 Dec 22 14:01:33 dm7080 enigma2[591]: mask: ff 00 00 00 00 00 Dec 22 14:01:33 dm7080 enigma2[591]: mode: 00 00 00 00 00 00 Dec 22 14:01:33 dm7080 enigma2[591]: have 1 video stream(s) (17de), and 4 audio stream(s) (17e8, 17e9, 17ea, 17eb), and the pcr pid is 17de, and the text pid is 17f2 Dec 22 14:01:33 dm7080 enigma2[591]: decoder state: play, vpid=6110, apid=6122 Dec 22 14:01:33 dm7080 enigma2[591]: [TeleText] serviceInfoChanged Dec 22 14:01:33 dm7080 enigma2[591]: [TeleText] TXT PID 6130 DEMUX 1 Dec 22 14:01:33 dm7080 enigma2[591]: [TeleText] send array('B', [1, 23, 242, 1]) Dec 22 14:01:33 dm7080 enigma2[591]: doing version filtering Dec 22 14:01:33 dm7080 enigma2[591]: 17d4: 02 2b 66 01 00 00 Dec 22 14:01:33 dm7080 enigma2[591]: mask: ff ff ff 3f 00 00 Dec 22 14:01:33 dm7080 enigma2[591]: mode: 00 00 00 3e 00 00 Dec 22 14:01:34 dm7080 enigma2[591]: -+ 1/2 TID 4e Dec 22 14:01:34 dm7080 enigma2[591]: [ePicLoad] finished decoding /tmp/wallpaper. Dec 22 14:01:34 dm7080 enigma2[591]: VIDEO_GET_EVENT - ok Dec 22 14:01:34 dm7080 enigma2[591]: unhandled DVBAPI Video Event 32 Dec 22 14:01:34 dm7080 enigma2[591]: + 1/1 TID 74 Dec 22 14:01:34 dm7080 enigma2[591]: done! Dec 22 14:01:34 dm7080 enigma2[591]: [eHbbtv] aitChanged pid=0x181a Dec 22 14:01:34 dm7080 enigma2[591]: [eOipfApplication] Profile 0000, Version 1.1.1 Dec 22 14:01:34 dm7080 enigma2[591]: [eOipfApplication] deu:ZDF Start Dec 22 14:01:34 dm7080 enigma2[591]: [eHbbtv] New Application: ZDF Start (orgid=17, appid=1, urlBase=http://hbbtv.zdf.de/zdfstart/, initalPath=index.php, controlCode=1, visibility=2) Dec 22 14:01:34 dm7080 enigma2[591]: [eHbbtv] Resolving Application Locator: dvb://current.ait/11.1 Dec 22 14:01:34 dm7080 enigma2[591]: [eHbbtv] We have 1 app(s) for service 1.1011.11110 Dec 22 14:01:34 dm7080 enigma2[591]: [eHbbtv] 'dvb://current.ait/11.1' resolved to 'http://hbbtv.zdf.de/zdfstart/index.php' Dec 22 14:01:34 dm7080 enigma2[591]: [eOipfApplication] Profile 0000, Version 1.1.1 Dec 22 14:01:34 dm7080 enigma2[591]: [eOipfApplication] deu:ZDF mediathek Dec 22 14:01:34 dm7080 enigma2[591]: [eHbbtv] New Application: ZDF mediathek (orgid=17, appid=2, urlBase=http://hbbtv.zdf.de/zdfm3/, initalPath=index.php, controlCode=2, visibility=2) Dec 22 14:01:34 dm7080 enigma2[591]: [eHbbtv] Resolving Application Locator: dvb://current.ait/11.2 Dec 22 14:01:34 dm7080 enigma2[591]: [eHbbtv] We have 2 app(s) for service 1.1011.11110 Dec 22 14:01:34 dm7080 enigma2[591]: [eHbbtv] 'dvb://current.ait/11.2' resolved to 'http://hbbtv.zdf.de/zdfm3/index.php' Dec 22 14:01:34 dm7080 enigma2[591]: [eOipfApplication] Profile 0000, Version 1.1.1 Dec 22 14:01:34 dm7080 enigma2[591]: [eOipfApplication] deu:ZDF Nachrichten Dec 22 14:01:34 dm7080 enigma2[591]: [eHbbtv] New Application: ZDF Nachrichten (orgid=17, appid=7, urlBase=http://hbbtv.zdf.de/zdfnews/, initalPath=index.php, controlCode=2, visibility=2) Dec 22 14:01:34 dm7080 enigma2[591]: [eHbbtv] Resolving Application Locator: dvb://current.ait/11.7 Dec 22 14:01:34 dm7080 enigma2[591]: [eHbbtv] We have 3 app(s) for service 1.1011.11110 Dec 22 14:01:34 dm7080 enigma2[591]: [eHbbtv] 'dvb://current.ait/11.7' resolved to 'http://hbbtv.zdf.de/zdfnews/index.php' Dec 22 14:01:34 dm7080 enigma2[591]: [eOipfApplication] Profile 0000, Version 1.1.1 Dec 22 14:01:34 dm7080 enigma2[591]: [eOipfApplication] deu:ZDF Programm Dec 22 14:01:34 dm7080 enigma2[591]: [eHbbtv] New Application: ZDF Programm (orgid=17, appid=6, urlBase=http://hbbtv.zdf.de/zdfepg/, initalPath=index.php, controlCode=2, visibility=2) Dec 22 14:01:34 dm7080 enigma2[591]: [eHbbtv] Resolving Application Locator: dvb://current.ait/11.6 Dec 22 14:01:34 dm7080 enigma2[591]: [eHbbtv] We have 4 app(s) for service 1.1011.11110 Dec 22 14:01:34 dm7080 enigma2[591]: [eHbbtv] 'dvb://current.ait/11.6' resolved to 'http://hbbtv.zdf.de/zdfepg/index.php' Dec 22 14:01:34 dm7080 enigma2[591]: [eOipfApplication] Profile 0000, Version 1.1.1 Dec 22 14:01:34 dm7080 enigma2[591]: [eOipfApplication] deu:ZDF FIFA WM Dec 22 14:01:34 dm7080 enigma2[591]: [eHbbtv] New Application: ZDF FIFA WM (orgid=17, appid=8, urlBase=http://hbbtv.zdf.de/zdffifawm2/, initalPath=index.php, controlCode=2, visibility=2) Dec 22 14:01:34 dm7080 enigma2[591]: [eHbbtv] Resolving Application Locator: dvb://current.ait/11.8 Dec 22 14:01:34 dm7080 enigma2[591]: [eHbbtv] We have 5 app(s) for service 1.1011.11110 Dec 22 14:01:34 dm7080 enigma2[591]: [eHbbtv] 'dvb://current.ait/11.8' resolved to 'http://hbbtv.zdf.de/zdffifawm2/index.php' Dec 22 14:01:34 dm7080 enigma2[591]: [HbbTV].readButtonApplicationReady, appid=11.1 Dec 22 14:01:34 dm7080 enigma2[591]: doing version filtering Dec 22 14:01:34 dm7080 enigma2[591]: 181a: 74 00 00 07 00 00 Dec 22 14:01:34 dm7080 enigma2[591]: mask: ff 00 00 3f 00 00 Dec 22 14:01:34 dm7080 enigma2[591]: mode: 00 00 00 3e 00 00 Dec 22 14:01:34 dm7080 enigma2[591]: ++ 2/2 TID 4e Dec 22 14:01:34 dm7080 enigma2[591]: done! Dec 22 14:01:34 dm7080 enigma2[591]: W/ [InfoBar.__servicePlaying] :: Dec 22 14:01:34 dm7080 enigma2[591]: I/ [InfoBar.setPlaybackState] :: None None 1545483694.98 Dec 22 14:01:34 dm7080 enigma2[591]: doing version filtering Dec 22 14:01:34 dm7080 enigma2[591]: 0012: 4e 2b 66 07 00 00 Dec 22 14:01:34 dm7080 enigma2[591]: mask: ff ff ff 3f 00 00 Dec 22 14:01:34 dm7080 enigma2[591]: mode: 00 00 00 3e 00 00 Dec 22 14:01:35 dm7080 enigma2[591]: [EPGC] start caching events(1545483695) Dec 22 14:01:38 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 11 ee Dec 22 14:01:38 dm7080 enigma2[591]: action -> QuickButtonActions up Dec 22 14:01:38 dm7080 enigma2[591]: unknown action QuickButtonActions/up! typo in keymap? Dec 22 14:01:38 dm7080 enigma2[591]: reused converter! Dec 22 14:01:38 dm7080 enigma2[591]: reused converter! Dec 22 14:01:38 dm7080 enigma2[591]: reused converter! Dec 22 14:01:38 dm7080 enigma2[591]: create buffer for widget 1920 x 1080 Dec 22 14:01:38 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:38 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:38 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:38 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:38 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:38 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:38 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:38 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:38 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:38 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:38 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:38 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:38 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:38 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:38 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:38 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:39 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:39 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:39 dm7080 enigma2[591]: libpng warning: iCCP: cHRM chunk does not match sRGB Dec 22 14:01:39 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 17 e8 Dec 22 14:01:39 dm7080 enigma2[591]: action -> ChannelSelectBaseActions selectServiceDown Dec 22 14:01:39 dm7080 enigma2[591]: unknown action ChannelSelectBaseActions/selectServiceDown! typo in keymap? Dec 22 14:01:39 dm7080 enigma2[591]: action -> WizardActions down Dec 22 14:01:39 dm7080 enigma2[591]: unknown action WizardActions/down! typo in keymap? Dec 22 14:01:39 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:39 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:39 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:39 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:39 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:39 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:39 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:39 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:39 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:39 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:40 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:40 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:40 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:40 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:40 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:40 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:40 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:40 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:40 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:01:40 dm7080 enigma2[591]: Start timeshift! Dec 22 14:01:40 dm7080 enigma2[591]: timeshift recording to /media/ssd/pts//timeshift.K4RMEM Dec 22 14:01:40 dm7080 enigma2[591]: before: 1 Dec 22 14:01:40 dm7080 enigma2[591]: after: 1 Dec 22 14:01:40 dm7080 enigma2[591]: setIoPrio realtime level 7 ok Dec 22 14:01:40 dm7080 enigma2[591]: eRecordFileThread (direct io) START Dec 22 14:01:40 dm7080 enigma2[591]: record write thread succesfully created! Dec 22 14:01:40 dm7080 enigma2[591]: setIoPrio realtime level 7 ok Dec 22 14:01:40 dm7080 enigma2[591]: I/ [InfoBar.ptsSetNextPlaybackFile] :: [PTS-Plugin] setNextPlaybackFile(/media/ssd/pts//pts_livebuffer.1) Dec 22 14:01:40 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 17 e8 Dec 22 14:01:40 dm7080 enigma2[591]: action -> ChannelSelectBaseActions selectServiceDown Dec 22 14:01:40 dm7080 enigma2[591]: unknown action ChannelSelectBaseActions/selectServiceDown! typo in keymap? Dec 22 14:01:40 dm7080 enigma2[591]: action -> WizardActions down Dec 22 14:01:40 dm7080 enigma2[591]: unknown action WizardActions/down! typo in keymap? Dec 22 14:01:40 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 17 e8 Dec 22 14:01:40 dm7080 enigma2[591]: action -> ChannelSelectBaseActions selectServiceDown Dec 22 14:01:40 dm7080 enigma2[591]: unknown action ChannelSelectBaseActions/selectServiceDown! typo in keymap? Dec 22 14:01:40 dm7080 enigma2[591]: action -> WizardActions down Dec 22 14:01:40 dm7080 enigma2[591]: unknown action WizardActions/down! typo in keymap? Dec 22 14:01:41 dm7080 enigma2[591]: [eDVBLocalTimeHandler] Receiver time is 'Sat Dec 22 14:01:41 2018' Dec 22 14:01:41 dm7080 enigma2[591]: [eDVBLocalTimeHandler] Transponder time is 'Sat Dec 22 14:01:40 2018' Dec 22 14:01:41 dm7080 enigma2[591]: [eDVBLocalTimeHandler] diff is -1 Dec 22 14:01:41 dm7080 enigma2[591]: [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time Dec 22 14:01:40 dm7080 enigma2[591]: [eDVBLocalTimeHandler] update RTC Dec 22 14:01:40 dm7080 enigma2[591]: [eDVBLocalTimeHandler] time_difference is -1 Dec 22 14:01:41 dm7080 enigma2[591]: [eDVBLocalTimeHandler] update Linux Time Dec 22 14:01:41 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x32 (1): 01 Dec 22 14:01:41 dm7080 enigma2[591]: [eInputDeviceHandlerDreamBLE::onCommand] 32 [OK]! Dec 22 14:01:41 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x30 (5): 01 b4 35 1e 5c Dec 22 14:01:41 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x33 (1): 01 Dec 22 14:01:41 dm7080 enigma2[591]: [eInputDeviceHandlerDreamBLE::onCommand] 33 [OK]! Dec 22 14:01:41 dm7080 enigma2[591]: eBackgroundFileEraser '/media/ssd/pts//pts_livebuffer.1' finished Dec 22 14:01:41 dm7080 enigma2[591]: eBackgroundFileEraser '/media/ssd/pts//pts_livebuffer.1.meta' finished Dec 22 14:01:41 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 17 e8 Dec 22 14:01:41 dm7080 enigma2[591]: action -> ChannelSelectBaseActions selectServiceDown Dec 22 14:01:41 dm7080 enigma2[591]: unknown action ChannelSelectBaseActions/selectServiceDown! typo in keymap? Dec 22 14:01:41 dm7080 enigma2[591]: action -> WizardActions down Dec 22 14:01:41 dm7080 enigma2[591]: unknown action WizardActions/down! typo in keymap? Dec 22 14:01:42 dm7080 enigma2[591]: [EPGC] abort non avail schedule other reading Dec 22 14:01:42 dm7080 enigma2[591]: [EPGC] abort non avail viasat reading Dec 22 14:01:42 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 17 e8 Dec 22 14:01:42 dm7080 enigma2[591]: action -> ChannelSelectBaseActions selectServiceDown Dec 22 14:01:42 dm7080 enigma2[591]: unknown action ChannelSelectBaseActions/selectServiceDown! typo in keymap? Dec 22 14:01:42 dm7080 enigma2[591]: action -> WizardActions down Dec 22 14:01:42 dm7080 enigma2[591]: unknown action WizardActions/down! typo in keymap? Dec 22 14:01:43 dm7080 enigma2[591]: [EPGC] nownext finished(1545483703) Dec 22 14:01:45 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 17 e8 Dec 22 14:01:45 dm7080 enigma2[591]: action -> ChannelSelectBaseActions selectServiceDown Dec 22 14:01:45 dm7080 enigma2[591]: unknown action ChannelSelectBaseActions/selectServiceDown! typo in keymap? Dec 22 14:01:45 dm7080 enigma2[591]: action -> WizardActions down Dec 22 14:01:45 dm7080 enigma2[591]: unknown action WizardActions/down! typo in keymap? Dec 22 14:01:47 dm7080 enigma2[591]: 99934 ms latency per 1000 blits (10,006604 fps) Dec 22 14:01:49 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 83 32 cd 17 e8 Dec 22 14:01:49 dm7080 enigma2[591]: action -> ChannelSelectBaseActions selectServiceDown Dec 22 14:01:49 dm7080 enigma2[591]: unknown action ChannelSelectBaseActions/selectServiceDown! typo in keymap? Dec 22 14:01:49 dm7080 enigma2[591]: action -> WizardActions down Dec 22 14:01:49 dm7080 enigma2[591]: unknown action WizardActions/down! typo in keymap? Dec 22 14:01:49 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 17 e8 Dec 22 14:01:50 dm7080 enigma2[591]: [EPGC] schedule finished(1545483710) Dec 22 14:01:50 dm7080 enigma2[591]: [EPGC] stop caching events(1545483710) Dec 22 14:01:50 dm7080 enigma2[591]: [EPGC] next update in 60 min Dec 22 14:01:50 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:01:50 CET Dec 22 14:01:50 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:01:50 dm7080 enigma2[591]: [timer.py] next activation: 1545483810 (in 99008 ms) Dec 22 14:01:53 dm7080 enigma2[591]: no ancillary data in audio stream... abort radiotext pes parser Dec 22 14:01:54 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 14 eb Dec 22 14:01:54 dm7080 enigma2[591]: action -> OkCancelActions ok Dec 22 14:01:54 dm7080 enigma2[591]: playing 1:0:19:EF75:3F9:1:C00000:0:0:0: Dec 22 14:01:54 dm7080 enigma2[591]: stopping thread. Dec 22 14:01:54 dm7080 enigma2[591]: waiting for aio thread shutdown! Dec 22 14:01:54 dm7080 enigma2[591]: record aio thread has finished Dec 22 14:01:54 dm7080 enigma2[591]: eRecordFileThread (direct io) STOP Dec 22 14:01:54 dm7080 enigma2[591]: thread joined 0 Dec 22 14:01:54 dm7080 enigma2[591]: remove timeshift file Dec 22 14:01:54 dm7080 enigma2[591]: [eDVBCAService] free slot 0 demux 1 for service 1:0:19:2B66:3F3:1:C00000:0:0:0: Dec 22 14:01:54 dm7080 enigma2[591]: [eDVBCAService] free service 1:0:19:2B66:3F3:1:C00000:0:0:0: Dec 22 14:01:54 dm7080 enigma2[591]: I/ [PhotoScreensaver.setEnabled] :: True Dec 22 14:01:54 dm7080 enigma2[591]: before: 1 Dec 22 14:01:54 dm7080 enigma2[591]: [eDBusInterface::Private::sendEvent 0 Dec 22 14:01:55 dm7080 enigma2[591]: [ePicLoad] decode picture... /tmp/wallpaper Dec 22 14:01:55 dm7080 enigma2[591]: [TeleText] service stopped Dec 22 14:01:55 dm7080 enigma2[591]: [TeleText] send array('B', [1, 0, 0, 0]) Dec 22 14:01:55 dm7080 enigma2[591]: disable dvb subtitles Dec 22 14:01:55 dm7080 enigma2[591]: disable teletext subtitles page ffffffffffffffff (und) Dec 22 14:01:55 dm7080 enigma2[591]: decoder state: play, vpid=-1, apid=-1 Dec 22 14:01:55 dm7080 enigma2[591]: DEMUX_STOP - pcr - ok Dec 22 14:01:55 dm7080 enigma2[591]: DEMUX_STOP - video - ok Dec 22 14:01:55 dm7080 enigma2[591]: VIDEO_STOP - ok Dec 22 14:01:55 dm7080 enigma2[591]: AUDIO_STOP - ok Dec 22 14:01:55 dm7080 enigma2[591]: DEMUX_STOP - audio - ok Dec 22 14:01:55 dm7080 enigma2[591]: AUDIO_CONTINUE - ok Dec 22 14:01:55 dm7080 enigma2[591]: DEMUX_STOP - ttx - ok Dec 22 14:01:55 dm7080 enigma2[591]: start release channel timer Dec 22 14:01:55 dm7080 enigma2[591]: [TeleText] service started Dec 22 14:01:55 dm7080 enigma2[591]: not pauseable. Dec 22 14:01:55 dm7080 enigma2[591]: W/ [InfoBar.__servicePlaying] :: Dec 22 14:01:55 dm7080 enigma2[591]: I/ [InfoBar.setPlaybackState] :: None None 1545483715.04 Dec 22 14:01:55 dm7080 enigma2[591]: [eDVBCAService] remove channel 0x2339418 Dec 22 14:01:55 dm7080 enigma2[591]: [eDVBCAService] write leave transponder to '/tmp/camd.socket' ok Dec 22 14:01:55 dm7080 enigma2[591]: [eDVBLocalTimeHandler] remove channel 0x2339418 Dec 22 14:01:55 dm7080 enigma2[591]: [EPGC] remove channel 0x2339418 Dec 22 14:01:55 dm7080 enigma2[591]: [ 1] preClose Dec 22 14:01:55 dm7080 enigma2[591]: allocate channel.. 03f9:0001:00c00000 Dec 22 14:01:55 dm7080 enigma2[591]: available channel.. 03fb:0001:00c00000 Dec 22 14:01:55 dm7080 enigma2[591]: [eDVBCAService] new channel 0x2339418! Dec 22 14:01:55 dm7080 enigma2[591]: [ 1] tune type 1 Dec 22 14:01:55 dm7080 enigma2[591]: RotorCmd ffffffff, lastRotorCmd ffffffff Dec 22 14:01:55 dm7080 enigma2[591]: [ 1] prepare_sat System DVB-S2 Freq 11464250H SR 22000000 INV Auto FEC 2/3 orbpos 192 modulation 8PSK pilot Auto, rolloff 0.35 Dec 22 14:01:55 dm7080 enigma2[591]: [ 1] tuning to 1714 mhz Dec 22 14:01:55 dm7080 enigma2[591]: OURSTATE: tuning Dec 22 14:01:55 dm7080 enigma2[591]: [SEC-1] update oparm Dec 22 14:01:55 dm7080 enigma2[591]: [SEC-1] lock 0 Dec 22 14:01:55 dm7080 enigma2[591]: [SEC-1] locked 1 Dec 22 14:01:55 dm7080 enigma2[591]: [SEC-1] set static current limiting Dec 22 14:01:55 dm7080 enigma2[591]: allocate Channel: res 0 Dec 22 14:01:55 dm7080 enigma2[591]: allocate demux Dec 22 14:01:55 dm7080 enigma2[591]: [SEC-1] invalidate current switch params Dec 22 14:01:55 dm7080 enigma2[591]: [SEC-1] update current switch params Dec 22 14:01:55 dm7080 enigma2[591]: [SEC-1] startTuneTimeout 5000 Dec 22 14:01:55 dm7080 enigma2[591]: [SEC-1] setFrontend 1 Dec 22 14:01:55 dm7080 enigma2[591]: [ 1] setting frontend Dec 22 14:01:55 dm7080 enigma2[591]: [SEC-1] unlock 1 Dec 22 14:01:55 dm7080 enigma2[591]: [SEC-1] sleep 500ms Dec 22 14:01:55 dm7080 enigma2[591]: setInputSource input1 to A2 Dec 22 14:01:55 dm7080 enigma2[591]: have 1 video stream(s) (01ff), and 1 audio stream(s) (0203), and the pcr pid is 01ff, and the text pid is 0021 Dec 22 14:01:55 dm7080 enigma2[591]: allocate demux Dec 22 14:01:55 dm7080 enigma2[591]: disable teletext subtitles page ffffffffffffffff (und) Dec 22 14:01:55 dm7080 enigma2[591]: decoder state: play, vpid=511, apid=515 Dec 22 14:01:55 dm7080 enigma2[591]: DMX_SET_PES_FILTER(0x1ff) - pcr - ok Dec 22 14:01:55 dm7080 enigma2[591]: DEMUX_START - pcr - ok Dec 22 14:01:55 dm7080 enigma2[591]: DMX_SET_PES_FILTER(0x203) - audio - ok Dec 22 14:01:55 dm7080 enigma2[591]: DEMUX_START - audio - ok Dec 22 14:01:55 dm7080 enigma2[591]: AUDIO_SET_BYPASS(0) - ok Dec 22 14:01:55 dm7080 enigma2[591]: AUDIO_PAUSE - ok Dec 22 14:01:55 dm7080 enigma2[591]: AUDIO_PLAY - ok Dec 22 14:01:55 dm7080 enigma2[591]: Video Device: /dev/dvb/adapter0/video0 Dec 22 14:01:55 dm7080 enigma2[591]: demux device: /dev/dvb/adapter0/demux1 Dec 22 14:01:55 dm7080 enigma2[591]: VIDEO_SET_STREAMTYPE 1 - ok Dec 22 14:01:55 dm7080 enigma2[591]: DMX_SET_PES_FILTER(0x1ff) - video - ok Dec 22 14:01:55 dm7080 enigma2[591]: DEMUX_START - video - ok Dec 22 14:01:55 dm7080 enigma2[591]: VIDEO_FREEZE - ok Dec 22 14:01:55 dm7080 enigma2[591]: VIDEO_PLAY - ok Dec 22 14:01:55 dm7080 enigma2[591]: DMX_SET_PES_FILTER(0x21) - ttx - ok Dec 22 14:01:55 dm7080 enigma2[591]: DEMUX_START - ttx - ok Dec 22 14:01:55 dm7080 enigma2[591]: VIDEO_SLOWMOTION(0) - ok Dec 22 14:01:55 dm7080 enigma2[591]: VIDEO_FAST_FORWARD(0) - ok Dec 22 14:01:55 dm7080 enigma2[591]: VIDEO_CONTINUE - ok Dec 22 14:01:55 dm7080 enigma2[591]: AUDIO_CONTINUE - ok Dec 22 14:01:55 dm7080 enigma2[591]: W/ [InfoBar.__servicePlaying] :: Dec 22 14:01:55 dm7080 enigma2[591]: I/ [InfoBar.setPlaybackState] :: None None 1545483715.07 Dec 22 14:01:55 dm7080 enigma2[591]: I/ [ScreenSaverHandler._onEvent] :: play event, checking for video Dec 22 14:01:55 dm7080 enigma2[591]: I/ [PhotoScreensaver.setEnabled] :: False Dec 22 14:01:55 dm7080 enigma2[591]: not pauseable. Dec 22 14:01:55 dm7080 enigma2[591]: [HbbTV].aitInvalidated Dec 22 14:01:55 dm7080 enigma2[591]: I/ [InfoBar.__restoreState] :: Dec 22 14:01:55 dm7080 enigma2[591]: create buffer for widget 1920 x 250 Dec 22 14:01:55 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 83 32 cd 14 eb Dec 22 14:01:55 dm7080 enigma2[591]: eBackgroundFileEraser '/media/ssd/pts//timeshift.K4RMEM' finished Dec 22 14:01:55 dm7080 enigma2[591]: create buffer for widget 917 x 37 Dec 22 14:01:55 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 94 6b Dec 22 14:01:55 dm7080 enigma2[591]: [ 1] fe event: status 0, freq 1714250, inversion off, m_tuning 1 F Dec 22 14:01:55 dm7080 enigma2[591]: [ 1] fe event: status 1, freq 1714250, inversion off, m_tuning 1 N Dec 22 14:01:55 dm7080 enigma2[591]: [ 1] fe event: status 0, freq 1714250, inversion off, m_tuning 2 N Dec 22 14:01:55 dm7080 enigma2[591]: [ 1] fe event: status 1f, freq 1714250, inversion off, m_tuning 3 N Dec 22 14:01:55 dm7080 enigma2[591]: OURSTATE: ok Dec 22 14:01:55 dm7080 enigma2[591]: [eDVBCAService] channel 0x2339418 running Dec 22 14:01:55 dm7080 enigma2[591]: [eDVBLocalTimeHandler] channel 0x2339418 running Dec 22 14:01:55 dm7080 enigma2[591]: no version filtering Dec 22 14:01:55 dm7080 enigma2[591]: 0014: 70 00 00 00 00 00 Dec 22 14:01:55 dm7080 enigma2[591]: mask: fc 00 00 00 00 00 Dec 22 14:01:55 dm7080 enigma2[591]: mode: 00 00 00 00 00 00 Dec 22 14:01:55 dm7080 enigma2[591]: [EPGC] channel 0x2339418 running Dec 22 14:01:55 dm7080 enigma2[591]: [EPGC] next update in 2 sec Dec 22 14:01:55 dm7080 enigma2[591]: stop release channel timer Dec 22 14:01:55 dm7080 enigma2[591]: no version filtering Dec 22 14:01:55 dm7080 enigma2[591]: 0012: 4e ef 75 00 00 00 Dec 22 14:01:55 dm7080 enigma2[591]: mask: ff ff ff 00 00 00 Dec 22 14:01:55 dm7080 enigma2[591]: mode: 00 00 00 00 00 00 Dec 22 14:01:55 dm7080 enigma2[591]: ok ... now we start!! Dec 22 14:01:55 dm7080 enigma2[591]: no version filtering Dec 22 14:01:55 dm7080 enigma2[591]: 0000: 00 00 00 00 00 00 Dec 22 14:01:55 dm7080 enigma2[591]: mask: ff 00 00 00 00 00 Dec 22 14:01:55 dm7080 enigma2[591]: mode: 00 00 00 00 00 00 Dec 22 14:01:55 dm7080 enigma2[591]: + 1/1 TID 00 Dec 22 14:01:55 dm7080 enigma2[591]: done! Dec 22 14:01:55 dm7080 enigma2[591]: PATready Dec 22 14:01:55 dm7080 enigma2[591]: use pmtpid 0061 for service_id ef75 Dec 22 14:01:55 dm7080 enigma2[591]: no version filtering Dec 22 14:01:55 dm7080 enigma2[591]: 0061: 02 ef 75 00 00 00 Dec 22 14:01:55 dm7080 enigma2[591]: mask: ff ff ff 00 00 00 Dec 22 14:01:55 dm7080 enigma2[591]: mode: 00 00 00 00 00 00 Dec 22 14:01:55 dm7080 enigma2[591]: doing version filtering Dec 22 14:01:55 dm7080 enigma2[591]: 0000: 00 00 00 1d 00 00 Dec 22 14:01:55 dm7080 enigma2[591]: mask: ff 00 00 3f 00 00 Dec 22 14:01:55 dm7080 enigma2[591]: mode: 00 00 00 3e 00 00 Dec 22 14:01:55 dm7080 enigma2[591]: + 1/1 TID 02 Dec 22 14:01:55 dm7080 enigma2[591]: done! Dec 22 14:01:55 dm7080 enigma2[591]: [eDVBCAService] new service 1:0:19:EF75:3F9:1:C00000:0:0:0: Dec 22 14:01:55 dm7080 enigma2[591]: [eDVBCAService] add demux 1 to slot 0 service 1:0:19:EF75:3F9:1:C00000:0:0:0: Dec 22 14:01:55 dm7080 enigma2[591]: [eDVBCAService] demux 1 mask 02 Dec 22 14:01:55 dm7080 enigma2[591]: [eDVBCAServiceConn] send 594 bytes to '/tmp/camd.socket' Dec 22 14:01:55 dm7080 enigma2[591]: 9f 80 32 82 02 4c 03 ef 75 05 02 32 01 81 08 00 c0 00 00 03 f9 00 01 82 02 02 01 84 02 00 61 85 03 01 41 32 86 01 01 09 6f 18 30 fc ec 8c 69 00 00 3d a3 0d 01 80 11 80 00 02 18 30 01 0f 9f 20 ff aa 15 02 80 11 00 00 00 64 00 03 03 21 00 00 00 02 18 30 00 00 00 64 aa 15 02 80 11 00 00 0b ea 00 03 03 21 00 00 00 02 18 30 00 00 0b ea 01 00 26 a3 0d 01 80 11 80 00 02 18 30 01 0d ab 20 ff aa 15 02 80 11 00 00 0b b8 00 03 03 21 00 00 00 02 18 43 00 00 0b b8 09 7b 18 43 f9 ec 8c 75 00 00 43 8c 13 00 80 11 08 02 18 43 20 0a 09 38 59 00 0f 9f 59 00 0f 9f aa 15 03 80 11 5d 00 00 66 00 03 03 21 00 00 02 18 43 5d 00 00 66 00 aa 15 03 80 11 00 00 0b ea 00 03 03 21 00 00 02 18 43 5d 00 0b ea 00 01 00 2c 8c 13 00 80 11 08 02 18 43 20 0a 09 38 59 00 0d 7a 59 00 0d 7a aa 15 03 80 11 5d 00 0b b8 00 03 03 21 00 00 02 18 43 5d 00 0b b8 00 09 04 09 c4 fb ec 09 04 09 8c fa ec 09 7b 18 60 fe ec 8c 75 00 00 43 8c 13 00 80 11 08 02 18 60 20 0a 09 38 59 00 0f 9f 59 00 0f 9f aa 15 03 80 11 5d 00 00 68 00 03 03 21 00 00 02 18 60 5d 00 00 68 00 aa 15 03 80 11 00 00 0b ea 00 03 03 21 00 00 02 18 60 5d 00 0b ea 00 01 00 2c 8c 13 00 80 11 08 02 18 60 20 0a 09 38 59 00 0d 7a 59 00 0d 7a aa 15 03 80 11 5d 00 0b b8 00 03 03 21 00 00 02 18 60 5d 00 0b b8 00 09 7b 18 6a fd ec 8c 75 00 00 43 8c 13 00 80 11 08 02 18 6a 20 0a 09 38 59 00 0f 9f 59 00 0f 9f aa 15 03 80 11 5d 00 00 6a 00 03 03 21 00 00 02 18 6a 5d 00 00 6a 00 aa 15 03 80 11 00 00 0b ea 00 03 03 21 00 00 02 18 6a 5d 00 0b ea 00 01 00 2c 8c 13 00 80 11 08 02 18 6a 20 0a 09 38 59 00 0d 7a 59 00 0d 7a aa 15 03 80 11 5d 00 0b b8 00 03 03 21 00 00 02 18 6a 5d 00 0b b8 00 09 04 09 8d f8 ec 09 04 18 6d fd ed 09 0f 05 00 ff ec 10 01 00 13 01 20 14 03 05 19 00 09 04 06 cb fb ed 06 00 21 00 00 1b 01 ff 00 00 06 02 03 00 00 05 02 05 00 00 Dec 22 14:01:55 dm7080 enigma2[591]: [eDVBCIInterfaces] addPMTHandler 1:0:19:EF75:3F9:1:C00000:0:0:0: Dec 22 14:01:55 dm7080 enigma2[591]: [eDVBCIInterfaces] gotPMT Dec 22 14:01:55 dm7080 enigma2[591]: eventNewProgramInfo 0 0 Dec 22 14:01:55 dm7080 enigma2[591]: start ait on pid 0205 Dec 22 14:01:55 dm7080 enigma2[591]: no version filtering Dec 22 14:01:55 dm7080 enigma2[591]: 0205: 74 00 00 00 00 00 Dec 22 14:01:55 dm7080 enigma2[591]: mask: ff 00 00 00 00 00 Dec 22 14:01:55 dm7080 enigma2[591]: mode: 00 00 00 00 00 00 Dec 22 14:01:55 dm7080 enigma2[591]: have 1 video stream(s) (01ff), and 1 audio stream(s) (0203), and the pcr pid is 01ff, and the text pid is 0021 Dec 22 14:01:55 dm7080 enigma2[591]: decoder state: play, vpid=511, apid=515 Dec 22 14:01:55 dm7080 enigma2[591]: [SEC-1] set dynamic current limiting Dec 22 14:01:55 dm7080 enigma2[591]: [TeleText] serviceInfoChanged Dec 22 14:01:55 dm7080 enigma2[591]: [TeleText] TXT PID 33 DEMUX 1 Dec 22 14:01:55 dm7080 enigma2[591]: [TeleText] send array('B', [1, 0, 33, 1]) Dec 22 14:01:55 dm7080 enigma2[591]: doing version filtering Dec 22 14:01:55 dm7080 enigma2[591]: 0061: 02 ef 75 05 00 00 Dec 22 14:01:55 dm7080 enigma2[591]: mask: ff ff ff 3f 00 00 Dec 22 14:01:55 dm7080 enigma2[591]: mode: 00 00 00 3e 00 00 Dec 22 14:01:55 dm7080 enigma2[591]: [eFileMonitor] 1 events queued Dec 22 14:01:55 dm7080 enigma2[591]: [eFileMonitor] File {/tmp/ecm.info} has been created Dec 22 14:01:56 dm7080 enigma2[591]: [ePicLoad] finished decoding /tmp/wallpaper. Dec 22 14:01:56 dm7080 enigma2[591]: + 1/1 TID 74 Dec 22 14:01:56 dm7080 enigma2[591]: done! Dec 22 14:01:56 dm7080 enigma2[591]: [eHbbtv] aitChanged pid=0x205 Dec 22 14:01:56 dm7080 enigma2[591]: [eOipfApplication] Profile 0000, Version 1.1.1 Dec 22 14:01:56 dm7080 enigma2[591]: [eOipfApplication] deu:Pro7 Dec 22 14:01:56 dm7080 enigma2[591]: [eHbbtv] New Application: Pro7 (orgid=96, appid=2, urlBase=http://hbbtv.redbutton.de/service/, initalPath=redbutton.php?brand=p7de, controlCode=1, visibility=2) Dec 22 14:01:56 dm7080 enigma2[591]: [eHbbtv] Resolving Application Locator: dvb://current.ait/60.2 Dec 22 14:01:56 dm7080 enigma2[591]: [eHbbtv] We have 1 app(s) for service 1.1017.61301 Dec 22 14:01:56 dm7080 enigma2[591]: [eHbbtv] 'dvb://current.ait/60.2' resolved to 'http://hbbtv.redbutton.de/service/redbutton.php?brand=p7de' Dec 22 14:01:56 dm7080 enigma2[591]: [HbbTV].readButtonApplicationReady, appid=60.2 Dec 22 14:01:56 dm7080 enigma2[591]: doing version filtering Dec 22 14:01:56 dm7080 enigma2[591]: 0205: 74 00 00 11 00 00 Dec 22 14:01:56 dm7080 enigma2[591]: mask: ff 00 00 3f 00 00 Dec 22 14:01:56 dm7080 enigma2[591]: mode: 00 00 00 3e 00 00 Dec 22 14:01:56 dm7080 enigma2[591]: +- 1/2 TID 4e Dec 22 14:01:56 dm7080 enigma2[591]: sdt update done! Dec 22 14:01:57 dm7080 enigma2[591]: VIDEO_GET_EVENT - ok Dec 22 14:01:57 dm7080 enigma2[591]: VIDEO_GET_EVENT - ok Dec 22 14:01:57 dm7080 enigma2[591]: VIDEO_GET_EVENT - ok Dec 22 14:01:57 dm7080 enigma2[591]: ++ 2/2 TID 4e Dec 22 14:01:57 dm7080 enigma2[591]: done! Dec 22 14:01:57 dm7080 enigma2[591]: W/ [InfoBar.__servicePlaying] :: Dec 22 14:01:57 dm7080 enigma2[591]: I/ [InfoBar.setPlaybackState] :: None None 1545483717.22 Dec 22 14:01:57 dm7080 enigma2[591]: doing version filtering Dec 22 14:01:57 dm7080 enigma2[591]: 0012: 4e ef 75 39 00 00 Dec 22 14:01:57 dm7080 enigma2[591]: mask: ff ff ff 3f 00 00 Dec 22 14:01:57 dm7080 enigma2[591]: mode: 00 00 00 3e 00 00 Dec 22 14:01:57 dm7080 enigma2[591]: VIDEO_GET_EVENT - ok Dec 22 14:01:57 dm7080 enigma2[591]: unhandled DVBAPI Video Event 32 Dec 22 14:01:57 dm7080 enigma2[591]: [EPGC] start caching events(1545483717) Dec 22 14:01:57 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 a5 5a 0b f4 Dec 22 14:01:57 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 a5 5a 0b f4 Dec 22 14:01:57 dm7080 enigma2[591]: [eDVBLocalTimeHandler] Receiver time is 'Sat Dec 22 14:01:57 2018' Dec 22 14:01:57 dm7080 enigma2[591]: [eDVBLocalTimeHandler] Transponder time is 'Sat Dec 22 14:01:56 2018' Dec 22 14:01:57 dm7080 enigma2[591]: [eDVBLocalTimeHandler] diff is -1 Dec 22 14:01:57 dm7080 enigma2[591]: [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time Dec 22 14:01:57 dm7080 enigma2[591]: [eDVBLocalTimeHandler] update RTC Dec 22 14:01:57 dm7080 enigma2[591]: [eDVBLocalTimeHandler] time_difference is -1 Dec 22 14:01:57 dm7080 enigma2[591]: [eDVBLocalTimeHandler] update Linux Time Dec 22 14:01:57 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x32 (1): 01 Dec 22 14:01:57 dm7080 enigma2[591]: [eInputDeviceHandlerDreamBLE::onCommand] 32 [OK]! Dec 22 14:01:57 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x30 (5): 01 c4 35 1e 5c Dec 22 14:01:57 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x33 (1): 01 Dec 22 14:01:57 dm7080 enigma2[591]: [eInputDeviceHandlerDreamBLE::onCommand] 33 [OK]! Dec 22 14:01:57 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 a5 5a 0b f4 Dec 22 14:01:58 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 a5 5a 0b f4 Dec 22 14:01:58 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 a5 5a 0b f4 Dec 22 14:01:58 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 a5 5a 0b f4 Dec 22 14:01:58 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 a5 5a 0b f4 Dec 22 14:01:58 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 a5 5a 0b f4 Dec 22 14:01:58 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 a5 5a 0b f4 Dec 22 14:01:58 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 a5 5a 0b f4 Dec 22 14:01:58 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 a5 5a 0b f4 Dec 22 14:01:58 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 a5 5a 0b f4 Dec 22 14:01:58 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 a5 5a 0b f4 Dec 22 14:01:58 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 a5 5a 0b f4 Dec 22 14:01:59 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 a5 5a 0b f4 Dec 22 14:01:59 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 a5 5a 0b f4 Dec 22 14:01:59 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 a5 5a 0b f4 Dec 22 14:01:59 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 a5 5a 0b f4 Dec 22 14:01:59 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 a5 5a 0b f4 Dec 22 14:01:59 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 a5 5a 0b f4 Dec 22 14:02:00 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 a5 5a 0b f4 Dec 22 14:02:00 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 a5 5a 0b f4 Dec 22 14:02:00 dm7080 enigma2[591]: I/ [InfoBar.ptsCleanTimeshiftFolder] :: [PTS-Plugin] Erasing stranded timeshift pts_livebuffer.1 Dec 22 14:02:00 dm7080 enigma2[591]: eBackgroundFileEraser '/media/ssd/pts//pts_livebuffer.1' finished Dec 22 14:02:00 dm7080 enigma2[591]: eBackgroundFileEraser '/media/ssd/pts//pts_livebuffer.1.meta' finished Dec 22 14:02:00 dm7080 enigma2[591]: eBackgroundFileEraser '/media/ssd/pts//pts_livebuffer.1.eit' finished Dec 22 14:02:00 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 14 eb Dec 22 14:02:00 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 83 32 cd 14 eb Dec 22 14:02:01 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 94 6b Dec 22 14:02:01 dm7080 enigma2[591]: action -> QuickButtonActions ok Dec 22 14:02:01 dm7080 enigma2[591]: unknown action QuickButtonActions/ok! typo in keymap? Dec 22 14:02:01 dm7080 enigma2[591]: create buffer for widget 917 x 37 Dec 22 14:02:01 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 14 eb Dec 22 14:02:01 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 83 32 cd 14 eb Dec 22 14:02:01 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 94 6b Dec 22 14:02:01 dm7080 enigma2[591]: action -> QuickButtonActions ok Dec 22 14:02:01 dm7080 enigma2[591]: unknown action QuickButtonActions/ok! typo in keymap? Dec 22 14:02:02 dm7080 enigma2[591]: Start timeshift! Dec 22 14:02:02 dm7080 enigma2[591]: timeshift recording to /media/ssd/pts//timeshift.HCDRx1 Dec 22 14:02:02 dm7080 enigma2[591]: before: 1 Dec 22 14:02:02 dm7080 enigma2[591]: after: 1 Dec 22 14:02:02 dm7080 enigma2[591]: setIoPrio realtime level 7 ok Dec 22 14:02:02 dm7080 enigma2[591]: eRecordFileThread (direct io) START Dec 22 14:02:02 dm7080 enigma2[591]: record write thread succesfully created! Dec 22 14:02:02 dm7080 enigma2[591]: setIoPrio realtime level 7 ok Dec 22 14:02:02 dm7080 enigma2[591]: I/ [InfoBar.ptsSetNextPlaybackFile] :: [PTS-Plugin] setNextPlaybackFile(/media/ssd/pts//pts_livebuffer.1) Dec 22 14:02:02 dm7080 enigma2[591]: [EPGC] cleanup invalid data Dec 22 14:02:04 dm7080 enigma2[591]: [EPGC] abort non avail schedule other reading Dec 22 14:02:04 dm7080 enigma2[591]: [EPGC] abort non avail viasat reading Dec 22 14:02:04 dm7080 enigma2[591]: [EPGC] nownext finished(1545483724) Dec 22 14:02:05 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:02:05 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:02:05 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:02:05 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:02:05 dm7080 enigma2[591]: header: EXT: Dec 22 14:02:05 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:02:05 dm7080 enigma2[591]: header: Connection: close Dec 22 14:02:14 dm7080 enigma2[591]: [EPGC] schedule finished(1545483734) Dec 22 14:02:14 dm7080 enigma2[591]: [EPGC] stop caching events(1545483734) Dec 22 14:02:14 dm7080 enigma2[591]: [EPGC] next update in 60 min Dec 22 14:02:15 dm7080 enigma2[591]: no ancillary data in audio stream... abort radiotext pes parser Dec 22 14:02:15 dm7080 enigma2[591]: [EPGC] cleanup invalid data Dec 22 14:02:43 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:02:43 CET Dec 22 14:02:43 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:02:43 dm7080 enigma2[591]: [timer.py] next activation: 1545483863 (in 99008 ms) Dec 22 14:02:48 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:02:48 CET Dec 22 14:02:48 dm7080 enigma2[591]: [timer.py] next activation: 1545483868 (in 99009 ms) Dec 22 14:03:03 dm7080 enigma2[591]: [Netatmo] start async update Dec 22 14:03:03 dm7080 enigma2[591]: [Netatmo] begin update Dec 22 14:03:03 dm7080 enigma2[591]: [Netatmo] token expire in 7200 Dec 22 14:03:04 dm7080 enigma2[591]: [Netatmo] location from cache 48.26088,12.28173 Pfarrer-Egerer-Straße, Mesmering, Obertaufkirchen, Landkreis Mühldorf am Inn, Obb, Bayern, 84419, Deutschland Dec 22 14:03:04 dm7080 enigma2[591]: [Netatmo] update took 0.66489315033 sec Dec 22 14:03:04 dm7080 enigma2[591]: [Netatmo] recalculate battery percent: 1.2 Dec 22 14:03:04 dm7080 enigma2[591]: [Netatmo] check notification Dec 22 14:03:11 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:03:11 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:03:11 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:03:11 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:03:11 dm7080 enigma2[591]: header: EXT: Dec 22 14:03:11 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:03:11 dm7080 enigma2[591]: header: Connection: close Dec 22 14:03:12 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:03:30 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:03:30 CET Dec 22 14:03:30 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:03:30 dm7080 enigma2[591]: [timer.py] next activation: 1545483910 (in 99998 ms) Dec 22 14:04:12 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:04:16 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:04:16 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:04:16 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:04:16 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:04:16 dm7080 enigma2[591]: header: EXT: Dec 22 14:04:16 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:04:16 dm7080 enigma2[591]: header: Connection: close Dec 22 14:04:23 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:04:23 CET Dec 22 14:04:23 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:04:23 dm7080 enigma2[591]: [timer.py] next activation: 1545483963 (in 99998 ms) Dec 22 14:04:28 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:04:28 CET Dec 22 14:04:28 dm7080 enigma2[591]: [timer.py] next activation: 1545483968 (in 99998 ms) Dec 22 14:05:10 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:05:10 CET Dec 22 14:05:10 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:05:10 dm7080 enigma2[591]: [timer.py] next activation: 1545484010 (in 99998 ms) Dec 22 14:05:12 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:05:21 dm7080 enigma2[591]: send: 'POST /ZoneGroupTopology/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:ZoneGroupTopology:1#GetZoneGroupState\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 277\r\n\r\n' Dec 22 14:05:21 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:05:21 dm7080 enigma2[591]: header: CONTENT-LENGTH: 5054 Dec 22 14:05:21 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:05:21 dm7080 enigma2[591]: header: EXT: Dec 22 14:05:21 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:05:21 dm7080 enigma2[591]: header: Connection: close Dec 22 14:05:21 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:05:21 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:05:21 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:05:21 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:05:21 dm7080 enigma2[591]: header: EXT: Dec 22 14:05:21 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:05:21 dm7080 enigma2[591]: header: Connection: close Dec 22 14:06:03 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:06:02 CET Dec 22 14:06:03 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:06:03 dm7080 enigma2[591]: [timer.py] next activation: 1545484062 (in 98999 ms) Dec 22 14:06:08 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:06:08 CET Dec 22 14:06:08 dm7080 enigma2[591]: [timer.py] next activation: 1545484068 (in 99997 ms) Dec 22 14:06:12 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:06:26 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:06:26 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:06:26 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:06:26 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:06:26 dm7080 enigma2[591]: header: EXT: Dec 22 14:06:26 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:06:26 dm7080 enigma2[591]: header: Connection: close Dec 22 14:06:50 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:06:49 CET Dec 22 14:06:50 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:06:50 dm7080 enigma2[591]: [timer.py] next activation: 1545484110 (in 99999 ms) Dec 22 14:07:12 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:07:31 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:07:31 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:07:31 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:07:31 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:07:31 dm7080 enigma2[591]: header: EXT: Dec 22 14:07:31 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:07:31 dm7080 enigma2[591]: header: Connection: close Dec 22 14:07:42 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:07:41 CET Dec 22 14:07:42 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:07:42 dm7080 enigma2[591]: [timer.py] next activation: 1545484161 (in 99000 ms) Dec 22 14:07:48 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:07:48 CET Dec 22 14:07:48 dm7080 enigma2[591]: [timer.py] next activation: 1545484168 (in 99999 ms) Dec 22 14:08:03 dm7080 enigma2[591]: [Netatmo] start async update Dec 22 14:08:03 dm7080 enigma2[591]: [Netatmo] begin update Dec 22 14:08:03 dm7080 enigma2[591]: [Netatmo] token expire in 6900 Dec 22 14:08:04 dm7080 enigma2[591]: [Netatmo] location from cache 48.26088,12.28173 Pfarrer-Egerer-Straße, Mesmering, Obertaufkirchen, Landkreis Mühldorf am Inn, Obb, Bayern, 84419, Deutschland Dec 22 14:08:04 dm7080 enigma2[591]: [Netatmo] update took 0.669350147247 sec Dec 22 14:08:04 dm7080 enigma2[591]: [Netatmo] recalculate battery percent: 1.2 Dec 22 14:08:04 dm7080 enigma2[591]: [Netatmo] check notification Dec 22 14:08:12 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:08:30 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:08:30 CET Dec 22 14:08:30 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:08:30 dm7080 enigma2[591]: [timer.py] next activation: 1545484210 (in 99998 ms) Dec 22 14:08:36 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:08:36 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:08:36 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:08:36 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:08:36 dm7080 enigma2[591]: header: EXT: Dec 22 14:08:36 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:08:36 dm7080 enigma2[591]: header: Connection: close Dec 22 14:09:12 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:09:21 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:09:21 CET Dec 22 14:09:21 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:09:21 dm7080 enigma2[591]: [timer.py] next activation: 1545484261 (in 99999 ms) Dec 22 14:09:28 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:09:27 CET Dec 22 14:09:28 dm7080 enigma2[591]: [timer.py] next activation: 1545484267 (in 99000 ms) Dec 22 14:09:41 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:09:41 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:09:41 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:09:41 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:09:41 dm7080 enigma2[591]: header: EXT: Dec 22 14:09:41 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:09:41 dm7080 enigma2[591]: header: Connection: close Dec 22 14:10:10 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:10:10 CET Dec 22 14:10:10 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:10:10 dm7080 enigma2[591]: [timer.py] next activation: 1545484310 (in 99998 ms) Dec 22 14:10:12 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:10:46 dm7080 enigma2[591]: send: 'POST /ZoneGroupTopology/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:ZoneGroupTopology:1#GetZoneGroupState\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 277\r\n\r\n' Dec 22 14:10:46 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:10:46 dm7080 enigma2[591]: header: CONTENT-LENGTH: 5054 Dec 22 14:10:46 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:10:46 dm7080 enigma2[591]: header: EXT: Dec 22 14:10:46 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:10:46 dm7080 enigma2[591]: header: Connection: close Dec 22 14:10:46 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:10:46 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:10:46 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:10:46 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:10:46 dm7080 enigma2[591]: header: EXT: Dec 22 14:10:46 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:10:46 dm7080 enigma2[591]: header: Connection: close Dec 22 14:11:01 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:11:01 CET Dec 22 14:11:01 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:11:01 dm7080 enigma2[591]: [timer.py] next activation: 1545484361 (in 99998 ms) Dec 22 14:11:07 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:11:07 CET Dec 22 14:11:07 dm7080 enigma2[591]: [timer.py] next activation: 1545484367 (in 99999 ms) Dec 22 14:11:12 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:11:49 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:11:49 CET Dec 22 14:11:50 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:11:50 dm7080 enigma2[591]: [timer.py] next activation: 1545484409 (in 99000 ms) Dec 22 14:11:51 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:11:51 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:11:51 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:11:51 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:11:51 dm7080 enigma2[591]: header: EXT: Dec 22 14:11:51 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:11:51 dm7080 enigma2[591]: header: Connection: close Dec 22 14:12:13 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:12:41 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:12:40 CET Dec 22 14:12:41 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:12:41 dm7080 enigma2[591]: [timer.py] next activation: 1545484460 (in 99000 ms) Dec 22 14:12:42 dm7080 enigma2[591]: 654612 ms latency per 1000 blits (1,527622 fps) Dec 22 14:12:47 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:12:47 CET Dec 22 14:12:47 dm7080 enigma2[591]: [timer.py] next activation: 1545484467 (in 99999 ms) Dec 22 14:12:57 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:12:57 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:12:57 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:12:57 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:12:57 dm7080 enigma2[591]: header: EXT: Dec 22 14:12:57 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:12:57 dm7080 enigma2[591]: header: Connection: close Dec 22 14:13:03 dm7080 enigma2[591]: [Netatmo] start async update Dec 22 14:13:03 dm7080 enigma2[591]: [Netatmo] begin update Dec 22 14:13:03 dm7080 enigma2[591]: [Netatmo] token expire in 6600 Dec 22 14:13:04 dm7080 enigma2[591]: [Netatmo] location from cache 48.26088,12.28173 Pfarrer-Egerer-Straße, Mesmering, Obertaufkirchen, Landkreis Mühldorf am Inn, Obb, Bayern, 84419, Deutschland Dec 22 14:13:04 dm7080 enigma2[591]: [Netatmo] update took 0.767620801926 sec Dec 22 14:13:04 dm7080 enigma2[591]: [Netatmo] recalculate battery percent: 1.2 Dec 22 14:13:04 dm7080 enigma2[591]: [Netatmo] check notification Dec 22 14:13:13 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:13:29 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:13:28 CET Dec 22 14:13:29 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:13:29 dm7080 enigma2[591]: [timer.py] next activation: 1545484509 (in 99999 ms) Dec 22 14:14:02 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:14:02 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:14:02 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:14:02 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:14:02 dm7080 enigma2[591]: header: EXT: Dec 22 14:14:02 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:14:02 dm7080 enigma2[591]: header: Connection: close Dec 22 14:14:13 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:14:20 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:14:20 CET Dec 22 14:14:20 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:14:20 dm7080 enigma2[591]: [timer.py] next activation: 1545484560 (in 99999 ms) Dec 22 14:14:27 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:14:26 CET Dec 22 14:14:27 dm7080 enigma2[591]: [timer.py] next activation: 1545484567 (in 99999 ms) Dec 22 14:15:07 dm7080 enigma2[591]: send: 'POST /ZoneGroupTopology/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:ZoneGroupTopology:1#GetZoneGroupState\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 277\r\n\r\n' Dec 22 14:15:07 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:15:07 dm7080 enigma2[591]: header: CONTENT-LENGTH: 5054 Dec 22 14:15:07 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:15:07 dm7080 enigma2[591]: header: EXT: Dec 22 14:15:07 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:15:07 dm7080 enigma2[591]: header: Connection: close Dec 22 14:15:07 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:15:07 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:15:07 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:15:07 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:15:07 dm7080 enigma2[591]: header: EXT: Dec 22 14:15:07 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:15:07 dm7080 enigma2[591]: header: Connection: close Dec 22 14:15:09 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:15:08 CET Dec 22 14:15:09 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:15:09 dm7080 enigma2[591]: [timer.py] next activation: 1545484609 (in 99997 ms) Dec 22 14:15:13 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:16:00 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:15:59 CET Dec 22 14:16:00 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:16:00 dm7080 enigma2[591]: [timer.py] next activation: 1545484660 (in 99998 ms) Dec 22 14:16:07 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:16:06 CET Dec 22 14:16:07 dm7080 enigma2[591]: [timer.py] next activation: 1545484667 (in 99999 ms) Dec 22 14:16:13 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:16:49 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:16:48 CET Dec 22 14:16:49 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:16:49 dm7080 enigma2[591]: [timer.py] next activation: 1545484709 (in 99997 ms) Dec 22 14:17:13 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:17:17 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:17:17 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:17:17 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:17:17 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:17:17 dm7080 enigma2[591]: header: EXT: Dec 22 14:17:17 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:17:17 dm7080 enigma2[591]: header: Connection: close Dec 22 14:17:40 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:17:39 CET Dec 22 14:17:40 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:17:40 dm7080 enigma2[591]: [timer.py] next activation: 1545484760 (in 99999 ms) Dec 22 14:17:46 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:17:46 CET Dec 22 14:17:47 dm7080 enigma2[591]: [timer.py] next activation: 1545484766 (in 99001 ms) Dec 22 14:17:48 dm7080 enigma2[591]: +- 1/2 TID 4e Dec 22 14:17:49 dm7080 enigma2[591]: ++ 2/2 TID 4e Dec 22 14:17:49 dm7080 enigma2[591]: done! Dec 22 14:17:49 dm7080 enigma2[591]: W/ [InfoBar.__servicePlaying] :: Dec 22 14:17:49 dm7080 enigma2[591]: I/ [InfoBar.setPlaybackState] :: None None 1545484669.1 Dec 22 14:17:49 dm7080 enigma2[591]: doing version filtering Dec 22 14:17:49 dm7080 enigma2[591]: 0012: 4e ef 75 3b 00 00 Dec 22 14:17:49 dm7080 enigma2[591]: mask: ff ff ff 3f 00 00 Dec 22 14:17:49 dm7080 enigma2[591]: mode: 00 00 00 3e 00 00 Dec 22 14:18:03 dm7080 enigma2[591]: [Netatmo] start async update Dec 22 14:18:03 dm7080 enigma2[591]: [Netatmo] begin update Dec 22 14:18:03 dm7080 enigma2[591]: [Netatmo] token expire in 6300 Dec 22 14:18:03 dm7080 enigma2[591]: [Netatmo] location from cache 48.26088,12.28173 Pfarrer-Egerer-Straße, Mesmering, Obertaufkirchen, Landkreis Mühldorf am Inn, Obb, Bayern, 84419, Deutschland Dec 22 14:18:03 dm7080 enigma2[591]: [Netatmo] update took 0.56672000885 sec Dec 22 14:18:03 dm7080 enigma2[591]: [Netatmo] recalculate battery percent: 1.2 Dec 22 14:18:03 dm7080 enigma2[591]: [Netatmo] check notification Dec 22 14:18:13 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:18:16 dm7080 enigma2[591]: +- 1/2 TID 4e Dec 22 14:18:17 dm7080 enigma2[591]: ++ 2/2 TID 4e Dec 22 14:18:17 dm7080 enigma2[591]: done! Dec 22 14:18:17 dm7080 enigma2[591]: W/ [InfoBar.__servicePlaying] :: Dec 22 14:18:17 dm7080 enigma2[591]: I/ [InfoBar.setPlaybackState] :: None None 1545484697.6 Dec 22 14:18:17 dm7080 enigma2[591]: doing version filtering Dec 22 14:18:17 dm7080 enigma2[591]: 0012: 4e ef 75 3d 00 00 Dec 22 14:18:17 dm7080 enigma2[591]: mask: ff ff ff 3f 00 00 Dec 22 14:18:17 dm7080 enigma2[591]: mode: 00 00 00 3e 00 00 Dec 22 14:18:17 dm7080 enigma2[591]: create buffer for widget 917 x 37 Dec 22 14:18:18 dm7080 enigma2[591]: stopping thread. Dec 22 14:18:18 dm7080 enigma2[591]: waiting for aio thread shutdown! Dec 22 14:18:18 dm7080 enigma2[591]: record aio thread has finished Dec 22 14:18:18 dm7080 enigma2[591]: eRecordFileThread (direct io) STOP Dec 22 14:18:18 dm7080 enigma2[591]: thread joined 0 Dec 22 14:18:18 dm7080 enigma2[591]: remove timeshift file Dec 22 14:18:18 dm7080 enigma2[591]: Start timeshift! Dec 22 14:18:18 dm7080 enigma2[591]: timeshift recording to /media/ssd/pts//timeshift.QwNsmN Dec 22 14:18:18 dm7080 enigma2[591]: before: 1 Dec 22 14:18:18 dm7080 enigma2[591]: after: 1 Dec 22 14:18:18 dm7080 enigma2[591]: setIoPrio realtime level 7 ok Dec 22 14:18:18 dm7080 enigma2[591]: eRecordFileThread (direct io) START Dec 22 14:18:18 dm7080 enigma2[591]: record write thread succesfully created! Dec 22 14:18:18 dm7080 enigma2[591]: setIoPrio realtime level 7 ok Dec 22 14:18:18 dm7080 enigma2[591]: I/ [InfoBar.ptsSetNextPlaybackFile] :: [PTS-Plugin] setNextPlaybackFile(/media/ssd/pts//pts_livebuffer.2) Dec 22 14:18:18 dm7080 enigma2[591]: eBackgroundFileEraser '/media/ssd/pts//timeshift.HCDRx1' finished Dec 22 14:18:29 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:18:29 CET Dec 22 14:18:29 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:18:29 dm7080 enigma2[591]: [timer.py] next activation: 1545484809 (in 99997 ms) Dec 22 14:19:13 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:19:20 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:19:20 CET Dec 22 14:19:20 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:19:20 dm7080 enigma2[591]: [timer.py] next activation: 1545484860 (in 99998 ms) Dec 22 14:19:26 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:19:26 CET Dec 22 14:19:26 dm7080 enigma2[591]: [timer.py] next activation: 1545484866 (in 99998 ms) Dec 22 14:19:27 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:19:27 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:19:27 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:19:27 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:19:27 dm7080 enigma2[591]: header: EXT: Dec 22 14:19:27 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:19:27 dm7080 enigma2[591]: header: Connection: close Dec 22 14:20:09 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:20:08 CET Dec 22 14:20:09 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:20:09 dm7080 enigma2[591]: [timer.py] next activation: 1545484909 (in 99999 ms) Dec 22 14:20:13 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:20:32 dm7080 enigma2[591]: send: 'POST /ZoneGroupTopology/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:ZoneGroupTopology:1#GetZoneGroupState\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 277\r\n\r\n' Dec 22 14:20:32 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:20:32 dm7080 enigma2[591]: header: CONTENT-LENGTH: 5054 Dec 22 14:20:32 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:20:32 dm7080 enigma2[591]: header: EXT: Dec 22 14:20:32 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:20:32 dm7080 enigma2[591]: header: Connection: close Dec 22 14:20:32 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:20:32 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:20:32 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:20:32 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:20:32 dm7080 enigma2[591]: header: EXT: Dec 22 14:20:32 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:20:32 dm7080 enigma2[591]: header: Connection: close Dec 22 14:21:00 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:20:59 CET Dec 22 14:21:00 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:21:00 dm7080 enigma2[591]: [timer.py] next activation: 1545484960 (in 99999 ms) Dec 22 14:21:06 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:21:05 CET Dec 22 14:21:06 dm7080 enigma2[591]: [timer.py] next activation: 1545484966 (in 99999 ms) Dec 22 14:21:13 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:21:37 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:21:37 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:21:37 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:21:37 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:21:37 dm7080 enigma2[591]: header: EXT: Dec 22 14:21:37 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:21:37 dm7080 enigma2[591]: header: Connection: close Dec 22 14:21:49 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:21:49 CET Dec 22 14:21:49 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:21:49 dm7080 enigma2[591]: [timer.py] next activation: 1545485009 (in 99998 ms) Dec 22 14:22:14 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:22:21 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 83 32 cd 94 6b Dec 22 14:22:40 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:22:40 CET Dec 22 14:22:40 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:22:40 dm7080 enigma2[591]: [timer.py] next activation: 1545485060 (in 99998 ms) Dec 22 14:22:43 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:22:43 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:22:43 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:22:43 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:22:43 dm7080 enigma2[591]: header: EXT: Dec 22 14:22:43 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:22:43 dm7080 enigma2[591]: header: Connection: close Dec 22 14:22:46 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:22:45 CET Dec 22 14:22:46 dm7080 enigma2[591]: [timer.py] next activation: 1545485065 (in 99000 ms) Dec 22 14:23:03 dm7080 enigma2[591]: [Netatmo] start async update Dec 22 14:23:03 dm7080 enigma2[591]: [Netatmo] begin update Dec 22 14:23:03 dm7080 enigma2[591]: [Netatmo] token expire in 6000 Dec 22 14:23:03 dm7080 enigma2[591]: [Netatmo] location from cache 48.26088,12.28173 Pfarrer-Egerer-Straße, Mesmering, Obertaufkirchen, Landkreis Mühldorf am Inn, Obb, Bayern, 84419, Deutschland Dec 22 14:23:03 dm7080 enigma2[591]: [Netatmo] update took 0.498020887375 sec Dec 22 14:23:03 dm7080 enigma2[591]: [Netatmo] recalculate battery percent: 1.2 Dec 22 14:23:03 dm7080 enigma2[591]: [Netatmo] check notification Dec 22 14:23:14 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:23:29 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:23:28 CET Dec 22 14:23:29 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:23:29 dm7080 enigma2[591]: [timer.py] next activation: 1545485109 (in 99998 ms) Dec 22 14:23:48 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:23:48 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:23:48 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:23:48 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:23:48 dm7080 enigma2[591]: header: EXT: Dec 22 14:23:48 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:23:48 dm7080 enigma2[591]: header: Connection: close Dec 22 14:23:58 dm7080 enigma2[591]: 676002 ms latency per 1000 blits (1,479286 fps) Dec 22 14:24:14 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:24:20 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:24:19 CET Dec 22 14:24:20 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:24:20 dm7080 enigma2[591]: [timer.py] next activation: 1545485160 (in 99999 ms) Dec 22 14:24:25 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:24:24 CET Dec 22 14:24:25 dm7080 enigma2[591]: [timer.py] next activation: 1545485165 (in 99999 ms) Dec 22 14:24:53 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:24:53 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:24:53 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:24:53 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:24:53 dm7080 enigma2[591]: header: EXT: Dec 22 14:24:53 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:24:53 dm7080 enigma2[591]: header: Connection: close Dec 22 14:25:09 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:25:08 CET Dec 22 14:25:09 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:25:09 dm7080 enigma2[591]: [timer.py] next activation: 1545485209 (in 99998 ms) Dec 22 14:25:14 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:25:58 dm7080 enigma2[591]: send: 'POST /ZoneGroupTopology/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:ZoneGroupTopology:1#GetZoneGroupState\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 277\r\n\r\n' Dec 22 14:25:58 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:25:58 dm7080 enigma2[591]: header: CONTENT-LENGTH: 5054 Dec 22 14:25:58 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:25:58 dm7080 enigma2[591]: header: EXT: Dec 22 14:25:58 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:25:58 dm7080 enigma2[591]: header: Connection: close Dec 22 14:25:58 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:25:58 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:25:58 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:25:58 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:25:58 dm7080 enigma2[591]: header: EXT: Dec 22 14:25:58 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:25:58 dm7080 enigma2[591]: header: Connection: close Dec 22 14:26:00 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:25:59 CET Dec 22 14:26:00 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:26:00 dm7080 enigma2[591]: [timer.py] next activation: 1545485259 (in 99000 ms) Dec 22 14:26:05 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:26:04 CET Dec 22 14:26:05 dm7080 enigma2[591]: [timer.py] next activation: 1545485264 (in 99000 ms) Dec 22 14:26:14 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:26:49 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:26:48 CET Dec 22 14:26:49 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:26:49 dm7080 enigma2[591]: [timer.py] next activation: 1545485309 (in 99999 ms) Dec 22 14:27:03 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:27:03 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:27:03 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:27:03 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:27:03 dm7080 enigma2[591]: header: EXT: Dec 22 14:27:03 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:27:03 dm7080 enigma2[591]: header: Connection: close Dec 22 14:27:14 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:27:39 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:27:39 CET Dec 22 14:27:39 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:27:39 dm7080 enigma2[591]: [timer.py] next activation: 1545485359 (in 99999 ms) Dec 22 14:27:44 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:27:44 CET Dec 22 14:27:44 dm7080 enigma2[591]: [timer.py] next activation: 1545485364 (in 99963 ms) Dec 22 14:27:50 dm7080 enigma2[591]: [ 0] fe event: status 21, freq 1743750, inversion off, m_tuning 0 N Dec 22 14:27:50 dm7080 enigma2[591]: [ 0] lost lock Dec 22 14:27:50 dm7080 enigma2[591]: [ 0] fe event: status 20, freq 1743750, inversion off, m_tuning 0 N Dec 22 14:27:51 dm7080 enigma2[591]: [ 0] fe event: status 1f, freq 1743750, inversion off, m_tuning 0 N Dec 22 14:28:03 dm7080 enigma2[591]: [Netatmo] start async update Dec 22 14:28:03 dm7080 enigma2[591]: [Netatmo] begin update Dec 22 14:28:03 dm7080 enigma2[591]: [Netatmo] token expire in 5700 Dec 22 14:28:04 dm7080 enigma2[591]: [Netatmo] location from cache 48.26088,12.28173 Pfarrer-Egerer-Straße, Mesmering, Obertaufkirchen, Landkreis Mühldorf am Inn, Obb, Bayern, 84419, Deutschland Dec 22 14:28:04 dm7080 enigma2[591]: [Netatmo] update took 0.608175992966 sec Dec 22 14:28:04 dm7080 enigma2[591]: [Netatmo] recalculate battery percent: 1.2 Dec 22 14:28:04 dm7080 enigma2[591]: [Netatmo] check notification Dec 22 14:28:08 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:28:08 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:28:08 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:28:08 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:28:08 dm7080 enigma2[591]: header: EXT: Dec 22 14:28:08 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:28:08 dm7080 enigma2[591]: header: Connection: close Dec 22 14:28:14 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:28:29 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:28:29 CET Dec 22 14:28:29 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:28:29 dm7080 enigma2[591]: [timer.py] next activation: 1545485409 (in 99998 ms) Dec 22 14:28:41 dm7080 enigma2[591]: no version filtering Dec 22 14:28:41 dm7080 enigma2[591]: 0014: 70 00 00 00 00 00 Dec 22 14:28:41 dm7080 enigma2[591]: mask: fc 00 00 00 00 00 Dec 22 14:28:41 dm7080 enigma2[591]: mode: 00 00 00 00 00 00 Dec 22 14:28:42 dm7080 enigma2[591]: [eDVBLocalTimeHandler] Receiver time is 'Sat Dec 22 14:28:42 2018' Dec 22 14:28:42 dm7080 enigma2[591]: [eDVBLocalTimeHandler] Transponder time is 'Sat Dec 22 14:28:41 2018' Dec 22 14:28:42 dm7080 enigma2[591]: [eDVBLocalTimeHandler] diff is -1 Dec 22 14:28:42 dm7080 enigma2[591]: [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time Dec 22 14:28:41 dm7080 enigma2[591]: [eDVBLocalTimeHandler] difference between linux time and RTC time is < 60 sec... so the transponder time looks ok Dec 22 14:28:41 dm7080 enigma2[591]: [eDVBLocalTimeHandler] time_difference is -1 Dec 22 14:28:41 dm7080 enigma2[591]: [eDVBLocalTimeHandler] update Linux Time Dec 22 14:28:42 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x31 (2): 01 01 Dec 22 14:28:42 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x30 (5): 01 08 3c 1e 5c Dec 22 14:28:42 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x31 (2): 01 01 Dec 22 14:28:42 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x30 (5): 01 08 3c 1e 5c Dec 22 14:29:13 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:29:13 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:29:13 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:29:13 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:29:13 dm7080 enigma2[591]: header: EXT: Dec 22 14:29:13 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:29:13 dm7080 enigma2[591]: header: Connection: close Dec 22 14:29:14 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:29:18 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:29:18 CET Dec 22 14:29:18 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:29:18 dm7080 enigma2[591]: [timer.py] next activation: 1545485458 (in 99010 ms) Dec 22 14:29:23 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:29:23 CET Dec 22 14:29:23 dm7080 enigma2[591]: [timer.py] next activation: 1545485463 (in 99008 ms) Dec 22 14:30:08 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:30:08 CET Dec 22 14:30:08 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:30:08 dm7080 enigma2[591]: [timer.py] next activation: 1545485508 (in 99009 ms) Dec 22 14:30:14 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:30:18 dm7080 enigma2[591]: send: 'POST /ZoneGroupTopology/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:ZoneGroupTopology:1#GetZoneGroupState\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 277\r\n\r\n' Dec 22 14:30:18 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:30:18 dm7080 enigma2[591]: header: CONTENT-LENGTH: 5054 Dec 22 14:30:18 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:30:18 dm7080 enigma2[591]: header: EXT: Dec 22 14:30:18 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:30:18 dm7080 enigma2[591]: header: Connection: close Dec 22 14:30:18 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:30:18 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:30:18 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:30:18 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:30:18 dm7080 enigma2[591]: header: EXT: Dec 22 14:30:18 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:30:18 dm7080 enigma2[591]: header: Connection: close Dec 22 14:30:58 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:30:58 CET Dec 22 14:30:58 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:30:58 dm7080 enigma2[591]: [timer.py] next activation: 1545485558 (in 99995 ms) Dec 22 14:31:03 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:31:03 CET Dec 22 14:31:03 dm7080 enigma2[591]: [timer.py] next activation: 1545485563 (in 99997 ms) Dec 22 14:31:14 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:31:24 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:31:24 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:31:24 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:31:24 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:31:24 dm7080 enigma2[591]: header: EXT: Dec 22 14:31:24 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:31:24 dm7080 enigma2[591]: header: Connection: close Dec 22 14:31:48 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:31:48 CET Dec 22 14:31:48 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:31:48 dm7080 enigma2[591]: [timer.py] next activation: 1545485608 (in 99998 ms) Dec 22 14:31:57 dm7080 enigma2[591]: no version filtering Dec 22 14:31:57 dm7080 enigma2[591]: 0014: 70 00 00 00 00 00 Dec 22 14:31:57 dm7080 enigma2[591]: mask: fc 00 00 00 00 00 Dec 22 14:31:57 dm7080 enigma2[591]: mode: 00 00 00 00 00 00 Dec 22 14:31:59 dm7080 enigma2[591]: [eDVBLocalTimeHandler] Receiver time is 'Sat Dec 22 14:31:59 2018' Dec 22 14:31:59 dm7080 enigma2[591]: [eDVBLocalTimeHandler] Transponder time is 'Sat Dec 22 14:31:58 2018' Dec 22 14:31:59 dm7080 enigma2[591]: [eDVBLocalTimeHandler] diff is -1 Dec 22 14:31:59 dm7080 enigma2[591]: [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time Dec 22 14:31:58 dm7080 enigma2[591]: [eDVBLocalTimeHandler] difference between linux time and RTC time is < 60 sec... so the transponder time looks ok Dec 22 14:31:58 dm7080 enigma2[591]: [eDVBLocalTimeHandler] time_difference is -1 Dec 22 14:31:58 dm7080 enigma2[591]: [eDVBLocalTimeHandler] update Linux Time Dec 22 14:31:59 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x31 (2): 01 01 Dec 22 14:31:59 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x30 (5): 01 ce 3c 1e 5c Dec 22 14:31:59 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x31 (2): 01 01 Dec 22 14:31:59 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x30 (5): 01 ce 3c 1e 5c Dec 22 14:32:14 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:32:29 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:32:29 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:32:29 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:32:29 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:32:29 dm7080 enigma2[591]: header: EXT: Dec 22 14:32:29 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:32:29 dm7080 enigma2[591]: header: Connection: close Dec 22 14:32:37 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:32:37 CET Dec 22 14:32:37 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:32:37 dm7080 enigma2[591]: [timer.py] next activation: 1545485657 (in 99007 ms) Dec 22 14:32:42 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:32:42 CET Dec 22 14:32:42 dm7080 enigma2[591]: [timer.py] next activation: 1545485662 (in 99007 ms) Dec 22 14:33:03 dm7080 enigma2[591]: [Netatmo] start async update Dec 22 14:33:03 dm7080 enigma2[591]: [Netatmo] begin update Dec 22 14:33:03 dm7080 enigma2[591]: [Netatmo] token expire in 5400 Dec 22 14:33:04 dm7080 enigma2[591]: [Netatmo] location from cache 48.26088,12.28173 Pfarrer-Egerer-Straße, Mesmering, Obertaufkirchen, Landkreis Mühldorf am Inn, Obb, Bayern, 84419, Deutschland Dec 22 14:33:04 dm7080 enigma2[591]: [Netatmo] update took 1.08343291283 sec Dec 22 14:33:04 dm7080 enigma2[591]: [Netatmo] recalculate battery percent: 1.2 Dec 22 14:33:04 dm7080 enigma2[591]: [Netatmo] check notification Dec 22 14:33:15 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:33:27 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:33:27 CET Dec 22 14:33:27 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:33:27 dm7080 enigma2[591]: [timer.py] next activation: 1545485707 (in 99007 ms) Dec 22 14:33:34 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:33:34 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:33:34 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:33:34 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:33:34 dm7080 enigma2[591]: header: EXT: Dec 22 14:33:34 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:33:34 dm7080 enigma2[591]: header: Connection: close Dec 22 14:33:38 dm7080 enigma2[591]: +- 1/2 TID 4e Dec 22 14:33:39 dm7080 enigma2[591]: ++ 2/2 TID 4e Dec 22 14:33:39 dm7080 enigma2[591]: done! Dec 22 14:33:39 dm7080 enigma2[591]: pcr of eit change: 108f637a0 Dec 22 14:33:39 dm7080 enigma2[591]: [TIMER] record event 9 Dec 22 14:33:39 dm7080 enigma2[591]: doing version filtering Dec 22 14:33:39 dm7080 enigma2[591]: 0012: 4e 28 3d 3d 00 00 Dec 22 14:33:39 dm7080 enigma2[591]: mask: ff ff ff 3f 00 00 Dec 22 14:33:39 dm7080 enigma2[591]: mode: 00 00 00 3e 00 00 Dec 22 14:33:41 dm7080 enigma2[591]: +- 1/2 TID 4e Dec 22 14:33:41 dm7080 enigma2[591]: ++ 2/2 TID 4e Dec 22 14:33:41 dm7080 enigma2[591]: done! Dec 22 14:33:41 dm7080 enigma2[591]: pcr of eit change: 108fa01f0 Dec 22 14:33:41 dm7080 enigma2[591]: [TIMER] record event 9 Dec 22 14:33:41 dm7080 enigma2[591]: doing version filtering Dec 22 14:33:41 dm7080 enigma2[591]: 0012: 4e 28 3d 3f 00 00 Dec 22 14:33:41 dm7080 enigma2[591]: mask: ff ff ff 3f 00 00 Dec 22 14:33:41 dm7080 enigma2[591]: mode: 00 00 00 3e 00 00 Dec 22 14:34:15 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:34:17 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:34:17 CET Dec 22 14:34:17 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:34:17 dm7080 enigma2[591]: [timer.py] next activation: 1545485757 (in 99999 ms) Dec 22 14:34:18 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 83 32 cd 94 6b Dec 22 14:34:22 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:34:22 CET Dec 22 14:34:22 dm7080 enigma2[591]: [timer.py] next activation: 1545485762 (in 99999 ms) Dec 22 14:34:39 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:34:39 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:34:39 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:34:39 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:34:39 dm7080 enigma2[591]: header: EXT: Dec 22 14:34:39 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:34:39 dm7080 enigma2[591]: header: Connection: close Dec 22 14:35:01 dm7080 enigma2[591]: +- 1/2 TID 4e Dec 22 14:35:02 dm7080 enigma2[591]: ++ 2/2 TID 4e Dec 22 14:35:02 dm7080 enigma2[591]: done! Dec 22 14:35:02 dm7080 enigma2[591]: pcr of eit change: 109686b90 Dec 22 14:35:02 dm7080 enigma2[591]: [eDVBServiceRecord] now running: Tagesschau (300 seconds) (RECORDING) Dec 22 14:35:02 dm7080 enigma2[591]: [TIMER] record event 9 Dec 22 14:35:02 dm7080 enigma2[591]: doing version filtering Dec 22 14:35:02 dm7080 enigma2[591]: 0012: 4e 28 3d 01 00 00 Dec 22 14:35:02 dm7080 enigma2[591]: mask: ff ff ff 3f 00 00 Dec 22 14:35:02 dm7080 enigma2[591]: mode: 00 00 00 3e 00 00 Dec 22 14:35:07 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:35:07 CET Dec 22 14:35:07 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:35:07 dm7080 enigma2[591]: [timer.py] next activation: 1545485807 (in 99998 ms) Dec 22 14:35:15 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:35:44 dm7080 enigma2[591]: send: 'POST /ZoneGroupTopology/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:ZoneGroupTopology:1#GetZoneGroupState\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 277\r\n\r\n' Dec 22 14:35:44 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:35:44 dm7080 enigma2[591]: header: CONTENT-LENGTH: 5054 Dec 22 14:35:44 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:35:44 dm7080 enigma2[591]: header: EXT: Dec 22 14:35:44 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:35:44 dm7080 enigma2[591]: header: Connection: close Dec 22 14:35:44 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:35:44 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:35:44 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:35:44 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:35:44 dm7080 enigma2[591]: header: EXT: Dec 22 14:35:44 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:35:44 dm7080 enigma2[591]: header: Connection: close Dec 22 14:35:57 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:35:56 CET Dec 22 14:35:57 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:35:57 dm7080 enigma2[591]: [timer.py] next activation: 1545485856 (in 98999 ms) Dec 22 14:36:02 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:36:02 CET Dec 22 14:36:02 dm7080 enigma2[591]: [timer.py] next activation: 1545485862 (in 99999 ms) Dec 22 14:36:15 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:36:47 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:36:46 CET Dec 22 14:36:47 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:36:47 dm7080 enigma2[591]: [timer.py] next activation: 1545485907 (in 99999 ms) Dec 22 14:36:49 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:36:49 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:36:49 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:36:49 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:36:49 dm7080 enigma2[591]: header: EXT: Dec 22 14:36:49 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:36:49 dm7080 enigma2[591]: header: Connection: close Dec 22 14:37:15 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:37:36 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:37:35 CET Dec 22 14:37:36 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:37:36 dm7080 enigma2[591]: [timer.py] next activation: 1545485956 (in 99998 ms) Dec 22 14:37:42 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:37:41 CET Dec 22 14:37:42 dm7080 enigma2[591]: [timer.py] next activation: 1545485961 (in 99000 ms) Dec 22 14:37:54 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:37:54 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:37:54 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:37:54 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:37:54 dm7080 enigma2[591]: header: EXT: Dec 22 14:37:54 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:37:54 dm7080 enigma2[591]: header: Connection: close Dec 22 14:38:03 dm7080 enigma2[591]: [Netatmo] start async update Dec 22 14:38:03 dm7080 enigma2[591]: [Netatmo] begin update Dec 22 14:38:03 dm7080 enigma2[591]: [Netatmo] token expire in 5100 Dec 22 14:38:04 dm7080 enigma2[591]: [Netatmo] location from cache 48.26088,12.28173 Pfarrer-Egerer-Straße, Mesmering, Obertaufkirchen, Landkreis Mühldorf am Inn, Obb, Bayern, 84419, Deutschland Dec 22 14:38:04 dm7080 enigma2[591]: [Netatmo] update took 0.85896396637 sec Dec 22 14:38:04 dm7080 enigma2[591]: [Netatmo] recalculate battery percent: 1.2 Dec 22 14:38:04 dm7080 enigma2[591]: [Netatmo] check notification Dec 22 14:38:15 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:38:27 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:38:26 CET Dec 22 14:38:27 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:38:27 dm7080 enigma2[591]: [timer.py] next activation: 1545486007 (in 99997 ms) Dec 22 14:38:59 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:38:59 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:38:59 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:38:59 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:38:59 dm7080 enigma2[591]: header: EXT: Dec 22 14:38:59 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:38:59 dm7080 enigma2[591]: header: Connection: close Dec 22 14:39:15 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:39:16 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:39:16 CET Dec 22 14:39:16 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:39:16 dm7080 enigma2[591]: [timer.py] next activation: 1545486056 (in 99998 ms) Dec 22 14:39:17 dm7080 enigma2[591]: +- 1/2 TID 4e Dec 22 14:39:18 dm7080 enigma2[591]: ++ 2/2 TID 4e Dec 22 14:39:18 dm7080 enigma2[591]: done! Dec 22 14:39:18 dm7080 enigma2[591]: pcr of eit change: 10ac810a8 Dec 22 14:39:18 dm7080 enigma2[591]: [TIMER] record event 9 Dec 22 14:39:18 dm7080 enigma2[591]: doing version filtering Dec 22 14:39:18 dm7080 enigma2[591]: 0012: 4e 28 3d 03 00 00 Dec 22 14:39:18 dm7080 enigma2[591]: mask: ff ff ff 3f 00 00 Dec 22 14:39:18 dm7080 enigma2[591]: mode: 00 00 00 3e 00 00 Dec 22 14:39:21 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:39:20 CET Dec 22 14:39:21 dm7080 enigma2[591]: [timer.py] next activation: 1545486060 (in 99000 ms) Dec 22 14:39:52 dm7080 enigma2[591]: +- 1/2 TID 4e Dec 22 14:39:52 dm7080 enigma2[591]: ++ 2/2 TID 4e Dec 22 14:39:52 dm7080 enigma2[591]: done! Dec 22 14:39:52 dm7080 enigma2[591]: pcr of eit change: 10af76380 Dec 22 14:39:52 dm7080 enigma2[591]: [eDVBServiceRecord] now running: Sportschau (12000 seconds) (RECORDING) Dec 22 14:39:52 dm7080 enigma2[591]: [TIMER] record event 9 Dec 22 14:39:52 dm7080 enigma2[591]: doing version filtering Dec 22 14:39:52 dm7080 enigma2[591]: 0012: 4e 28 3d 05 00 00 Dec 22 14:39:52 dm7080 enigma2[591]: mask: ff ff ff 3f 00 00 Dec 22 14:39:52 dm7080 enigma2[591]: mode: 00 00 00 3e 00 00 Dec 22 14:40:04 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:40:04 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:40:04 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:40:04 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:40:04 dm7080 enigma2[591]: header: EXT: Dec 22 14:40:04 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:40:04 dm7080 enigma2[591]: header: Connection: close Dec 22 14:40:07 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:40:06 CET Dec 22 14:40:07 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:40:07 dm7080 enigma2[591]: [timer.py] next activation: 1545486106 (in 98999 ms) Dec 22 14:40:15 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:40:21 dm7080 enigma2[591]: 982995 ms latency per 1000 blits (1,017299 fps) Dec 22 14:40:56 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:40:55 CET Dec 22 14:40:56 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:40:56 dm7080 enigma2[591]: [timer.py] next activation: 1545486156 (in 99999 ms) Dec 22 14:41:00 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:40:59 CET Dec 22 14:41:00 dm7080 enigma2[591]: [timer.py] next activation: 1545486159 (in 99000 ms) Dec 22 14:41:09 dm7080 enigma2[591]: send: 'POST /ZoneGroupTopology/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:ZoneGroupTopology:1#GetZoneGroupState\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 277\r\n\r\n' Dec 22 14:41:09 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:41:09 dm7080 enigma2[591]: header: CONTENT-LENGTH: 5054 Dec 22 14:41:09 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:41:09 dm7080 enigma2[591]: header: EXT: Dec 22 14:41:09 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:41:09 dm7080 enigma2[591]: header: Connection: close Dec 22 14:41:10 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:41:10 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:41:10 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:41:10 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:41:10 dm7080 enigma2[591]: header: EXT: Dec 22 14:41:10 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:41:10 dm7080 enigma2[591]: header: Connection: close Dec 22 14:41:15 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:41:45 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:41:45 CET Dec 22 14:41:46 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:41:46 dm7080 enigma2[591]: [timer.py] next activation: 1545486205 (in 99000 ms) Dec 22 14:42:15 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:42:15 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:42:15 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:42:15 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:42:15 dm7080 enigma2[591]: header: EXT: Dec 22 14:42:15 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:42:15 dm7080 enigma2[591]: header: Connection: close Dec 22 14:42:15 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:42:36 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:42:35 CET Dec 22 14:42:36 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:42:36 dm7080 enigma2[591]: [timer.py] next activation: 1545486255 (in 98999 ms) Dec 22 14:42:39 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:42:39 CET Dec 22 14:42:39 dm7080 enigma2[591]: [timer.py] next activation: 1545486259 (in 99999 ms) Dec 22 14:43:03 dm7080 enigma2[591]: [Netatmo] start async update Dec 22 14:43:03 dm7080 enigma2[591]: [Netatmo] begin update Dec 22 14:43:03 dm7080 enigma2[591]: [Netatmo] token expire in 4800 Dec 22 14:43:03 dm7080 enigma2[591]: [Netatmo] location from cache 48.26088,12.28173 Pfarrer-Egerer-Straße, Mesmering, Obertaufkirchen, Landkreis Mühldorf am Inn, Obb, Bayern, 84419, Deutschland Dec 22 14:43:03 dm7080 enigma2[591]: [Netatmo] update took 0.49872303009 sec Dec 22 14:43:03 dm7080 enigma2[591]: [Netatmo] recalculate battery percent: 1.2 Dec 22 14:43:03 dm7080 enigma2[591]: [Netatmo] check notification Dec 22 14:43:15 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:43:20 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:43:20 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:43:20 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:43:20 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:43:20 dm7080 enigma2[591]: header: EXT: Dec 22 14:43:20 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:43:20 dm7080 enigma2[591]: header: Connection: close Dec 22 14:43:25 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:43:25 CET Dec 22 14:43:25 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:43:25 dm7080 enigma2[591]: [timer.py] next activation: 1545486305 (in 99997 ms) Dec 22 14:44:15 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:44:14 CET Dec 22 14:44:15 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:44:15 dm7080 enigma2[591]: [timer.py] next activation: 1545486354 (in 99000 ms) Dec 22 14:44:16 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:44:19 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:44:18 CET Dec 22 14:44:19 dm7080 enigma2[591]: [timer.py] next activation: 1545486359 (in 99998 ms) Dec 22 14:44:25 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:44:25 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:44:25 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:44:25 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:44:25 dm7080 enigma2[591]: header: EXT: Dec 22 14:44:25 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:44:25 dm7080 enigma2[591]: header: Connection: close Dec 22 14:44:52 dm7080 enigma2[591]: +- 1/2 TID 4e Dec 22 14:44:53 dm7080 enigma2[591]: ++ 2/2 TID 4e Dec 22 14:44:53 dm7080 enigma2[591]: done! Dec 22 14:44:53 dm7080 enigma2[591]: W/ [InfoBar.__servicePlaying] :: Dec 22 14:44:53 dm7080 enigma2[591]: I/ [InfoBar.setPlaybackState] :: None None 1545486293.46 Dec 22 14:44:53 dm7080 enigma2[591]: doing version filtering Dec 22 14:44:53 dm7080 enigma2[591]: 0012: 4e ef 75 3f 00 00 Dec 22 14:44:53 dm7080 enigma2[591]: mask: ff ff ff 3f 00 00 Dec 22 14:44:53 dm7080 enigma2[591]: mode: 00 00 00 3e 00 00 Dec 22 14:45:05 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:45:04 CET Dec 22 14:45:05 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:45:05 dm7080 enigma2[591]: [timer.py] next activation: 1545486405 (in 99997 ms) Dec 22 14:45:16 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:45:22 dm7080 enigma2[591]: +- 1/2 TID 4e Dec 22 14:45:23 dm7080 enigma2[591]: ++ 2/2 TID 4e Dec 22 14:45:23 dm7080 enigma2[591]: done! Dec 22 14:45:23 dm7080 enigma2[591]: W/ [InfoBar.__servicePlaying] :: Dec 22 14:45:23 dm7080 enigma2[591]: I/ [InfoBar.setPlaybackState] :: None None 1545486323.86 Dec 22 14:45:23 dm7080 enigma2[591]: doing version filtering Dec 22 14:45:23 dm7080 enigma2[591]: 0012: 4e ef 75 01 00 00 Dec 22 14:45:23 dm7080 enigma2[591]: mask: ff ff ff 3f 00 00 Dec 22 14:45:23 dm7080 enigma2[591]: mode: 00 00 00 3e 00 00 Dec 22 14:45:23 dm7080 enigma2[591]: create buffer for widget 917 x 37 Dec 22 14:45:24 dm7080 enigma2[591]: stopping thread. Dec 22 14:45:24 dm7080 enigma2[591]: waiting for aio thread shutdown! Dec 22 14:45:24 dm7080 enigma2[591]: record aio thread has finished Dec 22 14:45:24 dm7080 enigma2[591]: eRecordFileThread (direct io) STOP Dec 22 14:45:24 dm7080 enigma2[591]: thread joined 0 Dec 22 14:45:24 dm7080 enigma2[591]: remove timeshift file Dec 22 14:45:24 dm7080 enigma2[591]: Start timeshift! Dec 22 14:45:24 dm7080 enigma2[591]: timeshift recording to /media/ssd/pts//timeshift.Z1D76R Dec 22 14:45:24 dm7080 enigma2[591]: before: 1 Dec 22 14:45:24 dm7080 enigma2[591]: after: 1 Dec 22 14:45:24 dm7080 enigma2[591]: setIoPrio realtime level 7 ok Dec 22 14:45:24 dm7080 enigma2[591]: eRecordFileThread (direct io) START Dec 22 14:45:24 dm7080 enigma2[591]: record write thread succesfully created!setIoPrio realtime level 7 ok Dec 22 14:45:24 dm7080 enigma2[591]: I/ [InfoBar.ptsSetNextPlaybackFile] :: [PTS-Plugin] setNextPlaybackFile(/media/ssd/pts//pts_livebuffer.3) Dec 22 14:45:24 dm7080 enigma2[591]: eBackgroundFileEraser '/media/ssd/pts//timeshift.QwNsmN' finished Dec 22 14:45:30 dm7080 enigma2[591]: send: 'POST /ZoneGroupTopology/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:ZoneGroupTopology:1#GetZoneGroupState\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 277\r\n\r\n' Dec 22 14:45:30 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:45:30 dm7080 enigma2[591]: header: CONTENT-LENGTH: 5054 Dec 22 14:45:30 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:45:30 dm7080 enigma2[591]: header: EXT: Dec 22 14:45:30 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:45:30 dm7080 enigma2[591]: header: Connection: close Dec 22 14:45:30 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:45:30 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:45:30 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:45:30 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:45:30 dm7080 enigma2[591]: header: EXT: Dec 22 14:45:30 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:45:30 dm7080 enigma2[591]: header: Connection: close Dec 22 14:45:54 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:45:54 CET Dec 22 14:45:54 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:45:54 dm7080 enigma2[591]: [timer.py] next activation: 1545486454 (in 99998 ms) Dec 22 14:45:59 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:45:58 CET Dec 22 14:45:59 dm7080 enigma2[591]: [timer.py] next activation: 1545486458 (in 99000 ms) Dec 22 14:46:12 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 11 ee Dec 22 14:46:12 dm7080 enigma2[591]: action -> QuickButtonActions up Dec 22 14:46:12 dm7080 enigma2[591]: unknown action QuickButtonActions/up! typo in keymap? Dec 22 14:46:12 dm7080 enigma2[591]: reused converter! Dec 22 14:46:12 dm7080 enigma2[591]: reused converter! Dec 22 14:46:12 dm7080 enigma2[591]: reused converter! Dec 22 14:46:16 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:46:25 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 13 ec Dec 22 14:46:25 dm7080 enigma2[591]: action -> ChannelSelectBaseActions selectServicePageUp Dec 22 14:46:25 dm7080 enigma2[591]: unknown action ChannelSelectBaseActions/selectServicePageUp! typo in keymap? Dec 22 14:46:25 dm7080 enigma2[591]: action -> WizardActions left Dec 22 14:46:25 dm7080 enigma2[591]: unknown action WizardActions/left! typo in keymap? Dec 22 14:46:25 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 83 32 cd 13 ec Dec 22 14:46:25 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 93 6c Dec 22 14:46:35 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 13 ec Dec 22 14:46:35 dm7080 enigma2[591]: action -> ChannelSelectBaseActions selectServicePageUp Dec 22 14:46:35 dm7080 enigma2[591]: unknown action ChannelSelectBaseActions/selectServicePageUp! typo in keymap? Dec 22 14:46:35 dm7080 enigma2[591]: action -> WizardActions left Dec 22 14:46:35 dm7080 enigma2[591]: unknown action WizardActions/left! typo in keymap? Dec 22 14:46:35 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:46:35 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:46:35 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:46:35 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:46:35 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:46:35 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:46:35 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:46:35 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:46:35 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:46:35 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:46:35 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:46:35 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:46:35 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:46:35 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:46:35 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:46:35 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:46:35 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:46:35 dm7080 enigma2[591]: libpng warning: iCCP: cHRM chunk does not match sRGB Dec 22 14:46:35 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:46:35 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:46:35 dm7080 enigma2[591]: libpng warning: iCCP: known incorrect sRGB profile Dec 22 14:46:35 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:46:35 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:46:35 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:46:35 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:46:35 dm7080 enigma2[591]: header: EXT: Dec 22 14:46:35 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:46:35 dm7080 enigma2[591]: header: Connection: close Dec 22 14:46:35 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 83 32 cd 13 ec Dec 22 14:46:35 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 93 6c Dec 22 14:46:41 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 11 ee Dec 22 14:46:41 dm7080 enigma2[591]: action -> ChannelSelectBaseActions selectServiceUp Dec 22 14:46:41 dm7080 enigma2[591]: unknown action ChannelSelectBaseActions/selectServiceUp! typo in keymap? Dec 22 14:46:41 dm7080 enigma2[591]: action -> WizardActions up Dec 22 14:46:41 dm7080 enigma2[591]: unknown action WizardActions/up! typo in keymap? Dec 22 14:46:43 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 17 e8 Dec 22 14:46:43 dm7080 enigma2[591]: action -> ChannelSelectBaseActions selectServiceDown Dec 22 14:46:43 dm7080 enigma2[591]: unknown action ChannelSelectBaseActions/selectServiceDown! typo in keymap? Dec 22 14:46:43 dm7080 enigma2[591]: action -> WizardActions down Dec 22 14:46:43 dm7080 enigma2[591]: unknown action WizardActions/down! typo in keymap? Dec 22 14:46:43 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 17 e8 Dec 22 14:46:43 dm7080 enigma2[591]: action -> ChannelSelectBaseActions selectServiceDown Dec 22 14:46:43 dm7080 enigma2[591]: unknown action ChannelSelectBaseActions/selectServiceDown! typo in keymap? Dec 22 14:46:43 dm7080 enigma2[591]: action -> WizardActions down Dec 22 14:46:43 dm7080 enigma2[591]: unknown action WizardActions/down! typo in keymap? Dec 22 14:46:44 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 17 e8 Dec 22 14:46:44 dm7080 enigma2[591]: action -> ChannelSelectBaseActions selectServiceDown Dec 22 14:46:44 dm7080 enigma2[591]: unknown action ChannelSelectBaseActions/selectServiceDown! typo in keymap? Dec 22 14:46:44 dm7080 enigma2[591]: action -> WizardActions down Dec 22 14:46:44 dm7080 enigma2[591]: unknown action WizardActions/down! typo in keymap? Dec 22 14:46:44 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 17 e8 Dec 22 14:46:44 dm7080 enigma2[591]: action -> ChannelSelectBaseActions selectServiceDown Dec 22 14:46:44 dm7080 enigma2[591]: unknown action ChannelSelectBaseActions/selectServiceDown! typo in keymap? Dec 22 14:46:44 dm7080 enigma2[591]: action -> WizardActions down Dec 22 14:46:44 dm7080 enigma2[591]: unknown action WizardActions/down! typo in keymap? Dec 22 14:46:45 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:46:45 CET Dec 22 14:46:45 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:46:45 dm7080 enigma2[591]: [timer.py] next activation: 1545486505 (in 99997 ms) Dec 22 14:46:45 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 14 eb Dec 22 14:46:45 dm7080 enigma2[591]: action -> OkCancelActions ok Dec 22 14:46:45 dm7080 enigma2[591]: playing 1:0:19:8C:4:85:C00000:0:0:0: Dec 22 14:46:45 dm7080 enigma2[591]: stopping thread. Dec 22 14:46:45 dm7080 enigma2[591]: waiting for aio thread shutdown! Dec 22 14:46:45 dm7080 enigma2[591]: record aio thread has finished Dec 22 14:46:45 dm7080 enigma2[591]: eRecordFileThread (direct io) STOP Dec 22 14:46:45 dm7080 enigma2[591]: thread joined 0 Dec 22 14:46:45 dm7080 enigma2[591]: remove timeshift file Dec 22 14:46:45 dm7080 enigma2[591]: [eDVBCAService] free slot 0 demux 1 for service 1:0:19:EF75:3F9:1:C00000:0:0:0: Dec 22 14:46:45 dm7080 enigma2[591]: [eDVBCAService] free service 1:0:19:EF75:3F9:1:C00000:0:0:0: Dec 22 14:46:45 dm7080 enigma2[591]: [eFileMonitor] 1 events queued Dec 22 14:46:45 dm7080 enigma2[591]: I/ [PhotoScreensaver.setEnabled] :: True Dec 22 14:46:45 dm7080 enigma2[591]: before: 1 Dec 22 14:46:45 dm7080 enigma2[591]: [ePicLoad] decode picture... /tmp/wallpaper Dec 22 14:46:45 dm7080 enigma2[591]: [eDBusInterface::Private::sendEvent 0 Dec 22 14:46:45 dm7080 enigma2[591]: [TeleText] service stopped Dec 22 14:46:45 dm7080 enigma2[591]: [TeleText] send array('B', [1, 0, 0, 0]) Dec 22 14:46:45 dm7080 enigma2[591]: disable dvb subtitles Dec 22 14:46:45 dm7080 enigma2[591]: disable teletext subtitles page ffffffffffffffff (und) Dec 22 14:46:45 dm7080 enigma2[591]: decoder state: play, vpid=-1, apid=-1 Dec 22 14:46:45 dm7080 enigma2[591]: DEMUX_STOP - pcr - ok Dec 22 14:46:45 dm7080 enigma2[591]: DEMUX_STOP - video - ok Dec 22 14:46:45 dm7080 enigma2[591]: VIDEO_STOP - ok Dec 22 14:46:45 dm7080 enigma2[591]: AUDIO_STOP - ok Dec 22 14:46:45 dm7080 enigma2[591]: DEMUX_STOP - audio - ok Dec 22 14:46:45 dm7080 enigma2[591]: AUDIO_CONTINUE - ok Dec 22 14:46:45 dm7080 enigma2[591]: DEMUX_STOP - ttx - ok Dec 22 14:46:45 dm7080 enigma2[591]: start release channel timer Dec 22 14:46:45 dm7080 enigma2[591]: [TeleText] service started Dec 22 14:46:45 dm7080 enigma2[591]: not pauseable. Dec 22 14:46:45 dm7080 enigma2[591]: W/ [InfoBar.__servicePlaying] :: Dec 22 14:46:45 dm7080 enigma2[591]: I/ [InfoBar.setPlaybackState] :: None None 1545486405.62 Dec 22 14:46:45 dm7080 enigma2[591]: [eDVBCAService] remove channel 0x2339418 Dec 22 14:46:45 dm7080 enigma2[591]: [eDVBCAService] write leave transponder to '/tmp/camd.socket' ok Dec 22 14:46:45 dm7080 enigma2[591]: [eDVBLocalTimeHandler] remove channel 0x2339418 Dec 22 14:46:45 dm7080 enigma2[591]: [EPGC] remove channel 0x2339418 Dec 22 14:46:45 dm7080 enigma2[591]: [ 1] preClose Dec 22 14:46:45 dm7080 enigma2[591]: allocate channel.. 0004:0085:00c00000 Dec 22 14:46:45 dm7080 enigma2[591]: available channel.. 03fb:0001:00c00000 Dec 22 14:46:45 dm7080 enigma2[591]: [eDVBCAService] new channel 0x2339418! Dec 22 14:46:45 dm7080 enigma2[591]: [ 1] tune type 1 Dec 22 14:46:45 dm7080 enigma2[591]: RotorCmd ffffffff, lastRotorCmd ffffffff Dec 22 14:46:45 dm7080 enigma2[591]: [ 1] prepare_sat System DVB-S2 Freq 12031500H SR 27500000 INV Auto FEC 9/10 orbpos 192 modulation QPSK pilot Auto, rolloff 0.35 Dec 22 14:46:45 dm7080 enigma2[591]: [ 1] tuning to 1431 mhz Dec 22 14:46:45 dm7080 enigma2[591]: OURSTATE: tuning Dec 22 14:46:45 dm7080 enigma2[591]: [SEC-1] update oparm Dec 22 14:46:45 dm7080 enigma2[591]: [SEC-1] lock 0 Dec 22 14:46:45 dm7080 enigma2[591]: [SEC-1] locked 1 Dec 22 14:46:45 dm7080 enigma2[591]: [SEC-1] set static current limiting Dec 22 14:46:45 dm7080 enigma2[591]: allocate Channel: res 0 Dec 22 14:46:45 dm7080 enigma2[591]: [SEC-1] invalidate current switch params Dec 22 14:46:45 dm7080 enigma2[591]: [SEC-1] setTone On Dec 22 14:46:45 dm7080 enigma2[591]: allocate demux Dec 22 14:46:45 dm7080 enigma2[591]: [SEC-1] sleep 10ms Dec 22 14:46:45 dm7080 enigma2[591]: setInputSource input1 to A2 Dec 22 14:46:45 dm7080 enigma2[591]: getting program info failed. Dec 22 14:46:45 dm7080 enigma2[591]: allocate demux Dec 22 14:46:45 dm7080 enigma2[591]: disable teletext subtitles page ffffffffffffffff (und) Dec 22 14:46:45 dm7080 enigma2[591]: PES filter: DMX_SET_PES_FILTER - Invalid argument Dec 22 14:46:45 dm7080 enigma2[591]: decoder state: play, vpid=-1, apid=-1 Dec 22 14:46:45 dm7080 enigma2[591]: W/ [InfoBar.__servicePlaying] :: Dec 22 14:46:45 dm7080 enigma2[591]: I/ [InfoBar.setPlaybackState] :: None None 1545486405.63 Dec 22 14:46:45 dm7080 enigma2[591]: I/ [ScreenSaverHandler._onEvent] :: play event, checking for video Dec 22 14:46:45 dm7080 enigma2[591]: I/ [PhotoScreensaver.setEnabled] :: True Dec 22 14:46:45 dm7080 enigma2[591]: [HbbTV].aitInvalidated[SEC-1] update current switch params Dec 22 14:46:45 dm7080 enigma2[591]: [SEC-1] startTuneTimeout 5000 Dec 22 14:46:45 dm7080 enigma2[591]: [SEC-1] setFrontend 1 Dec 22 14:46:45 dm7080 enigma2[591]: [ 1] setting frontend Dec 22 14:46:45 dm7080 enigma2[591]: [SEC-1] unlock 1 Dec 22 14:46:45 dm7080 enigma2[591]: [SEC-1] sleep 500ms Dec 22 14:46:45 dm7080 enigma2[591]: I/ [InfoBar.__restoreState] :: Dec 22 14:46:45 dm7080 enigma2[591]: create buffer for widget 1920 x 250 Dec 22 14:46:45 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 83 32 cd 14 eb Dec 22 14:46:45 dm7080 enigma2[591]: eBackgroundFileEraser '/media/ssd/pts//timeshift.Z1D76R' finished Dec 22 14:46:45 dm7080 enigma2[591]: [eFileMonitor] File {/tmp/ecm.info} has been deleted Dec 22 14:46:45 dm7080 enigma2[591]: create buffer for widget 917 x 37 Dec 22 14:46:45 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 94 6b Dec 22 14:46:45 dm7080 enigma2[591]: [ 1] fe event: status 0, freq 1431500, inversion off, m_tuning 1 F Dec 22 14:46:45 dm7080 enigma2[591]: [ 1] fe event: status 1, freq 1431500, inversion off, m_tuning 1 N Dec 22 14:46:45 dm7080 enigma2[591]: [ 1] fe event: status 1f, freq 1431500, inversion off, m_tuning 2 N Dec 22 14:46:45 dm7080 enigma2[591]: OURSTATE: ok Dec 22 14:46:45 dm7080 enigma2[591]: [eDVBCAService] channel 0x2339418 running Dec 22 14:46:45 dm7080 enigma2[591]: [eDVBLocalTimeHandler] channel 0x2339418 running Dec 22 14:46:45 dm7080 enigma2[591]: no version filtering Dec 22 14:46:45 dm7080 enigma2[591]: 0014: 70 00 00 00 00 00 Dec 22 14:46:45 dm7080 enigma2[591]: mask: fc 00 00 00 00 00 Dec 22 14:46:45 dm7080 enigma2[591]: mode: 00 00 00 00 00 00 Dec 22 14:46:45 dm7080 enigma2[591]: [EPGC] channel 0x2339418 running Dec 22 14:46:45 dm7080 enigma2[591]: [EPGC] next update in 2 sec Dec 22 14:46:45 dm7080 enigma2[591]: stop release channel timer Dec 22 14:46:45 dm7080 enigma2[591]: no version filtering Dec 22 14:46:45 dm7080 enigma2[591]: 0012: 4e 00 8c 00 00 00 Dec 22 14:46:45 dm7080 enigma2[591]: mask: ff ff ff 00 00 00 Dec 22 14:46:45 dm7080 enigma2[591]: mode: 00 00 00 00 00 00 Dec 22 14:46:45 dm7080 enigma2[591]: ok ... now we start!! Dec 22 14:46:45 dm7080 enigma2[591]: no version filtering Dec 22 14:46:45 dm7080 enigma2[591]: 0000: 00 00 00 00 00 00 Dec 22 14:46:45 dm7080 enigma2[591]: mask: ff 00 00 00 00 00 Dec 22 14:46:45 dm7080 enigma2[591]: mode: 00 00 00 00 00 00 Dec 22 14:46:46 dm7080 enigma2[591]: + 1/1 TID 00 Dec 22 14:46:46 dm7080 enigma2[591]: done! Dec 22 14:46:46 dm7080 enigma2[591]: PATready Dec 22 14:46:46 dm7080 enigma2[591]: use pmtpid 006a for service_id 008c Dec 22 14:46:46 dm7080 enigma2[591]: no version filtering Dec 22 14:46:46 dm7080 enigma2[591]: 006a: 02 00 8c 00 00 00 Dec 22 14:46:46 dm7080 enigma2[591]: mask: ff ff ff 00 00 00 Dec 22 14:46:46 dm7080 enigma2[591]: mode: 00 00 00 00 00 00 Dec 22 14:46:46 dm7080 enigma2[591]: doing version filtering Dec 22 14:46:46 dm7080 enigma2[591]: 0000: 00 00 00 25 00 00 Dec 22 14:46:46 dm7080 enigma2[591]: mask: ff 00 00 3f 00 00 Dec 22 14:46:46 dm7080 enigma2[591]: mode: 00 00 00 3e 00 00 Dec 22 14:46:46 dm7080 enigma2[591]: [SEC-1] set dynamic current limiting Dec 22 14:46:46 dm7080 enigma2[591]: + 1/1 TID 02 Dec 22 14:46:46 dm7080 enigma2[591]: done! Dec 22 14:46:46 dm7080 enigma2[591]: [eDVBCAService] new service 1:0:19:8C:4:85:C00000:0:0:0: Dec 22 14:46:46 dm7080 enigma2[591]: [eDVBCAService] add demux 1 to slot 0 service 1:0:19:8C:4:85:C00000:0:0:0: Dec 22 14:46:46 dm7080 enigma2[591]: [eDVBCAService] demux 1 mask 02 Dec 22 14:46:46 dm7080 enigma2[591]: [eDVBCAServiceConn] send 70 bytes to '/tmp/camd.socket' Dec 22 14:46:46 dm7080 enigma2[591]: 9f 80 32 42 03 00 8c 0b 00 2d 01 81 08 00 c0 00 00 00 04 00 85 82 02 02 01 84 02 00 6a 85 03 01 41 32 86 01 01 09 04 09 c4 fb 26 09 04 09 8c fa 26 09 04 09 8d fc 26 1b 0a ff 00 00 06 0b 03 00 00 06 0b 04 00 00 Dec 22 14:46:46 dm7080 enigma2[591]: [eDVBCIInterfaces] addPMTHandler 1:0:19:8C:4:85:C00000:0:0:0: Dec 22 14:46:46 dm7080 enigma2[591]: [eDVBCIInterfaces] gotPMT Dec 22 14:46:46 dm7080 enigma2[591]: eventNewProgramInfo 0 0 Dec 22 14:46:46 dm7080 enigma2[591]: have 1 video stream(s) (0aff), and 2 audio stream(s) (0b03, 0b04), and the pcr pid is 0aff, and the text pid is ffffffff Dec 22 14:46:46 dm7080 enigma2[591]: PES filter: DMX_SET_PES_FILTER - Invalid argument Dec 22 14:46:46 dm7080 enigma2[591]: decoder state: play, vpid=2815, apid=2819 Dec 22 14:46:46 dm7080 enigma2[591]: DMX_SET_PES_FILTER(0xaff) - pcr - ok Dec 22 14:46:46 dm7080 enigma2[591]: DEMUX_START - pcr - ok Dec 22 14:46:46 dm7080 enigma2[591]: DMX_SET_PES_FILTER(0xb03) - audio - ok Dec 22 14:46:46 dm7080 enigma2[591]: DEMUX_START - audio - ok Dec 22 14:46:46 dm7080 enigma2[591]: AUDIO_SET_BYPASS(0) - ok Dec 22 14:46:46 dm7080 enigma2[591]: AUDIO_PAUSE - ok Dec 22 14:46:46 dm7080 enigma2[591]: AUDIO_PLAY - ok Dec 22 14:46:46 dm7080 enigma2[591]: Video Device: /dev/dvb/adapter0/video0 Dec 22 14:46:46 dm7080 enigma2[591]: demux device: /dev/dvb/adapter0/demux1 Dec 22 14:46:46 dm7080 enigma2[591]: VIDEO_SET_STREAMTYPE 1 - ok Dec 22 14:46:46 dm7080 enigma2[591]: DMX_SET_PES_FILTER(0xaff) - video - ok Dec 22 14:46:46 dm7080 enigma2[591]: DEMUX_START - video - ok Dec 22 14:46:46 dm7080 enigma2[591]: VIDEO_FREEZE - ok Dec 22 14:46:46 dm7080 enigma2[591]: VIDEO_PLAY - ok Dec 22 14:46:46 dm7080 enigma2[591]: VIDEO_SLOWMOTION(0) - ok Dec 22 14:46:46 dm7080 enigma2[591]: VIDEO_FAST_FORWARD(0) - ok Dec 22 14:46:46 dm7080 enigma2[591]: VIDEO_CONTINUE - ok Dec 22 14:46:46 dm7080 enigma2[591]: AUDIO_CONTINUE - ok Dec 22 14:46:46 dm7080 enigma2[591]: W/ [InfoBar.__servicePlaying] :: Dec 22 14:46:46 dm7080 enigma2[591]: I/ [InfoBar.setPlaybackState] :: None None 1545486406.21 Dec 22 14:46:46 dm7080 enigma2[591]: I/ [ScreenSaverHandler._onEvent] :: play event, checking for video Dec 22 14:46:46 dm7080 enigma2[591]: I/ [PhotoScreensaver.setEnabled] :: False Dec 22 14:46:46 dm7080 enigma2[591]: [eDBusInterface::Private::sendEvent 1 Dec 22 14:46:46 dm7080 enigma2[591]: not pauseable. Dec 22 14:46:46 dm7080 enigma2[591]: [TeleText] serviceInfoChanged Dec 22 14:46:46 dm7080 enigma2[591]: [TeleText] TXT PID -1 DEMUX 1 Dec 22 14:46:46 dm7080 enigma2[591]: doing version filtering Dec 22 14:46:46 dm7080 enigma2[591]: 006a: 02 00 8c 0b 00 00 Dec 22 14:46:46 dm7080 enigma2[591]: mask: ff ff ff 3f 00 00 Dec 22 14:46:46 dm7080 enigma2[591]: mode: 00 00 00 3e 00 00 Dec 22 14:46:46 dm7080 enigma2[591]: [eFileMonitor] 1 events queued Dec 22 14:46:46 dm7080 enigma2[591]: [eFileMonitor] File {/tmp/ecm.info} has been created Dec 22 14:46:46 dm7080 enigma2[591]: +- 1/2 TID 4e Dec 22 14:46:46 dm7080 enigma2[591]: [ePicLoad] finished decoding /tmp/wallpaper. Dec 22 14:46:46 dm7080 enigma2[591]: sdt update done! Dec 22 14:46:47 dm7080 enigma2[591]: VIDEO_GET_EVENT - ok Dec 22 14:46:47 dm7080 enigma2[591]: unhandled DVBAPI Video Event 32 Dec 22 14:46:47 dm7080 enigma2[591]: ++ 2/2 TID 4e Dec 22 14:46:47 dm7080 enigma2[591]: done! Dec 22 14:46:47 dm7080 enigma2[591]: W/ [InfoBar.__servicePlaying] :: Dec 22 14:46:47 dm7080 enigma2[591]: I/ [InfoBar.setPlaybackState] :: None None 1545486407.46 Dec 22 14:46:47 dm7080 enigma2[591]: doing version filtering Dec 22 14:46:47 dm7080 enigma2[591]: 0012: 4e 00 8c 07 00 00 Dec 22 14:46:47 dm7080 enigma2[591]: mask: ff ff ff 3f 00 00 Dec 22 14:46:47 dm7080 enigma2[591]: mode: 00 00 00 3e 00 00 Dec 22 14:46:47 dm7080 enigma2[591]: [eDVBLocalTimeHandler] Receiver time is 'Sat Dec 22 14:46:47 2018' Dec 22 14:46:47 dm7080 enigma2[591]: [eDVBLocalTimeHandler] Transponder time is 'Sat Dec 22 14:46:45 2018' Dec 22 14:46:47 dm7080 enigma2[591]: [eDVBLocalTimeHandler] diff is -2 Dec 22 14:46:47 dm7080 enigma2[591]: [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time Dec 22 14:46:45 dm7080 enigma2[591]: [eDVBLocalTimeHandler] update RTC Dec 22 14:46:45 dm7080 enigma2[591]: [eDVBLocalTimeHandler] time_difference is -2 Dec 22 14:46:45 dm7080 enigma2[591]: [eDVBLocalTimeHandler] update Linux Time Dec 22 14:46:45 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x32 (1): 01 Dec 22 14:46:47 dm7080 enigma2[591]: [eInputDeviceHandlerDreamBLE::onCommand] 32 [OK]! Dec 22 14:46:47 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x30 (5): 01 45 40 1e 5c Dec 22 14:46:47 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x33 (1): 01 Dec 22 14:46:47 dm7080 enigma2[591]: [eInputDeviceHandlerDreamBLE::onCommand] 33 [OK]! Dec 22 14:46:47 dm7080 enigma2[591]: [EPGC] start caching events(1545486407) Dec 22 14:46:50 dm7080 enigma2[591]: I/ [InfoBar.ptsCleanTimeshiftFolder] :: [PTS-Plugin] Erasing stranded timeshift pts_livebuffer.3 Dec 22 14:46:50 dm7080 enigma2[591]: I/ [InfoBar.ptsCleanTimeshiftFolder] :: [PTS-Plugin] Erasing stranded timeshift pts_livebuffer.2 Dec 22 14:46:50 dm7080 enigma2[591]: I/ [InfoBar.ptsCleanTimeshiftFolder] :: [PTS-Plugin] Erasing stranded timeshift pts_livebuffer.1 Dec 22 14:46:50 dm7080 enigma2[591]: eBackgroundFileEraser '/media/ssd/pts//pts_livebuffer.3' finished Dec 22 14:46:50 dm7080 enigma2[591]: eBackgroundFileEraser '/media/ssd/pts//pts_livebuffer.3.meta' finished Dec 22 14:46:50 dm7080 enigma2[591]: eBackgroundFileEraser '/media/ssd/pts//pts_livebuffer.3.eit' finished Dec 22 14:46:50 dm7080 enigma2[591]: 389443 ms latency per 1000 blits (2,567770 fps) Dec 22 14:46:52 dm7080 enigma2[591]: Start timeshift! Dec 22 14:46:52 dm7080 enigma2[591]: timeshift recording to /media/ssd/pts//timeshift.4gpQBn Dec 22 14:46:52 dm7080 enigma2[591]: before: 1 Dec 22 14:46:52 dm7080 enigma2[591]: after: 1 Dec 22 14:46:52 dm7080 enigma2[591]: setIoPrio realtime level 7 ok Dec 22 14:46:52 dm7080 enigma2[591]: eRecordFileThread (direct io) START Dec 22 14:46:52 dm7080 enigma2[591]: record write thread succesfully created! Dec 22 14:46:52 dm7080 enigma2[591]: setIoPrio realtime level 7 ok Dec 22 14:46:52 dm7080 enigma2[591]: I/ [InfoBar.ptsSetNextPlaybackFile] :: [PTS-Plugin] setNextPlaybackFile(/media/ssd/pts//pts_livebuffer.1) Dec 22 14:46:54 dm7080 enigma2[591]: [EPGC] abort non avail schedule other reading Dec 22 14:46:54 dm7080 enigma2[591]: [EPGC] abort non avail viasat reading Dec 22 14:46:54 dm7080 enigma2[591]: [EPGC] nownext finished(1545486414) Dec 22 14:46:56 dm7080 enigma2[591]: [EPGC] schedule finished(1545486416) Dec 22 14:46:56 dm7080 enigma2[591]: [EPGC] stop caching events(1545486416) Dec 22 14:46:56 dm7080 enigma2[591]: [EPGC] next update in 60 min Dec 22 14:46:58 dm7080 enigma2[591]: [EPGC] cleanup invalid data Dec 22 14:46:58 dm7080 enigma2[591]: eBackgroundFileEraser '/media/ssd/pts//pts_livebuffer.2' finished Dec 22 14:46:58 dm7080 enigma2[591]: eBackgroundFileEraser '/media/ssd/pts//pts_livebuffer.2.meta' finished Dec 22 14:46:58 dm7080 enigma2[591]: eBackgroundFileEraser '/media/ssd/pts//pts_livebuffer.2.eit' finished Dec 22 14:47:03 dm7080 enigma2[591]: eBackgroundFileEraser '/media/ssd/pts//pts_livebuffer.1' finished Dec 22 14:47:03 dm7080 enigma2[591]: eBackgroundFileEraser '/media/ssd/pts//pts_livebuffer.1.meta' finished Dec 22 14:47:03 dm7080 enigma2[591]: eBackgroundFileEraser '/media/ssd/pts//pts_livebuffer.1.eit' finished Dec 22 14:47:06 dm7080 enigma2[591]: no ancillary data in audio stream... abort radiotext pes parser Dec 22 14:47:16 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:47:33 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:47:33 CET Dec 22 14:47:33 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:47:33 dm7080 enigma2[591]: [timer.py] next activation: 1545486553 (in 99010 ms) Dec 22 14:47:37 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:47:37 CET Dec 22 14:47:37 dm7080 enigma2[591]: [timer.py] next activation: 1545486557 (in 99010 ms) Dec 22 14:47:41 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:47:41 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:47:41 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:47:41 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:47:41 dm7080 enigma2[591]: header: EXT: Dec 22 14:47:41 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:47:41 dm7080 enigma2[591]: header: Connection: close Dec 22 14:48:03 dm7080 enigma2[591]: [Netatmo] start async update Dec 22 14:48:03 dm7080 enigma2[591]: [Netatmo] begin update Dec 22 14:48:03 dm7080 enigma2[591]: [Netatmo] token expire in 4500 Dec 22 14:48:03 dm7080 enigma2[591]: [Netatmo] location from cache 48.26088,12.28173 Pfarrer-Egerer-Straße, Mesmering, Obertaufkirchen, Landkreis Mühldorf am Inn, Obb, Bayern, 84419, Deutschland Dec 22 14:48:03 dm7080 enigma2[591]: [Netatmo] update took 0.557449817657 sec Dec 22 14:48:03 dm7080 enigma2[591]: [Netatmo] recalculate battery percent: 1.2 Dec 22 14:48:03 dm7080 enigma2[591]: [Netatmo] check notification Dec 22 14:48:06 dm7080 enigma2[591]: + 1/1 TID 00 Dec 22 14:48:06 dm7080 enigma2[591]: done! Dec 22 14:48:06 dm7080 enigma2[591]: PATready Dec 22 14:48:06 dm7080 enigma2[591]: use pmtpid 006a for service_id 008c Dec 22 14:48:06 dm7080 enigma2[591]: no version filtering Dec 22 14:48:06 dm7080 enigma2[591]: 006a: 02 00 8c 00 00 00 Dec 22 14:48:06 dm7080 enigma2[591]: mask: ff ff ff 00 00 00 Dec 22 14:48:06 dm7080 enigma2[591]: mode: 00 00 00 00 00 00 Dec 22 14:48:06 dm7080 enigma2[591]: doing version filtering Dec 22 14:48:06 dm7080 enigma2[591]: 0000: 00 00 00 27 00 00 Dec 22 14:48:06 dm7080 enigma2[591]: mask: ff 00 00 3f 00 00 Dec 22 14:48:06 dm7080 enigma2[591]: mode: 00 00 00 3e 00 00 Dec 22 14:48:06 dm7080 enigma2[591]: + 1/1 TID 02 Dec 22 14:48:06 dm7080 enigma2[591]: done! Dec 22 14:48:06 dm7080 enigma2[591]: [eDVBCAService] don't send the same capmt twice Dec 22 14:48:06 dm7080 enigma2[591]: [eDVBCIInterfaces] gotPMT Dec 22 14:48:06 dm7080 enigma2[591]: eventNewProgramInfo 1 0 Dec 22 14:48:06 dm7080 enigma2[591]: have 1 video stream(s) (0aff), and 2 audio stream(s) (0b03, 0b04), and the pcr pid is 0aff, and the text pid is ffffffff Dec 22 14:48:06 dm7080 enigma2[591]: PES filter: DMX_SET_PES_FILTER - Invalid argument Dec 22 14:48:06 dm7080 enigma2[591]: decoder state: play, vpid=2815, apid=2819 Dec 22 14:48:06 dm7080 enigma2[591]: VIDEO_SLOWMOTION(0) - ok Dec 22 14:48:06 dm7080 enigma2[591]: VIDEO_FAST_FORWARD(0) - ok Dec 22 14:48:06 dm7080 enigma2[591]: VIDEO_CONTINUE - ok Dec 22 14:48:06 dm7080 enigma2[591]: AUDIO_CONTINUE - ok Dec 22 14:48:06 dm7080 enigma2[591]: W/ [InfoBar.__servicePlaying] :: Dec 22 14:48:06 dm7080 enigma2[591]: I/ [InfoBar.setPlaybackState] :: None None 1545486486.42 Dec 22 14:48:06 dm7080 enigma2[591]: I/ [ScreenSaverHandler._onEvent] :: play event, checking for video Dec 22 14:48:06 dm7080 enigma2[591]: I/ [PhotoScreensaver.setEnabled] :: False Dec 22 14:48:06 dm7080 enigma2[591]: [eDBusInterface::Private::sendEvent 1 Dec 22 14:48:06 dm7080 enigma2[591]: [TeleText] serviceInfoChanged Dec 22 14:48:06 dm7080 enigma2[591]: [TeleText] TXT PID -1 DEMUX 1 Dec 22 14:48:06 dm7080 enigma2[591]: doing version filtering Dec 22 14:48:06 dm7080 enigma2[591]: 006a: 02 00 8c 0b 00 00 Dec 22 14:48:06 dm7080 enigma2[591]: mask: ff ff ff 3f 00 00 Dec 22 14:48:06 dm7080 enigma2[591]: mode: 00 00 00 3e 00 00 Dec 22 14:48:16 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:48:24 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:48:24 CET Dec 22 14:48:24 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:48:24 dm7080 enigma2[591]: [timer.py] next activation: 1545486604 (in 99010 ms) Dec 22 14:48:46 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:48:46 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:48:46 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:48:46 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:48:46 dm7080 enigma2[591]: header: EXT: Dec 22 14:48:46 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:48:46 dm7080 enigma2[591]: header: Connection: close Dec 22 14:49:13 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:49:12 CET Dec 22 14:49:13 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:49:13 dm7080 enigma2[591]: [timer.py] next activation: 1545486652 (in 99000 ms) Dec 22 14:49:16 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:49:17 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:49:16 CET Dec 22 14:49:17 dm7080 enigma2[591]: [timer.py] next activation: 1545486656 (in 99000 ms) Dec 22 14:49:51 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:49:51 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:49:51 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:49:51 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:49:51 dm7080 enigma2[591]: header: EXT: Dec 22 14:49:51 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:49:51 dm7080 enigma2[591]: header: Connection: close Dec 22 14:50:04 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:50:04 CET Dec 22 14:50:04 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:50:04 dm7080 enigma2[591]: [timer.py] next activation: 1545486704 (in 99998 ms) Dec 22 14:50:16 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:50:51 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:50:51 CET Dec 22 14:50:52 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:50:52 dm7080 enigma2[591]: [timer.py] next activation: 1545486751 (in 99001 ms) Dec 22 14:50:55 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:50:55 CET Dec 22 14:50:56 dm7080 enigma2[591]: [timer.py] next activation: 1545486755 (in 99001 ms) Dec 22 14:50:56 dm7080 enigma2[591]: send: 'POST /ZoneGroupTopology/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:ZoneGroupTopology:1#GetZoneGroupState\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 277\r\n\r\n' Dec 22 14:50:56 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:50:56 dm7080 enigma2[591]: header: CONTENT-LENGTH: 5054 Dec 22 14:50:56 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:50:56 dm7080 enigma2[591]: header: EXT: Dec 22 14:50:56 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:50:56 dm7080 enigma2[591]: header: Connection: close Dec 22 14:50:56 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:50:56 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:50:56 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:50:56 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:50:56 dm7080 enigma2[591]: header: EXT: Dec 22 14:50:56 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:50:56 dm7080 enigma2[591]: header: Connection: close Dec 22 14:51:16 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:51:43 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:51:43 CET Dec 22 14:51:44 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:51:44 dm7080 enigma2[591]: [timer.py] next activation: 1545486803 (in 98998 ms) Dec 22 14:52:01 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:52:01 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:52:01 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:52:01 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:52:01 dm7080 enigma2[591]: header: EXT: Dec 22 14:52:01 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:52:01 dm7080 enigma2[591]: header: Connection: close Dec 22 14:52:16 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:52:31 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:52:31 CET Dec 22 14:52:31 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:52:31 dm7080 enigma2[591]: [timer.py] next activation: 1545486851 (in 99999 ms) Dec 22 14:52:35 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:52:35 CET Dec 22 14:52:35 dm7080 enigma2[591]: [timer.py] next activation: 1545486855 (in 99999 ms) Dec 22 14:53:03 dm7080 enigma2[591]: [Netatmo] start async update Dec 22 14:53:03 dm7080 enigma2[591]: [Netatmo] begin update Dec 22 14:53:03 dm7080 enigma2[591]: [Netatmo] token expire in 4200 Dec 22 14:53:03 dm7080 enigma2[591]: [Netatmo] location from cache 48.26088,12.28173 Pfarrer-Egerer-Straße, Mesmering, Obertaufkirchen, Landkreis Mühldorf am Inn, Obb, Bayern, 84419, Deutschland Dec 22 14:53:03 dm7080 enigma2[591]: [Netatmo] update took 0.495667934418 sec Dec 22 14:53:03 dm7080 enigma2[591]: [Netatmo] recalculate battery percent: 1.2 Dec 22 14:53:03 dm7080 enigma2[591]: [Netatmo] check notification Dec 22 14:53:06 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:53:06 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:53:06 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:53:06 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:53:06 dm7080 enigma2[591]: header: EXT: Dec 22 14:53:06 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:53:06 dm7080 enigma2[591]: header: Connection: close Dec 22 14:53:16 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:53:23 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:53:22 CET Dec 22 14:53:23 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:53:23 dm7080 enigma2[591]: [timer.py] next activation: 1545486902 (in 99000 ms) Dec 22 14:54:11 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:54:10 CET Dec 22 14:54:11 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:54:11 dm7080 enigma2[591]: [timer.py] next activation: 1545486951 (in 99999 ms) Dec 22 14:54:11 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:54:11 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:54:11 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:54:11 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:54:11 dm7080 enigma2[591]: header: EXT: Dec 22 14:54:11 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:54:11 dm7080 enigma2[591]: header: Connection: close Dec 22 14:54:15 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:54:14 CET Dec 22 14:54:15 dm7080 enigma2[591]: [timer.py] next activation: 1545486954 (in 99000 ms) Dec 22 14:54:16 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:55:02 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:55:02 CET Dec 22 14:55:02 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:55:02 dm7080 enigma2[591]: [timer.py] next activation: 1545487002 (in 99998 ms) Dec 22 14:55:16 dm7080 enigma2[591]: send: 'POST /ZoneGroupTopology/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:ZoneGroupTopology:1#GetZoneGroupState\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 277\r\n\r\n' Dec 22 14:55:16 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:55:16 dm7080 enigma2[591]: header: CONTENT-LENGTH: 5054 Dec 22 14:55:16 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:55:16 dm7080 enigma2[591]: header: EXT: Dec 22 14:55:16 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:55:16 dm7080 enigma2[591]: header: Connection: close Dec 22 14:55:16 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:55:16 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:55:16 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:55:16 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:55:16 dm7080 enigma2[591]: header: EXT: Dec 22 14:55:16 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:55:16 dm7080 enigma2[591]: header: Connection: close Dec 22 14:55:17 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:55:29 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 14 eb Dec 22 14:55:29 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 83 32 cd 14 eb Dec 22 14:55:29 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 94 6b Dec 22 14:55:29 dm7080 enigma2[591]: action -> QuickButtonActions ok Dec 22 14:55:29 dm7080 enigma2[591]: unknown action QuickButtonActions/ok! typo in keymap? Dec 22 14:55:29 dm7080 enigma2[591]: create buffer for widget 898 x 37 Dec 22 14:55:31 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 14 eb Dec 22 14:55:32 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 83 32 cd 14 eb Dec 22 14:55:32 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x13 (5): 82 32 cd 94 6b Dec 22 14:55:32 dm7080 enigma2[591]: action -> QuickButtonActions ok Dec 22 14:55:32 dm7080 enigma2[591]: unknown action QuickButtonActions/ok! typo in keymap? Dec 22 14:55:38 dm7080 enigma2[591]: +- 1/2 TID 4e Dec 22 14:55:38 dm7080 enigma2[591]: ++ 2/2 TID 4e Dec 22 14:55:38 dm7080 enigma2[591]: done! Dec 22 14:55:38 dm7080 enigma2[591]: pcr of eit change: 1100acbf0 Dec 22 14:55:38 dm7080 enigma2[591]: [TIMER] record event 9 Dec 22 14:55:38 dm7080 enigma2[591]: doing version filtering Dec 22 14:55:38 dm7080 enigma2[591]: 0012: 4e 28 3d 07 00 00 Dec 22 14:55:38 dm7080 enigma2[591]: mask: ff ff ff 3f 00 00 Dec 22 14:55:38 dm7080 enigma2[591]: mode: 00 00 00 3e 00 00 Dec 22 14:55:51 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:55:50 CET Dec 22 14:55:51 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:55:51 dm7080 enigma2[591]: [timer.py] next activation: 1545487050 (in 98999 ms) Dec 22 14:55:54 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:55:53 CET Dec 22 14:55:54 dm7080 enigma2[591]: [timer.py] next activation: 1545487054 (in 99999 ms) Dec 22 14:56:17 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:56:22 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:56:22 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:56:22 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:56:22 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:56:22 dm7080 enigma2[591]: header: EXT: Dec 22 14:56:22 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:56:22 dm7080 enigma2[591]: header: Connection: close Dec 22 14:56:42 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:56:41 CET Dec 22 14:56:42 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:56:42 dm7080 enigma2[591]: [timer.py] next activation: 1545487102 (in 99999 ms) Dec 22 14:56:45 dm7080 enigma2[591]: +- 1/2 TID 4e Dec 22 14:56:46 dm7080 enigma2[591]: ++ 2/2 TID 4e Dec 22 14:56:46 dm7080 enigma2[591]: done! Dec 22 14:56:46 dm7080 enigma2[591]: pcr of eit change: 11067a898 Dec 22 14:56:46 dm7080 enigma2[591]: [TIMER] record event 9 Dec 22 14:56:46 dm7080 enigma2[591]: doing version filtering Dec 22 14:56:46 dm7080 enigma2[591]: 0012: 4e 28 3d 09 00 00 Dec 22 14:56:46 dm7080 enigma2[591]: mask: ff ff ff 3f 00 00 Dec 22 14:56:46 dm7080 enigma2[591]: mode: 00 00 00 3e 00 00 Dec 22 14:57:17 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:57:27 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:57:27 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:57:27 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:57:27 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:57:27 dm7080 enigma2[591]: header: EXT: Dec 22 14:57:27 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:57:27 dm7080 enigma2[591]: header: Connection: close Dec 22 14:57:30 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:57:30 CET Dec 22 14:57:30 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:57:30 dm7080 enigma2[591]: [timer.py] next activation: 1545487150 (in 99999 ms) Dec 22 14:57:33 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:57:33 CET Dec 22 14:57:34 dm7080 enigma2[591]: [timer.py] next activation: 1545487153 (in 99000 ms) Dec 22 14:58:03 dm7080 enigma2[591]: [Netatmo] start async update Dec 22 14:58:03 dm7080 enigma2[591]: [Netatmo] begin update Dec 22 14:58:03 dm7080 enigma2[591]: [Netatmo] token expire in 3900 Dec 22 14:58:03 dm7080 enigma2[591]: [Netatmo] location from cache 48.26088,12.28173 Pfarrer-Egerer-Straße, Mesmering, Obertaufkirchen, Landkreis Mühldorf am Inn, Obb, Bayern, 84419, Deutschland Dec 22 14:58:03 dm7080 enigma2[591]: [Netatmo] update took 0.51531291008 sec Dec 22 14:58:03 dm7080 enigma2[591]: [Netatmo] recalculate battery percent: 1.2 Dec 22 14:58:03 dm7080 enigma2[591]: [Netatmo] check notification Dec 22 14:58:17 dm7080 enigma2[591]: [EPGC] cleanupOutdated Dec 22 14:58:22 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:58:21 CET Dec 22 14:58:22 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 15:00:11 CET Dec 22 14:58:22 dm7080 enigma2[591]: [timer.py] next activation: 1545487202 (in 99999 ms) Dec 22 14:58:32 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:58:32 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:58:32 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:58:32 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:58:32 dm7080 enigma2[591]: header: EXT: Dec 22 14:58:32 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:58:32 dm7080 enigma2[591]: header: Connection: close Dec 22 14:58:42 dm7080 enigma2[591]: no version filtering Dec 22 14:58:42 dm7080 enigma2[591]: 0014: 70 00 00 00 00 00 Dec 22 14:58:42 dm7080 enigma2[591]: mask: fc 00 00 00 00 00 Dec 22 14:58:42 dm7080 enigma2[591]: mode: 00 00 00 00 00 00 Dec 22 14:58:42 dm7080 enigma2[591]: [eDVBLocalTimeHandler] Receiver time is 'Sat Dec 22 14:58:42 2018' Dec 22 14:58:42 dm7080 enigma2[591]: [eDVBLocalTimeHandler] Transponder time is 'Sat Dec 22 14:58:42 2018' Dec 22 14:58:42 dm7080 enigma2[591]: [eDVBLocalTimeHandler] diff is 0 Dec 22 14:58:42 dm7080 enigma2[591]: [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time Dec 22 14:58:42 dm7080 enigma2[591]: [eDVBLocalTimeHandler] not changed Dec 22 14:59:09 dm7080 enigma2[591]: [EPGC] start caching events(1545487149) Dec 22 14:59:10 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:59:09 CET Dec 22 14:59:10 dm7080 enigma2[591]: [EPGRefreshTimer] next real activation is So 23 Dez 2018 04:15:01 CET Dec 22 14:59:10 dm7080 enigma2[591]: [timer.py] next activation: 1545487249 (in 98999 ms) Dec 22 14:59:13 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 14:59:12 CET Dec 22 14:59:13 dm7080 enigma2[591]: [timer.py] next activation: 1545487253 (in 99999 ms) Dec 22 14:59:16 dm7080 enigma2[591]: [EPGC] abort non avail schedule other reading Dec 22 14:59:16 dm7080 enigma2[591]: [EPGC] abort non avail viasat reading Dec 22 14:59:16 dm7080 enigma2[591]: [EPGC] nownext finished(1545487156) Dec 22 14:59:37 dm7080 enigma2[591]: send: 'POST /MediaRenderer/AVTransport/Control HTTP/1.1\r\nHost: 192.168.178.51:1400\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.11.1\r\nSOAPACTION: urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo\r\nContent-Type: text/xml; charset="utf-8"\r\nContent-Length: 295\r\n\r\n0' Dec 22 14:59:37 dm7080 enigma2[591]: reply: 'HTTP/1.1 200 OK\r\n' Dec 22 14:59:37 dm7080 enigma2[591]: header: CONTENT-LENGTH: 407 Dec 22 14:59:37 dm7080 enigma2[591]: header: CONTENT-TYPE: text/xml; charset="utf-8" Dec 22 14:59:37 dm7080 enigma2[591]: header: EXT: Dec 22 14:59:37 dm7080 enigma2[591]: header: Server: Linux UPnP/1.0 Sonos/47.2-59120 (ZPS6) Dec 22 14:59:37 dm7080 enigma2[591]: header: Connection: close Dec 22 14:59:39 dm7080 enigma2[591]: 768812 ms latency per 1000 blits (1,300708 fps) Dec 22 14:59:42 dm7080 enigma2[591]: [EPGC] schedule finished(1545487182) Dec 22 14:59:42 dm7080 enigma2[591]: [EPGC] stop caching events(1545487182) Dec 22 14:59:42 dm7080 enigma2[591]: [EPGC] next update in 60 min Dec 22 15:00:01 dm7080 enigma2[591]: [EPGC] cleanup invalid data Dec 22 15:00:02 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 15:00:02 CET Dec 22 15:00:02 dm7080 enigma2[591]: [timer.py] next activation: 1545487211 (in 8998 ms) Dec 22 15:00:11 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 15:00:10 CET Dec 22 15:00:11 dm7080 enigma2[591]: [timer.py] next activation: 1545487211 (in 0 ms) Dec 22 15:00:11 dm7080 enigma2[591]: It's now Sa 22 Dez 2018 15:00:11 CET Dec 22 15:00:11 dm7080 enigma2[591]: [TIMER] activating state 3 Dec 22 15:00:11 dm7080 enigma2[591]: [TIMER] stop recording Dec 22 15:00:11 dm7080 enigma2[591]: stop recording! Dec 22 15:00:11 dm7080 enigma2[591]: stopping thread. Dec 22 15:00:11 dm7080 enigma2[591]: waiting for aio thread shutdown! Dec 22 15:00:11 dm7080 enigma2[591]: record aio thread has finished Dec 22 15:00:11 dm7080 enigma2[591]: eRecordFileThread (direct io) STOP Dec 22 15:00:11 dm7080 enigma2[591]: thread joined 0 Dec 22 15:00:11 dm7080 enigma2[591]: loading streaminfo for /media/hdd/movie/20181222 1400 - Das Erste HD - Sportschau.ts Dec 22 15:00:11 dm7080 enigma2[591]: fixed up 108fa01f0 to ad2c170 (offset 0) Dec 22 15:00:11 dm7080 enigma2[591]: fixed up 11067a898 to 12406818 (offset 0) Dec 22 15:00:11 dm7080 enigma2[591]: fixed up 10ac810a8 to ca0d028 (offset 0) Dec 22 15:00:11 dm7080 enigma2[591]: [eMediaScanner::checkWork] scanning /media/hdd/movie/20181222 1400 - Das Erste HD - Sportschau.ts for media content Dec 22 15:00:11 dm7080 enigma2[591]: [TIMER] record event 5 Dec 22 15:00:11 dm7080 enigma2[591]: [TIMER] record event 1 Dec 22 15:00:11 dm7080 enigma2[591]: [remove callback] Dec 22 15:00:11 dm7080 enigma2[591]: [eDVBCAService] free slot 1 demux 0 for service 1:0:19:283D:3FB:1:C00000:0:0:0: Dec 22 15:00:11 dm7080 enigma2[591]: [eDVBCAService] free service 1:0:19:283D:3FB:1:C00000:0:0:0: Dec 22 15:00:11 dm7080 enigma2[591]: [eFileMonitor] 1 events queued Dec 22 15:00:11 dm7080 enigma2[591]: [eDVBCAService] remove channel 0x231b080 Dec 22 15:00:11 dm7080 enigma2[591]: [eDVBCAService] write leave transponder to '/tmp/camd.socket' ok Dec 22 15:00:11 dm7080 enigma2[591]: [eDVBLocalTimeHandler] remove channel 0x231b080 Dec 22 15:00:11 dm7080 enigma2[591]: [EPGC] remove channel 0x231b080 Dec 22 15:00:11 dm7080 enigma2[591]: [ 0] preClose Dec 22 15:00:11 dm7080 enigma2[591]: create buffer for widget 789 x 37 Dec 22 15:00:11 dm7080 enigma2[591]: [AdvancedMovieSelection] timer state changed event Dec 22 15:00:11 dm7080 enigma2[591]: False False 3 Dec 22 15:00:11 dm7080 enigma2[591]: timer.event Sportschau Dec 22 15:00:11 dm7080 enigma2[591]: timer.state 3 Dec 22 15:00:11 dm7080 enigma2[591]: TimerEntry Sportschau Dec 22 15:00:11 dm7080 enigma2[591]: /media/hdd/movie/20181222 1400 - Das Erste HD - Sportschau.ts Dec 22 15:00:11 dm7080 enigma2[591]: /media/hdd/movie/ Dec 22 15:00:11 dm7080 enigma2[591]: --- [AdvancedMovieSelection] STACK TRACE --- Dec 22 15:00:11 dm7080 enigma2[591]: Traceback (most recent call last): Dec 22 15:00:11 dm7080 enigma2[591]: File "/usr/lib/enigma2/python/Plugins/Extensions/AdvancedMovieSelection/Source/MovieScanner.py", line 303, in timerStateChanged Dec 22 15:00:11 dm7080 enigma2[591]: self.movielibrary.addMovie(movie_path, mi) Dec 22 15:00:11 dm7080 enigma2[591]: File "/usr/lib/enigma2/python/Plugins/Extensions/AdvancedMovieSelection/Source/MovieLibrary.py", line 118, in addMovie Dec 22 15:00:11 dm7080 enigma2[591]: self["db"][location]["movies"].append(movie) Dec 22 15:00:11 dm7080 enigma2[591]: KeyError: '/media/hdd/movie/' Dec 22 15:00:11 dm7080 enigma2[591]: -------------------------------------------------- Dec 22 15:00:11 dm7080 enigma2[591]: [AutomaticTimerlistCleanUp] Timerentry has been changed to StateEnd Dec 22 15:00:11 dm7080 enigma2[591]: [AutomaticTimerlistCleanUp] Cleaning up timerlist-entries older than Sa 22 Dez 2018 15:00:11 CET Dec 22 15:00:11 dm7080 enigma2[591]: [AutomaticTimerlistCleanUp] Next automatic timerlist cleanup at So 23 Dez 2018 15:00:11 CET Dec 22 15:00:11 dm7080 enigma2[591]: next real activation is Sa 22 Dez 2018 20:04:40 CET Dec 22 15:00:11 dm7080 enigma2[591]: [timer.py] next activation: 1545487311 (in 99769 ms) Dec 22 15:00:11 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x85 (1): 01 Dec 22 15:00:11 dm7080 enigma2[591]: [eInputDeviceHandlerDreamBLE::onCommand] 85 [OK]! Dec 22 15:00:11 dm7080 enigma2[591]: [eFileMonitor] File {/tmp/ecm.info} has been deleted Dec 22 15:00:11 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x05 (3): 01 11 01 Dec 22 15:00:11 dm7080 enigma2[591]: [eInputDeviceHandlerDreamBLE::onCommand] Receiver Firmware Version: 1.17 Dec 22 15:00:11 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x82 (1): 01 Dec 22 15:00:11 dm7080 enigma2[591]: [eInputDeviceHandlerDreamBLE::onCommand] 82 [OK]! Dec 22 15:00:11 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x85 (1): 01 Dec 22 15:00:11 dm7080 enigma2[591]: [eInputDeviceHandlerDreamBLE::onCommand] 85 [OK]! Dec 22 15:00:11 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x05 (3): 01 11 01 Dec 22 15:00:11 dm7080 enigma2[591]: [eInputDeviceHandlerDreamBLE::onCommand] Receiver Firmware Version: 1.17 Dec 22 15:00:11 dm7080 enigma2[591]: [eInputDevicehandlerDreamBLE::onCommand] 0x82 (1): 01 Dec 22 15:00:11 dm7080 enigma2[591]: [eInputDeviceHandlerDreamBLE::onCommand] 82 [OK]! Dec 22 15:00:11 dm7080 enigma2[591]: [eFileMonitor] 1 events queued Dec 22 15:00:11 dm7080 enigma2[591]: [eFileMonitor] File {/tmp/ecm.info} has been created Dec 22 15:00:12 dm7080 enigma2[591]: [eMediaScanner] Transport Stream (mpegts) found... Dec 22 15:00:12 dm7080 enigma2[591]: [eMediaDatabaseThread] Updated 0 datasets! Dec 22 15:00:14 dm7080 enigma2[591]: [ 0] prepareClose running loop Dec 22 15:00:14 dm7080 enigma2[591]: [SEC-0] lock 0 Dec 22 15:00:14 dm7080 enigma2[591]: [SEC-0] locked 0 Dec 22 15:00:14 dm7080 enigma2[591]: [SEC-0] sendDiseqc: e01002 (DiSEqC peripherial power off) Dec 22 15:00:14 dm7080 enigma2[591]: [SEC-0] sleep 150ms Dec 22 15:00:14 dm7080 enigma2[591]: [SEC-0] delayed close frontend Dec 22 15:00:14 dm7080 enigma2[591]: [SEC-0] unlock 0 Dec 22 15:00:14 dm7080 enigma2[591]: [ 0] close frontend Dec 22 15:00:14 dm7080 enigma2[591]: [SEC-0] setVoltage 0V Dec 22 15:00:17 dm7080 enigma2[591]: [EPGC] cleanupOutdated