-- Logs begin at Thu 1970-01-01 01:00:02 CET. --
May 31 15:56:10 dreambox enigma2[484]: eAlsaOutput(SPDIF): Error (Broken pipe)
May 31 15:56:11 dreambox enigma2[484]: no cue sheet. forcing normal play
May 31 15:56:12 dreambox enigma2[484]: wait for driver eof timeout
May 31 15:56:12 dreambox enigma2[484]: wait for driver eof timeout
May 31 15:56:12 dreambox enigma2[484]: [eAudioPlayback] Audio buffer underrun! (2 times)
May 31 15:56:12 dreambox enigma2[484]: wait for driver eof timeout
May 31 15:56:12 dreambox enigma2[484]: eAlsaOutput(SPDIF): Error (Broken pipe)
May 31 15:56:12 dreambox enigma2[484]: eAlsaOutput(HDMI): Error (Broken pipe)
May 31 15:56:13 dreambox enigma2[484]: wait for driver eof timeout
May 31 15:56:15 dreambox enigma2[484]: wait for driver eof timeout
May 31 15:56:17 dreambox enigma2[484]: wait for driver eof timeout
May 31 15:56:17 dreambox enigma2[484]: unknown action QuickButtonActions/down! typo in keymap?
May 31 15:56:17 dreambox enigma2[484]: allocating new converter! (2 times)
May 31 15:56:17 dreambox enigma2[484]: reused converter! (2 times)
May 31 15:56:17 dreambox enigma2[484]: [CSP] own ChannelSelection_execBegin style: default, default
May 31 15:56:17 dreambox enigma2[484]: [CSP] set DVBIcons off - style: default, useTemplate: True, config: False
May 31 15:56:17 dreambox enigma2[484]: create buffer for widget 2560 x 1440
May 31 15:56:18 dreambox enigma2[484]: I/  [ServiceListOwn.buildOptionEntry] :: <no detail> (14 times)
May 31 15:56:18 dreambox enigma2[484]: wait for driver eof timeout
May 31 15:56:18 dreambox enigma2[484]: [InstantEpgTimer] >>>> SelectionEventInfo.updateEventInfo
May 31 15:56:18 dreambox enigma2[484]: wait for driver eof timeout
May 31 15:56:19 dreambox enigma2[484]: eAlsaOutput(SPDIF): pcr a7d49c6c vpts a7d497cd Apts a7d42e61 apcr delay -28171 vpcr delay -1183 av delay -26988 (-299 ms)
May 31 15:56:19 dreambox enigma2[484]: eAlsaOutput(SPDIF): OUT OF SYNC RESYNC!
May 31 15:56:19 dreambox enigma2[484]: eAlsaOutput(HDMI): pcr a7d49d0b vpts a7d497cd Apts a7d42ed9 apcr delay -28210 vpcr delay -1342 av delay -26868 (-298 ms)
May 31 15:56:19 dreambox enigma2[484]: eAlsaOutput(HDMI): OUT OF SYNC RESYNC!
May 31 15:56:19 dreambox enigma2[484]: eAlsaOutput(HDMI): pcr a7d49ecd Apts a7d49df1 a delay -220 (START)
May 31 15:56:19 dreambox enigma2[484]: eAlsaOutput(SPDIF): pcr a7d49ee6 Apts a7d49e69 a delay -125 (START)
May 31 15:56:20 dreambox enigma2[484]: I/  [ServiceListOwn.buildOptionEntry] :: <no detail> (2 times)
May 31 15:56:20 dreambox enigma2[484]: [InstantEpgTimer] >>>> SelectionEventInfo.updateEventInfo
May 31 15:56:20 dreambox enigma2[484]: no cue sheet. forcing normal play
May 31 15:56:20 dreambox enigma2[484]: [eAudioPlayback] Audio buffer underrun! (2 times)
May 31 15:56:20 dreambox enigma2[484]: wait for driver eof timeout
May 31 15:56:20 dreambox enigma2[484]: eAlsaOutput(SPDIF): Error (Broken pipe)
May 31 15:56:20 dreambox enigma2[484]: eAlsaOutput(HDMI): Error (Broken pipe)
May 31 15:56:22 dreambox enigma2[484]: wait for driver eof timeout
May 31 15:56:22 dreambox enigma2[484]: action ->  InfobarInstantRecord instantRecord
May 31 15:56:22 dreambox enigma2[484]: [InstantEpgTimer] self.recording []
May 31 15:56:22 dreambox enigma2[484]: I/  [TemplatedListFonts.__init__] :: Keyboard: 42, Regular
May 31 15:56:22 dreambox enigma2[484]: I/  [TemplatedListFonts.__init__] :: Bigger: 38, Regular
May 31 15:56:22 dreambox enigma2[484]: I/  [TemplatedListFonts.__init__] :: Big: 34, Regular
May 31 15:56:22 dreambox enigma2[484]: I/  [TemplatedListFonts.__init__] :: Medium: 34, Regular
May 31 15:56:22 dreambox enigma2[484]: I/  [TemplatedListFonts.__init__] :: Small: 32, Regular
May 31 15:56:22 dreambox enigma2[484]: I/  [TemplatedListFonts.__init__] :: Smaller: 30, Regular
May 31 15:56:22 dreambox enigma2[484]: create buffer for widget 950 x 1440
May 31 15:56:23 dreambox enigma2[484]: wait for driver eof timeout
May 31 15:56:23 dreambox enigma2[484]: wait for driver eof timeout
May 31 15:56:23 dreambox enigma2[484]: [eAudioPlayback] Audio buffer underrun! (2 times)
May 31 15:56:23 dreambox enigma2[484]: action ->  WizardActions ok
May 31 15:56:23 dreambox enigma2[484]: wait for driver eof timeout
May 31 15:56:23 dreambox enigma2[484]: eAlsaOutput(HDMI): Error (Broken pipe)
May 31 15:56:23 dreambox enigma2[484]: eAlsaOutput(SPDIF): Error (Broken pipe)
May 31 15:56:23 dreambox enigma2[484]: [CSP] own ChannelSelection_execBegin style: default, default
May 31 15:56:23 dreambox enigma2[484]: [CSP] set DVBIcons off - style: default, useTemplate: True, config: False
May 31 15:56:23 dreambox enigma2[484]: [InstantEpgTimer] pre:
May 31 15:56:23 dreambox enigma2[484]: []
May 31 15:56:23 dreambox enigma2[484]: [TIMER] record time changed, start prepare is now: Wed May 31 15:56:03 2023
May 31 15:56:23 dreambox enigma2[484]: sanitycheck
May 31 15:56:23 dreambox enigma2[484]: check
May 31 15:56:23 dreambox enigma2[484]: checkTimerlist
May 31 15:56:23 dreambox enigma2[484]: [Timer] Record <RecordTimerEntry instance at 7f16740c90 name=Sturm der Liebe >
May 31 15:56:23 dreambox enigma2[484]: I/  [RecordTimerEntry.processRepeated] :: ProcessRepeated
May 31 15:56:23 dreambox enigma2[484]: I/  [RecordTimer.processActivation] :: It's now Mi 31 Mai 2023 15:56:23 CEST
May 31 15:56:23 dreambox enigma2[484]: [TIMER] activating state 1
May 31 15:56:23 dreambox enigma2[484]: recording service: <enigma.eServiceReference; proxy of <Swig Object of type 'eServiceReference *' at 0x7f167952d0> >
May 31 15:56:23 dreambox enigma2[484]: record: 0
May 31 15:56:23 dreambox enigma2[484]: [add callback]
May 31 15:56:23 dreambox enigma2[484]: begin_date:  20230531 1556
May 31 15:56:23 dreambox enigma2[484]: service_name:  Das Erste HD
May 31 15:56:23 dreambox enigma2[484]: name: Sturm der Liebe
May 31 15:56:23 dreambox enigma2[484]: description:  Folge 4042 ║ 2023 ║ 12+
May 31 15:56:23 dreambox enigma2[484]: [TIMER] Directory 'None' doesn't seem to exist or isn't writable. Falling back to default movie path '/media/hdd/movie/'.
May 31 15:56:23 dreambox enigma2[484]: [TIMER] Filename calculated as: '/media/hdd/movie/20230531 1556 - Das Erste HD - Sturm der Liebe.ts'
May 31 15:56:23 dreambox enigma2[484]: alloc PVR
May 31 15:56:23 dreambox enigma2[484]: allocate channel.. 03fb:0001:00c00000 (http://root:dreambox@192.168.2.77:8001/1:256:19:283D:3FB:1:C00000:0:0:0:)
May 31 15:56:23 dreambox enigma2[484]: available channel.. 03fb:0001:00c00000 (http://root:dreambox@192.168.2.77:8001/1:256:19:283D:3FB:1:C00000:0:0:0:)
May 31 15:56:23 dreambox enigma2[484]: found shared channel..
May 31 15:56:23 dreambox enigma2[484]: RECORD service event 7
May 31 15:56:23 dreambox enigma2[484]: tuned..
May 31 15:56:23 dreambox enigma2[484]: no version filtering
May 31 15:56:23 dreambox enigma2[484]: 0012:  4e 28 3d 00 00 00
May 31 15:56:23 dreambox enigma2[484]: mask:  ff ff ff 00 00 00
May 31 15:56:23 dreambox enigma2[484]: mode:  00 00 00 00 00 00
May 31 15:56:23 dreambox enigma2[484]: [TIMER] record event 2
May 31 15:56:23 dreambox enigma2[484]: ok ... now we start!!
May 31 15:56:23 dreambox enigma2[484]: no version filtering
May 31 15:56:23 dreambox enigma2[484]: 0000:  00 00 00 00 00 00
May 31 15:56:23 dreambox enigma2[484]: mask:  ff 00 00 00 00 00
May 31 15:56:23 dreambox enigma2[484]: mode:  00 00 00 00 00 00
May 31 15:56:23 dreambox enigma2[484]: query epg event id 42902
May 31 15:56:23 dreambox enigma2[484]: found event.. store to disc
May 31 15:56:23 dreambox enigma2[484]: [TIMER] prepare ok, waiting for begin
May 31 15:56:23 dreambox enigma2[484]: [AdvancedMovieSelection] timer state changed event
May 31 15:56:23 dreambox enigma2[484]: False False 1
May 31 15:56:23 dreambox enigma2[484]: [AdvancedMovieSelection] RecordTimerEvent: 1 False 1685541383 1685541960 /media/hdd/movie/20230531 1556 - Das Erste HD - Sturm der Liebe.ts
May 31 15:56:23 dreambox enigma2[484]: 9
May 31 15:56:23 dreambox enigma2[484]: CAC: DEBUG: Recording.py: recordingEvent: timer.Filename: /media/hdd/movie/20230531 1556 - Das Erste HD - Sturm der Liebe.ts, timer.state: StatePrepared
May 31 15:56:23 dreambox enigma2[484]: TSC: INFO: BoxUtils.py: startLedBlinking: ...
May 31 15:56:23 dreambox enigma2[484]: RECSTATE: records: 0, prev_records: 0
May 31 15:56:23 dreambox enigma2[484]: [TIMER] activating state 2
May 31 15:56:23 dreambox enigma2[484]: [TIMER] start recording
May 31 15:56:23 dreambox enigma2[484]: [TIMER] record event 0
May 31 15:56:23 dreambox enigma2[484]: Recording to /media/hdd/movie/20230531 1556 - Das Erste HD - Sturm der Liebe.ts...
May 31 15:56:23 dreambox enigma2[484]: start recording...
May 31 15:56:23 dreambox enigma2[484]: getting program info failed.
May 31 15:56:23 dreambox enigma2[484]: [TIMER] record event 4
May 31 15:56:23 dreambox enigma2[484]: create buffer for widget 1356 x 60
May 31 15:56:23 dreambox enigma2[484]: [AdvancedMovieSelection] timer state changed event
May 31 15:56:23 dreambox enigma2[484]: False False 2
May 31 15:56:23 dreambox enigma2[484]: [AdvancedMovieSelection] RecordTimerEvent: 2 False 1685541383 1685541960 /media/hdd/movie/20230531 1556 - Das Erste HD - Sturm der Liebe.ts
May 31 15:56:23 dreambox enigma2[484]: 9
May 31 15:56:23 dreambox enigma2[484]: CAC: DEBUG: Recording.py: recordingEvent: timer.Filename: /media/hdd/movie/20230531 1556 - Das Erste HD - Sturm der Liebe.ts, timer.state: StateRunning
May 31 15:56:23 dreambox enigma2[484]: CAC: DEBUG: Recording.py: recordingEvent: REC START for: /media/hdd/movie/20230531 1556 - Das Erste HD - Sturm der Liebe.ts, afterEvent: 3
May 31 15:56:23 dreambox enigma2[484]: CAC: INFO: FileUtils.py: readFile: path: /media/hdd/movie/20230531 1556 - Das Erste HD - Sturm der Liebe.ts.xmeta, exception: [Errno 2] No such file or directory: '/media/hdd/movie/20230531 1556 - Das Erste HD - Sturm der Liebe.ts.xmeta'
May 31 15:56:23 dreambox enigma2[484]: CAC: DEBUG: ParserMetaFile.py: updateXMeta: xmeta: {'recording_margin_after': 360, 'timer_stop_time': 1685541960, 'recording_start_time': 1685541383, 'timer_start_time': 1685541383, 'recording_margin_before': 180, 'recording_stop_time': 0}
May 31 15:56:23 dreambox enigma2[484]: CAC: DEBUG: ParserMetaFile.py: updateXMeta: self.xmeta: {'recording_margin_after': 360, 'timer_stop_time': 1685541960, 'recording_start_time': 1685541383, 'timer_start_time': 1685541383, 'recording_margin_before': 180, 'recording_stop_time': 0}
May 31 15:56:23 dreambox enigma2[484]: CAC: DEBUG: ParserMetaFile.py: dict2list: adict: {'recording_margin_after': 360, 'timer_stop_time': 1685541960, 'recording_start_time': 1685541383, 'timer_start_time': 1685541383, 'recording_margin_before': 180, 'recording_stop_time': 0}
May 31 15:56:23 dreambox enigma2[484]: TSC: INFO: BoxUtils.py: startLedBlinking: ...
May 31 15:56:23 dreambox enigma2[484]: RECSTATE: records: 1, prev_records: 0
May 31 15:56:23 dreambox enigma2[484]: I/  [RecordTimer.calcNextActivation] :: next real activation is Mi 31 Mai 2023 16:06:00 CEST
May 31 15:56:23 dreambox enigma2[484]: I/  [RecordTimer.setNextActivation] :: Next activation: Mi 31 Mai 2023 15:58:03 CEST (in 99263 ms)
May 31 15:56:23 dreambox enigma2[484]: [InstantEpgTimer] after:
May 31 15:56:23 dreambox enigma2[484]: [<RecordTimer.RecordTimerEntry object at 0x7f16740c90>]
May 31 15:56:23 dreambox enigma2[484]: I/  [ServiceListOwn.buildOptionEntry] :: <no detail> (14 times)
May 31 15:56:23 dreambox enigma2[484]: [InstantEpgTimer] >>>> SelectionEventInfo.updateEventInfo
May 31 15:56:23 dreambox enigma2[484]: + 1/1 TID 00 (0000)
May 31 15:56:23 dreambox enigma2[484]: done!
May 31 15:56:23 dreambox enigma2[484]: PATready
May 31 15:56:23 dreambox enigma2[484]: use pmtpid 13ec for service_id 283d
May 31 15:56:23 dreambox enigma2[484]: no version filtering
May 31 15:56:23 dreambox enigma2[484]: 13ec:  02 28 3d 00 00 00
May 31 15:56:23 dreambox enigma2[484]: mask:  ff ff ff 00 00 00
May 31 15:56:23 dreambox enigma2[484]: mode:  00 00 00 00 00 00
May 31 15:56:23 dreambox enigma2[484]: doing version filtering
May 31 15:56:23 dreambox enigma2[484]: 0000:  00 00 00 05 00 00
May 31 15:56:23 dreambox enigma2[484]: mask:  ff 00 00 3f 00 00
May 31 15:56:23 dreambox enigma2[484]: mode:  00 00 00 3e 00 00
May 31 15:56:23 dreambox enigma2[484]: +- 1/2 TID 4e (0012)
May 31 15:56:23 dreambox enigma2[484]: CAC: INFO: FileManagerCache.py: loadDatabaseFile: path: /media/hdd/movie/20230531 1556 - Das Erste HD - Sturm der Liebe.ts
May 31 15:56:23 dreambox enigma2[484]: CAC: INFO: FileManagerCache.py: newFileData: path: /media/hdd/movie/20230531 1556 - Das Erste HD - Sturm der Liebe.ts
May 31 15:56:23 dreambox enigma2[484]: CAC: INFO: FileUtils.py: readFile: path: /media/hdd/movie/20230531 1556 - Das Erste HD - Sturm der Liebe.ts.cuts, exception: [Errno 2] No such file or directory: '/media/hdd/movie/20230531 1556 - Das Erste HD - Sturm der Liebe.ts.cuts'
May 31 15:56:23 dreambox enigma2[484]: CAC: DEBUG: FileManagerCache.py: parseFilename: file_name: 20230531 1556 - Das Erste HD - Sturm der Liebe, start_time: 1685541360, service_name: Das Erste HD, name: Sturm der Liebe, cutno:
May 31 15:56:23 dreambox enigma2[484]: CAC: DEBUG: ParserMetaFile.py: getMeta: meta: {'service_reference': '1:256:19:283D:3FB:1:C00000:0:0:0::Das Erste HD', 'recording_margin_after': 360, 'name': 'Sturm der Liebe', 'rec_time': 1685541383, 'tags': '', 'timer_stop_time': 1685541960, 'timer_start_time': 1685541383, 'recording_start_time': 1685541383, 'length': 0, 'recording_stop_time': 0, 'recording_margin_before': 180, 'service_data': '', 'size': 0, 'description': 'Folge 4042 \xe2\x95\x91 2023 \xe2\x95\x91 12+'}
May 31 15:56:23 dreambox enigma2[484]: CAC: INFO: FileManagerCache.py: getMetaStartLength: recording_start_time: 2023-05-31 15:56:23, recording_stop_time: 1970-01-01 01:00:00
May 31 15:56:23 dreambox enigma2[484]: CAC: DEBUG: FileManagerCache.py: getMetaStartLength: start_time: 2023-05-31 15:56:23, length: 0
May 31 15:56:24 dreambox enigma2[484]: CAC: DEBUG: ParserEitFile.py: parseHeader: dt: 2023-05-31 13:10:00
May 31 15:56:24 dreambox enigma2[484]: CAC: DEBUG: FileManagerCache.py: getEitStartLength: recording_start_time: 2023-05-31 15:56:23, recording_stop_time: 1970-01-01 01:00:00, recording_margin_before: 180, recording_margin_after: 360
May 31 15:56:24 dreambox enigma2[484]: CAC: DEBUG: FileManagerCache.py: getEitStartLength: start 2: es rs: 1685541383, 217
May 31 15:56:24 dreambox enigma2[484]: CAC: DEBUG: FileManagerCache.py: getEitStartLength: start: 2023-05-31 15:56:23, length: 217
May 31 15:56:24 dreambox enigma2[484]: CAC: DEBUG: FileManagerCache.py: newFileData: path: /media/hdd/movie/20230531 1556 - Das Erste HD - Sturm der Liebe.ts, name: Sturm der Liebe, event_start_time 2023-05-31 15:56:23, length: 217, cuts: (l.
May 31 15:56:24 dreambox enigma2[484]: CAC: INFO: FileManagerCache.py: newCoverData: path: /media/hdd/movie/20230531 1556 - Das Erste HD - Sturm der Liebe.ts
May 31 15:56:24 dreambox enigma2[484]: CAC: INFO: FileUtils.py: readFile: path: /media/hdd/movie/20230531 1556 - Das Erste HD - Sturm der Liebe.jpg, exception: [Errno 2] No such file or directory: '/media/hdd/movie/20230531 1556 - Das Erste HD - Sturm der Liebe.jpg'
May 31 15:56:24 dreambox enigma2[484]: + 1/1 TID 02 (13ec)
May 31 15:56:24 dreambox enigma2[484]: done!
May 31 15:56:24 dreambox enigma2[484]: [eDVBCAService] add demux 16 to slot 2 service 1:256:19:283D:3FB:1:C00000:0:0:0:http%3a//root%3adreambox@192.168.2.77%3a8001/1%3a256%3a19%3a283D%3a3FB%3a1%3aC00000%3a0%3a0%3a0%3a:Das Erste HD
May 31 15:56:24 dreambox enigma2[484]: HBBTV broadcast data on pid 087b
May 31 15:56:24 dreambox enigma2[484]: HBBTV broadcast data on pid 1434
May 31 15:56:24 dreambox enigma2[484]: [eDVBCAService] don't send the same capmt twice
May 31 15:56:24 dreambox enigma2[484]: RECORD service event 5
May 31 15:56:24 dreambox enigma2[484]: start recording...
May 31 15:56:24 dreambox enigma2[484]: RECORD: have 1 video stream(s) (13ed), and 4 audio stream(s) (13ee, 13ef, 13f3, 13f2) (13f1), and the pcr pid is 13ed, and the text pid is 13f0
May 31 15:56:24 dreambox enigma2[484]: ADD PID: 0000
May 31 15:56:24 dreambox enigma2[484]: ADD PID: 13ec
May 31 15:56:24 dreambox enigma2[484]: ADD PID: 13ed
May 31 15:56:24 dreambox enigma2[484]: ADD PID: 13ee
May 31 15:56:24 dreambox enigma2[484]: ADD PID: 13ef
May 31 15:56:24 dreambox enigma2[484]: ADD PID: 13f0
May 31 15:56:24 dreambox enigma2[484]: ADD PID: 13f1
May 31 15:56:24 dreambox enigma2[484]: ADD PID: 13f2
May 31 15:56:24 dreambox enigma2[484]: ADD PID: 13f3
May 31 15:56:24 dreambox enigma2[484]: setIoPrio realtime level 7 ok
May 31 15:56:24 dreambox enigma2[484]: [TIMER] record event 4
May 31 15:56:24 dreambox enigma2[484]: [TIMER] record event 6
May 31 15:56:24 dreambox enigma2[484]: doing version filtering
May 31 15:56:24 dreambox enigma2[484]: 13ec:  02 28 3d 01 00 00
May 31 15:56:24 dreambox enigma2[484]: mask:  ff ff ff 3f 00 00
May 31 15:56:24 dreambox enigma2[484]: mode:  00 00 00 3e 00 00
May 31 15:56:24 dreambox enigma2[484]: eRecordFileThread (direct io) START
May 31 15:56:24 dreambox enigma2[484]: record write thread succesfully created!
May 31 15:56:24 dreambox enigma2[484]: setIoPrio realtime level 7 ok
May 31 15:56:24 dreambox enigma2[484]: I/  [ServiceListOwn.buildOptionEntry] :: <no detail> (2 times)
May 31 15:56:24 dreambox enigma2[484]: wait for driver eof timeout
May 31 15:56:24 dreambox enigma2[484]: ++ 2/2 TID 4e (0012)
May 31 15:56:24 dreambox enigma2[484]: done!
May 31 15:56:24 dreambox enigma2[484]: pcr of eit change: 1a7dc72bd
May 31 15:56:24 dreambox enigma2[484]: [eDVBServiceRecord] now running: Sturm der Liebe (4042) (3000 seconds) (RECORDING)
May 31 15:56:24 dreambox enigma2[484]: [TIMER] record event 9
May 31 15:56:24 dreambox enigma2[484]: doing version filtering
May 31 15:56:24 dreambox enigma2[484]: 0012:  4e 28 3d 15 00 00
May 31 15:56:24 dreambox enigma2[484]: mask:  ff ff ff 3f 00 00
May 31 15:56:24 dreambox enigma2[484]: mode:  00 00 00 3e 00 00
May 31 15:56:24 dreambox enigma2[484]: [InstantEpgTimer] >>>> SelectionEventInfo.updateEventInfo
May 31 15:56:24 dreambox enigma2[484]: CAC: DEBUG: FileManagerCache.py: getFile: table: recordings, path: /media/hdd/movie/20230531 1556 - Das Erste HD - Sturm der Liebe.ts
May 31 15:56:24 dreambox enigma2[484]: CAC: DEBUG: FileManagerCacheSQL.py: sqlSelect: sql: SELECT * FROM recordings WHERE path = ?, args: ['/media/hdd/movie/20230531 1556 - Das Erste HD - Sturm der Liebe.ts']
May 31 15:56:24 dreambox enigma2[484]: CAC: INFO: MovieCoverDownload.py: getMovieCover: path: /media/hdd/movie/20230531 1556 - Das Erste HD - Sturm der Liebe.ts, title: Sturm der Liebe
May 31 15:56:24 dreambox enigma2[484]: CAC: INFO: MovieCoverUNIDownload.py: getSourceMovieCover: path: /media/hdd/movie/20230531 1556 - Das Erste HD - Sturm der Liebe.ts, cover_source: tvs_id, title: Sturm der Liebe
May 31 15:56:24 dreambox enigma2[484]: CAC: INFO: MovieCoverUNIDownload.py: getChannelId: service_ref: 1:256:19:283D:3FB:1:C00000:0:0:0:http%3a//root%3adreambox@192.168.2.77%3a8001/1%3a256%3a19%3a283D%3a3FB%3a1%3aC00000%3a0%3a0%3a0%3a:Das Erste HD
May 31 15:56:24 dreambox enigma2[484]: CAC: DEBUG: MovieCoverUNIDownload.py: getChannelId: tvs_id:
May 31 15:56:24 dreambox enigma2[484]: CAC: INFO: MovieCoverUNIDownload.py: getSourceMovieCover: path: /media/hdd/movie/20230531 1556 - Das Erste HD - Sturm der Liebe.ts, cover_source: tvm_id, title: Sturm der Liebe
May 31 15:56:24 dreambox enigma2[484]: CAC: INFO: MovieCoverUNIDownload.py: getChannelId: service_ref: 1:256:19:283D:3FB:1:C00000:0:0:0:http%3a//root%3adreambox@192.168.2.77%3a8001/1%3a256%3a19%3a283D%3a3FB%3a1%3aC00000%3a0%3a0%3a0%3a:Das Erste HD
May 31 15:56:24 dreambox enigma2[484]: CAC: DEBUG: MovieCoverUNIDownload.py: getChannelId: tvm_id:
May 31 15:56:24 dreambox enigma2[484]: CAC: INFO: MovieCoverUNIDownload.py: getSourceMovieCover: path: /media/hdd/movie/20230531 1556 - Das Erste HD - Sturm der Liebe.ts, cover_source: tvfa_id, title: Sturm der Liebe
May 31 15:56:24 dreambox enigma2[484]: CAC: INFO: MovieCoverUNIDownload.py: getChannelId: service_ref: 1:256:19:283D:3FB:1:C00000:0:0:0:http%3a//root%3adreambox@192.168.2.77%3a8001/1%3a256%3a19%3a283D%3a3FB%3a1%3aC00000%3a0%3a0%3a0%3a:Das Erste HD
May 31 15:56:24 dreambox enigma2[484]: CAC: DEBUG: MovieCoverUNIDownload.py: getChannelId: tvfa_id:
May 31 15:56:24 dreambox enigma2[484]: CAC: INFO: MovieCoverUNIDownload.py: getSourceMovieCover: path: /media/hdd/movie/20230531 1556 - Das Erste HD - Sturm der Liebe.ts, cover_source: tvh_id, title: Sturm der Liebe
May 31 15:56:24 dreambox enigma2[484]: CAC: INFO: MovieCoverUNIDownload.py: getChannelId: service_ref: 1:256:19:283D:3FB:1:C00000:0:0:0:http%3a//root%3adreambox@192.168.2.77%3a8001/1%3a256%3a19%3a283D%3a3FB%3a1%3aC00000%3a0%3a0%3a0%3a:Das Erste HD
May 31 15:56:24 dreambox enigma2[484]: CAC: DEBUG: MovieCoverUNIDownload.py: getChannelId: tvh_id:
May 31 15:56:24 dreambox enigma2[484]: CAC: INFO: FileManagerCache.py: loadDatabaseCover: path: /media/hdd/movie/20230531 1556 - Das Erste HD - Sturm der Liebe.ts
May 31 15:56:24 dreambox enigma2[484]: CAC: INFO: FileManagerCache.py: newCoverData: path: /media/hdd/movie/20230531 1556 - Das Erste HD - Sturm der Liebe.ts
May 31 15:56:24 dreambox enigma2[484]: CAC: INFO: FileUtils.py: readFile: path: /media/hdd/movie/20230531 1556 - Das Erste HD - Sturm der Liebe.jpg, exception: [Errno 2] No such file or directory: '/media/hdd/movie/20230531 1556 - Das Erste HD - Sturm der Liebe.jpg'
May 31 15:56:25 dreambox enigma2[484]: [EPGC] cleanupOutdated
May 31 15:56:27 dreambox enigma2[484]: wait for driver eof timeout
May 31 15:56:27 dreambox enigma2[484]: action ->  ChannelSelectEPGActions showEPGList
May 31 15:56:27 dreambox enigma2[484]: [InstantEpgTimer] ChannelSelectionEPG_ori_showEPGList
May 31 15:56:27 dreambox enigma2[484]: [InstantEpgTimer] >>>> EPGSelection.__init__
May 31 15:56:27 dreambox enigma2[484]: I/  [TemplatedListFonts.__init__] :: Keyboard: 42, Regular
May 31 15:56:27 dreambox enigma2[484]: I/  [TemplatedListFonts.__init__] :: Bigger: 38, Regular
May 31 15:56:27 dreambox enigma2[484]: I/  [TemplatedListFonts.__init__] :: Big: 34, Regular
May 31 15:56:27 dreambox enigma2[484]: I/  [TemplatedListFonts.__init__] :: Medium: 34, Regular
May 31 15:56:27 dreambox enigma2[484]: I/  [TemplatedListFonts.__init__] :: Small: 32, Regular
May 31 15:56:27 dreambox enigma2[484]: I/  [TemplatedListFonts.__init__] :: Smaller: 30, Regular
May 31 15:56:27 dreambox enigma2[484]: allocating new converter! (11 times)
May 31 15:56:27 dreambox enigma2[484]: create buffer for widget 2560 x 1440
May 31 15:56:28 dreambox enigma2[484]: no cue sheet. forcing normal play
May 31 15:56:30 dreambox enigma2[484]: action ->  OkCancelActions cancel
May 31 15:56:30 dreambox enigma2[484]: [CSP] own ChannelSelection_execBegin style: default, default
May 31 15:56:30 dreambox enigma2[484]: [CSP] set DVBIcons off - style: default, useTemplate: True, config: False
May 31 15:56:31 dreambox enigma2[484]: I/  [ServiceListOwn.buildOptionEntry] :: <no detail> (14 times)
May 31 15:56:31 dreambox enigma2[484]: eAlsaOutput(HDMI): pcr a7e443eb vpts a7e43f9d apts a7e3bec1 apcr delay -34090 vpcr delay -1102 av delay -32988 (-366 ms)
May 31 15:56:31 dreambox enigma2[484]: eAlsaOutput(HDMI): OUT OF SYNC RESYNC!
May 31 15:56:31 dreambox enigma2[484]: eAlsaOutput(HDMI): pcr a7e4440a Apts a7e445c1 a delay 439 (START)
May 31 15:56:31 dreambox enigma2[484]: eAlsaOutput(SPDIF): pcr a7e444a9 vpts a7e43f9d apts a7e3bf39 apcr delay -34160 vpcr delay -1292 av delay -32868 (-365 ms)
May 31 15:56:31 dreambox enigma2[484]: eAlsaOutput(SPDIF): OUT OF SYNC RESYNC!
May 31 15:56:31 dreambox enigma2[484]: eAlsaOutput(SPDIF): pcr a7e444ba Apts a7e44639 a delay 383 (START)
May 31 15:56:31 dreambox enigma2[484]: [InstantEpgTimer] >>>> SelectionEventInfo.updateEventInfo
May 31 15:56:31 dreambox enigma2[484]: action ->  OkCancelActions cancel
May 31 15:56:31 dreambox enigma2[484]: I/  [InfoBar.__restoreState] :: <no detail>
May 31 15:56:32 dreambox enigma2[484]: [InstantEpgTimer] >>>> SelectionEventInfo.updateEventInfo
May 31 15:56:33 dreambox enigma2[484]: unknown action QuickButtonActions/pvr! typo in keymap?
May 31 15:56:33 dreambox enigma2[484]: MVC: INFO: plugin.py: openMovieCockpit: ...
May 31 15:56:33 dreambox enigma2[484]: MVC: INFO: MovieCockpit.py: __init__: self.return_dir: , self.return_path:
May 31 15:56:33 dreambox enigma2[484]: MVC: INFO: SelfTest.py: __init__: ...
May 31 15:56:33 dreambox enigma2[484]: allocating new converter! (7 times)
May 31 15:56:33 dreambox enigma2[484]: WARNING!!!!: unsupported skin attribute render=Label (2 times)
May 31 15:56:33 dreambox enigma2[484]: warning, skin is missing element level in <class 'Plugins.Extensions.MovieCockpit.MovieCockpit.MovieCockpit'>
May 31 15:56:33 dreambox enigma2[484]: MVC: INFO: MovieListParseTemplate.py: parseTemplate: list_styles: {0: ('default', 'List style: default', 100, 3), 1: ('compact_description', 'List style: compact with description', 80, 2), 2: ('compact', 'List style: compact', 80, 2), 3: ('compact_single', 'List style: compact single line', 45, 1), 4: ('minimal', 'List style: minimal', 45, 1)}
May 31 15:56:33 dreambox enigma2[484]: MVC: INFO: MovieListParseTemplate.py: parseTemplate: template_attributes: {'progress_width': 200, 'length_width': 306, 'spacer': 20, 'bar_size': (120, 19), 'font_height': [47, 44, 41], 'row_height': [133, 106, 106, 60, 60], 'picon_size': (73, 47), 'start': 7, 'date_width': 306, 'font_sizes': [43, 40, 37], 'icon_size': (60, 47), 'line_height': [44, 53, 53, 60, 60], 'yoffs': 4}
May 31 15:56:33 dreambox enigma2[484]: CAC: DEBUG: FileManagerJob.py: getLockList: lock_list: {}
May 31 15:56:33 dreambox enigma2[484]: warning, skin is missing element list in <class 'Plugins.Extensions.MovieCockpit.MovieCockpit.MovieCockpit'>
May 31 15:56:33 dreambox enigma2[484]: warning, skin is missing element no_support in <class 'Plugins.Extensions.MovieCockpit.MovieCockpit.MovieCockpit'>
May 31 15:56:33 dreambox enigma2[484]: WARNING!!!!: unsupported skin attribute render=Label (2 times)
May 31 15:56:33 dreambox enigma2[484]: warning, skin is missing element mini_tv in <class 'Plugins.Extensions.MovieCockpit.MovieCockpit.MovieCockpit'>
May 31 15:56:33 dreambox enigma2[484]: MVC: INFO: MovieCockpit.py: __init__: ...
May 31 15:56:33 dreambox enigma2[484]: No skin to read...
May 31 15:56:33 dreambox enigma2[484]: warning, skin is missing element background in <class 'Plugins.Extensions.MovieCockpit.MovieCockpit.MovieCockpitSummary'>
May 31 15:56:33 dreambox enigma2[484]: warning, skin is missing element lcd_pic_loading in <class 'Plugins.Extensions.MovieCockpit.MovieCockpit.MovieCockpitSummary'>
May 31 15:56:33 dreambox enigma2[484]: create buffer for widget 2560 x 1440
May 31 15:56:33 dreambox enigma2[484]: MVC: INFO: MovieCockpit.py: onDialogShow: self.return_path:
May 31 15:56:33 dreambox enigma2[484]: MVC: INFO: MovieCockpit.py: onDialogShow: self.last_service: 1:256:19:283D:3FB:1:C00000:0:0:0:http%3a//root%3adreambox@192.168.2.77%3a8001/1%3a256%3a19%3a283D%3a3FB%3a1%3aC00000%3a0%3a0%3a0%3a:Das Erste HD
May 31 15:56:33 dreambox enigma2[484]: CAC: INFO: FileManagerCache.py: onDatabaseLoaded: ...
May 31 15:56:33 dreambox enigma2[484]: CAC: INFO: FileManagerCache.py: onDatabaseLoadedCallback: ...
May 31 15:56:33 dreambox enigma2[484]: MVC: INFO: MovieCockpit.py: loadList: return_dir: , return_path:
May 31 15:56:33 dreambox enigma2[484]: MVC: INFO: MovieList.py: loadList: load_dir: /media/hdd/movie, selection_path:  (2 times)
May 31 15:56:33 dreambox enigma2[484]: CAC: DEBUG: FileManagerJob.py: getLockList: lock_list: {}
May 31 15:56:33 dreambox enigma2[484]: CAC: INFO: FileManagerCache.py: getRecordings: ...
May 31 15:56:33 dreambox enigma2[484]: CAC: DEBUG: RecordingUtils.py: getRecordings: ...
May 31 15:56:33 dreambox enigma2[484]: CAC: INFO: FileManagerCache.py: newDirData: path: /media/hdd/movie/trashcan
May 31 15:56:33 dreambox enigma2[484]: MNC: INFO: MountCockpit.py: getVirtualDirs: plugin: MVC, dirs: ['/media/hdd/movie']
May 31 15:56:33 dreambox enigma2[484]: CAC: DEBUG: FileManagerCache.py: getDirList: dirs: ['/media/hdd/movie']
May 31 15:56:33 dreambox enigma2[484]: CAC: DEBUG: FileManagerCacheSQL.py: sqlSelect: sql: SELECT * FROM recordings WHERE directory IN (?) AND file_name != 'trashcan' AND file_type IN (?,?), args: ['/media/hdd/movie', 2, 3]
May 31 15:56:33 dreambox enigma2[484]: CAC: DEBUG: FileManagerCache.py: getDirList: dir_list: []
May 31 15:56:33 dreambox enigma2[484]: CAC: DEBUG: FileManagerCache.py: getFileList: dirs: ['/media/hdd/movie']
May 31 15:56:33 dreambox enigma2[484]: CAC: DEBUG: FileManagerCacheSQL.py: sqlSelect: sql: SELECT * FROM recordings WHERE directory IN (?) AND file_type = 1, args: ['/media/hdd/movie']
May 31 15:56:33 dreambox enigma2[484]: MVC: INFO: MovieCockpit.py: updateSortModeDisplay: current_sort_mode: 0 (2 times)
May 31 15:56:33 dreambox enigma2[484]: CAC: INFO: FileManagerCache.py: onDatabaseChanged: ...
May 31 15:56:33 dreambox enigma2[484]: CAC: DEBUG: FileManagerJob.py: getLockList: lock_list: {}
May 31 15:56:33 dreambox enigma2[484]: CAC: INFO: FileManagerCache.py: getCountSize: path: /media/hdd/movie/trashcan
May 31 15:56:33 dreambox enigma2[484]: CAC: DEBUG: FileManagerCache.py: getFile: table: recordings, path: /media/hdd/movie/trashcan
May 31 15:56:33 dreambox enigma2[484]: CAC: DEBUG: FileManagerCacheSQL.py: sqlSelect: sql: SELECT * FROM recordings WHERE path = ?, args: ['/media/hdd/movie/trashcan']
May 31 15:56:33 dreambox enigma2[484]: MNC: INFO: MountCockpit.py: getVirtualDirs: plugin: MVC, dirs: ['/media/hdd/movie/trashcan']
May 31 15:56:33 dreambox enigma2[484]: CAC: DEBUG: FileManagerCacheSQL.py: sqlSelect: sql: SELECT * FROM recordings WHERE path LIKE ? AND file_type = ?, args: ['/media/hdd/movie/trashcan/%', 1]
May 31 15:56:33 dreambox enigma2[484]: CAC: DEBUG: FileManagerCache.py: getCountSize: path: /media/hdd/movie/trashcan, total_count: 1, total_size: 2295705600
May 31 15:56:33 dreambox enigma2[484]: CAC: DEBUG: FileManagerJob.py: getLockList: lock_list: {}
May 31 15:56:33 dreambox enigma2[484]: gPixmap: Failed to access '/usr/share/enigma2/picon_50x30/1_256_19_283D_3FB_1_C00000_0_0_0.png': No such file or directory
May 31 15:56:33 dreambox enigma2[484]: CAC: DEBUG: FileManagerJob.py: getLockList: lock_list: {}
May 31 15:56:33 dreambox enigma2[484]: gPixmap: Failed to access '/usr/share/enigma2/picon_50x30/1_256_19_EF77_3F9_1_C00000_0_0_0.png': No such file or directory
May 31 15:56:33 dreambox enigma2[484]: CAC: DEBUG: FileManagerJob.py: getLockList: lock_list: {}
May 31 15:56:33 dreambox enigma2[484]: gPixmap: Failed to access '/usr/share/enigma2/picon_50x30/1_256_19_283E_3FB_1_C00000_0_0_0.png': No such file or directory
May 31 15:56:33 dreambox enigma2[484]: CAC: DEBUG: FileManagerJob.py: getLockList: lock_list: {}
May 31 15:56:33 dreambox enigma2[484]: gPixmap: Failed to access '/usr/share/enigma2/picon_50x30/1_256_19_EF75_3F9_1_C00000_0_0_0.png': No such file or directory
May 31 15:56:33 dreambox enigma2[484]: CAC: DEBUG: FileManagerJob.py: getLockList: lock_list: {}
May 31 15:56:33 dreambox enigma2[484]: gPixmap: Failed to access '/usr/share/enigma2/picon_50x30/1_256_19_EF75_3F9_1_C00000_0_0_0.png': No such file or directory
May 31 15:56:33 dreambox enigma2[484]: CAC: DEBUG: FileManagerJob.py: getLockList: lock_list: {}
May 31 15:56:33 dreambox enigma2[484]: gPixmap: Failed to access '/usr/share/enigma2/picon_50x30/1_256_19_2B66_3F3_1_C00000_0_0_0.png': No such file or directory
May 31 15:56:33 dreambox enigma2[484]: CAC: DEBUG: FileManagerJob.py: getLockList: lock_list: {}
May 31 15:56:33 dreambox enigma2[484]: gPixmap: Failed to access '/usr/share/enigma2/picon_50x30/1_256_19_283D_3FB_1_C00000_0_0_0.png': No such file or directory
May 31 15:56:33 dreambox enigma2[484]: CAC: DEBUG: FileManagerJob.py: getLockList: lock_list: {}
May 31 15:56:33 dreambox enigma2[484]: gPixmap: Failed to access '/usr/share/enigma2/picon_50x30/1_256_19_EF10_421_1_C00000_0_0_0.png': No such file or directory
May 31 15:56:33 dreambox enigma2[484]: CAC: DEBUG: FileManagerJob.py: getLockList: lock_list: {}
May 31 15:56:33 dreambox enigma2[484]: gPixmap: Failed to access '/usr/share/enigma2/picon_50x30/1_256_19_EF75_3F9_1_C00000_0_0_0.png': No such file or directory
May 31 15:56:33 dreambox enigma2[484]: CAC: DEBUG: FileManagerJob.py: getLockList: lock_list: {}
May 31 15:56:33 dreambox enigma2[484]: gPixmap: Failed to access '/usr/share/enigma2/picon_50x30/1_256_19_2E9B_411_1_C00000_0_0_0.png': No such file or directory
May 31 15:56:33 dreambox enigma2[484]: CAC: DEBUG: FileManagerJob.py: getLockList: lock_list: {}
May 31 15:56:33 dreambox enigma2[484]: gPixmap: Failed to access '/usr/share/enigma2/picon_50x30/1_256_19_283D_3FB_1_C00000_0_0_0.png': No such file or directory
May 31 15:56:33 dreambox enigma2[484]: CAC: DEBUG: FileManagerJob.py: getLockList: lock_list: {}
May 31 15:56:33 dreambox enigma2[484]: gPixmap: Failed to access '/usr/share/enigma2/picon_50x30/1_256_19_EF77_3F9_1_C00000_0_0_0.png': No such file or directory
May 31 15:56:33 dreambox enigma2[484]: CAC: DEBUG: FileManagerJob.py: getLockList: lock_list: {}
May 31 15:56:33 dreambox enigma2[484]: gPixmap: Failed to access '/usr/share/enigma2/picon_50x30/1_256_19_2B66_3F3_1_C00000_0_0_0.png': No such file or directory
May 31 15:56:33 dreambox enigma2[484]: CAC: DEBUG: FileManagerJob.py: getLockList: lock_list: {}
May 31 15:56:34 dreambox enigma2[484]: libpng warning: iCCP: known incorrect sRGB profile
May 31 15:56:34 dreambox enigma2[484]: gPixmap: Failed to access '/usr/share/enigma2/picon_50x30/1_256_19_EF10_421_1_C00000_0_0_0.png': No such file or directory
May 31 15:56:34 dreambox enigma2[484]: MVC: INFO: ServiceCenter.py: __init__: ... (2 times)
May 31 15:56:35 dreambox enigma2[484]: action ->  CockpitActions DOWN
May 31 15:56:35 dreambox enigma2[484]: MVC: INFO: MovieCockpit.py: updateSortModeDisplay: current_sort_mode: 0
May 31 15:56:35 dreambox enigma2[484]: CAC: DEBUG: FileManagerJob.py: getLockList: lock_list: {}
May 31 15:56:35 dreambox enigma2[484]: CAC: INFO: FileManagerCache.py: getCountSize: path: /media/hdd/movie/trashcan
May 31 15:56:35 dreambox enigma2[484]: CAC: DEBUG: FileManagerCache.py: getFile: table: recordings, path: /media/hdd/movie/trashcan
May 31 15:56:35 dreambox enigma2[484]: CAC: DEBUG: FileManagerCacheSQL.py: sqlSelect: sql: SELECT * FROM recordings WHERE path = ?, args: ['/media/hdd/movie/trashcan']
May 31 15:56:35 dreambox enigma2[484]: MNC: INFO: MountCockpit.py: getVirtualDirs: plugin: MVC, dirs: ['/media/hdd/movie/trashcan']
May 31 15:56:35 dreambox enigma2[484]: CAC: DEBUG: FileManagerCacheSQL.py: sqlSelect: sql: SELECT * FROM recordings WHERE path LIKE ? AND file_type = ?, args: ['/media/hdd/movie/trashcan/%', 1]
May 31 15:56:35 dreambox enigma2[484]: CAC: DEBUG: FileManagerCache.py: getCountSize: path: /media/hdd/movie/trashcan, total_count: 1, total_size: 2295705600
May 31 15:56:35 dreambox enigma2[484]: CAC: DEBUG: FileManagerJob.py: getLockList: lock_list: {}
May 31 15:56:35 dreambox enigma2[484]: gPixmap: Failed to access '/usr/share/enigma2/picon_50x30/1_256_19_283D_3FB_1_C00000_0_0_0.png': No such file or directory
May 31 15:56:35 dreambox enigma2[484]: MVC: INFO: ServiceCenter.py: __init__: ...
May 31 15:56:35 dreambox enigma2[484]: CAC: INFO: FileManager.py: getMovieFile: table: covers, path: /media/hdd/movie/20230531 1556 - Das Erste HD - Sturm der Liebe.ts
May 31 15:56:35 dreambox enigma2[484]: CAC: DEBUG: FileManagerCache.py: getFile: table: covers, path: /media/hdd/movie/20230531 1556 - Das Erste HD - Sturm der Liebe.ts
May 31 15:56:35 dreambox enigma2[484]: CAC: DEBUG: FileManagerCacheSQL.py: sqlSelect: sql: SELECT * FROM covers WHERE file_name = ?, args: ['20230531 1556 - Das Erste HD - Sturm der Liebe.ts']
May 31 15:56:35 dreambox enigma2[484]: MVC: INFO: ServiceCenter.py: __init__: ...
May 31 15:56:37 dreambox enigma2[484]: no cue sheet. forcing normal play
May 31 15:56:38 dreambox enigma2[484]: action ->  CockpitActions EXIT
May 31 15:56:38 dreambox enigma2[484]: MVC: INFO: MovieCockpit.py: exit: reload_moviecockpit: False
May 31 15:56:38 dreambox enigma2[484]: MVC: INFO: MovieCockpit.py: onDialogHide: self.return_path: /media/hdd/movie/20230531 1556 - Das Erste HD - Sturm der Liebe.ts
May 31 15:56:38 dreambox enigma2[484]: CAC: INFO: FileManagerCache.py: onDatabaseLoaded: ...
May 31 15:56:38 dreambox enigma2[484]: CAC: INFO: FileManagerCache.py: onDatabaseLoadedCallback: ...
May 31 15:56:38 dreambox enigma2[484]: CAC: INFO: FileManagerCache.py: onDatabaseChanged: ...
May 31 15:56:38 dreambox enigma2[484]: MVC: INFO: MovieCockpit.py: updateSortModeDisplay: current_sort_mode: 0
May 31 15:56:38 dreambox enigma2[484]: I/  [InfoBar.__restoreState] :: <no detail>