20:51:01.310 [e2-python] ProcessRepeated
20:51:01.310 [e2-python] [#----] VTiCore [TIMER]activating state 3
20:51:01.311 [e2-python] [#----] VTiCore [TIMER]stop recording
20:51:01.311 [e2-python] [#----] VTiCore [VTiEvent] PVRDESCRAMBLE_STOP Jack und Jill, Sky Hits/media/hdd/Aufnahmen/Jack und Jill.ts, 1579809060, 1579809061
20:51:01.311 [e2-core] stop recording!
20:51:01.311 [e2-core] (was not recording)
20:51:01.312 [e2-python] [#----] VTiCore [TIMER]record event 5
20:51:01.313 [e2-python] [#----] VTiCore [TIMER]record event 1
20:51:01.317 [e2-python] [#----] VTiCore [remove callback]
20:51:01.318 [e2-core] decoder state: play, vpid=-1, apid=-1
20:51:01.319 [e2-core] DEMUX_STOP - video - ok
20:51:01.322 [e2-core] VIDEO_STOP - ok
20:51:01.332 [e2-core] AUDIO_STOP - ok
20:51:01.332 [e2-core] DEMUX_STOP - audio - ok
20:51:01.342 [e2-core] AUDIO_CONTINUE - ok
20:51:01.344 [e2-core] [eDVBCAService] free slot 0 demux 0 for service 1:0:19:6B:C:85:C00000:0:0:0::Sky Hits/media/hdd/Aufnahmen/Jack und Jill.ts
20:51:01.344 [e2-core] [eDVBCAService] free service 1:0:19:6B:C:85:C00000:0:0:0::Sky Hits/media/hdd/Aufnahmen/Jack und Jill.ts
20:51:01.344 [e2-core] [eDVBCIInterfaces] remove last pmt handler for service 1:0:19:6B:C:85:C00000:0:0:0::Sky Hits/media/hdd/Aufnahmen/Jack und Jill.ts send empty capmt
20:51:01.346 [e2-core] stop ecm
20:51:01.346 [e2-core] stop ecm
20:51:01.346 [e2-core] stop ecm
20:51:01.347 [e2-core] (3) slot 0 usecount is now 0
20:51:01.348 [e2-core] start release channel timer
20:51:01.348 [e2-python] [#----] VTiCore [SILENT_REC] we are in auto mode
20:51:01.349 [e2-python] next real activation isFri Jan 24 01:35:43 2020
20:51:01.349 [e2-python] [#----] VTiCore state: 3
20:51:01.349 [e2-python] [#----] VTiCore in processed: False
20:51:01.349 [e2-python] [#----] VTiCore in running: False
20:51:01.351 [e2-core] Removing /media/hdd/Aufnahmen/Jack und Jill_pvrdesc.ts...
20:51:01.351 [e2-core] before: 1
20:51:01.351 [e2-core] after: 1
20:51:01.351 [e2-core] old thread joined 0
20:51:01.352 [e2-core] Removing /media/hdd/Aufnahmen/Jack und Jill_pvrdesc.ts.meta...
20:51:01.352 [e2-core] setIoPrio best-effort level 7 ok
20:51:01.352 [e2-core] before: 1
20:51:01.352 [e2-core] Removing /media/hdd/Aufnahmen/Jack und Jill_pvrdesc.ts.ap...
20:51:01.352 [e2-core] file /media/hdd/Aufnahmen/Jack und Jill_pvrdesc.ts.del erased
20:51:01.352 [e2-core] Removing /media/hdd/Aufnahmen/Jack und Jill_pvrdesc.ts.sc...
20:51:01.352 [e2-core] Removing /media/hdd/Aufnahmen/Jack und Jill_pvrdesc.ts.cuts...
20:51:01.352 [e2-core] file /media/hdd/Aufnahmen/Jack und Jill_pvrdesc.ts.meta.del erased
20:51:01.352 [e2-core] Removing /media/hdd/Aufnahmen/Jack und Jill_pvrdesc.ts.info...
20:51:01.353 [e2-core] Removing /media/hdd/Aufnahmen/Jack und Jill_pvrdesc.ts.txt...
20:51:01.353 [e2-core] Removing /media/hdd/Aufnahmen/Jack und Jill_pvrdesc.ts.jpg...
20:51:01.353 [e2-core] Removing /media/hdd/Aufnahmen/Jack und Jill_pvrdesc.ts.png...
20:51:01.353 [e2-core] Removing /media/hdd/Aufnahmen/Jack und Jill_pvrdesc.ts.jpeg...
20:51:01.353 [e2-core] Removing /media/hdd/Aufnahmen/Jack und Jill_pvrdesc.ts.rec...
20:51:01.353 [e2-core] Removing /media/hdd/Aufnahmen/Jack und Jill_pvrdesc.ts.del...
20:51:01.353 [e2-core] Removing /media/hdd/Aufnahmen/Jack und Jill_pvrdesc.eit...
20:51:01.353 [e2-core] before: 1
20:51:01.354 [e2-core] Removing /media/hdd/Aufnahmen/Jack und Jill_pvrdesc.info...
20:51:01.354 [e2-core] file /media/hdd/Aufnahmen/Jack und Jill_pvrdesc.eit.del erased
20:51:01.354 [e2-core] Removing /media/hdd/Aufnahmen/Jack und Jill_pvrdesc.txt...
20:51:01.354 [e2-core] Removing /media/hdd/Aufnahmen/Jack und Jill_pvrdesc.jpg...
20:51:01.354 [e2-core] Removing /media/hdd/Aufnahmen/Jack und Jill_pvrdesc.png...
20:51:01.354 [e2-core] Removing /media/hdd/Aufnahmen/Jack und Jill_pvrdesc.jpeg...
20:51:01.354 [e2-core] Removing /media/hdd/Aufnahmen/Jack und Jill_pvrdesc.rec...
20:51:01.354 [e2-core] Removing /media/hdd/Aufnahmen/Jack und Jill_pvrdesc.del...
20:51:04.319 [e2-python] [#----] VTiCore [PVRDescramble] get unscrambled recordings
20:51:04.321 [e2-python] [#----] VTiCore getRecordings : []
20:51:04.321 [e2-python] playing service..
20:51:04.338 [e2-python] [#----] VTiCore not pauseable.
20:51:04.339 [e2-python] RemovePopup, id =ZapError
20:51:04.339 [e2-core] use cached_channel
20:51:04.339 [e2-core] stop release channel timer
20:51:04.340 [e2-core] allocate Channel: res 0
20:51:04.340 [e2-core] '1:0:19:6B:C:85:C00000:0:0:0::Sky Hits' is in service list of slot 0... so use it
20:51:04.340 [e2-core] (1)CISlot 0, usecount now 1
20:51:04.341 [e2-core] no version filtering
20:51:04.341 [e2-core] 0012: 4e 00 6b 00 00 00
20:51:04.341 [e2-core] mask: ff ff ff 00 00 00
20:51:04.341 [e2-core] mode: 00 00 00 00 00 00
20:51:04.342 [e2-core] ok ... now we start!!
20:51:04.342 [e2-core] no version filtering
20:51:04.342 [e2-core] 0000: 00 00 00 00 00 00
20:51:04.342 [e2-core] mask: ff 00 00 00 00 00
20:51:04.342 [e2-core] mode: 00 00 00 00 00 00
20:51:04.343 [e2-core] eventNewProgramInfo 0 0
20:51:04.343 [e2-core] have 1 video stream(s) (02ff), and 1 audio stream(s) (0303), and the pcr pid is 02ff, and the text pid is ffffffff
20:51:04.346 [e2-core] disable teletext subtitles
20:51:04.355 [e2-core] PES filter: DMX_SET_PES_FILTER - Invalid argument
20:51:04.356 [e2-core] decoder state: play, vpid=767, apid=771
20:51:04.356 [e2-core] DMX_SET_PES_FILTER(0x2ff) - pcr - ok
20:51:04.356 [e2-core] DEMUX_START - pcr - ok
20:51:04.360 [e2-core] DMX_SET_PES_FILTER(0x303) - audio - ok
20:51:04.361 [e2-core] DEMUX_START - audio - ok
20:51:04.369 [e2-core] AUDIO_SET_BYPASS(0) - ok
20:51:04.374 [e2-core] AUDIO_PAUSE - ok
20:51:04.381 [e2-core] AUDIO_PLAY - ok
20:51:04.382 [e2-core] Video Device: /dev/dvb/adapter0/video0
20:51:04.382 [e2-core] demux device: /dev/dvb/adapter0/demux0
20:51:04.390 [e2-core] VIDEO_SET_STREAMTYPE 1 - ok
20:51:04.391 [e2-core] DMX_SET_PES_FILTER(0x2ff) - video - ok
20:51:04.391 [e2-core] DEMUX_START - video - ok
20:51:04.396 [e2-core] VIDEO_FREEZE - ok
20:51:04.405 [e2-core] VIDEO_PLAY - ok
20:51:04.410 [e2-core] VIDEO_SLOWMOTION(0) - ok
20:51:04.415 [e2-core] VIDEO_FAST_FORWARD(0) - ok
20:51:04.420 [e2-core] VIDEO_CONTINUE - ok
20:51:04.430 [e2-core] AUDIO_CONTINUE - ok
20:51:04.430 [e2-python] [#----] VTiCore not pauseable.
20:51:04.453 [e2-python] [AutoRes] service changed
20:51:04.456 [e2-core] resolve: resolve ${sysconfdir}/scan_tp_valid_check.py
20:51:04.456 [e2-core] resolve: -> /etc/scan_tp_valid_check.py
20:51:04.457 [e2-python] [#----] VTiCore [VTiEvent] SERVICE_START 1:0:19:6B:C:85:C00000:0:0:0::Sky Hits, Sky Hits
20:51:04.469 [e2-core] -+ 1/2 TID 4e
20:51:04.470 [e2-core] + 1/1 TID 00
20:51:04.470 [e2-core] done!
20:51:04.470 [e2-core] PATready
20:51:04.470 [e2-core] use pmtpid 0062 for service_id 006b
20:51:04.470 [e2-core] no version filtering
20:51:04.470 [e2-core] 0062: 02 00 6b 00 00 00
20:51:04.471 [e2-core] mask: ff ff ff 00 00 00
20:51:04.471 [e2-core] mode: 00 00 00 00 00 00
20:51:04.471 [e2-core] doing version filtering
20:51:04.471 [e2-core] 0000: 00 00 00 17 00 00
20:51:04.471 [e2-core] mask: ff 00 00 3f 00 00
20:51:04.471 [e2-core] mode: 00 00 00 3e 00 00
20:51:04.569 [e2-core] + 1/1 TID 02
20:51:04.569 [e2-core] done!
20:51:04.570 [e2-core] eventNewProgramInfo 0 0
20:51:04.570 [e2-core] [autoAudioTrack] use audio track: 0
20:51:04.571 [e2-core] have 1 video stream(s) (02ff), and 2 audio stream(s) (0303, 0304), and the pcr pid is 02ff, and the text pid is ffffffff
20:51:04.578 [e2-core] PES filter: DMX_SET_PES_FILTER - Invalid argument
20:51:04.578 [e2-core] decoder state: play, vpid=767, apid=771
20:51:04.583 [e2-core] VIDEO_SLOWMOTION(0) - ok
20:51:04.588 [e2-core] VIDEO_FAST_FORWARD(0) - ok
20:51:04.593 [e2-core] VIDEO_CONTINUE - ok
20:51:04.603 [e2-core] AUDIO_CONTINUE - ok
20:51:04.607 [e2-core] [autoAudioTrack] use audio track: 0
20:51:04.617 [e2-core] [eDVBCAService] new service 1:0:19:6B:C:85:C00000:0:0:0::Sky Hits
20:51:04.617 [e2-core] [eDVBCAService] add demux 0 to slot 0 service 1:0:19:6B:C:85:C00000:0:0:0::Sky Hits
20:51:04.617 [e2-core] '1:0:19:6B:C:85:C00000:0:0:0::Sky Hits' is in service list of slot 0... so use it
20:51:04.617 [e2-core] PES Start CAPID = 6923 Caid = 2500
20:51:04.618 [e2-core] PES Start CAPID = 6667 Caid = 2444
20:51:04.618 [e2-core] PES Start CAPID = 7179 Caid = 2445
20:51:04.619 [e2-core] demux 0 mask 01 prevhash 00000000
20:51:04.619 [e2-core] [eDVBCAService] send 62 bytes
20:51:04.620 [e2-core] doing version filtering
20:51:04.620 [e2-core] 0062: 02 00 6b 05 00 00
20:51:04.620 [e2-core] mask: ff ff ff 3f 00 00
20:51:04.620 [e2-core] mode: 00 00 00 3e 00 00
20:51:05.269 [e2-core] ++ 2/2 TID 4e
20:51:05.269 [e2-core] done!
20:51:05.284 [e2-core] doing version filtering
20:51:05.284 [e2-core] 0012: 4e 00 6b 0d 00 00
20:51:05.284 [e2-core] mask: ff ff ff 3f 00 00
20:51:05.284 [e2-core] mode: 00 00 00 3e 00 00
20:51:05.459 [e2-python] [AutoRes] determineContent
20:51:07.010 [e2-python] next real activation isFri Jan 24 02:33:01 2020