Apr 21 01:53:05 vdrsrv01 systemd[1]: Starting Video Disk Recorder...
Apr 21 01:53:06 vdrsrv01 vdr: [31975] VDR version 2.4.0 started
Apr 21 01:53:06 vdrsrv01 vdr: [31975] switched to user 'vdr'
Apr 21 01:53:06 vdrsrv01 vdr: [31975] codeset is 'UTF-8' - known
Apr 21 01:53:06 vdrsrv01 vdr: [31975] found 28 locales in /usr/share/locale
Apr 21 01:53:06 vdrsrv01 vdr: [31975] loading plugin: /usr/lib/vdr/plugins/libvdr-dbus2vdr.so.2.4.0
Apr 21 01:53:06 vdrsrv01 vdr: [31975] dbus2vdr: use shutdown-hooks in /usr/share/vdr/shutdown-hooks
Apr 21 01:53:06 vdrsrv01 vdr: [31975] dbus2vdr: use shutdown-hooks-wrapper /usr/share/vdr-plugin-dbus2vdr/shutdown-wrapper
Apr 21 01:53:06 vdrsrv01 vdr: [31975] loading plugin: /usr/lib/vdr/plugins/libvdr-ddci2.so.2.4.0
Apr 21 01:53:06 vdrsrv01 vdr: [31975] loading plugin: /usr/lib/vdr/plugins/libvdr-desktop.so.2.4.0
Apr 21 01:53:06 vdrsrv01 vdr: [31975] loading plugin: /usr/lib/vdr/plugins/libvdr-devstatus.so.2.4.0
Apr 21 01:53:06 vdrsrv01 vdr: [31975] loading plugin: /usr/lib/vdr/plugins/libvdr-markad.so.2.4.0
Apr 21 01:53:06 vdrsrv01 vdr: [31975] loading plugin: /usr/lib/vdr/plugins/libvdr-osd2web.so.2.4.0
Apr 21 01:53:06 vdrsrv01 vdr: [31975] loading plugin: /usr/lib/vdr/plugins/libvdr-pulsecontrol.so.2.4.0
Apr 21 01:53:06 vdrsrv01 vdr: [31975] loading plugin: /usr/lib/vdr/plugins/libvdr-satip.so.2.4.0
Apr 21 01:53:06 vdrsrv01 vdr: [31975] loading plugin: /usr/lib/vdr/plugins/libvdr-softhddevice.so.2.4.0
Apr 21 01:53:06 vdrsrv01 vdr: [31975] loading /var/lib/vdr/setup.conf
Apr 21 01:53:06 vdrsrv01 vdr: [31975] loading /var/lib/vdr/sources.conf
Apr 21 01:53:06 vdrsrv01 vdr: [31975] loading /var/lib/vdr/diseqc.conf
Apr 21 01:53:06 vdrsrv01 vdr: [31975] loading /var/lib/vdr/scr.conf
Apr 21 01:53:06 vdrsrv01 vdr: [31975] loading /var/lib/vdr/channels.conf
Apr 21 01:53:06 vdrsrv01 vdr: [31975] loading /var/lib/vdr/timers.conf
Apr 21 01:53:06 vdrsrv01 vdr: [31975] loading /var/lib/vdr/commands.conf
Apr 21 01:53:06 vdrsrv01 vdr: [31975] loading /var/lib/vdr/reccmds.conf
Apr 21 01:53:06 vdrsrv01 vdr: [31975] loading /var/lib/vdr/svdrphosts.conf
Apr 21 01:53:06 vdrsrv01 vdr: [31975] loading /var/lib/vdr/remote.conf
Apr 21 01:53:06 vdrsrv01 vdr: [31975] loading /var/lib/vdr/keymacros.conf
Apr 21 01:53:06 vdrsrv01 vdr: [31975] loading /var/lib/vdr/camtweaks.conf
Apr 21 01:53:06 vdrsrv01 vdr: [31975] registered source parameters for 'A - ATSC'
Apr 21 01:53:06 vdrsrv01 vdr: [31975] registered source parameters for 'C - DVB-C'
Apr 21 01:53:06 vdrsrv01 vdr: [31975] registered source parameters for 'S - DVB-S'
Apr 21 01:53:06 vdrsrv01 vdr: [31982] video directory scanner thread started (pid=31975, tid=31982, prio=low)
Apr 21 01:53:06 vdrsrv01 vdr: [31975] registered source parameters for 'T - DVB-T'
Apr 21 01:53:06 vdrsrv01 vdr: [31983] epg data reader thread started (pid=31975, tid=31983, prio=high)
Apr 21 01:53:06 vdrsrv01 vdr: [31975] no DVB device found
Apr 21 01:53:06 vdrsrv01 vdr: [31983] reading EPG data from /var/cache/vdr/epg.data
Apr 21 01:53:06 vdrsrv01 vdr: [31975] initializing plugin: dbus2vdr (31): control vdr via D-Bus
Apr 21 01:53:06 vdrsrv01 vdr: [31982] video directory scanner thread ended (pid=31975, tid=31982)
Apr 21 01:53:06 vdrsrv01 vdr: [31975] initializing plugin: ddci2 (1.0.5): External Digital Devices CI-Adapter
Apr 21 01:53:06 vdrsrv01 vdr: [31975] initializing plugin: desktop (0.0.3): desktop apps menu
Apr 21 01:53:06 vdrsrv01 vdr: [31975] initializing plugin: devstatus (0.4.1): Status of dvb devices
Apr 21 01:53:06 vdrsrv01 vdr: [31975] initializing plugin: markad (0.1.6): Mark advertisements
Apr 21 01:53:06 vdrsrv01 vdr: [31975] initializing plugin: osd2web (0.2.48-GIT): osd2web plugin
Apr 21 01:53:06 vdrsrv01 vdr: [31975] initializing plugin: pulsecontrol (0.2.1): control settings of pulseaudio
Apr 21 01:53:06 vdrsrv01 vdr: [31975] initializing plugin: satip (2.4.0): SAT>IP Devices
Apr 21 01:53:06 vdrsrv01 vdr: [31984] SATIP poller thread started (pid=31975, tid=31984, prio=high)
Apr 21 01:53:06 vdrsrv01 vdr: [31975] cTimeMs: using monotonic clock (resolution is 1 ns)
Apr 21 01:53:06 vdrsrv01 vdr: [31975] new device number 1
Apr 21 01:53:06 vdrsrv01 vdr: [31975] SATIP: Creating device CardIndex=0 DeviceNumber=0 [device 0]
Apr 21 01:53:06 vdrsrv01 vdr: [31985] SATIP discover thread started (pid=31975, tid=31985, prio=high)
Apr 21 01:53:06 vdrsrv01 vdr: [31987] SATIP#0 tuner thread started (pid=31975, tid=31987, prio=high)
Apr 21 01:53:06 vdrsrv01 vdr: [31975] new device number 2
Apr 21 01:53:06 vdrsrv01 vdr: [31975] SATIP: Creating device CardIndex=1 DeviceNumber=1 [device 1]
Apr 21 01:53:06 vdrsrv01 vdr: [31989] SATIP#0 section handler thread started (pid=31975, tid=31989, prio=high)
Apr 21 01:53:06 vdrsrv01 vdr: [31990] device 1 section handler thread started (pid=31975, tid=31990, prio=low)
Apr 21 01:53:06 vdrsrv01 vdr: [31991] SATIP#1 tuner thread started (pid=31975, tid=31991, prio=high)
Apr 21 01:53:06 vdrsrv01 vdr: [31992] SATIP#1 section handler thread started (pid=31975, tid=31992, prio=high)
Apr 21 01:53:06 vdrsrv01 vdr: [31975] new device number 3
Apr 21 01:53:06 vdrsrv01 vdr: [31975] SATIP: Creating device CardIndex=2 DeviceNumber=2 [device 2]
Apr 21 01:53:06 vdrsrv01 vdr: [31993] device 2 section handler thread started (pid=31975, tid=31993, prio=low)
Apr 21 01:53:06 vdrsrv01 vdr: [31994] SATIP#2 tuner thread started (pid=31975, tid=31994, prio=high)
Apr 21 01:53:06 vdrsrv01 vdr: [31995] SATIP#2 section handler thread started (pid=31975, tid=31995, prio=high)
Apr 21 01:53:06 vdrsrv01 vdr: [31996] device 3 section handler thread started (pid=31975, tid=31996, prio=low)
Apr 21 01:53:06 vdrsrv01 vdr: [31975] new device number 4
Apr 21 01:53:06 vdrsrv01 vdr: [31975] SATIP: Creating device CardIndex=3 DeviceNumber=3 [device 3]
Apr 21 01:53:06 vdrsrv01 vdr: [31998] SATIP#3 section handler thread started (pid=31975, tid=31998, prio=high)
Apr 21 01:53:06 vdrsrv01 vdr: [31975] initializing plugin: softhddevice (0.7.0): A software and GPU emulated HD device
Apr 21 01:53:06 vdrsrv01 vdr: [31975] new device number 5
Apr 21 01:53:06 vdrsrv01 vdr: [31975] setting primary device to 5
Apr 21 01:53:06 vdrsrv01 vdr: [31975] assuming manual start of VDR
Apr 21 01:53:06 vdrsrv01 vdr: [31975] setting current skin to "lcars"
Apr 21 01:53:06 vdrsrv01 vdr: [31975] loading /var/lib/vdr/themes/lcars-default.theme
Apr 21 01:53:06 vdrsrv01 vdr: [31975] starting plugin: dbus2vdr
Apr 21 01:53:06 vdrsrv01 vdr: [32000] dbus2vdr: mainloop started
Apr 21 01:53:06 vdrsrv01 vdr: [31997] SATIP#3 tuner thread started (pid=31975, tid=31997, prio=high)
Apr 21 01:53:06 vdrsrv01 vdr: [31975] starting plugin: ddci2
Apr 21 01:53:06 vdrsrv01 vdr: [31975] DDCI-Inf: plugin version 1.0.5 initializing (compiled for VDR version 2.4.0)
Apr 21 01:53:06 vdrsrv01 vdr: [31975] DDCI-Inf: found 2 DD CI adapters
Apr 21 01:53:06 vdrsrv01 vdr: [31975] DDCI-Inf: Creating DdCiAdapter 0 (/dev/dvb/adapter0/ca0)
Apr 21 01:53:06 vdrsrv01 vdr: [31999] device 4 section handler thread started (pid=31975, tid=31999, prio=low)
Apr 21 01:53:06 vdrsrv01 vdr: [32000] dbus2vdr: System: connected with unique name :1.140
Apr 21 01:53:06 vdrsrv01 vdr: [32000] dbus2vdr: thread-pool for handling signal-emits started
Apr 21 01:53:06 vdrsrv01 avahi-linker[1603]: 2019-04-21 01:53:06,055 INFO   VDR started
Apr 21 01:53:06 vdrsrv01 vdr: [31983] epg data reader thread ended (pid=31975, tid=31983)
Apr 21 01:53:06 vdrsrv01 vdr: [32005] DDCI adapter /dev/dvb/adapter0/ca0 thread started (pid=31975, tid=32005, prio=high)
Apr 21 01:53:06 vdrsrv01 vdr: [31975] DDCI-Inf: Creating DdCiAdapter 1 (/dev/dvb/adapter1/ca0)
Apr 21 01:53:06 vdrsrv01 vdr: [31975] DDCI-Inf: plugin started
Apr 21 01:53:06 vdrsrv01 vdr: [31975] starting plugin: desktop
Apr 21 01:53:06 vdrsrv01 vdr: [31975] starting plugin: devstatus
Apr 21 01:53:06 vdrsrv01 vdr: [31975] starting plugin: markad
Apr 21 01:53:06 vdrsrv01 vdr: [31975] starting plugin: osd2web
Apr 21 01:53:06 vdrsrv01 vdr[31975]: vdr: error while reading '/var/lib/vdr/plugins/pulsecontrol/startup.script'
Apr 21 01:53:06 vdrsrv01 vdr: [32007] DDCI adapter /dev/dvb/adapter1/ca0 thread started (pid=31975, tid=32007, prio=high)
Apr 21 01:53:06 vdrsrv01 vdr: [32006] DDCI Send (/dev/dvb/adapter0/sec0) thread started (pid=31975, tid=32006, prio=high)
Apr 21 01:53:06 vdrsrv01 vdr: [32008] DDCI Recv (/dev/dvb/adapter0/sec0) thread started (pid=31975, tid=32008, prio=high)
Apr 21 01:53:06 vdrsrv01 vdr: [31975] starting plugin: pulsecontrol
Apr 21 01:53:06 vdrsrv01 vdr: [31975] pulsecontrol: error on reading script /var/lib/vdr/plugins/pulsecontrol/startup.script
Apr 21 01:53:06 vdrsrv01 vdr: [31975] starting plugin: satip
Apr 21 01:53:06 vdrsrv01 vdr: [31975] SATIP: Using CURL 7.58.0 rtsp
Apr 21 01:53:06 vdrsrv01 vdr: osd2web: osd2web plugin thread started (pid=31975)
Apr 21 01:53:06 vdrsrv01 vdr: [31975] starting plugin: softhddevice
Apr 21 01:53:06 vdrsrv01 vdr: [32011] DDCI Send (/dev/dvb/adapter1/sec0) thread started (pid=31975, tid=32011, prio=high)
Apr 21 01:53:06 vdrsrv01 vdr: [32013] DDCI Recv (/dev/dvb/adapter1/sec0) thread started (pid=31975, tid=32013, prio=high)
Apr 21 01:53:06 vdrsrv01 vdr: [32012] DDCI Recv Deliver (/dev/dvb/adapter0/sec0) thread started (pid=31975, tid=32012, prio=high)
Apr 21 01:53:06 vdrsrv01 vdr: osd2web: Listener at port (4444) established
Apr 21 01:53:06 vdrsrv01 vdr: osd2web: using libwebsocket version '2.4.1 unknown-build-hash'
Apr 21 01:53:06 vdrsrv01 vdr: [32014] DDCI Recv Deliver (/dev/dvb/adapter1/sec0) thread started (pid=31975, tid=32014, prio=high)
Apr 21 01:53:06 vdrsrv01 vdr: audio: 'alsa' output module used
Apr 21 01:53:06 vdrsrv01 vdr: audio/alsa: supports pause: yes
Apr 21 01:53:06 vdrsrv01 vdr: [32005] CAM 1: module present
Apr 21 01:53:06 vdrsrv01 vdr: audio:  44100Hz supports 1 2 3 4 5 6 7 8 channels
Apr 21 01:53:06 vdrsrv01 vdr: audio:  48000Hz supports 1 2 3 4 5 6 7 8 channels
Apr 21 01:53:06 vdrsrv01 vdr: audio: 192000Hz supports 1 2 3 4 5 6 7 8 channels
Apr 21 01:53:06 vdrsrv01 vdr: video/vdpau: VDPAU API version: 1
Apr 21 01:53:06 vdrsrv01 vdr: video/vdpau: VDPAU information: NVIDIA VDPAU Driver Shared Library  390.116  Sun Jan 27 06:28:58 PST 2019
Apr 21 01:53:06 vdrsrv01 vdr: video/vdpau: highest supported high quality scaling 1
Apr 21 01:53:06 vdrsrv01 vdr: video/vdpau: feature deinterlace temporal supported
Apr 21 01:53:06 vdrsrv01 vdr: video/vdpau: feature deinterlace temporal spatial supported
Apr 21 01:53:06 vdrsrv01 vdr: video/vdpau: attribute skip chroma deinterlace supported
Apr 21 01:53:06 vdrsrv01 vdr: video/vdpau: 4:2:0 chroma format with 4096x4096 supported
Apr 21 01:53:06 vdrsrv01 vdr: video/vdpau: 4:2:2 chroma format with 4096x4096 supported
Apr 21 01:53:06 vdrsrv01 vdr: video/vdpau: 8bit BGRA format with 16384x16384 supported
Apr 21 01:53:06 vdrsrv01 vdr: video/vdpau: 10bit RGBA format with 16384x16384 supported
Apr 21 01:53:06 vdrsrv01 vdr: [softhddev] ready
Apr 21 01:53:06 vdrsrv01 vdr: [31975] remote control LIRC - keys known
Apr 21 01:53:06 vdrsrv01 vdr: [31975] loading /var/cache/vdr/cam.data
Apr 21 01:53:06 vdrsrv01 vdr: [32045] LIRC remote control thread started (pid=31975, tid=32045, prio=high)
Apr 21 01:53:07 vdrsrv01 vdr: [31985] SATIP: Adding server '10.0.0.139|DVBT2-4,DVBC2-4|OctopusNet:satipsrv01' Bind: default Filters: none CI: yes Quirks: CiXpmt
Apr 21 01:53:07 vdrsrv01 kernel: [17151.787688] dvb_ca_en50221: dvb_ca adapter 0: DVB CAM detected and initialised successfully
Apr 21 01:53:07 vdrsrv01 vdr: [32005] CAM 1: module ready
Apr 21 01:53:08 vdrsrv01 vdr: [32007] CAM 2: no module present
Apr 21 01:53:09 vdrsrv01 vdr: [32005] CAM 1: Conax PRO CAM, 01, 0B00, 8001
Apr 21 01:53:09 vdrsrv01 vdr: [32005] CAM 1: Tweaks [enabled]:, Flags: 0x2, Limit: 4
Apr 21 01:53:09 vdrsrv01 vdr: [32005] CAM 1: system ids: 0B00
Apr 21 01:53:09 vdrsrv01 vdr: [32005] CAM 1: multi channel decryption (MCD) forced by Setup!
Apr 21 01:53:09 vdrsrv01 vdr: [32005] CAM 1: multi transponder decryption (MTD) forced by Setup!
Apr 21 01:53:09 vdrsrv01 vdr: [32005] CAM 1: activating MTD support
Apr 21 01:53:09 vdrsrv01 vdr: [31975] CAM 1: ready, master (Conax PRO CAM)
Apr 21 01:53:09 vdrsrv01 vdr: [31975] CAM 2: ready, master (empty)
Apr 21 01:53:09 vdrsrv01 vdr: [31975] switching to channel 1 C-70-9-108 (NRK1 Sørlandet)
Apr 21 01:53:09 vdrsrv01 vdr: [31975] CAM 1/1: creating new MTD CAM slot
Apr 21 01:53:09 vdrsrv01 vdr: [31975] CAM 1: assigned to device 1
Apr 21 01:53:09 vdrsrv01 vdr: [32046] device 1 receiver thread started (pid=31975, tid=32046, prio=high)
Apr 21 01:53:09 vdrsrv01 vdr: [31975] BuildCaPmts : [1]  ActiveProgs: 0 of 1
Apr 21 01:53:09 vdrsrv01 vdr: [31975] SendCaPmts : [0] actives in CAM: 0 -> 0
Apr 21 01:53:09 vdrsrv01 vdr: [31975] BuildCaPmts : [1]  ActiveProgs: 1 of 1
Apr 21 01:53:09 vdrsrv01 vdr: [31975] SendCaPmts : [1] actives in CAM: 0 -> 1
Apr 21 01:53:09 vdrsrv01 vdr: [32048] SVDRP server handler thread started (pid=31975, tid=32048, prio=low)
Apr 21 01:53:09 vdrsrv01 systemd[1]: Started Video Disk Recorder.
Apr 21 01:53:09 vdrsrv01 vdr: [32048] SVDRP vdrsrv01 opening port 6419/tcp
Apr 21 01:53:09 vdrsrv01 vdr: [32048] SVDRP vdrsrv01 listening on port 6419/tcp