Searching for plugins (VDR 2.4.2/2.4.2) (cache hit): vaapidevice ddci2 ciplus remote skinnopacity externalplayer osdteletext devstatus femon tvguide recsearch dvdswitch live dvd radio markad streamdev-server suspendoutput epgborder epgsearch epg2vdr scraper2vdr.
Jun 29 21:14:07 roadrunner vdr: [18283] CAM 1: module ready
Jun 29 21:14:08 roadrunner vdr: [18287] CAM 2: no module present
Jun 29 21:14:09 roadrunner vdr: [18283] CAM 1: Sky NDS CI Plus Modul, 01, CAFE, BABE
Jun 29 21:14:23 roadrunner vdr: [18283] CAM 1: system ids: 098C
Jun 29 21:14:23 roadrunner vdr: [18283] CAM 1: activating static CaPmt mapping: CAID 0x098C, 2 services, 4 pids
Jun 29 21:14:23 roadrunner vdr: [18283] CAM 1: Tweaks [enabled]: Flags: 0x1843, Limit: 2 (MCD STATIC DESELECT DEBUG)
Jun 29 21:14:23 roadrunner vdr: [18283] CAM 1: multi channel decryption (MCD) forced by Setup!
Jun 29 21:14:23 roadrunner vdr: [18283] CAM 1: supports multi transponder decryption (MTD)
Jun 29 21:14:23 roadrunner vdr: [18283] CAM 1: activating MTD support
Jun 29 21:14:23 roadrunner vdr: [18283] CAM 1/0: resend ProgramList
Jun 29 21:14:23 roadrunner vdr: [18270] CAM 1: ready, master (Sky NDS CI Plus Modul)
Jun 29 21:14:23 roadrunner vdr: [18270] CAM 2: ready, master (empty)
Jun 29 21:14:23 roadrunner vdr: [18270] switching to channel 114 S19.2E-133-13-110 (Sky Atlantic HD)
Jun 29 21:14:23 roadrunner vdr: [18270] CAM 1: CanDecrypt(110/1000-) limit 2 - active 0 -> TRUE
Jun 29 21:14:23 roadrunner vdr: [18270] CAM 1: CanDecrypt(110/1000-) limit 2 - active 0 -> TRUE
Jun 29 21:14:23 roadrunner vdr: [18270] CAM 1/1: creating new MTD CAM slot
Jun 29 21:14:23 roadrunner vdr: [18270] ...cs:setpid + 1(1)
Jun 29 21:14:23 roadrunner vdr: [18270] CAM 1: assigned to device 1
Jun 29 21:14:23 roadrunner vdr: [18270] SendCaPmts CAM 1: [0] actives in CAM: 0 -> 0 (0 pids)
Jun 29 21:14:23 roadrunner vdr: [18270] ...cs:setpid + 1279(4FF)
Jun 29 21:14:23 roadrunner vdr: [18270] ...cs:setpid + 1283(503)
Jun 29 21:14:23 roadrunner vdr: [18270] ...cs:setpid + 1284(504)
Jun 29 21:14:23 roadrunner vdr: [18270] BuildCaPmts CAM 1/1: Sid 110 (6E) -> 110 (6E)
Jun 29 21:14:23 roadrunner vdr: [18270] BuildCaPmts CAM 1/1: Pid 1279 (4FF) +
Jun 29 21:14:23 roadrunner vdr: [18270] BuildCaPmts CAM 1/1: Pid 1283 (503) +
Jun 29 21:14:23 roadrunner vdr: [18270] BuildCaPmts CAM 1/1: Pid 1284 (504) +
Jun 29 21:14:23 roadrunner vdr: [18270] ------ MtdMapSid: 110 (006E) -> 256 (0100)
Jun 29 21:14:23 roadrunner vdr: [18270] ------ MtdMapPid: 1279 (04FF) -> 256 (0100)
Jun 29 21:14:23 roadrunner vdr: [18270] ------ MtdMapPid: 1283 (0503) -> 257 (0101)
Jun 29 21:14:23 roadrunner vdr: [18270] ------ MtdMapPid: 1284 (0504) -> 258 (0102)
Jun 29 21:14:23 roadrunner vdr: [18270] BuildCaPmts CAM 1/1: ListManagement CPLM_ADD
Jun 29 21:14:23 roadrunner vdr: [18270] BuildCaPmts CAM 1/1: [ok_descrambling] ActiveProgs: 1 of 1 (3 Pids)
Jun 29 21:14:23 roadrunner vdr: [18270] >>> StatCapmt: capmt <4> 256(100)
Jun 29 21:14:23 roadrunner vdr: [18270] >>> StatCapmt: capmt    p -256(100)
Jun 29 21:14:23 roadrunner vdr: [18270] >>> StatCapmt: capmt    p -257(101)
Jun 29 21:14:23 roadrunner vdr: [18270] >>> StatCapmt: capmt    p -258(102)
Jun 29 21:14:23 roadrunner vdr: [18270] >>> StatCapmt: Sid 256(100) EsPids/EcmPids/CaIds: 0/0/0
Jun 29 21:14:23 roadrunner vdr: [18270] SendCaPmts CAM 1: [1] actives in CAM: 0 -> 1 (3 pids)
Jun 29 21:14:23 roadrunner vdr: [18270] setting watchdog timer to 180 seconds
Jun 29 21:14:23 roadrunner vdr: [18312] device 1 receiver thread started (pid=18270, tid=18312, prio=high)
Jun 29 21:14:23 roadrunner vdr: [18313] SVDRP server handler thread started (pid=18270, tid=18313, prio=low)
Jun 29 21:14:23 roadrunner vdr: [18313] SVDRP roadrunner opening port 6419/tcp
Jun 29 21:14:23 roadrunner vdr: [18313] SVDRP roadrunner listening on port 6419/tcp
Jun 29 21:14:23 roadrunner vdr: [18314] device 1 TS buffer thread started (pid=18270, tid=18314, prio=high)
Jun 29 21:14:23 roadrunner vdr: [18315] SVDRP client handler thread started (pid=18270, tid=18315, prio=low)
Jun 29 21:14:23 roadrunner vdr: [18270] VAAPI: video: set trick-speed 0
Jun 29 21:14:23 roadrunner vdr: [18315] SVDRP roadrunner opening port 6419/udp
Jun 29 21:14:23 roadrunner vdr: [18315] SVDRP roadrunner listening on port 6419/udp
Jun 29 21:14:23 roadrunner vdr: [18315] SVDRP roadrunner > 255.255.255.255:6419 send dgram 'SVDRP:discover name:roadrunner port:6419 vdrversion:20402 apiversion:20402 timeout:300'
Jun 29 21:14:23 roadrunner vdr: [18316] VAAPI: video: display thread started
Jun 29 21:14:23 roadrunner vdr: [18316] VAAPI: video/event: MapNotify
Jun 29 21:14:23 roadrunner vdr: [18316] VAAPI: video/vaapi: associate 04000000
Jun 29 21:14:23 roadrunner vdr: [18316] VAAPI: video/vaapi: search format NV12 in 9 image formats
Jun 29 21:14:23 roadrunner vdr: [18316] VAAPI: video/vaapi: supported image formats:
Jun 29 21:14:23 roadrunner vdr: [18316] VAAPI: video/vaapi:#011YV12#0110
Jun 29 21:14:23 roadrunner vdr: [18316] VAAPI: video/vaapi:#011I420#0110
Jun 29 21:14:23 roadrunner vdr: [18316] VAAPI: video/vaapi:#011NV12#0110
Jun 29 21:14:23 roadrunner vdr: [18316] VAAPI: video/vaapi:#011YUY2#0110
Jun 29 21:14:23 roadrunner vdr: [18316] VAAPI: video/vaapi:#011UYVY#0110
Jun 29 21:14:23 roadrunner vdr: [18316] VAAPI: video/vaapi:#011422H#0110
Jun 29 21:14:23 roadrunner vdr: [18316] VAAPI: video/vaapi:#011RGBX#01124
Jun 29 21:14:23 roadrunner vdr: [18316] VAAPI: video/vaapi:#011BGRX#01124
Jun 29 21:14:23 roadrunner vdr: [18316] VAAPI: video/vaapi:#011P010#0110
Jun 29 21:14:23 roadrunner vdr: [18316] VAAPI: video/vaapi: use#011NV12#0110
Jun 29 21:14:23 roadrunner vdr: [18283] +++++++ SendData Tag: 9F9010 (L:48.)
Jun 29 21:14:23 roadrunner vdr: [18270] OSD size changed to 1920x1080 @ 1
Jun 29 21:14:23 roadrunner vdr: [18283] +++++++ SendData Tag: 9F8441 (L:15.)
Jun 29 21:14:23 roadrunner vdr: [18270] VAAPI: video/vaapi: clear image
Jun 29 21:14:24 roadrunner vdr: [18270] CAM 1: CanDecrypt(110/1000-) limit 2 - active 1 -> TRUE
Jun 29 21:14:24 roadrunner vdr: [18270] switching device 1 to channel 114 S19.2E-133-13-110 (Sky Atlantic HD)
Jun 29 21:14:24 roadrunner vdr: [18270] SendCaPmts CAM 1: [0] actives in CAM: 1 -> 1 (3 pids)
Jun 29 21:14:24 roadrunner vdr: [18270] timer 1 (114 2010-2120 'Serien~Westworld~(S03E04) Mutter der Exilanten') start
Jun 29 21:14:24 roadrunner vdr: [18270] Title: 'Westworld' Subtitle: '(S03E04) Mutter der Exilanten'
Jun 29 21:14:24 roadrunner vdr: [18270] executing '/usr/lib/vdr/vdr-recordingaction before "/srv/vdr/video/local/Serien/Westworld/(S03E04)_Mutter_der_Exilanten/2020-06-29.20.10.114-0.rec"'
Jun 29 21:14:24 roadrunner vdr: [18270] record /srv/vdr/video/local/Serien/Westworld/(S03E04)_Mutter_der_Exilanten/2020-06-29.20.10.114-0.rec
Jun 29 21:14:24 roadrunner vdr: [18270] Starting NALU fill dumper
Jun 29 21:14:24 roadrunner vdr: [18270] cFileName::SetOffset: removing zero-sized file /srv/vdr/video/local/Serien/Westworld/(S03E04)_Mutter_der_Exilanten/2020-06-29.20.10.114-0.rec/00002.ts
Jun 29 21:14:24 roadrunner vdr: [18270] recording to '/srv/vdr/video/local/Serien/Westworld/(S03E04)_Mutter_der_Exilanten/2020-06-29.20.10.114-0.rec/00002.ts'
Jun 29 21:14:24 roadrunner vdr: [18270] SendCaPmts CAM 1: [0] actives in CAM: 1 -> 1 (3 pids)
Jun 29 21:14:24 roadrunner vdr: [18326] recording thread started (pid=18270, tid=18326, prio=high)
Jun 29 21:14:24 roadrunner vdr: [18270] markad: cannot find timer for '/srv/vdr/video/local/Serien/Westworld/(S03E04)_Mutter_der_Exilanten/2020-06-29.20.10.114-0.rec'
Jun 29 21:14:24 roadrunner vdr: [18270] markad: no logo found for Serien~Westworld~(S03E04) Mutter der Exilanten
Jun 29 21:14:24 roadrunner vdr: [18270] writing timer id '1@roadrunner' to /srv/vdr/video/local/Serien/Westworld/(S03E04)_Mutter_der_Exilanten/2020-06-29.20.10.114-0.rec/.timer
Jun 29 21:14:24 roadrunner vdr: [18312] >>> StatCapmt: mapped PID 256(0100) to 2048(0800)
Jun 29 21:14:24 roadrunner vdr: [18312] >>> StatCapmt: mapped PID 257(0101) to 2049(0801)
Jun 29 21:14:24 roadrunner vdr: [18312] >>> StatCapmt: mapped PID 258(0102) to 2050(0802)
Jun 29 21:14:24 roadrunner vdr: [18312] >>> StatCapmt: mapped PID 259(0103) to 2051(0803)
Jun 29 21:14:24 roadrunner vdr: [18270] max. latency time 1 seconds
Jun 29 21:14:24 roadrunner vdr: [18304] EPGSearch: search timer update started
Jun 29 21:14:24 roadrunner vdr: [18305] EPGSearch: timer conflict check started
Jun 29 21:14:24 roadrunner vdr: [18305] EPGSearch: timer conflict check finished
Jun 29 21:14:24 roadrunner vdr: [18283] +++++++ SendData Tag: 400041 (L:9.)
Jun 29 21:14:24 roadrunner vdr: [18283] +++++++ SendData Tag: 9F8441 (L:15.)
Jun 29 21:14:24 roadrunner vdr: [18283] +++++++ SendData Tag: 9F8802 (L:10.)
Jun 29 21:14:24 roadrunner vdr: [18312] ------ InjectEit: 1000 (03E8) -> 1000 (03E8)
Jun 29 21:14:24 roadrunner vdr: [18312] ------ InjectEit: 1000 (03E8) -> 1000 (03E8)
Jun 29 21:14:24 roadrunner vdr: [18312] ...cs:setpid + 4104(1008)
Jun 29 21:14:24 roadrunner vdr: [18312] ------ MtdMapPid: 4104 (1008) -> 260 (0104)
Jun 29 21:14:24 roadrunner vdr: [18312] >>> StatCapmt: mapped PID 260(0104) to 2052(0804)
Jun 29 21:14:24 roadrunner vdr: [18312] ------ MtdMapPid: 4104 (1008) -> 260 (0104)
Jun 29 21:14:24 roadrunner vdr: [18312] ------ MtdMapPid: 4104 (1008) -> 260 (0104)
Jun 29 21:14:25 roadrunner vdr: [18312] ------ InjectEit: 1000 (03E8) -> 1000 (03E8)
Jun 29 21:14:25 roadrunner vdr: [18312] ------ InjectEit: 1000 (03E8) -> 1000 (03E8)
Jun 29 21:14:25 roadrunner vdr: [18270] stopping recording due to modification of channel 114 (Sky Atlantic HD)
Jun 29 21:14:25 roadrunner vdr: [18326] recording thread ended (pid=18270, tid=18326)
Jun 29 21:14:25 roadrunner vdr: [18270] SendCaPmts CAM 1: [0] actives in CAM: 1 -> 1 (3 pids)
Jun 29 21:14:25 roadrunner vdr: [18270] NALU fill dumper: 0 of 0 packets dropped, 0%
Jun 29 21:14:25 roadrunner vdr: [18270] buffer stats: 293468 (0%) used
Jun 29 21:14:25 roadrunner vdr: [18270] timer 1 (114 2010-2120 'Serien~Westworld~(S03E04) Mutter der Exilanten') stop
Jun 29 21:14:25 roadrunner vdr: [18270] removing /srv/vdr/video/local/Serien/Westworld/(S03E04)_Mutter_der_Exilanten/2020-06-29.20.10.114-0.rec/.timer
Jun 29 21:14:25 roadrunner vdr: [18329] EPGSearch: recdone thread started (pid=18270, tid=18329, prio=high)
Jun 29 21:14:25 roadrunner vdr: [18270] executing '/usr/lib/vdr/vdr-recordingaction after "/srv/vdr/video/local/Serien/Westworld/(S03E04)_Mutter_der_Exilanten/2020-06-29.20.10.114-0.rec"'
Jun 29 21:14:25 roadrunner vdr: [18329] EPGSearch: recdone thread ended (pid=18270, tid=18329)
Jun 29 21:14:25 roadrunner vdr: [18270] retuning due to modification of channel 114 (Sky Atlantic HD)
Jun 29 21:14:25 roadrunner vdr: [18270] switching to channel 114 S19.2E-133-13-110 (Sky Atlantic HD)
Jun 29 21:14:25 roadrunner vdr: [18316] VAAPI: video: reset start
Jun 29 21:14:25 roadrunner vdr: [18316] VAAPI: video: set clock --:--:--.---
Jun 29 21:14:25 roadrunner vdr: [18270] ...cs:setpid - 1279(4FF)
Jun 29 21:14:25 roadrunner vdr: [18270] ...cs:setpid - 1283(503)
Jun 29 21:14:25 roadrunner vdr: [18270] ...cs:setpid - 1284(504)
Jun 29 21:14:25 roadrunner vdr: [18270] BuildCaPmts CAM 1/1: Sid 110 (6E) -> 110 (6E)
Jun 29 21:14:25 roadrunner vdr: [18270] BuildCaPmts CAM 1/1: Pid 1279 (4FF) -
Jun 29 21:14:25 roadrunner vdr: [18270] BuildCaPmts CAM 1/1: Pid 1283 (503) -
Jun 29 21:14:25 roadrunner vdr: [18270] BuildCaPmts CAM 1/1: Pid 1284 (504) -
Jun 29 21:14:25 roadrunner vdr: [18270] ------ MtdMapSid: 110 (006E) -> 256 (0100)
Jun 29 21:14:25 roadrunner vdr: [18270] ------ MtdMapPid: 6670 (1A0E) -> 261 (0105)
Jun 29 21:14:25 roadrunner vdr: [18270] ------ MtdMapPid: 1279 (04FF) -> 256 (0100)
Jun 29 21:14:25 roadrunner vdr: [18270] ------ MtdMapPid: 1283 (0503) -> 257 (0101)
Jun 29 21:14:25 roadrunner vdr: [18270] ------ MtdMapPid: 1284 (0504) -> 258 (0102)
Jun 29 21:14:25 roadrunner vdr: [18270] BuildCaPmts CAM 1/1: ListManagement CPLM_UPDATE
Jun 29 21:14:25 roadrunner vdr: [18270] BuildCaPmts CAM 1/1: [not_selected] ActiveProgs: 0 of 1 (0 Pids)
Jun 29 21:14:25 roadrunner vdr: [18270] >>> StatCapmt: capmt <5> 256(100)
Jun 29 21:14:25 roadrunner vdr: [18270] >>> StatCapmt: capmt   [4] ca 98C e 261(105)
Jun 29 21:14:25 roadrunner vdr: [18270] >>> StatCapmt: capmt    p -256(100)
Jun 29 21:14:25 roadrunner vdr: [18270] >>> StatCapmt: capmt    p -257(101)
Jun 29 21:14:25 roadrunner vdr: [18270] >>> StatCapmt: capmt    p -258(102)
Jun 29 21:14:25 roadrunner vdr: [18270] >>> StatCapmt: Sid 256(100) EsPids/EcmPids/CaIds: 0/1/1
Jun 29 21:14:25 roadrunner vdr: [18270] SendCaPmts CAM 1: [1] actives in CAM: 1 -> 0 (0 pids)
Jun 29 21:14:25 roadrunner vdr: [18270] ...cs:setpid - 1(1)
Jun 29 21:14:25 roadrunner vdr: [18270] ...cs:setpid - 4104(1008)
Jun 29 21:14:25 roadrunner vdr: [18270] BuildCaPmts CAM 1/1: [not_selected] ActiveProgs: 0 of 0 (0 Pids)
Jun 29 21:14:25 roadrunner vdr: [18270] SendCaPmts CAM 1: [1] actives in CAM: 0 -> 0 (0 pids)
Jun 29 21:14:25 roadrunner vdr: [18270] CAM 1: unassigned from device 1
Jun 29 21:14:25 roadrunner vdr: [18270] CAM 1: CanDecrypt(110/1000-) limit 2 - active 0 -> TRUE
Jun 29 21:14:25 roadrunner vdr: [18270] CAM 1: CanDecrypt(110/1000-) limit 2 - active 0 -> TRUE
Jun 29 21:14:25 roadrunner vdr: [18270] CAM 1/1: reusing MTD CAM slot
Jun 29 21:14:25 roadrunner vdr: [18270] ...cs:setpid + 1(1)
Jun 29 21:14:25 roadrunner vdr: [18282] VAAPI: audio/alsa: using device 'hdmi:CARD=PCH,DEV=2,AES0=0x04'
Jun 29 21:14:25 roadrunner vdr: [18282] VAAPI-ERROR: audio/alsa: set params error: Das Argument ist ungültig
Jun 29 21:14:25 roadrunner vdr: [18282] VAAPI-ERROR: audio: can't set channels 0 sample-rate 0Hz
Jun 29 21:14:25 roadrunner vdr: [18314] device 1 TS buffer thread ended (pid=18270, tid=18314)
Jun 29 21:14:25 roadrunner vdr: [18312] buffer stats: 133668 (0%) used
Jun 29 21:14:25 roadrunner vdr: [18312] device 1 receiver thread ended (pid=18270, tid=18312)
Jun 29 21:14:25 roadrunner vdr: [18270] CAM 1: assigned to device 1
Jun 29 21:14:25 roadrunner vdr: [18339] device 1 receiver thread started (pid=18270, tid=18339, prio=high)
Jun 29 21:14:25 roadrunner vdr: [18270] SendCaPmts CAM 1: [0] actives in CAM: 0 -> 0 (0 pids)
Jun 29 21:14:25 roadrunner vdr: [18270] ...cs:setpid + 1279(4FF)
Jun 29 21:14:25 roadrunner vdr: [18270] ...cs:setpid + 1283(503)
Jun 29 21:14:25 roadrunner vdr: [18270] ...cs:setpid + 1284(504)
Jun 29 21:14:25 roadrunner vdr: [18270] BuildCaPmts CAM 1/1: Sid 110 (6E) -> 110 (6E)
Jun 29 21:14:25 roadrunner vdr: [18270] BuildCaPmts CAM 1/1: Pid 1279 (4FF) +
Jun 29 21:14:25 roadrunner vdr: [18270] BuildCaPmts CAM 1/1: Pid 1283 (503) +
Jun 29 21:14:25 roadrunner vdr: [18270] BuildCaPmts CAM 1/1: Pid 1284 (504) +
Jun 29 21:14:25 roadrunner vdr: [18340] device 1 TS buffer thread started (pid=18270, tid=18340, prio=high)
Jun 29 21:14:25 roadrunner vdr: [18270] ...cs:setpid + 6670(1A0E)
Jun 29 21:14:25 roadrunner vdr: [18270] ------ MtdMapSid: 110 (006E) -> 256 (0100)
Jun 29 21:14:25 roadrunner vdr: [18270] ------ MtdMapPid: 6670 (1A0E) -> 262 (0106)
Jun 29 21:14:25 roadrunner vdr: [18270] ------ MtdMapPid: 1279 (04FF) -> 263 (0107)
Jun 29 21:14:25 roadrunner vdr: [18270] ------ MtdMapPid: 1283 (0503) -> 264 (0108)
Jun 29 21:14:25 roadrunner vdr: [18270] ------ MtdMapPid: 1284 (0504) -> 265 (0109)
Jun 29 21:14:25 roadrunner vdr: [18270] BuildCaPmts CAM 1/1: ListManagement CPLM_ADD
Jun 29 21:14:25 roadrunner vdr: [18270] BuildCaPmts CAM 1/1: [ok_descrambling] ActiveProgs: 1 of 1 (3 Pids)
Jun 29 21:14:25 roadrunner vdr: [18270] >>> StatCapmt: capmt <4> 256(100)
Jun 29 21:14:25 roadrunner vdr: [18270] >>> StatCapmt: capmt   [1] ca 98C e 262(106)
Jun 29 21:14:25 roadrunner vdr: [18270] >>> StatCapmt: capmt    p +263(107)
Jun 29 21:14:25 roadrunner vdr: [18270] >>> StatCapmt: capmt    p +264(108)
Jun 29 21:14:25 roadrunner vdr: [18270] >>> StatCapmt: capmt    p +265(109)
Jun 29 21:14:25 roadrunner vdr: [18270] >>> StatCapmt: Sid 256(100) EsPids/EcmPids/CaIds: 3/1/1
Jun 29 21:14:25 roadrunner vdr: [18270] [3] PL:1000(3E8) ES:4097(1001){1}<2444(98C)/4096(1000)> ES:4098(1002){1}<2444(98C)/4096(1000)> ES:4099(1003){1}<2444(98C)/4096(1000)> ES:4100(1004){1}<2444(98C)/4096(1000)> ES:4113(1011){1}<2444(98C)/4112(1010)> ES:4114(1012){1}<2444(98C)/4112(1010)> ES:4115(1013){1}<2444(98C)/4112(1010)> ES:4116(1014){1}<2444(98C)/4112(1010)>
Jun 29 21:14:25 roadrunner vdr: [18270] ----- CaPmtTracker: Service <1/1>:  [1:1000(03E8){1}]
Jun 29 21:14:25 roadrunner vdr: [18270] +++++++ SendData Tag: 9F8032 (L:110.)
Jun 29 21:14:25 roadrunner vdr: [18270] >>> StatCapmt: Link service 256(100) to slot[0]
Jun 29 21:14:25 roadrunner vdr: [18270] >>> StatCapmt: slot[0] map CAPID 262(0106) to 4096(1000)
Jun 29 21:14:25 roadrunner vdr: [18270] >>> StatCapmt: slot[0] map CAPID 263(0107) to 4097(1001)
Jun 29 21:14:25 roadrunner vdr: [18270] >>> StatCapmt: slot[0] map CAPID 264(0108) to 4098(1002)
Jun 29 21:14:25 roadrunner vdr: [18270] >>> StatCapmt: slot[0] map CAPID 265(0109) to 4099(1003)
Jun 29 21:14:25 roadrunner vdr: [18270] SendCaPmts CAM 1: [1] actives in CAM: 0 -> 1 (3 pids)
Jun 29 21:14:25 roadrunner vdr: [18270] CAM 1: CanDecrypt(110/1000*) limit 2 - active 1 -> TRUE
Jun 29 21:14:25 roadrunner vdr: [18270] switching device 1 to channel 114 S19.2E-133-13-110 (Sky Atlantic HD)
Jun 29 21:14:25 roadrunner vdr: [18270] SendCaPmts CAM 1: [0] actives in CAM: 1 -> 1 (3 pids)
Jun 29 21:14:25 roadrunner vdr: [18339] >>> StatCapmt: mapped PID 266(010A) to 2053(0805)
Jun 29 21:14:26 roadrunner vdr: [18339] ------ InjectEit: 1000 (03E8) -> 1000 (03E8)
Jun 29 21:14:26 roadrunner vdr: [18283] +++++++ SendData Tag: 077F00 (L:5.)
Jun 29 21:14:26 roadrunner vdr: [18339] ...cs:setpid + 4104(1008)
Jun 29 21:14:26 roadrunner vdr: [18339] ------ MtdMapPid: 4104 (1008) -> 267 (010B)
Jun 29 21:14:26 roadrunner vdr: [18339] >>> StatCapmt: mapped PID 267(010B) to 2054(0806)
Jun 29 21:14:26 roadrunner vdr: [18339] ------ MtdMapPid: 4104 (1008) -> 267 (010B)
Jun 29 21:14:26 roadrunner vdr: [18339] ------ MtdMapPid: 4104 (1008) -> 267 (010B)
Jun 29 21:14:26 roadrunner vdr: [18283] +++++++ SendData Tag: 9F9008 (L:80.)
Jun 29 21:14:27 roadrunner vdr: [18339] ------ InjectEit: 1000 (03E8) -> 1000 (03E8)
Jun 29 21:14:28 roadrunner vdr: [18339] ------ InjectEit: 1000 (03E8) -> 1000 (03E8)
Jun 29 21:14:29 roadrunner vdr: [18339] ------ InjectEit: 1000 (03E8) -> 1000 (03E8)
Jun 29 21:14:30 roadrunner vdr: [18339] ------ InjectEit: 1000 (03E8) -> 1000 (03E8)
Jun 29 21:14:31 roadrunner vdr: [18339] ------ InjectEit: 1000 (03E8) -> 1000 (03E8)
Jun 29 21:14:32 roadrunner vdr: [18339] ------ InjectEit: 1000 (03E8) -> 1000 (03E8)
Jun 29 21:14:33 roadrunner vdr: [18339] ------ InjectEit: 1000 (03E8) -> 1000 (03E8)
Jun 29 21:14:34 roadrunner vdr: [18339] ------ InjectEit: 1000 (03E8) -> 1000 (03E8)
Jun 29 21:14:35 roadrunner vdr: [18339] ------ InjectEit: 1000 (03E8) -> 1000 (03E8)
Jun 29 21:14:36 roadrunner vdr: [18339] ------ InjectEit: 1000 (03E8) -> 1000 (03E8)
Jun 29 21:15:24 roadrunner vdr: [18270] timer 1 (114 2010-2120 'Serien~Westworld~(S03E04) Mutter der Exilanten') start
Jun 29 21:15:24 roadrunner vdr: [18270] Title: 'Westworld' Subtitle: '(S03E04) Mutter der Exilanten'
Jun 29 21:15:24 roadrunner vdr: [18270] executing '/usr/lib/vdr/vdr-recordingaction before "/srv/vdr/video/local/Serien/Westworld/(S03E04)_Mutter_der_Exilanten/2020-06-29.20.10.114-0.rec"'
Jun 29 21:15:24 roadrunner vdr: [18270] record /srv/vdr/video/local/Serien/Westworld/(S03E04)_Mutter_der_Exilanten/2020-06-29.20.10.114-0.rec
Jun 29 21:15:24 roadrunner vdr: [18270] Starting NALU fill dumper
Jun 29 21:15:24 roadrunner vdr: [18270] cFileName::SetOffset: removing zero-sized file /srv/vdr/video/local/Serien/Westworld/(S03E04)_Mutter_der_Exilanten/2020-06-29.20.10.114-0.rec/00002.ts
Jun 29 21:15:24 roadrunner vdr: [18270] recording to '/srv/vdr/video/local/Serien/Westworld/(S03E04)_Mutter_der_Exilanten/2020-06-29.20.10.114-0.rec/00002.ts'
Jun 29 21:15:24 roadrunner vdr: [18270] SendCaPmts CAM 1: [0] actives in CAM: 1 -> 1 (3 pids)
Jun 29 21:15:24 roadrunner vdr: [18270] markad: cannot find timer for '/srv/vdr/video/local/Serien/Westworld/(S03E04)_Mutter_der_Exilanten/2020-06-29.20.10.114-0.rec'
Jun 29 21:15:24 roadrunner vdr: [18270] markad: no logo found for Serien~Westworld~(S03E04) Mutter der Exilanten
Jun 29 21:15:24 roadrunner vdr: [18270] writing timer id '1@roadrunner' to /srv/vdr/video/local/Serien/Westworld/(S03E04)_Mutter_der_Exilanten/2020-06-29.20.10.114-0.rec/.timer
Jun 29 21:15:24 roadrunner vdr: [18356] recording thread started (pid=18270, tid=18356, prio=high)
Jun 29 21:15:24 roadrunner vdr: epg2vdr: Handler: Init handler instance for thread 18275
Jun 29 21:15:24 roadrunner vdr: epg2vdr: Handler: Trying to re-connect to database!
Jun 29 21:15:24 roadrunner vdr: epg2vdr: Handler: Start reading hashes from db
Jun 29 21:15:24 roadrunner vdr: [18339] ------ InjectEit: 1000 (03E8) -> 1000 (03E8)
Jun 29 21:15:25 roadrunner vdr: epg2vdr: Updating table timers done
Jun 29 21:15:25 roadrunner vdr: [18339] ------ InjectEit: 1000 (03E8) -> 1000 (03E8)
Jun 29 21:15:25 roadrunner vdr: epg2vdr: Updated changes since '29.06.2020 18:03:05'; 1 channels, 0 events (0 deletions) in 805 ms
Jun 29 21:15:25 roadrunner vdr: epg2vdr: Checking switch timer actions ..
Jun 29 21:15:26 roadrunner vdr: [18270] VAAPI: video/vaapi: clear image
Jun 29 21:15:26 roadrunner vdr: [18270] VAAPI: video: set trick-speed 0
Jun 29 21:15:26 roadrunner vdr: [18339] ------ InjectEit: 1000 (03E8) -> 1000 (03E8)
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: codec: using video codec ID 0x001b (h264)
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: codec: video 'H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10'
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: codec: can use own buffer management
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: codec: supports frame threads
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: codec: supports slice threads
Jun 29 21:15:26 roadrunner vdr: [18339] VAAPI: codec: using audio codec ID 0x15003 (ac3)
Jun 29 21:15:26 roadrunner vdr: [18339] VAAPI: codec: audio 'ATSC A/52A (AC-3)'
Jun 29 21:15:26 roadrunner vdr: [18339] VAAPI: codec/audio: format change fltp 48000Hz *2 channels PCM AC-3 pass-through
Jun 29 21:15:26 roadrunner vdr: [18339] VAAPI: codec/audio: resample fltp 48000Hz *2 -> s16 48000Hz *2
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: codec: sending video packet failed
Jun 29 21:15:26 roadrunner vdr: [18339] VAAPI: codec/audio: initial drift delay 192ms
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: codec: sending video packet failed
Jun 29 21:15:26 roadrunner vdr: [18356] executing '/usr/lib/vdr/vdr-recordingaction started "/srv/vdr/video/local/Serien/Westworld/(S03E04)_Mutter_der_Exilanten/2020-06-29.20.10.114-0.rec"'
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: codec: sending video packet failed
Jun 29 21:15:26 roadrunner vdr: [18282] VAAPI: audio/alsa: using pass-through device 'hdmi:CARD=PCH,DEV=2,AES0=0x06'
Jun 29 21:15:26 roadrunner vdr: [18282] VAAPI: audio/alsa: start delay 336ms
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: codec: sending video packet failed
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: codec: sending video packet failed
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi: Picture change detected
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi: supports video processing
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi: search format NV12 in 9 image formats
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi: supported image formats:
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi:#011YV12#0110
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi:#011I420#0110
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi:#011NV12#0110
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi:#011YUY2#0110
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi:#011UYVY#0110
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi:#011422H#0110
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi:#011RGBX#01124
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi:#011BGRX#01124
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi:#011P010#0110
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi: use#011NV12#0110
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi: created image 1920x1088 with id 0x0a000001 and buffer id 0x08000005
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video: resolution 1080i selected
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi: noise reduction supported
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi: 0,00 - 1,00 ++ 0,03 = 0,50
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi: enabling denoise filter (pos = 0)
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi: deinterlacing supported
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi: bob deinterlace supported
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi: motion adaptive deinterlace supported
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi: motion compensated deinterlace supported
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi: enabling deinterlacing (pos = 1)
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi: sharpening supported
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi: 0,00 - 1,00 ++ 0,03 = 0,50
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi: enabling sharpening filter (pos = 0)
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi: enabling color balance filters
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi: supported color balance filter count: 4
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi: hue (-180,00 - 180,00 ++ 1,00 = 0,00) (pos = 2)
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi: saturation (0,00 - 10,00 ++ 0,10 = 1,00) (pos = 2)
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi: brightness (-100,00 - 100,00 ++ 1,00 = 0,00) (pos = 2)
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi: contrast (0,00 - 10,00 ++ 0,10 = 1,00) (pos = 2)
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi: skin tone enhancement supported
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi: 0,00 - 4,00 ++ 1,00 = 0,00
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi: enabling skin tone filter (pos = 3)
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi: allocating 1 forward reference surfaces for postprocessing
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi: allocating 0 backward reference surfaces for postprocessing
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video: aspect defaults to 1:1
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video: VideoScreen aspect px ratio 1920:1080
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video: VideoScreen aspect mm ratio 1104:621
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video: aspect ratio 30:17
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video: aspect output 1920x1088+0+0
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi: interlaced 1 top-field-first 1
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi: aspect ratio changed
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video: VideoScreen aspect px ratio 1920:1080
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video: VideoScreen aspect mm ratio 1104:621
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video: aspect ratio 30:17
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video: aspect output 1920x1088+0+0
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi: time/frame too long 48ms
Jun 29 21:15:26 roadrunner vdr: [18316] VAAPI: video/vaapi: time/frame too long 34ms
Jun 29 21:15:27 roadrunner vdr: [18339] ------ InjectEit: 1000 (03E8) -> 1000 (03E8)
Jun 29 21:15:27 roadrunner vdr: [18316] VAAPI: video: slow down video, duping frame (/\=309,51 ms, vClk  6:45:16.213 - aClk  6:45:15.903)
Jun 29 21:15:27 roadrunner vdr: [18316] VAAPI: video: slow down video, duping frame (/\=314,62 ms, vClk  6:45:16.253 - aClk  6:45:15.938)
Jun 29 21:15:27 roadrunner vdr: [18316] VAAPI: video: slow down video, duping frame (/\=270,22 ms, vClk  6:45:16.253 - aClk  6:45:15.982)
Jun 29 21:15:27 roadrunner vdr: [18316] VAAPI: video: slow down video, duping frame (/\=273,89 ms, vClk  6:45:16.293 - aClk  6:45:16.019)
Jun 29 21:15:27 roadrunner vdr: [18316] VAAPI: video: slow down video, duping frame (/\=230,14 ms, vClk  6:45:16.293 - aClk  6:45:16.062)
Jun 29 21:15:27 roadrunner vdr: [18316] VAAPI: video: slow down video, duping frame (/\=232,07 ms, vClk  6:45:16.333 - aClk  6:45:16.099)
Jun 29 21:15:27 roadrunner vdr: [18316] VAAPI: video: slow down video, duping frame (/\=211,12 ms, vClk  6:45:16.333 - aClk  6:45:16.142)
Jun 29 21:15:27 roadrunner vdr: [18316] VAAPI: video: slow down video, duping frame (/\=202,82 ms, vClk  6:45:16.373 - aClk  6:45:16.178)
Jun 29 21:15:27 roadrunner vdr: [18316] VAAPI: video: slow down video, duping frame (/\=176,00 ms, vClk  6:45:16.373 - aClk  6:45:16.223)
Jun 29 21:15:28 roadrunner vdr: [18339] ------ InjectEit: 1000 (03E8) -> 1000 (03E8)
Jun 29 21:15:28 roadrunner vdr: [18316] VAAPI: video: slow down video, duping frame (/\=165,21 ms, vClk  6:45:16.413 - aClk  6:45:16.258)
Jun 29 21:15:28 roadrunner vdr: [18316] VAAPI: video: slow down video, duping frame (/\=137,52 ms, vClk  6:45:16.413 - aClk  6:45:16.303)
Jun 29 21:15:28 roadrunner vdr: [18316] VAAPI: video: slow down video, duping frame (/\=125,94 ms, vClk  6:45:16.453 - aClk  6:45:16.338)
Jun 29 21:15:28 roadrunner vdr: [18316] VAAPI: video: slow down video, duping frame (/\=98,30 ms, vClk  6:45:16.453 - aClk  6:45:16.382)
Jun 29 21:15:28 roadrunner vdr: [18316] VAAPI: video: slow down video, duping frame (/\=86,32 ms, vClk  6:45:16.493 - aClk  6:45:16.418)
Jun 29 21:15:28 roadrunner vdr: [18316] VAAPI: video: slow down video, duping frame (/\=58,56 ms, vClk  6:45:16.493 - aClk  6:45:16.462)
Jun 29 21:15:28 roadrunner vdr: [18316] VAAPI: video: slow down video, duping frame (/\=46,28 ms, vClk  6:45:16.533 - aClk  6:45:16.499)
Jun 29 21:15:28 roadrunner vdr: [18316] VAAPI: video/vaapi: synced after 82 frames
Jun 29 21:15:29 roadrunner vdr: [18339] ------ InjectEit: 1000 (03E8) -> 1000 (03E8)
Jun 29 21:15:30 roadrunner vdr: [18339] ------ InjectEit: 1000 (03E8) -> 1000 (03E8)
Jun 29 21:15:31 roadrunner vdr: [18339] ------ InjectEit: 1000 (03E8) -> 1000 (03E8)
Jun 29 21:15:31 roadrunner vdr: [18316] VAAPI: video: slow down video, duping frame (/\=44,63 ms, vClk  6:45:19.973 - aClk  6:45:19.890)
Jun 29 21:15:31 roadrunner vdr: [18316] VAAPI: video: slow down video, duping frame (/\=41,80 ms, vClk  6:45:19.973 - aClk  6:45:19.934)
Jun 29 21:15:31 roadrunner vdr: [18316] VAAPI: video: slow down video, duping frame (/\=42,27 ms, vClk  6:45:20.013 - aClk  6:45:19.970)
Jun 29 21:15:32 roadrunner vdr: [18339] ------ InjectEit: 1000 (03E8) -> 1000 (03E8)
Jun 29 21:15:32 roadrunner vdr: [18282] VAAPI-ERROR: audio/alsa: wait underrun error? 'Datenübergabe unterbrochen (broken pipe)'
Jun 29 21:15:33 roadrunner vdr: [18339] ------ InjectEit: 1000 (03E8) -> 1000 (03E8)
Jun 29 21:15:33 roadrunner vdr: [18282] VAAPI-ERROR: audio/alsa: wait underrun error? 'Datenübergabe unterbrochen (broken pipe)'
Jun 29 21:15:34 roadrunner vdr: [18316] VAAPI: video: slow down video, duping frame (/\=41,90 ms, vClk  6:45:22.213 - aClk  6:45:22.159)
Jun 29 21:15:34 roadrunner vdr: epg2vdr: Handler: Finished reading hashes from db, got 64 hashes (in 10 seconds)
Jun 29 21:15:34 roadrunner vdr: epg2vdr: Handler: Start reading external ids from db
Jun 29 21:15:34 roadrunner vdr: [18339] ------ InjectEit: 1000 (03E8) -> 1000 (03E8)
Jun 29 21:15:34 roadrunner vdr: epg2vdr: Handler: Finished reading external id's from db, got 90 id's
Jun 29 21:15:34 roadrunner vdr: epg2vdr: Handler: Connection established successfull!
Jun 29 21:15:35 roadrunner vdr: [18339] ------ InjectEit: 1000 (03E8) -> 1000 (03E8)
Jun 29 21:15:36 roadrunner vdr: [18339] VAAPI: codec/audio: drift(     0) 302ms reset
Jun 29 21:15:36 roadrunner vdr: [18339] VAAPI: codec/audio: drift(     0)   302622us     0
Jun 29 21:15:36 roadrunner vdr: [18339] VAAPI: codec/audio: initial drift delay 551ms
Jun 29 21:16:03 roadrunner vdr: [18283] +++++++ SendData Tag: 9F9008 (L:64.)
Jun 29 21:16:12 roadrunner vdr: [18283] +++++++ SendData Tag: 9F9010 (L:48.)
Jun 29 21:16:26 roadrunner vdr: [18316] VAAPI: video:  6:46:14.813   +9  350   0/\ms  10+5 v-buf
Jun 29 21:16:32 roadrunner vdr: [18316] VAAPI: video: slow down video, duping frame (/\=40,04 ms, vClk  6:46:20.813 - aClk  6:46:20.765)
Jun 29 21:16:37 roadrunner vdr: [18339] VAAPI: codec/audio: drift(     0)  14ms reset
Jun 29 21:16:37 roadrunner vdr: [18339] VAAPI: codec/audio: initial drift delay 345ms
Jun 29 21:16:50 roadrunner vdr: epg2vdr: Info: Found 5179 recordings; 7 inserted; 24 updated and 656 directories
Jun 29 21:16:50 roadrunner vdr: epg2vdr: Updating recording info in info.epg2vdr
Jun 29 21:16:50 roadrunner vdr: epg2vdr: Updated 0 pending info.epg2vdr files
Jun 29 21:16:50 roadrunner vdr: scraper2vdr: Handled 34 of 654 series, continuing...