-- Logs begin at Mon 2019-06-17 17:48:11 CEST. -- Jun 17 20:25:07 dreamone enigma2[433]: nr_read 1169 nr_write 43813 Jun 17 20:25:07 dreamone enigma2[433]: sum 44982 prev_sum 44982 Jun 17 20:25:07 dreamone enigma2[433]: hdd IDLE! Jun 17 20:25:07 dreamone enigma2[433]: [IDLE] 73471.535233 300 True Jun 17 20:25:09 dreamone enigma2[433]: It's now Mon Jun 17 20:25:09 2019 Jun 17 20:25:09 dreamone enigma2[433]: [timer.py] next activation: 1560796009 (in 99999 ms) Jun 17 20:25:15 dreamone enigma2[433]: [eCec] handle message 0 -> 3 : 8f Jun 17 20:25:15 dreamone enigma2[433]: [eCec] Give Device Power Status Jun 17 20:25:15 dreamone enigma2[433]: [eCec] send 3 -> 0 : 90 00 Jun 17 20:25:16 dreamone enigma2[433]: [eFileMonitor] 1 events queued Jun 17 20:25:16 dreamone enigma2[433]: [eFileMonitor] File {/tmp/enigma2.log} has been created Jun 17 20:25:34 dreamone enigma2[433]: action -> InfobarChannelSelection zapDown Jun 17 20:25:34 dreamone enigma2[433]: playing 1:256:19:4331:300C:13E:820000:0:0:0:http%3a//root%3adreambox@192.168.1.120%3a8001/1%3a256%3a19%3a4331%3a300C%3a13E%3a820000%3a0%3a0%3a0%3a:SRF 1 HD (dreambox) Jun 17 20:25:34 dreamone enigma2[433]: stopping thread. Jun 17 20:25:34 dreamone enigma2[433]: waiting for aio thread shutdown! Jun 17 20:25:34 dreamone enigma2[433]: record aio thread has finished Jun 17 20:25:34 dreamone enigma2[433]: eRecordFileThread (direct io) STOP Jun 17 20:25:34 dreamone enigma2[433]: thread joined 0 Jun 17 20:25:34 dreamone enigma2[433]: remove timeshift file Jun 17 20:25:34 dreamone enigma2[433]: [eDVBCAService] free slot 0 demux 0 for service 1:0:1:445D:453:1:C00000:0:0:0: Jun 17 20:25:34 dreamone enigma2[433]: [eDVBCAService] free service 1:0:1:445D:453:1:C00000:0:0:0: Jun 17 20:25:34 dreamone enigma2[433]: [eDBusInterface::Private::sendEvent 0 Jun 17 20:25:34 dreamone enigma2[433]: FIXMEE unknown frontend type in FrontendInfo getValue Converter return 0 (SAT) None Jun 17 20:25:34 dreamone enigma2[433]: [TeleText] service stopped Jun 17 20:25:34 dreamone enigma2[433]: [TeleText] send array('B', [1, 0, 0, 0]) Jun 17 20:25:34 dreamone enigma2[433]: disable dvb subtitles Jun 17 20:25:34 dreamone enigma2[433]: disable teletext subtitles page ffffffffffffffff (und) Jun 17 20:25:34 dreamone enigma2[433]: decoder state: play, vpid=-1, apid=-1 Jun 17 20:25:34 dreamone enigma2[433]: DEMUX_STOP - pcr - ok Jun 17 20:25:34 dreamone enigma2[433]: DEMUX_STOP - video - ok Jun 17 20:25:34 dreamone enigma2[433]: VIDEO_STOP - ok Jun 17 20:25:34 dreamone enigma2[433]: DMX_GET_STC failed! (Resource temporarily unavailable) (43 times) Jun 17 20:25:34 dreamone enigma2[433]: DEMUX_STOP - audio - ok Jun 17 20:25:34 dreamone enigma2[433]: eAlsaOutput(HDMI): state transition requested 1, old 4 Jun 17 20:25:34 dreamone enigma2[433]: eAlsaOutput(HDMI): STOP_REQ Jun 17 20:25:34 dreamone enigma2[433]: eAlsaOutput(SPDIF): state transition requested 1, old 4 Jun 17 20:25:34 dreamone enigma2[433]: eAlsaOutput(SPDIF): STOP_REQ Jun 17 20:25:34 dreamone enigma2[433]: eDVBAudio: quit thread Jun 17 20:25:34 dreamone enigma2[433]: poll: unhandled POLLNVAL for fd 395 Jun 17 20:25:34 dreamone enigma2[433]: thread joined 0 Jun 17 20:25:34 dreamone enigma2[433]: DEMUX_STOP - ttx - ok Jun 17 20:25:34 dreamone enigma2[433]: start release channel timer Jun 17 20:25:34 dreamone enigma2[433]: I/ [InfoBar.setPlaybackState] :: connecting... Please wait! 1560795934.21 Jun 17 20:25:34 dreamone enigma2[433]: create buffer for widget 700 x 140 Jun 17 20:25:34 dreamone enigma2[433]: [Picon Renderer] Sorry, i give up! (2 times) Jun 17 20:25:34 dreamone enigma2[433]: [TeleText] service started Jun 17 20:25:34 dreamone enigma2[433]: create buffer for widget 1920 x 240 Jun 17 20:25:34 dreamone enigma2[433]: not pauseable. Jun 17 20:25:34 dreamone enigma2[433]: alloc PVR Jun 17 20:25:34 dreamone enigma2[433]: allocate channel.. 300c:013e:00820000 (http://root:dreambox@192.168.1.120:8001/1:256:19:4331:300C:13E:820000:0:0:0:) Jun 17 20:25:34 dreamone enigma2[433]: [eDVBCAService] new channel 0x14e4b9e0! Jun 17 20:25:34 dreamone enigma2[433]: eTsRemoteSource::close() Jun 17 20:25:34 dreamone enigma2[433]: [eTsRemoteSource] souphttpsrc user-agent='GStreamer souphttpsrc libsoup/2.52.2;' Jun 17 20:25:34 dreamone enigma2[433]: allocate pvr demux Jun 17 20:25:34 dreamone enigma2[433]: have 1 video stream(s) (01f6), and 1 audio stream(s) (01f7), and the pcr pid is 01f6, and the text pid is 01fb Jun 17 20:25:34 dreamone enigma2[433]: allocate pvr demux Jun 17 20:25:34 dreamone enigma2[433]: disable teletext subtitles page ffffffffffffffff (und) Jun 17 20:25:34 dreamone enigma2[433]: decoder state: play, vpid=502, apid=503 Jun 17 20:25:34 dreamone enigma2[433]: DMX_SET_PES_FILTER(0x1f6) - pcr - ok Jun 17 20:25:34 dreamone enigma2[433]: DEMUX_START - pcr - ok Jun 17 20:25:34 dreamone enigma2[433]: demux device: /dev/dvb/adapter0/demux16 Jun 17 20:25:34 dreamone enigma2[433]: before: 1 Jun 17 20:25:34 dreamone enigma2[433]: after: 1 Jun 17 20:25:34 dreamone enigma2[433]: DMX_SET_PES_FILTER(0x1f7) - audio - ok Jun 17 20:25:34 dreamone enigma2[433]: DMX_SET_BUFFER_SIZE(0x1f7) - audio - ok Jun 17 20:25:34 dreamone enigma2[433]: DEMUX_START - audio - Video Device: /dev/dvb/adapter0/video0 Jun 17 20:25:34 dreamone enigma2[433]: ok Jun 17 20:25:34 dreamone enigma2[433]: demux device: /dev/dvb/adapter0/demux16 Jun 17 20:25:34 dreamone enigma2[433]: VIDEO_SET_STREAMTYPE 1 - ok Jun 17 20:25:34 dreamone enigma2[433]: DMX_SET_PES_FILTER(0x1f6) - video - ok Jun 17 20:25:34 dreamone enigma2[433]: DEMUX_START - video - ok Jun 17 20:25:34 dreamone enigma2[433]: VIDEO_FREEZE - ok Jun 17 20:25:34 dreamone enigma2[433]: VIDEO_PLAY - ok Jun 17 20:25:34 dreamone enigma2[433]: DMX_SET_PES_FILTER(0x1fb) - ttx - ok Jun 17 20:25:34 dreamone enigma2[433]: DEMUX_START - ttx - ok Jun 17 20:25:34 dreamone enigma2[433]: AUDIO_CONTINUE Jun 17 20:25:34 dreamone enigma2[433]: VIDEO_SLOWMOTION(0) - ok Jun 17 20:25:34 dreamone enigma2[433]: VIDEO_FAST_FORWARD(0) - ok Jun 17 20:25:34 dreamone enigma2[433]: VIDEO_CONTINUE - ok Jun 17 20:25:34 dreamone enigma2[433]: W/ [InfoBar.__servicePlaying] :: Jun 17 20:25:34 dreamone enigma2[433]: I/ [InfoBar.setPlaybackState] :: None None 1560795934.24 Jun 17 20:25:34 dreamone enigma2[433]: not pauseable. Jun 17 20:25:34 dreamone enigma2[433]: loading streaminfo for http://root:dreambox@192.168.1.120:8001/1:256:19:4331:300C:13E:820000:0:0:0: Jun 17 20:25:34 dreamone enigma2[433]: cutfile not found! Jun 17 20:25:34 dreamone enigma2[433]: no cue sheet Jun 17 20:25:34 dreamone enigma2[433]: before: 1 Jun 17 20:25:34 dreamone enigma2[433]: after: 1 Jun 17 20:25:34 dreamone enigma2[433]: setIoPrio best-effort level 5 ok Jun 17 20:25:34 dreamone enigma2[433]: FILEPUSH THREAD START Jun 17 20:25:34 dreamone enigma2[433]: no cue sheet. forcing normal play Jun 17 20:25:34 dreamone enigma2[433]: [eDVBCAService] channel 0x14e4b9e0 running Jun 17 20:25:34 dreamone enigma2[433]: [eDVBLocalTimeHandler] channel 0x14e4b9e0 running Jun 17 20:25:34 dreamone enigma2[433]: no version filtering Jun 17 20:25:34 dreamone enigma2[433]: 0014: 70 00 00 00 00 00 Jun 17 20:25:34 dreamone enigma2[433]: mask: fc 00 00 00 00 00 Jun 17 20:25:34 dreamone enigma2[433]: mode: 00 00 00 00 00 00 Jun 17 20:25:34 dreamone enigma2[433]: [EPGC] channel 0x14e4b9e0 running Jun 17 20:25:34 dreamone enigma2[433]: no version filtering Jun 17 20:25:34 dreamone enigma2[433]: 0012: 4e 43 31 00 00 00 Jun 17 20:25:34 dreamone enigma2[433]: [EPGC] next update in 54 min Jun 17 20:25:34 dreamone enigma2[433]: mask: ff ff ff 00 00 00 Jun 17 20:25:34 dreamone enigma2[433]: mode: 00 00 00 00 00 00 Jun 17 20:25:34 dreamone enigma2[433]: FIXMEE unknown frontend type in FrontendInfo getValue Converter return 0 (SAT) None Jun 17 20:25:34 dreamone enigma2[433]: ok ... now we start!! Jun 17 20:25:34 dreamone enigma2[433]: no version filtering Jun 17 20:25:34 dreamone enigma2[433]: 0000: 00 00 00 00 00 00 Jun 17 20:25:34 dreamone enigma2[433]: mask: ff 00 00 00 00 00 Jun 17 20:25:34 dreamone enigma2[433]: mode: 00 00 00 00 00 00 Jun 17 20:25:34 dreamone enigma2[433]: [HbbTV].aitInvalidated Jun 17 20:25:34 dreamone enigma2[433]: eBackgroundFileEraser '/media/sdcard//timeshift.fEkjUD' finished Jun 17 20:25:34 dreamone enigma2[433]: eTsRemoteSource::state transition NULL -> READY Jun 17 20:25:35 dreamone enigma2[433]: eTsRemoteSource::state transition READY -> PAUSED Jun 17 20:25:35 dreamone enigma2[433]: eDVBAudio: skip TS PACKET (no PUSI) (9 times) Jun 17 20:25:35 dreamone enigma2[433]: +eDVBAudio: skip TS PACKET (no PUSI) Jun 17 20:25:35 dreamone enigma2[433]: 1/1 TID 00 Jun 17 20:25:35 dreamone enigma2[433]: done! Jun 17 20:25:35 dreamone enigma2[433]: eDVBAudio: skip TS PACKET (no PUSI) Jun 17 20:25:35 dreamone enigma2[433]: PATready Jun 17 20:25:35 dreamone enigma2[433]: use pmtpid 01f5 for service_id 4331 Jun 17 20:25:35 dreamone enigma2[433]: no version filtering Jun 17 20:25:35 dreamone enigma2[433]: 01f5: 02 43 31 00 00 00 Jun 17 20:25:35 dreamone enigma2[433]: mask: ff ff ff 00 00 00 Jun 17 20:25:35 dreamone enigma2[433]: mode: 00 00 00 00 00 00 Jun 17 20:25:35 dreamone enigma2[433]: doing version filtering Jun 17 20:25:35 dreamone enigma2[433]: 0000: 00 00 00 11 00 00 Jun 17 20:25:35 dreamone enigma2[433]: mask: ff 00 00 3f 00 00 Jun 17 20:25:35 dreamone enigma2[433]: eDVBAudio: skip TS PACKET (no PUSI) Jun 17 20:25:35 dreamone enigma2[433]: mode: 00 00 00 3e 00 00 Jun 17 20:25:35 dreamone enigma2[433]: eDVBAudio: skip TS PACKET (no PUSI) (5 times) Jun 17 20:25:35 dreamone enigma2[433]: eDVBAudio: first TS PACKET with PUSI Jun 17 20:25:35 dreamone enigma2[433]: VIDEO_GET_EVENT - ok Jun 17 20:25:35 dreamone enigma2[433]: eAudioDecoder: Error while sending audio packet to decoder! Error Code: -1094995529, Size: 4823 Jun 17 20:25:35 dreamone enigma2[433]: eAlsaOutput(HDMI): state transition requested 5, old 0 Jun 17 20:25:35 dreamone enigma2[433]: eAlsaOutput(HDMI): PLAY_REQ Jun 17 20:25:35 dreamone enigma2[433]: eAlsaOutput(HDMI): start with sample_rate 48000, channels 2(2), bits 16 ok Jun 17 20:25:35 dreamone enigma2[433]: eAlsaOutput(SPDIF): state transition requested 5, old 0 Jun 17 20:25:35 dreamone enigma2[433]: eAlsaOutput(SPDIF): PLAY_REQ Jun 17 20:25:35 dreamone enigma2[433]: eAlsaOutput(SPDIF): start with sample_rate 48000, channels 2(2), bits 16 ok Jun 17 20:25:35 dreamone enigma2[433]: + 1/1 TID 02 Jun 17 20:25:35 dreamone enigma2[433]: done! Jun 17 20:25:35 dreamone enigma2[433]: [eDVBCAService] new service 1:256:19:4331:300C:13E:820000:0:0:0:http%3a//root%3adreambox@192.168.1.120%3a8001/1%3a256%3a19%3a4331%3a300C%3a13E%3a820000%3a0%3a0%3a0%3a:SRF 1 HD (dreambox) Jun 17 20:25:35 dreamone enigma2[433]: [eDVBCAService] add demux 16 to slot 0 service 1:256:19:4331:300C:13E:820000:0:0:0:http%3a//root%3adreambox@192.168.1.120%3a8001/1%3a256%3a19%3a4331%3a300C%3a13E%3a820000%3a0%3a0%3a0%3a:SRF 1 HD (dreambox) Jun 17 20:25:35 dreamone enigma2[433]: HBBTV broadcast data on pid 13d8 Jun 17 20:25:35 dreamone enigma2[433]: [eDVBCAService] demux 16 mask 10000 Jun 17 20:25:35 dreamone enigma2[433]: [eDVBCAServiceConn] send 284 bytes to '/tmp/camd.socket' Jun 17 20:25:35 dreamone enigma2[433]: 9f 80 32 82 01 16 03 43 31 37 00 18 01 81 08 00 82 00 00 30 0c 01 3e 82 02 00 10 84 02 01 f5 85 00 86 01 10 1b 01 f6 00 34 01 09 0f 05 00 e2 ed 10 01 00 13 01 20 14 03 06 02 08 09 0f 05 00 e2 d9 10 01 00 13 01 20 14 03 04 08 18 09 0f 05 00 e2 e3 10 01 00 13 01 20 14 03 05 08 08 03 01 f7 00 34 01 09 0f 05 00 e2 ed 10 01 00 13 01 20 14 03 06 02 08 09 0f 05 00 e2 d9 10 01 00 13 01 20 14 03 04 08 18 09 0f 05 00 e2 e3 10 01 00 13 01 20 14 03 05 08 08 03 01 f8 00 34 01 09 0f 05 00 e2 d9 10 01 00 13 01 20 14 03 04 08 18 09 0f 05 00 e2 e3 10 01 00 13 01 20 14 03 05 08 08 09 0f 05 00 e2 ed 10 01 00 13 01 20 14 03 06 02 08 06 01 f9 00 34 01 09 0f 05 00 e2 d9 10 01 00 13 01 20 14 03 04 08 18 09 0f 05 00 e2 e3 10 01 00 13 01 20 14 03 05 08 08 09 0f 05 00 e2 ed 10 01 00 13 01 20 14 03 06 02 08 06 01 fb 00 00 05 01 fc 00 00 0b 13 d8 00 00 0c 13 d9 00 00 Jun 17 20:25:35 dreamone enigma2[433]: eventNewProgramInfo 0 0 Jun 17 20:25:35 dreamone enigma2[433]: start ait on pid 01fc Jun 17 20:25:35 dreamone enigma2[433]: no version filtering Jun 17 20:25:35 dreamone enigma2[433]: 01fc: 74 00 00 00 00 00 Jun 17 20:25:35 dreamone enigma2[433]: mask: ff 00 00 00 00 00 Jun 17 20:25:35 dreamone enigma2[433]: mode: 00 00 00 00 00 00 Jun 17 20:25:35 dreamone enigma2[433]: have 1 video stream(s) (01f6), and 3 audio stream(s) (01f7, 01f8, 01f9), and the pcr pid is 01f6, and the text pid is 01fb Jun 17 20:25:35 dreamone enigma2[433]: decoder state: play, vpid=502, apid=503 Jun 17 20:25:35 dreamone enigma2[433]: HBBTV broadcast data on pid 13d8 Jun 17 20:25:35 dreamone enigma2[433]: [TeleText] serviceInfoChanged Jun 17 20:25:35 dreamone enigma2[433]: [TeleText] TXT PID 507 DEMUX 16 Jun 17 20:25:35 dreamone enigma2[433]: [TeleText] send array('B', [1, 1, 251, 16]) Jun 17 20:25:35 dreamone enigma2[433]: doing version filtering Jun 17 20:25:35 dreamone enigma2[433]: 01f5: 02 43 31 37 00 00 Jun 17 20:25:35 dreamone enigma2[433]: mask: ff ff ff 3f 00 00 Jun 17 20:25:35 dreamone enigma2[433]: mode: 00 00 00 3e 00 00 Jun 17 20:25:36 dreamone enigma2[433]: eTsRemoteSource::state transition PAUSED -> PLAYING Jun 17 20:25:36 dreamone enigma2[433]: VIDEO_GET_EVENT - ok (2 times) Jun 17 20:25:36 dreamone enigma2[433]: -> setting (aspect, policy, policy2) => auto scale letterbox Jun 17 20:25:36 dreamone enigma2[433]: eAlsaOutput(SPDIF): pcr 9019b9c5 apts 9019b9c7 a delay 2 (START) Jun 17 20:25:36 dreamone enigma2[433]: eAlsaOutput(SPDIF): Error (File descriptor in bad state) Jun 17 20:25:36 dreamone enigma2[433]: eAlsaOutput(HDMI): pcr 9019b9f7 apts 9019b9c7 a delay -48 (START) Jun 17 20:25:36 dreamone enigma2[433]: eAlsaOutput(HDMI): Error (File descriptor in bad state) Jun 17 20:25:37 dreamone enigma2[433]: nr_read 1169 nr_write 43813 Jun 17 20:25:37 dreamone enigma2[433]: sum 44982 prev_sum 44982 Jun 17 20:25:37 dreamone enigma2[433]: hdd IDLE! Jun 17 20:25:37 dreamone enigma2[433]: [IDLE] 73501.534719 300 True Jun 17 20:25:37 dreamone enigma2[433]: release cached channel (timer timeout) Jun 17 20:25:37 dreamone enigma2[433]: [eDVBCAService] remove channel 0x14413410 Jun 17 20:25:37 dreamone enigma2[433]: [eDVBCAService] write leave transponder to '/tmp/camd.socket' ok Jun 17 20:25:37 dreamone enigma2[433]: [eDVBLocalTimeHandler] remove channel 0x14413410 Jun 17 20:25:37 dreamone enigma2[433]: [EPGC] remove channel 0x14413410 Jun 17 20:25:37 dreamone enigma2[433]: stop release channel timer Jun 17 20:25:37 dreamone enigma2[433]: [ 0] preClose Jun 17 20:25:37 dreamone enigma2[433]: timeout 0012! Jun 17 20:25:37 dreamone enigma2[433]: W/ [InfoBar.__servicePlaying] :: Jun 17 20:25:37 dreamone enigma2[433]: I/ [InfoBar.setPlaybackState] :: None None 1560795937.24 Jun 17 20:25:40 dreamone enigma2[433]: [ 0] prepareClose running loop Jun 17 20:25:40 dreamone enigma2[433]: [SEC-0] lock 0 Jun 17 20:25:40 dreamone enigma2[433]: [SEC-0] locked 0 Jun 17 20:25:40 dreamone enigma2[433]: [SEC-0] setTone Off Jun 17 20:25:40 dreamone enigma2[433]: [SEC-0] sleep 25ms Jun 17 20:25:40 dreamone enigma2[433]: I/ [InfoBar.ptsCleanTimeshiftFolder] :: [PTS-Plugin] Erasing stranded timeshift pts_livebuffer.1 Jun 17 20:25:40 dreamone enigma2[433]: [SEC-0] sendDiseqc: e01002 (DiSEqC peripherial power off) Jun 17 20:25:40 dreamone enigma2[433]: [SEC-0] sleep 150ms Jun 17 20:25:40 dreamone enigma2[433]: [SEC-0] delayed close frontend Jun 17 20:25:40 dreamone enigma2[433]: [SEC-0] unlock 0 Jun 17 20:25:40 dreamone enigma2[433]: [ 0] close frontend Jun 17 20:25:40 dreamone enigma2[433]: [SEC-0] setVoltage 0V Jun 17 20:25:40 dreamone enigma2[433]: eBackgroundFileEraser '/media/sdcard//pts_livebuffer.1' finished Jun 17 20:25:40 dreamone enigma2[433]: eBackgroundFileEraser '/media/sdcard//pts_livebuffer.1.meta' finished Jun 17 20:25:40 dreamone enigma2[433]: eBackgroundFileEraser '/media/sdcard//pts_livebuffer.1.eit' finished Jun 17 20:25:42 dreamone enigma2[433]: Start timeshift! Jun 17 20:25:42 dreamone enigma2[433]: timeshift recording to /media/sdcard//timeshift.YnuxbW Jun 17 20:25:42 dreamone enigma2[433]: before: 1 Jun 17 20:25:42 dreamone enigma2[433]: after: 1 Jun 17 20:25:42 dreamone enigma2[433]: I/ [InfoBar.ptsSetNextPlaybackFile] :: [PTS-Plugin] setNextPlaybackFile(/media/sdcard//pts_livebuffer.1) Jun 17 20:25:42 dreamone enigma2[433]: setIoPrio realtime level 7 ok Jun 17 20:25:42 dreamone enigma2[433]: eRecordFileThread (direct io) START Jun 17 20:25:42 dreamone enigma2[433]: record write thread succesfully created! Jun 17 20:25:42 dreamone enigma2[433]: setIoPrio realtime level 7 ok Jun 17 20:25:42 dreamone enigma2[433]: no cue sheet. forcing normal play Jun 17 20:25:46 dreamone enigma2[433]: It's now Mon Jun 17 20:25:45 2019 Jun 17 20:25:46 dreamone enigma2[433]: [timer.py] next activation: 1560796045 (in 99000 ms) Jun 17 20:25:47 dreamone enigma2[433]: timeout 01fc! Jun 17 20:25:49 dreamone enigma2[433]: no cue sheet. forcing normal play Jun 17 20:25:54 dreamone enigma2[433]: no ancillary data in audio stream... abort radiotext pes parser Jun 17 20:25:54 dreamone enigma2[433]: [TVCharts] Status Update ... Jun 17 20:25:56 dreamone enigma2[433]: no cue sheet. forcing normal play Jun 17 20:25:57 dreamone enigma2[433]: [EPGC] cleanupOutdated