Oct 12 12:36:28 vdrmain systemd[1]: Starting Video Disk Recorder... Oct 12 12:36:28 vdrmain vdr[534]: [534] VDR version 2.4.1 started Oct 12 12:36:28 vdrmain vdr[534]: [534] switched to user 'vdr' Oct 12 12:36:28 vdrmain vdr[534]: [534] codeset is 'UTF-8' - known Oct 12 12:36:28 vdrmain vdr[534]: [534] override character table is 'ISO-8859-15' Oct 12 12:36:28 vdrmain vdr[534]: [534] loading plugin: /usr/lib/vdr/plugins/libvdr-femon.so.2.4.1 Oct 12 12:36:28 vdrmain vdr[534]: [534] loading plugin: /usr/lib/vdr/plugins/libvdr-softhdcuvid.so.2.4.1 Oct 12 12:36:28 vdrmain vdr[534]: [534] loading /var/lib/vdr/setup.conf Oct 12 12:36:28 vdrmain vdr[534]: [534] loading /var/lib/vdr/sources.conf Oct 12 12:36:28 vdrmain vdr[534]: [534] loading /var/lib/vdr/diseqc.conf Oct 12 12:36:28 vdrmain vdr[534]: [534] loading /var/lib/vdr/scr.conf Oct 12 12:36:28 vdrmain vdr[534]: [534] loading /var/lib/vdr/channels.conf Oct 12 12:36:28 vdrmain vdr[534]: [534] loading /var/lib/vdr/timers.conf Oct 12 12:36:28 vdrmain vdr[534]: [534] loading /var/lib/vdr/svdrphosts.conf Oct 12 12:36:28 vdrmain vdr[534]: [534] loading /var/lib/vdr/remote.conf Oct 12 12:36:28 vdrmain vdr[534]: [534] loading /var/lib/vdr/keymacros.conf Oct 12 12:36:28 vdrmain vdr[534]: [534] loading /var/lib/vdr/camresponses.conf Oct 12 12:36:28 vdrmain kernel: m88ds3103 1-0069: found a 'Montage Technology M88DS3103' in cold state Oct 12 12:36:28 vdrmain kernel: m88ds3103 1-0069: downloading firmware from file 'dvb-demod-m88rs6000.fw' Oct 12 12:36:29 vdrmain audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-hostnamed comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 12 12:36:29 vdrmain systemd[1]: systemd-hostnamed.service: Succeeded. Oct 12 12:36:29 vdrmain kernel: audit: type=1131 audit(1570876589.834:35): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-hostnamed comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 12 12:36:31 vdrmain kernel: m88ds3103 1-0069: found a 'Montage Technology M88DS3103' in warm state Oct 12 12:36:31 vdrmain kernel: m88ds3103 1-0069: firmware version: 4.1 Oct 12 12:36:31 vdrmain vdr[534]: [534] DVB API version is 0x050B (VDR was built with 0x050B) Oct 12 12:36:31 vdrmain vdr[534]: [534] frontend 0/0 provides DVB-S,DVB-S2 with QPSK ("Montage Technology M88RS6000") Oct 12 12:36:31 vdrmain kernel: m88ds3103 2-0069: found a 'Montage Technology M88DS3103' in cold state Oct 12 12:36:31 vdrmain kernel: m88ds3103 2-0069: downloading firmware from file 'dvb-demod-m88rs6000.fw' Oct 12 12:36:34 vdrmain kernel: m88ds3103 2-0069: found a 'Montage Technology M88DS3103' in warm state Oct 12 12:36:34 vdrmain kernel: m88ds3103 2-0069: firmware version: 4.1 Oct 12 12:36:34 vdrmain vdr[534]: [534] frontend 1/0 provides DVB-S,DVB-S2 with QPSK ("Montage Technology M88RS6000") Oct 12 12:36:34 vdrmain vdr[534]: [534] found 2 DVB devices Oct 12 12:36:34 vdrmain vdr[534]: [534] initializing plugin: femon (2.4.0): DVB Signal Information Monitor (OSD) Oct 12 12:36:34 vdrmain vdr[534]: [534] initializing plugin: softhdcuvid (2.1.0-GIT9003bee): A software and GPU emulated UHD device Oct 12 12:36:34 vdrmain vdr[534]: [534] setting primary device to 3 Oct 12 12:36:34 vdrmain vdr[534]: [534] setting current skin to "lcars" Oct 12 12:36:34 vdrmain vdr[534]: [534] loading /var/lib/vdr/themes/lcars-default.theme Oct 12 12:36:34 vdrmain vdr[534]: [534] starting plugin: femon Oct 12 12:36:34 vdrmain vdr[534]: [534] starting plugin: softhdcuvid Oct 12 12:36:34 vdrmain vdr[534]: video: visual 0x21 depth 24 Oct 12 12:36:34 vdrmain vdr[534]: Create Window at 0,0 Oct 12 12:36:34 vdrmain vdr[534]: video: window prepared Oct 12 12:36:34 vdrmain vdr[534]: video/glx: glx version 1.4 Oct 12 12:36:34 vdrmain vdr[534]: video/glx: GlxSwapIntervalMESA=(nil) Oct 12 12:36:34 vdrmain vdr[534]: video/glx: GlxSwapIntervalSGI=0x7f6540216000 Oct 12 12:36:34 vdrmain vdr[534]: video/glx: GlxGetVideoSyncSGI=0x7f65421af0a0 Oct 12 12:36:34 vdrmain vdr[534]: RGB size 8:8:8 Oct 12 12:36:34 vdrmain vdr[534]: Chosen visual ID = 0x27 Oct 12 12:36:34 vdrmain vdr[534]: video/glx: visual 0x27 depth 24 Oct 12 12:36:34 vdrmain vdr[534]: video/glx: default v-sync is -1 Oct 12 12:36:34 vdrmain vdr[534]: video/glx: SGI v-sync enabled Oct 12 12:36:34 vdrmain vdr[534]: video/egl: GlxSetupWindow 1200003 1920x1080 context: 0x55aebfcfd6f8 Oct 12 12:36:34 vdrmain vdr[534]: video/egl: ok Oct 12 12:36:34 vdrmain vdr[534]: video: screen saver extension present Oct 12 12:36:34 vdrmain vdr[534]: video/x11: send fullscreen message 1 149 Oct 12 12:36:34 vdrmain vdr[534]: Cuvid New HW Decoder Oct 12 12:36:34 vdrmain kernel: nvidia-uvm: Loaded the UVM driver in 8 mode, major device number 235 Oct 12 12:36:34 vdrmain vdr[534]: [softhddev] ready Oct 12 12:36:34 vdrmain vdr[534]: [534] switching to channel 31 S19.2E-1-1111-7290 (Sky News Intl) Oct 12 12:36:34 vdrmain audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=vdr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 12 12:36:34 vdrmain vdr[534]: [563] SVDRP vdrmain opening port 6419/tcp Oct 12 12:36:34 vdrmain systemd[1]: Started Video Disk Recorder. Oct 12 12:36:34 vdrmain vdr[534]: [563] SVDRP vdrmain listening on port 6419/tcp Oct 12 12:36:34 vdrmain kernel: audit: type=1130 audit(1570876594.874:36): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=vdr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 12 12:36:34 vdrmain vdr[534]: Set Playmode 1 Oct 12 12:36:34 vdrmain vdr[534]: video: set trick-speed 0 Oct 12 12:36:34 vdrmain vdr[534]: [softhddev]GetOsdSize: 1920x1080 1 Oct 12 12:36:34 vdrmain vdr[534]: [565] SVDRP vdrmain opening port 6419/udp Oct 12 12:36:34 vdrmain vdr[534]: [565] SVDRP vdrmain listening on port 6419/udp Oct 12 12:36:34 vdrmain vdr[534]: video/event: ReparentNotify Oct 12 12:36:34 vdrmain vdr[534]: [563] SVDRP vdrmain < 192.168.36.22:42592 client connection accepted Oct 12 12:36:34 vdrmain vdr[534]: [563] SVDRP vdrmain > 192.168.36.22:6419 server connection established Oct 12 12:36:34 vdrmain vdr[534]: Create OSD egl context Oct 12 12:36:35 vdrmain vdr[534]: pesdemux: pes start code id 0xc0 Oct 12 12:36:35 vdrmain vdr[534]: pesdemux: new codec 000000 -> 0x15000 Oct 12 12:36:35 vdrmain vdr[534]: codec: using audio codec ID 0x15000 (mp2) Oct 12 12:36:35 vdrmain vdr[534]: codec: audio 'MP2 (MPEG audio layer 2)' Oct 12 12:36:35 vdrmain vdr[534]: codec/audio: format change s16p 48000Hz *2 channels PCM AC-3 E-AC-3 pass-through Oct 12 12:36:35 vdrmain vdr[534]: codec/audio: resample s16p 48000Hz *2 -> s16 48000Hz *2 Oct 12 12:36:35 vdrmain vdr[534]: video: mpeg2 detected ID 9d Oct 12 12:36:35 vdrmain vdr[534]: [567] [softhddev]OglThread cleanup Oct 12 12:36:35 vdrmain vdr[534]: call back set video mode 1916 1039 Oct 12 12:36:35 vdrmain vdr[534]: Set video mode 1916x1039 Oct 12 12:36:35 vdrmain vdr[534]: video/egl: GlxSetupWindow 1200003 1916x1039 context: 0x55aebfcfd6f8 Oct 12 12:36:35 vdrmain vdr[534]: [563] SVDRP vdrmain < 192.168.36.22:42594 client connection accepted Oct 12 12:36:35 vdrmain vdr[534]: [563] SVDRP vdrmain < 192.168.36.22:42594 connection closed Oct 12 12:36:35 vdrmain vdr[534]: video/egl: ok Oct 12 12:36:36 vdrmain vdr[534]: video: aspect defaults to 1:1 Oct 12 12:36:36 vdrmain vdr[534]: video: aspect 11552:11547 Resolution 0 Oct 12 12:36:36 vdrmain vdr[534]: video: normal aspect output 1040x1039+438+0 Video 1916x1039 Oct 12 12:36:36 vdrmain vdr[534]: video/event: MapNotify Oct 12 12:36:37 vdrmain vdr[534]: call back set video mode 1920 1080 Oct 12 12:36:37 vdrmain vdr[534]: Set video mode 1920x1080 Oct 12 12:36:37 vdrmain vdr[534]: video/egl: GlxSetupWindow 1200003 1920x1080 context: 0x55aebfcfd6f8 Oct 12 12:36:37 vdrmain vdr[534]: video/egl: ok Oct 12 12:36:37 vdrmain vdr[534]: video: aspect defaults to 1:1 Oct 12 12:36:37 vdrmain vdr[534]: video: aspect 11552:11547 Resolution 0 Oct 12 12:36:37 vdrmain vdr[534]: ***************codec: Video Open using video codec ID 0x0002 (mpeg2video) Oct 12 12:36:37 vdrmain vdr[534]: codec: decoder found Oct 12 12:36:37 vdrmain vdr[534]: codec: video 'Nvidia CUVID MPEG2VIDEO decoder' Oct 12 12:36:37 vdrmain vdr[534]: Codec open 0 Oct 12 12:36:37 vdrmain vdr[534]: Initializing cuvid hwaccel thread ID:566 Oct 12 12:36:37 vdrmain vdr[534]: ***********CUDA API Version 3020 Oct 12 12:36:37 vdrmain vdr[534]: video: ready --:--:--.--- 20ms/frame 45505ms Oct 12 12:36:37 vdrmain vdr[534]: Cuvid_get_format: codec 2 fmts: Oct 12 12:36:37 vdrmain vdr[534]: 0x00000077 cuda Oct 12 12:36:37 vdrmain vdr[534]: 0x00000017 nv12 Oct 12 12:36:37 vdrmain vdr[534]: Cuvid_get_format: codec 2 fmts: Oct 12 12:36:37 vdrmain vdr[534]: 0x00000077 cuda Oct 12 12:36:37 vdrmain vdr[534]: video profile -99 codec id 2 Oct 12 12:36:37 vdrmain vdr[534]: video: create decoder 16bit?=0 704x576 old 0 0 Oct 12 12:36:37 vdrmain vdr[534]: Cuvid Clean up Oct 12 12:36:37 vdrmain vdr[534]: video/cuvid: CuvidCreateSurfaces: 704x576 * 7 Oct 12 12:36:37 vdrmain vdr[534]: video/vdpau: create 7 Textures Format NV12 w 704 h 576 Oct 12 12:36:37 vdrmain vdr[534]: video: aspect defaults to 1:1 Oct 12 12:36:37 vdrmain vdr[534]: video: aspect 127072:103923 Resolution 0 Oct 12 12:36:37 vdrmain vdr[534]: video: normal aspect output 1321x1080+299+0 Video 1920x1080 Oct 12 12:36:37 vdrmain vdr[534]: GetFormat Init ok 704x576 Oct 12 12:36:37 vdrmain vdr[534]: codec: key frame after 2 frames Oct 12 12:36:37 vdrmain vdr[534]: video/vdpau: aspect ratio changed Oct 12 12:36:37 vdrmain vdr[534]: video: aspect 184832:103923 Resolution 0 Oct 12 12:36:37 vdrmain vdr[534]: video: normal aspect output 1920x1080+0+0 Video 1920x1080 Oct 12 12:36:37 vdrmain vdr[534]: ++++++++++++++++++++++++++++++++++++starte audio Oct 12 12:36:37 vdrmain vdr[534]: BT601 Colorspace used Oct 12 12:36:37 vdrmain vdr[534]: vor create Oct 12 12:36:37 vdrmain vdr[534]: vor compile vertex Oct 12 12:36:37 vdrmain vdr[534]: compile Status 1 loglen 0 >< Oct 12 12:36:37 vdrmain vdr[534]: vor compile fragment Oct 12 12:36:37 vdrmain vdr[534]: compile Status 1 loglen 0 >< Oct 12 12:36:37 vdrmain vdr[534]: Link Status 1 loglen 0 Oct 12 12:36:37 vdrmain vdr[534]: get uniform colormatrix 0 Oct 12 12:36:37 vdrmain vdr[534]: nach set colormatrix Oct 12 12:36:37 vdrmain vdr[534]: get uniform colormatrix_c 1 -0.874202 Oct 12 12:36:37 vdrmain kernel: snd_hda_intel 0000:01:00.1: IRQ timing workaround is activated for card #1. Suggest a bigger bdl_pos_adj. Oct 12 12:36:37 vdrmain vdr[534]: codec/audio: inital drift delay 2009ms Oct 12 12:36:38 vdrmain vdr[534]: video/cuvid: synced after 24 frames 46205ms Oct 12 12:36:38 vdrmain vdr[534]: video: slow down video, duping frame 75 Oct 12 12:36:41 vdrmain vdr[534]: Create OSD egl context Oct 12 12:36:41 vdrmain vdr[534]: vor create osd Oct 12 12:36:41 vdrmain vdr[534]: vor compile vertex osd Oct 12 12:36:41 vdrmain vdr[534]: compile Status 1 loglen 0 >< Oct 12 12:36:41 vdrmain vdr[534]: vor compile fragment osd Oct 12 12:36:41 vdrmain vdr[534]: compile Status 1 loglen 0 >< Oct 12 12:36:41 vdrmain vdr[534]: Link Status 1 loglen 0 Oct 12 12:36:47 vdrmain vdr[534]: codec/audio: drift( 0) -200us -96 Oct 12 12:37:02 vdrmain systemd[1]: Stopping Video Disk Recorder... Oct 12 12:37:02 vdrmain vdr[534]: [534] SVDRP vdrmain < vdrkit connection closed Oct 12 12:37:02 vdrmain vdr[534]: [534] stopping plugin: softhdcuvid Oct 12 12:37:02 vdrmain vdr[534]: video: max used PES packet size: 93020 Oct 12 12:37:02 vdrmain vdr[534]: [534] stopping plugin: femon Oct 12 12:37:02 vdrmain vdr[534]: Set Playmode 0 Oct 12 12:37:02 vdrmain vdr[534]: video: set closing Oct 12 12:37:02 vdrmain vdr[534]: video: set clock --:--:--.--- Oct 12 12:37:02 vdrmain vdr[534]: video: reset start Oct 12 12:37:02 vdrmain vdr[534]: video: set clock --:--:--.--- Oct 12 12:37:02 vdrmain vdr[534]: video: new stream start Oct 12 12:37:02 vdrmain vdr[534]: [571] [softhddev]OglThread cleanup Oct 12 12:37:02 vdrmain vdr[534]: [534] saved setup to /var/lib/vdr/setup.conf Oct 12 12:37:03 vdrmain vdr[534]: [534] deleting plugin: softhdcuvid Oct 12 12:37:03 vdrmain vdr[534]: video: screen saver extension present Oct 12 12:37:03 vdrmain vdr[534]: cuvid del hw decoder Oct 12 12:37:03 vdrmain vdr[534]: video/cuvid: CuvidDestroySurfaces Oct 12 12:37:03 vdrmain vdr[534]: video: slow down video, duping frame 68 Oct 12 12:37:03 vdrmain vdr[534]: checkCudaErrors() Driver API error = 0219 "CUDA_ERROR_INVALID_GRAPHICS_CONTEXT" from file , line 1602. Oct 12 12:37:03 vdrmain systemd[1]: vdr.service: Main process exited, code=exited, status=1/FAILURE Oct 12 12:37:03 vdrmain systemd[1]: vdr.service: Failed with result 'exit-code'. Oct 12 12:37:03 vdrmain systemd[1]: Stopped Video Disk Recorder. Oct 12 12:37:03 vdrmain audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=vdr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=failed' Oct 12 12:37:03 vdrmain kernel: audit: type=1131 audit(1570876623.501:37): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=vdr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=failed'