Jan 1 19:01:04 vdr vdr: [16229] VDR version 2.6.3 started Jan 1 19:01:04 vdr vdr: [16229] codeset is 'UTF-8' - known Jan 1 19:01:04 vdr vdr: [16229] found 28 locales in /usr/share/locale Jan 1 19:01:04 vdr vdr: [16229] no locale for language code 'alb,sqi' Jan 1 19:01:04 vdr vdr: [16229] no locale for language code 'bos' Jan 1 19:01:04 vdr vdr: [16229] no locale for language code 'bul' Jan 1 19:01:04 vdr vdr: [16229] no locale for language code 'chi,zho' Jan 1 19:01:04 vdr vdr: [16229] no locale for language code 'eus,baq' Jan 1 19:01:04 vdr vdr: [16229] no locale for language code 'iri,gle' Jan 1 19:01:04 vdr vdr: [16229] no locale for language code 'jpn' Jan 1 19:01:04 vdr vdr: [16229] no locale for language code 'lav' Jan 1 19:01:04 vdr vdr: [16229] no locale for language code 'ltz' Jan 1 19:01:04 vdr vdr: [16229] no locale for language code 'mlt' Jan 1 19:01:04 vdr vdr: [16229] no locale for language code 'por' Jan 1 19:01:04 vdr vdr: [16229] no locale for language code 'smi' Jan 1 19:01:04 vdr vdr: [16229] loading plugin: /usr/lib/vdr/plugins/libvdr-remote.so.2.6.3 Jan 1 19:01:04 vdr vdr: [16229] loading plugin: /usr/lib/vdr/plugins/libvdr-skindesigner.so.2.6.3 Jan 1 19:01:04 vdr vdr: [16229] loading plugin: /usr/lib/vdr/plugins/libvdr-epgsearch.so.2.6.3 Jan 1 19:01:04 vdr vdr: [16229] loading plugin: /usr/lib/vdr/plugins/libvdr-osdteletext.so.2.6.3 Jan 1 19:01:04 vdr vdr: [16229] loading plugin: /usr/lib/vdr/plugins/libvdr-image.so.2.6.3 Jan 1 19:01:04 vdr vdr: [16229] loading plugin: /usr/lib/vdr/plugins/libvdr-screenshot.so.2.6.3 Jan 1 19:01:04 vdr vdr: [16229] loading plugin: /usr/lib/vdr/plugins/libvdr-radio.so.2.6.3 Jan 1 19:01:04 vdr vdr: [16229] loading plugin: /usr/lib/vdr/plugins/libvdr-softhddevice.so.2.6.3 Jan 1 19:01:04 vdr vdr: [16229] loading plugin: /usr/lib/vdr/plugins/libvdr-osd2web.so.2.6.3 Jan 1 19:01:04 vdr vdr: [16229] loading plugin: /usr/lib/vdr/plugins/libvdr-dbus2vdr.so.2.6.3 Jan 1 19:01:04 vdr vdr: [16229] loading plugin: /usr/lib/vdr/plugins/libvdr-streamdev-server.so.2.6.3 Jan 1 19:01:04 vdr vdr: [16229] loading plugin: /usr/lib/vdr/plugins/libvdr-mlist.so.2.6.3 Jan 1 19:01:04 vdr vdr: [16229] loading plugin: /usr/lib/vdr/plugins/libvdr-femon.so.2.6.3 Jan 1 19:01:04 vdr vdr: [16229] loading /etc/vdr/setup.conf Jan 1 19:01:04 vdr vdr: [16229] osdteletext: ignore obsolete option in setup.conf: osdteletext.OSDHAlign (<1.0.0) Jan 1 19:01:04 vdr vdr: [16229] osdteletext: ignore obsolete option in setup.conf: osdteletext.OSDheight (<1.0.0) Jan 1 19:01:04 vdr vdr: [16229] osdteletext: ignore obsolete option in setup.conf: osdteletext.OSDVAlign (<1.0.0) Jan 1 19:01:04 vdr vdr: [16229] osdteletext: ignore obsolete option in setup.conf: osdteletext.OSDwidth (<1.0.0) Jan 1 19:01:04 vdr vdr: [16229] loading /etc/vdr/sources.conf Jan 1 19:01:04 vdr vdr: [16229] loading /etc/vdr/diseqc.conf Jan 1 19:01:04 vdr vdr: [16229] loading /etc/vdr/scr.conf Jan 1 19:01:04 vdr vdr: [16229] loading /etc/vdr/channels.conf Jan 1 19:01:04 vdr vdr: [16229] loading /etc/vdr/timers.conf Jan 1 19:01:04 vdr vdr: [16229] loading /etc/vdr/commands.conf Jan 1 19:01:04 vdr vdr: [16229] loading /etc/vdr/reccmds.conf Jan 1 19:01:04 vdr vdr: [16229] loading /etc/vdr/svdrphosts.conf Jan 1 19:01:04 vdr vdr: [16229] loading /etc/vdr/remote.conf Jan 1 19:01:04 vdr vdr: [16229] loading /etc/vdr/keymacros.conf Jan 1 19:01:04 vdr vdr: [16231] video directory scanner thread started (pid=16229, tid=16231, prio=low) Jan 1 19:01:04 vdr vdr: [16229] registered source parameters for 'A - ATSC' Jan 1 19:01:04 vdr vdr: [16232] epg data reader thread started (pid=16229, tid=16232, prio=high) Jan 1 19:01:04 vdr vdr: [16229] registered source parameters for 'C - DVB-C' Jan 1 19:01:04 vdr vdr: [16229] registered source parameters for 'S - DVB-S' Jan 1 19:01:04 vdr vdr: [16232] reading EPG data from /var/cache/epg.data Jan 1 19:01:04 vdr vdr: [16229] registered source parameters for 'T - DVB-T' Jan 1 19:01:04 vdr vdr: [16229] detected /dev/dvb/adapter7/frontend0 Jan 1 19:01:04 vdr vdr: [16229] detected /dev/dvb/adapter6/frontend0 Jan 1 19:01:04 vdr vdr: [16229] detected /dev/dvb/adapter5/frontend0 Jan 1 19:01:04 vdr vdr: [16229] detected /dev/dvb/adapter4/frontend0 Jan 1 19:01:04 vdr vdr: [16229] detected /dev/dvb/adapter3/frontend0 Jan 1 19:01:04 vdr vdr: [16229] detected /dev/dvb/adapter2/frontend0 Jan 1 19:01:04 vdr vdr: [16229] detected /dev/dvb/adapter1/frontend0 Jan 1 19:01:04 vdr vdr: [16229] detected /dev/dvb/adapter0/frontend0 Jan 1 19:01:04 vdr vdr: [16229] probing /dev/dvb/adapter0/frontend0 Jan 1 19:01:04 vdr vdr: [16229] creating cDvbDevice Jan 1 19:01:04 vdr vdr: [16229] new device number 1 (card index 1) Jan 1 19:01:04 vdr vdr: [16229] cTimeMs: using monotonic clock (resolution is 1 ns) Jan 1 19:01:04 vdr vdr: [16233] device 1 section handler thread started (pid=16229, tid=16233, prio=low) Jan 1 19:01:04 vdr vdr: [16229] DVB API version is 0x050B (VDR was built with 0x050B) Jan 1 19:01:04 vdr vdr: [16229] frontend 0/0 provides DVB-S,DVB-S2 with QPSK ("DVB-S/S2X") Jan 1 19:01:04 vdr vdr: [16236] frontend 0/0 tuner thread started (pid=16229, tid=16236, prio=high) Jan 1 19:01:04 vdr vdr: [16229] probing /dev/dvb/adapter1/frontend0 Jan 1 19:01:04 vdr vdr: [16229] creating cDvbDevice Jan 1 19:01:04 vdr vdr: [16229] new device number 2 (card index 2) Jan 1 19:01:04 vdr vdr: [16237] device 2 section handler thread started (pid=16229, tid=16237, prio=low) Jan 1 19:01:04 vdr vdr: [16229] frontend 1/0 provides DVB-S,DVB-S2 with QPSK ("DVB-S/S2X") Jan 1 19:01:04 vdr vdr: [16240] frontend 1/0 tuner thread started (pid=16229, tid=16240, prio=high) Jan 1 19:01:04 vdr vdr: [16229] probing /dev/dvb/adapter2/frontend0 Jan 1 19:01:04 vdr vdr: [16229] creating cDvbDevice Jan 1 19:01:04 vdr vdr: [16229] new device number 3 (card index 3) Jan 1 19:01:04 vdr vdr: [16241] device 3 section handler thread started (pid=16229, tid=16241, prio=low) Jan 1 19:01:04 vdr vdr: [16229] frontend 2/0 provides DVB-S,DVB-S2 with QPSK ("DVB-S/S2X") Jan 1 19:01:04 vdr vdr: [16244] frontend 2/0 tuner thread started (pid=16229, tid=16244, prio=high) Jan 1 19:01:04 vdr vdr: [16229] probing /dev/dvb/adapter3/frontend0 Jan 1 19:01:04 vdr vdr: [16229] creating cDvbDevice Jan 1 19:01:04 vdr vdr: [16229] new device number 4 (card index 4) Jan 1 19:01:04 vdr vdr: [16245] device 4 section handler thread started (pid=16229, tid=16245, prio=low) Jan 1 19:01:04 vdr vdr: [16229] frontend 3/0 provides DVB-S,DVB-S2 with QPSK ("DVB-S/S2X") Jan 1 19:01:04 vdr vdr: [16248] frontend 3/0 tuner thread started (pid=16229, tid=16248, prio=high) Jan 1 19:01:04 vdr vdr: [16229] skipped /dev/dvb/adapter4/frontend0 Jan 1 19:01:04 vdr vdr: [16229] skipped /dev/dvb/adapter5/frontend0 Jan 1 19:01:04 vdr vdr: [16229] skipped /dev/dvb/adapter6/frontend0 Jan 1 19:01:04 vdr vdr: [16229] skipped /dev/dvb/adapter7/frontend0 Jan 1 19:01:04 vdr vdr: [16229] found 8 DVB devices Jan 1 19:01:04 vdr vdr: [16229] using only 4 DVB devices Jan 1 19:01:04 vdr vdr: [16229] initializing plugin: remote (0.7.0): Fernbedienung Jan 1 19:01:04 vdr vdr: [16229] initializing plugin: skindesigner (1.2.19): Skin Designer Jan 1 19:01:04 vdr vdr: [16229] initializing plugin: epgsearch (2.4.1): Suche im EPG nach Wiederholungen und anderem Jan 1 19:01:04 vdr vdr: [16229] initializing plugin: osdteletext (2.3.1): Zeigt den Videotext auf dem OSD an Jan 1 19:01:04 vdr vdr: [16229] initializing plugin: image (0.5.0): Ein Bildbetrachter Plugin Jan 1 19:01:04 vdr vdr: [16229] initializing plugin: screenshot (0.0.16): erstellt Bildschirmfotos Jan 1 19:01:04 vdr vdr: [16229] initializing plugin: radio (1.1.0): Hintergr.Bilder/RDS-Text für Radiosender Jan 1 19:01:04 vdr vdr: [16229] initializing plugin: softhddevice (1.9.7-GIT90d0365): Ein Software und GPU emulieres UHD-Gerät Jan 1 19:01:04 vdr vdr: [16229] new device number 5 (card index 9) Jan 1 19:01:04 vdr vdr: [16229] initializing plugin: osd2web (0.2.55-GIT): osd2web plugin Jan 1 19:01:04 vdr vdr: [16229] initializing plugin: dbus2vdr (31): Steuerung des VDR über D-Bus Jan 1 19:01:04 vdr vdr: [16229] initializing plugin: streamdev-server (0.6.3): VDR Streaming Server Jan 1 19:01:04 vdr vdr: [16229] initializing plugin: mlist (1.0.2): Zeigt vergangene Nachrichten an Jan 1 19:01:04 vdr vdr: [16229] initializing plugin: femon (2.4.1): DVB Signal Informationsanzeige (OSD) Jan 1 19:01:04 vdr vdr: [16229] setting primary device to 5 Jan 1 19:01:04 vdr vdr: [softhddev]MakePrimaryDevice: 1 Jan 1 19:01:04 vdr vdr: [softhddev]cSoftOsdProvider: Jan 1 19:01:04 vdr vdr: [16229] [softhddev]stopping OpenGL Worker Thread Jan 1 19:01:04 vdr vdr: [16229] [softhddev]OpenGL Worker Thread stopped Jan 1 19:01:04 vdr vdr: [softhddev]SetVideoFormat: 1 Jan 1 19:01:04 vdr vdr: [softhddev]SetVideoDisplayFormat: 0 Jan 1 19:01:04 vdr vdr: [softhddev]GetSpuDecoder: Jan 1 19:01:04 vdr vdr: [softhddev]SetVolumeDevice: 110 Jan 1 19:01:04 vdr vdr: [16229] scheduled wakeup time in 1 minutes, assuming automatic start of VDR Jan 1 19:01:04 vdr vdr: [16229] skin "simplextw" not available - using "lcars" instead Jan 1 19:01:04 vdr vdr: [16229] loading /etc/vdr/themes/lcars-default.theme Jan 1 19:01:04 vdr vdr: [16229] starting plugin: remote Jan 1 19:01:04 vdr vdr: [16229] remote: using '/dev/input/by-id/usb-flirc.tv_flirc-if01-event-kbd' Jan 1 19:01:04 vdr vdr: [16229] remote-usb-flirc_tv_flirc-if01-event-kbd: autorepeat supported Jan 1 19:01:04 vdr vdr: [16229] remote-usb-flirc_tv_flirc-if01-event-kbd: exclusive access granted Jan 1 19:01:04 vdr vdr: [16229] starting plugin: skindesigner Jan 1 19:01:04 vdr vdr: [16229] skindesigner: TrueColor OSD found Jan 1 19:01:04 vdr vdr: [16229] skindesigner: using libskindesigner API Version 0.1.2 Jan 1 19:01:04 vdr vdr: [16229] skindesigner: plugin setup uses libskindesigner API Version 0.1.2 Jan 1 19:01:04 vdr vdr: [16229] skindesigner: plugin setup has registered 1 menus Jan 1 19:01:04 vdr vdr: [16229] skindesigner: skinsetup template successfully registered at skindesigner, id 0 Jan 1 19:01:04 vdr vdr: [16229] skindesigner: using Skin Directory /usr/share/vdr/plugins/skindesigner/skins/ Jan 1 19:01:04 vdr vdr: [16229] skindesigner: using Installer Skin Directory /etc/vdr/plugins/skindesigner/installerskins/ Jan 1 19:01:04 vdr vdr: [16229] skindesigner: using common ChannelLogo Directory /etc/vdr/plugins/skindesigner/logos/ Jan 1 19:01:04 vdr vdr: [16229] skindesigner: using EPG Images Directory /var/cache/vdr/plugins/skindesigner/epgimages/ Jan 1 19:01:04 vdr vdr: [16229] skindesigner 4 skins found in /usr/share/vdr/plugins/skindesigner/skins/ Jan 1 19:01:04 vdr vdr: [16229] skindesigner 2 skins found in /etc/vdr/plugins/skindesigner/installerskins/ Jan 1 19:01:04 vdr vdr: [16229] skindesigner: skin metrixhd started Jan 1 19:01:04 vdr vdr: [16229] skindesigner: skin shady_KISS started Jan 1 19:01:04 vdr vdr: [16229] skindesigner: skin estuary4vdr started Jan 1 19:01:04 vdr vdr: [16229] skindesigner: skin shady started Jan 1 19:01:04 vdr vdr: [16229] skindesigner: skin simplex started Jan 1 19:01:04 vdr vdr: [16229] skindesigner: skin simplextw started Jan 1 19:01:04 vdr vdr: [16229] skindesigner: ERROR Unknown Setup Parameter nopacity.fadeTime Jan 1 19:01:04 vdr vdr: [16229] skindesigner: ERROR Unknown Setup Parameter nopacity.showposter Jan 1 19:01:04 vdr vdr: [16229] skindesigner: ERROR Unknown Setup Parameter nopacity.showweather Jan 1 19:01:04 vdr vdr: [16229] skindesigner: ERROR Unknown Setup Parameter nopacity.transparency Jan 1 19:01:04 vdr vdr: [16229] starting plugin: epgsearch Jan 1 19:01:04 vdr vdr: [16229] loading /etc/vdr/plugins/epgsearch/epgsearchcats.conf Jan 1 19:01:04 vdr vdr: [16229] loading /etc/vdr/plugins/epgsearch/epgsearchmenu.conf Jan 1 19:01:04 vdr vdr: [16231] video directory scanner thread ended (pid=16229, tid=16231) Jan 1 19:01:04 vdr kernel: [ 3429.890591] NFSD: Using nfsdcld client tracking operations. Jan 1 19:01:04 vdr kernel: [ 3429.890593] NFSD: no clients to reclaim, skipping NFSv4 grace period (net f0000000) Jan 1 19:01:04 vdr vdr: [16232] epg data reader thread ended (pid=16229, tid=16232) Jan 1 19:01:04 vdr vdr: [16229] loading /etc/vdr/plugins/epgsearch/epgsearchblacklists.conf Jan 1 19:01:04 vdr vdr: [16229] EPGSearch: loading /etc/vdr/plugins/epgsearch/epgsearch.conf Jan 1 19:01:04 vdr vdr: [16229] EPGSearch: loading /etc/vdr/plugins/epgsearch/epgsearchdone.data Jan 1 19:01:04 vdr vdr: [16229] loading /etc/vdr/plugins/epgsearch/timersdone.conf Jan 1 19:01:04 vdr vdr: [16229] EPGSearch: loading /etc/vdr/plugins/epgsearch/epgsearchupdmail.templ Jan 1 19:01:04 vdr vdr: [16250] EPGSearch: searchtimer thread started (pid=16229, tid=16250, prio=high) Jan 1 19:01:04 vdr vdr: [16251] EPGSearch: conflictcheck thread started (pid=16229, tid=16251, prio=high) Jan 1 19:01:04 vdr vdr: [16252] mail-checker thread started (pid=16229, tid=16252, prio=high) Jan 1 19:01:04 vdr vdr: [16229] starting plugin: osdteletext Jan 1 19:01:04 vdr vdr: [16229] osdteletext: selected storage system: packed Jan 1 19:01:04 vdr vdr: [16253] Fritz Plugin Initialization thread started (pid=16229, tid=16253, prio=high) Jan 1 19:01:04 vdr vdr: [16229] osdteletext: OSD multiple preset feature not activated Jan 1 19:01:04 vdr vdr: [16229] osdteletext: OSD menu Hotkey multi-level feature not activated Jan 1 19:01:04 vdr vdr: [16229] starting plugin: image Jan 1 19:01:04 vdr vdr: [16229] loading /etc/vdr/plugins/imagesources.conf Jan 1 19:01:04 vdr vdr: [16229] starting plugin: screenshot Jan 1 19:01:04 vdr vdr: [softhddev]GrabImage: 21928, 0, -1, -1x-1 Jan 1 19:01:04 vdr vdr: video: grab Jan 1 19:01:04 vdr vdr: [16229] starting plugin: radio Jan 1 19:01:04 vdr vdr: [16229] vdr-radio: Radio-Plugin Backgr.Image/RDS-Text starts... Jan 1 19:01:04 vdr vdr: [16254] radioimage thread started (pid=16229, tid=16254, prio=high) Jan 1 19:01:04 vdr vdr: [16229] radio: new cRadioAudio Jan 1 19:01:04 vdr vdr: [16229] starting plugin: softhddevice Jan 1 19:01:04 vdr vdr: [16255] radiocheck thread started (pid=16229, tid=16255, prio=high) Jan 1 19:01:04 vdr vdr: [softhddev] ready detached Jan 1 19:01:04 vdr vdr: [16229] starting plugin: osd2web Jan 1 19:01:04 vdr vdr: [16229] starting plugin: dbus2vdr Jan 1 19:01:04 vdr vdr: osd2web: osd2web plugin thread started (pid=16229) Jan 1 19:01:04 vdr vdr: [16258] dbus2vdr: mainloop started Jan 1 19:01:04 vdr vdr: osd2web: Listener at port (4444) established Jan 1 19:01:04 vdr vdr: osd2web: using libwebsocket version '4.0.20 unknown-build-hash' Jan 1 19:01:04 vdr vdr: [16229] starting plugin: streamdev-server Jan 1 19:01:04 vdr vdr: [16229] loading /etc/vdr/plugins/streamdev-server/streamdevhosts.conf Jan 1 19:01:04 vdr vdr: [16229] starting plugin: mlist Jan 1 19:01:04 vdr vdr: [16229] starting plugin: femon Jan 1 19:01:04 vdr vdr: [16261] streamdev server thread started (pid=16229, tid=16261, prio=high) Jan 1 19:01:04 vdr vdr: [16229] setting current skin to "simplextw" Jan 1 19:01:04 vdr vdr: [16229] loading /etc/vdr/themes/simplextw-default.theme Jan 1 19:01:04 vdr vdr: [16261] Streamdev: Listening (VTP) on port 2004 Jan 1 19:01:04 vdr vdr: [16229] remote control remote-usb-flirc_tv_flirc-if01-event-kbd - keys known Jan 1 19:01:04 vdr vdr: [16261] Streamdev: Listening (HTTP) on port 3000 Jan 1 19:01:04 vdr vdr: [16229] remote control XKeySym - keys known Jan 1 19:01:04 vdr vdr: [16229] loading /var/cache/vdr/cam.data Jan 1 19:01:04 vdr vdr: [16229] switching to channel 2 S19.2E-1-1011-11110 (ZDF HD) Jan 1 19:01:04 vdr vdr: [16262] device 1 receiver thread started (pid=16229, tid=16262, prio=high) Jan 1 19:01:04 vdr vdr: [16229] osdteletext: cTxtReceiver started on DVB 0 for channel 2 'ZDF HD' ID=S19.2E-1-1011-11110 storeTopText=false LiveView=true Jan 1 19:01:04 vdr vdr: [16229] creating directory /vtx/S19.2E-1-1011-11110 Jan 1 19:01:04 vdr vdr: [16265] device 1 TS buffer thread started (pid=16229, tid=16265, prio=high) Jan 1 19:01:04 vdr vdr: [softhddev]SetVolumeDevice: 51 Jan 1 19:01:04 vdr vdr: [16264] osdteletext-receiver thread started (pid=16229, tid=16264, prio=low) Jan 1 19:01:04 vdr vdr: [16229] setting watchdog timer to 30 seconds Jan 1 19:01:04 vdr vdr: [16266] SVDRP server handler thread started (pid=16229, tid=16266, prio=low) Jan 1 19:01:04 vdr vdr: [16266] SVDRP vdr opening port 6419/tcp Jan 1 19:01:04 vdr vdr: [16266] SVDRP vdr listening on port 6419/tcp Jan 1 19:01:04 vdr vdr: [16258] dbus2vdr: System: connected with unique name :1.82 Jan 1 19:01:04 vdr vdr: [16258] dbus2vdr: thread-pool for handling signal-emits started Jan 1 19:01:04 vdr vdr: [softhddev]SetPlayMode: 1 Jan 1 19:01:04 vdr vdr: [softhddev]GetOsdSize: 1920x1080 1 Jan 1 19:01:04 vdr vdr: [16229] OSD size changed to 1920x1080 @ 1 Jan 1 19:01:04 vdr systemd[1]: Finished NFS server and services. Jan 1 19:01:04 vdr systemd[1]: Starting Video Disk Recorder... Jan 1 19:01:04 vdr vdr: [16266] SVDRP vdr < 127.0.0.1:60420 client connection accepted Jan 1 19:01:04 vdr vdr: [16266] SVDRP vdr > 127.0.0.1:60420 server created Jan 1 19:01:04 vdr vdr: [16266] SVDRP vdr < 127.0.0.1:60420 connection closed Jan 1 19:01:04 vdr vdr: [16266] SVDRP vdr < 127.0.0.1:60420 server destroyed Jan 1 19:01:04 vdr vdr: [16266] SVDRP vdr < 127.0.0.1:60432 client connection accepted Jan 1 19:01:04 vdr vdr: [16266] SVDRP vdr > 127.0.0.1:60432 server created Jan 1 19:01:04 vdr vdr: [16266] SVDRP vdr < 127.0.0.1:60432 connection closed Jan 1 19:01:04 vdr vdr: [16266] SVDRP vdr < 127.0.0.1:60432 server destroyed Jan 1 19:01:04 vdr vdr: [16266] SVDRP vdr < 127.0.0.1:60446 client connection accepted Jan 1 19:01:04 vdr vdr: [16266] SVDRP vdr > 127.0.0.1:60446 server created Jan 1 19:01:04 vdr vdr: [16266] SVDRP vdr < 127.0.0.1:60446 connection closed Jan 1 19:01:04 vdr vdr: [16266] SVDRP vdr < 127.0.0.1:60446 server destroyed Jan 1 19:01:04 vdr vdr: [16229] skindesigner: initializing skin simplextw Jan 1 19:01:04 vdr vdr: [16229] skindesigner: using decimal point , Jan 1 19:01:04 vdr vdr: [16229] skindesigner: using channel logo path /etc/vdr/plugins/skindesigner/logos/ Jan 1 19:01:04 vdr vdr: [16229] skindesigner: using icon path /etc/vdr/plugins/skindesigner/installerskins/simplextw/themes/default/ Jan 1 19:01:04 vdr vdr: [16229] skindesigner: using skinparts path /etc/vdr/plugins/skindesigner/installerskins/simplextw/themes/default/skinparts/ Jan 1 19:01:04 vdr vdr: [16229] skindesigner: using svgtemplate path /etc/vdr/plugins/skindesigner/installerskins/simplextw/svgtemplates/ Jan 1 19:01:04 vdr vdr: [16229] skindesigner: using language de_DE Jan 1 19:01:04 vdr vdr: [16266] SVDRP vdr < 127.0.0.1:60450 client connection accepted Jan 1 19:01:04 vdr vdr: [16266] SVDRP vdr > 127.0.0.1:60450 server created Jan 1 19:01:04 vdr vdr: [16266] switching to channel 1 S19.2E-1-1019-10301 (Das Erste HD) Jan 1 19:01:04 vdr vdr: [softhddev]SetPlayMode: 0 Jan 1 19:01:04 vdr vdr: [softhddev]SetVideoDisplayFormat: 0 Jan 1 19:01:04 vdr vdr: [softhddev]GetSpuDecoder: Jan 1 19:01:04 vdr vdr: [16229] skindesigner: templates successfully validated and parsed Jan 1 19:01:04 vdr vdr: [16264] osdteletext-receiver thread ended (pid=16229, tid=16264) Jan 1 19:01:04 vdr vdr: [16266] osdteletext: cTxtReceiver stopped after 0 sec: cTelePage received on DVB 0 for channel 2 'ZDF HD' ID=S19.2E-1-1011-11110: 0 (-nan/sec) Jan 1 19:01:04 vdr vdr: [16266] buffer stats: 0 (0%) used Jan 1 19:01:04 vdr vdr: [16229] skindesigner: invalid factor {shifttimetimers} in expression "{shifttimetimers}" Jan 1 19:01:04 vdr vdr: [16265] device 1 TS buffer thread ended (pid=16229, tid=16265) Jan 1 19:01:04 vdr vdr: [16262] buffer stats: 0 (0%) used Jan 1 19:01:04 vdr vdr: [16262] device 1 receiver thread ended (pid=16229, tid=16262) Jan 1 19:01:04 vdr vdr: [16266] osdteletext: cTxtReceiver started on DVB 0 for channel 1 'Das Erste HD' ID=S19.2E-1-1019-10301 storeTopText=false LiveView=true Jan 1 19:01:04 vdr vdr: [16358] device 1 receiver thread started (pid=16229, tid=16358, prio=high) Jan 1 19:01:04 vdr vdr: [16266] creating directory /vtx/S19.2E-1-1019-10301 Jan 1 19:01:04 vdr vdr: [16359] device 1 TS buffer thread started (pid=16229, tid=16359, prio=high) Jan 1 19:01:04 vdr vdr: [16360] osdteletext-receiver thread started (pid=16229, tid=16360, prio=low) Jan 1 19:01:04 vdr vdr: [16266] SVDRP vdr < 127.0.0.1:60450 connection closed Jan 1 19:01:04 vdr vdr_delayed.sh[16307]: 220 vdr SVDRP VideoDiskRecorder 2.6.3; Sun Jan 1 19:01:04 2023; UTF-8 Jan 1 19:01:04 vdr vdr_delayed.sh[16307]: 250 1 Das Erste HD Jan 1 19:01:04 vdr vdr_delayed.sh[16307]: 221 vdr closing connection Jan 1 19:01:04 vdr vdr: [16266] SVDRP vdr < 127.0.0.1:60450 server destroyed Jan 1 19:01:04 vdr systemd[1]: Condition check resulted in Kernel Module supporting RPCSEC_GSS being skipped. Jan 1 19:01:04 vdr systemd[1]: Stopping NFS server and services... Jan 1 19:01:04 vdr vdr: [16229] skindesigner: templates and images cached Jan 1 19:01:04 vdr vdr: [16229] skindesigner: cached 77 icons - size internal mem 1,48MB, high level mem 0,00MB Jan 1 19:01:04 vdr vdr: [16229] skindesigner: cached 201 logos - size 7134,36MB internal mem Jan 1 19:01:04 vdr vdr: [16229] skindesigner: cached 8 skinparts - size internal mem 1,63MB, high level mem 0,00MB Jan 1 19:01:04 vdr vdr: [16229] skindesigner: templates loaded and caches created - needed 281 ms Jan 1 19:01:04 vdr vdr: [softhddev]CreateOsd: 130, 799, 0 Jan 1 19:01:04 vdr vdr: [16229] [softhddev]OpenGl Thread not started successfully, using Dummy OSD Jan 1 19:01:04 vdr vdr: [16460] animator thread thread started (pid=16229, tid=16460, prio=high) Jan 1 19:01:04 vdr vdr: [16229] timer 1 (2 2015-2145 VPS 'Mama~Der Bergdoktor~Getrennte Welten') set to event Do. 05.01.2023 20:15-21:45 (VPS: 05.01. 20:15) 'Der Bergdoktor' Jan 1 19:01:04 vdr vdr: [16229] timer 2 (26 1729-1759 VPS 'Serien~Retoure~1 Der ganz nahe Osten') set to event Sa. 07.01.2023 17:30-18:00 (VPS: 07.01. 17:29) 'Retoure (1)' Jan 1 19:01:04 vdr vdr: [16229] timer 3 (2 2015-2145 VPS 'Mama~Der Bergdoktor~Eine schwere Last') set to event Do. 12.01.2023 20:15-21:45 (VPS: 12.01. 20:15) 'Der Bergdoktor' Jan 1 19:01:04 vdr vdr: [16229] timer 4 (2 2015-2145 VPS 'Mama~Der Bergdoktor~Wer wir sind') set to event Do. 19.01.2023 20:15-21:45 (VPS: 19.01. 20:15) 'Der Bergdoktor' Jan 1 19:01:04 vdr vdr: [16229] timer 5 (2 2230-2300 VPS 'Spass~heute-show spezial') set to event Fr. 20.01.2023 22:30-23:00 (VPS: 20.01. 22:30) 'heute-show spezial' Jan 1 19:01:04 vdr vdr: [16229] timer 6 (3 2012-2237 'Das perfekte Geheimnis') set to event So. 01.01.2023 20:14-22:32 'Das perfekte Geheimnis' Jan 1 19:01:04 vdr vdr: [16229] timer 7 (2 2015-2145 VPS 'Das Traumschiff') set to event So. 01.01.2023 20:15-21:45 (VPS: 01.01. 20:15) 'Das Traumschiff' Jan 1 19:01:04 vdr vdr: [16229] timer 8 (1 1903-2031 'Ihr letzter Wille kann mich mal!') set to event So. 01.01.2023 20:00-20:15 (VPS: 01.01. 20:00) 'Tagesschau' Jan 1 19:01:04 vdr vdr: [16229] switching device 2 to channel 2 S19.2E-1-1011-11110 (ZDF HD) Jan 1 19:01:04 vdr kernel: [ 3430.363780] nfsd: last server has exited, flushing export cache Jan 1 19:01:04 vdr vdr: [16229] skindesigner: w 0 h 0 mode changed to 1 Jan 1 19:01:04 vdr vdr: [softhddev]SetPlayMode: 1 Jan 1 19:01:04 vdr systemd[1]: nfs-server.service: Deactivated successfully. Jan 1 19:01:04 vdr systemd[1]: Stopped NFS server and services. Jan 1 19:01:04 vdr rpc.idmapd[16218]: exiting on signal 15 Jan 1 19:01:04 vdr systemd[1]: Stopping NFSv4 ID-name mapping service... Jan 1 19:01:04 vdr systemd[1]: Stopping NFS Mount Daemon... Jan 1 19:01:04 vdr systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Jan 1 19:01:04 vdr rpc.mountd[16221]: Caught signal 15, un-registering and exiting. Jan 1 19:01:04 vdr systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Jan 1 19:01:04 vdr systemd[1]: nfs-idmapd.service: Main process exited, code=exited, status=1/FAILURE Jan 1 19:01:04 vdr systemd[1]: nfs-idmapd.service: Failed with result 'exit-code'. Jan 1 19:01:04 vdr systemd[1]: Stopped NFSv4 ID-name mapping service. Jan 1 19:01:04 vdr systemd[1]: nfs-mountd.service: Deactivated successfully. Jan 1 19:01:04 vdr systemd[1]: Stopped NFS Mount Daemon. Jan 1 19:01:04 vdr systemd[1]: Starting NFSv4 ID-name mapping service... Jan 1 19:01:04 vdr systemd[1]: Starting NFS Mount Daemon... Jan 1 19:01:04 vdr rpc.idmapd[16464]: Setting log level to 0 Jan 1 19:01:04 vdr systemd[1]: Started NFSv4 ID-name mapping service. Jan 1 19:01:04 vdr rpc.mountd[16465]: Version 2.6.1 starting Jan 1 19:01:04 vdr systemd[1]: Started NFS Mount Daemon. Jan 1 19:01:04 vdr systemd[1]: Starting NFS server and services... Jan 1 19:01:04 vdr exportfs[16466]: exportfs: Failed to resolve furion Jan 1 19:01:04 vdr exportfs[16466]: exportfs: Failed to resolve furion Jan 1 19:01:04 vdr exportfs[16466]: exportfs: Failed to resolve lifebook Jan 1 19:01:04 vdr exportfs[16466]: exportfs: Failed to resolve lifebook Jan 1 19:01:04 vdr exportfs[16466]: exportfs: Failed to resolve shuttle Jan 1 19:01:04 vdr exportfs[16466]: exportfs: Failed to resolve shuttle Jan 1 19:01:05 vdr vdr: [softhddev]PlayTsAudio: SoftIsPlayingVideo: 1 Jan 1 19:01:05 vdr kernel: [ 3430.706728] NFSD: Using nfsdcld client tracking operations. Jan 1 19:01:05 vdr kernel: [ 3430.706737] NFSD: no clients to reclaim, skipping NFSv4 grace period (net f0000000) Jan 1 19:01:05 vdr systemd[1]: Finished NFS server and services. Jan 1 19:01:05 vdr vdr: [16233] channel 1 (Das Erste HD) event So. 01.01.2023 18:30-20:00 (VPS: 01.01. 18:30) 'Ihr letzter Wille kann mich mal!' status 4 Jan 1 19:01:05 vdr vdr_delayed.sh[16485]: warning: commands will be executed using /bin/sh Jan 1 19:01:05 vdr vdr_delayed.sh[16485]: job 911 at Sun Jan 1 19:02:00 2023 Jan 1 19:01:05 vdr kernel: [ 3431.164879] ata2.00: configured for UDMA/133 Jan 1 19:01:05 vdr kernel: [ 3431.166221] ata2.00: Enabling discard_zeroes_data Jan 1 19:01:05 vdr vdr: [16237] channel 2 (ZDF HD) event So. 01.01.2023 19:00-19:15 (VPS: 01.01. 19:00) 'heute' status 4 Jan 1 19:01:05 vdr vdr: [16229] max. latency time 1 seconds Jan 1 19:01:06 vdr kernel: [ 3432.424622] r8169 0000:02:00.0 enp2s0: Link is Up - 1Gbps/Full - flow control rx/tx Jan 1 19:01:06 vdr systemd-networkd[1118]: enp2s0: Gained carrier Jan 1 19:01:06 vdr systemd-timesyncd[1032]: Network configuration changed, trying to establish connection. Jan 1 19:01:06 vdr systemd-networkd[1118]: enp2s0: DHCPv4 address 192.168.27.62/24 via 192.168.27.1 Jan 1 19:01:06 vdr avahi-daemon[1140]: Joining mDNS multicast group on interface enp2s0.IPv4 with address 192.168.27.62. Jan 1 19:01:06 vdr avahi-daemon[1140]: New relevant interface enp2s0.IPv4 for mDNS. Jan 1 19:01:06 vdr systemd-timesyncd[1032]: Network configuration changed, trying to establish connection. Jan 1 19:01:06 vdr avahi-daemon[1140]: Registering new address record for 192.168.27.62 on enp2s0.IPv4. Jan 1 19:01:06 vdr systemd-timesyncd[1032]: Initial synchronization to time server 192.168.27.1:123 (192.168.27.1). Jan 1 19:01:07 vdr systemd-resolved[1120]: Using degraded feature set UDP instead of UDP+EDNS0 for DNS server 192.168.27.1. Jan 1 19:01:07 vdr vdr: [16460] animator thread thread ended (pid=16229, tid=16460) Jan 1 19:01:08 vdr avahi-daemon[1140]: Leaving mDNS multicast group on interface enp2s0.IPv6 with address fe80::aaa1:59ff:feb2:dd7e. Jan 1 19:01:08 vdr avahi-daemon[1140]: Joining mDNS multicast group on interface enp2s0.IPv6 with address 2a02:908:2215:2160:aaa1:59ff:feb2:dd7e. Jan 1 19:01:08 vdr avahi-daemon[1140]: Registering new address record for 2a02:908:2215:2160:aaa1:59ff:feb2:dd7e on enp2s0.*. Jan 1 19:01:08 vdr avahi-daemon[1140]: Withdrawing address record for fe80::aaa1:59ff:feb2:dd7e on enp2s0. Jan 1 19:01:08 vdr avahi-daemon[1140]: Registering new address record for fd00::aaa1:59ff:feb2:dd7e on enp2s0.*. Jan 1 19:01:10 vdr systemd[1]: Condition check resulted in Kernel Module supporting RPCSEC_GSS being skipped. Jan 1 19:01:10 vdr systemd[1]: Stopping NFS server and services... Jan 1 19:01:10 vdr kernel: [ 3435.890263] nfsd: last server has exited, flushing export cache Jan 1 19:01:10 vdr systemd[1]: nfs-server.service: Deactivated successfully. Jan 1 19:01:10 vdr systemd[1]: Stopped NFS server and services. Jan 1 19:01:10 vdr rpc.idmapd[16464]: exiting on signal 15 Jan 1 19:01:10 vdr systemd[1]: Stopping NFSv4 ID-name mapping service... Jan 1 19:01:10 vdr systemd[1]: Stopping NFS Mount Daemon... Jan 1 19:01:10 vdr systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Jan 1 19:01:10 vdr rpc.mountd[16465]: Caught signal 15, un-registering and exiting. Jan 1 19:01:10 vdr systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Jan 1 19:01:10 vdr systemd[1]: nfs-idmapd.service: Main process exited, code=exited, status=1/FAILURE Jan 1 19:01:10 vdr systemd[1]: nfs-idmapd.service: Failed with result 'exit-code'. Jan 1 19:01:10 vdr systemd[1]: Stopped NFSv4 ID-name mapping service. Jan 1 19:01:10 vdr systemd[1]: Starting NFSv4 ID-name mapping service... Jan 1 19:01:10 vdr rpc.idmapd[16507]: Setting log level to 0 Jan 1 19:01:10 vdr systemd[1]: Started NFSv4 ID-name mapping service. Jan 1 19:01:10 vdr systemd[1]: nfs-mountd.service: Deactivated successfully. Jan 1 19:01:10 vdr systemd[1]: Stopped NFS Mount Daemon. Jan 1 19:01:10 vdr systemd[1]: Starting NFS Mount Daemon... Jan 1 19:01:10 vdr rpc.mountd[16509]: Version 2.6.1 starting Jan 1 19:01:10 vdr systemd[1]: Started NFS Mount Daemon. Jan 1 19:01:10 vdr systemd[1]: Starting NFS server and services... Jan 1 19:01:10 vdr kernel: [ 3436.096598] NFSD: Using nfsdcld client tracking operations. Jan 1 19:01:10 vdr kernel: [ 3436.096604] NFSD: no clients to reclaim, skipping NFSv4 grace period (net f0000000) Jan 1 19:01:10 vdr systemd[1]: Finished NFS server and services. Jan 1 19:01:10 vdr vdr_delayed.sh[16527]: warning: commands will be executed using /bin/sh Jan 1 19:01:10 vdr vdr_delayed.sh[16527]: job 912 at Sun Jan 1 19:02:00 2023 Jan 1 19:01:15 vdr vdr: [16251] EPGSearch: timer conflict check started Jan 1 19:01:15 vdr vdr: [16250] EPGSearch: search timer update started Jan 1 19:01:15 vdr vdr: [16251] EPGSearch: timer conflict check finished Jan 1 19:01:15 vdr vdr: [16250] timer 0 (2 2015-2145 VPS 'Der Bergdoktor') set to event Do. 05.01.2023 20:15-21:45 (VPS: 05.01. 20:15) 'Der Bergdoktor' Jan 1 19:01:15 vdr vdr: [16250] timer 0 (2 2015-2145 VPS 'Der Bergdoktor') set to event Do. 05.01.2023 20:15-21:45 (VPS: 05.01. 20:15) 'Der Bergdoktor' Jan 1 19:01:15 vdr vdr: [16250] timer 0 (2 2015-2145 VPS 'Der Bergdoktor') set to event Do. 12.01.2023 20:15-21:45 (VPS: 12.01. 20:15) 'Der Bergdoktor' Jan 1 19:01:15 vdr vdr: [16250] timer 0 (2 2015-2145 VPS 'Der Bergdoktor') set to event Do. 12.01.2023 20:15-21:45 (VPS: 12.01. 20:15) 'Der Bergdoktor' Jan 1 19:01:15 vdr vdr: [16250] timer 0 (2 2015-2145 VPS 'Der Bergdoktor') set to event Do. 19.01.2023 20:15-21:45 (VPS: 19.01. 20:15) 'Der Bergdoktor' Jan 1 19:01:15 vdr vdr: [16250] timer 0 (2 2015-2145 VPS 'Der Bergdoktor') set to event Do. 19.01.2023 20:15-21:45 (VPS: 19.01. 20:15) 'Der Bergdoktor' Jan 1 19:01:15 vdr systemd[1]: Finished Video Disk Recorder. Jan 1 19:01:15 vdr vdr: [16250] timer 0 (2 2230-2300 VPS 'heute-show spezial') set to event Fr. 20.01.2023 22:30-23:00 (VPS: 20.01. 22:30) 'heute-show spezial' Jan 1 19:01:15 vdr vdr: [16250] timer 0 (2 2230-2300 VPS 'heute-show spezial') set to event Fr. 20.01.2023 22:30-23:00 (VPS: 20.01. 22:30) 'heute-show spezial' Jan 1 19:01:15 vdr vdr: [16250] EPGSearch: search timer update finished Jan 1 19:01:35 vdr vdr: [16229] skindesigner: drop image cache Jan 1 19:01:35 vdr vdr: [16229] skindesigner: using channel logo path /etc/vdr/plugins/skindesigner/logos/ Jan 1 19:01:35 vdr vdr: [16229] skindesigner: using icon path /etc/vdr/plugins/skindesigner/installerskins/simplextw/themes/default/ Jan 1 19:01:35 vdr vdr: [16229] skindesigner: using skinparts path /etc/vdr/plugins/skindesigner/installerskins/simplextw/themes/default/skinparts/ Jan 1 19:01:35 vdr vdr: [16229] skindesigner: using svgtemplate path /etc/vdr/plugins/skindesigner/installerskins/simplextw/svgtemplates/ Jan 1 19:01:35 vdr vdr: [softhddev]CreateOsd: 498, 799, 0 Jan 1 19:01:35 vdr vdr: [16229] [softhddev]OpenGl Thread not started successfully, using Dummy OSD Jan 1 19:01:35 vdr vdr: [16672] animator thread thread started (pid=16229, tid=16672, prio=high) Jan 1 19:01:39 vdr vdr: [16672] animator thread thread ended (pid=16229, tid=16672) Jan 1 19:01:39 vdr vdr: [16253] Fritz Plugin Initialization thread ended (pid=16229, tid=16253) Jan 1 19:01:40 vdr vdr: [16229] max. latency time 5 seconds Jan 1 19:02:01 vdr atd[16715]: Exec failed for mail command: No such file or directory Jan 1 19:02:01 vdr atd[16716]: Exec failed for mail command: No such file or directory Jan 1 19:02:15 vdr vdr: [16240] frontend 1/0 timed out while tuning to channel 117 (arte), tp 110744 Jan 1 19:02:28 vdr vdr: [16237] changing pids of channel 24 (MDR Sachsen HD) from 5331+5331=27:5332=deu@3,5333=mis@3,5337=qks@3;5336=deu@106:5335=deu:5334 to 5321+5321=27:5322=deu@3,5323=mis@3,5327=qks@3;5326=deu@106:5325=deu:5324 Jan 1 19:02:29 vdr vdr: [16237] changing pids of channel 95 (MDR Thüringen HD) from 5331+5331=27:5332=deu@3,5333=mis@3,5337=qks@3;5336=deu@106:5335=deu:5334 to 5341+5341=27:5342=deu@3,5343=mis@3,5347=qks@3;5346=deu@106:5345=deu:5344 Jan 1 19:02:51 vdr vdr: [16241] changing pids of channel 91 (R9 Oesterreich HD) from 3120+3120=27:3121=deu@3:0:0 to 3120+3120=27:0:0:0 Jan 1 19:02:52 vdr vdr: [16241] changing pids of channel 72 (oe24.TV HD) from 3140+3140=27:3141=deu@3:0:0 to 3140+3140=27:0:0:0 Jan 1 19:03:00 vdr vdr: [16229] switching device 1 to channel 1 S19.2E-1-1019-10301 (Das Erste HD) Jan 1 19:03:00 vdr vdr: [16229] timer 8 (1 1903-2031 'Ihr letzter Wille kann mich mal!') start Jan 1 19:03:00 vdr vdr: [16229] Title: 'Tagesschau' Subtitle: '' Jan 1 19:03:00 vdr vdr: [16229] executing '/usr/local/bin/recordinghooks.sh before "/video0/Ihr_letzter_Wille_kann_mich_mal!/2023-01-01.19.03.1-0.rec"' Jan 1 19:03:00 vdr vdr: [16229] record /video0/Ihr_letzter_Wille_kann_mich_mal!/2023-01-01.19.03.1-0.rec Jan 1 19:03:00 vdr vdr: [16229] creating directory /video0/Ihr_letzter_Wille_kann_mich_mal! Jan 1 19:03:00 vdr vdr: [16229] creating directory /video0/Ihr_letzter_Wille_kann_mich_mal!/2023-01-01.19.03.1-0.rec Jan 1 19:03:00 vdr vdr: [16229] recording to '/video0/Ihr_letzter_Wille_kann_mich_mal!/2023-01-01.19.03.1-0.rec/00001.ts' Jan 1 19:03:00 vdr vdr: [16804] recording thread started (pid=16229, tid=16804, prio=high) Jan 1 19:03:00 vdr vdr: [16229] writing timer id '8@vdr' to /video0/Ihr_letzter_Wille_kann_mich_mal!/2023-01-01.19.03.1-0.rec/.timer Jan 1 19:03:00 vdr vdr: [16804] H.264: 1280 x 720p 50,00 fps 8 Bit Jan 1 19:03:00 vdr vdr: [16804] executing '/usr/local/bin/recordinghooks.sh started "/video0/Ihr_letzter_Wille_kann_mich_mal!/2023-01-01.19.03.1-0.rec"' Jan 1 19:03:30 vdr vdr: [16251] EPGSearch: timer conflict check started Jan 1 19:03:30 vdr vdr: [16251] EPGSearch: timer conflict check finished Jan 1 19:03:31 vdr vdr: [16245] channel 26 (NDR FS HH HD) event So. 01.01.2023 18:45-19:30 (VPS: 01.01. 18:45) 'Unsere Geschichte' status 4 Jan 1 19:03:33 vdr vdr: [16241] changing pids of channel 43 (tv.ingolstadt HD) from 1050+1050=27:1052=@3:0:0 to 1050+1050=27:1052=deu@3:0:0 Jan 1 19:03:34 vdr vdr: [16241] changing name of channel 43 from 'tv.ingolstadt HD,;' to 'tv.ingolstadt HD,;BMT' Jan 1 19:03:52 vdr vdr: [16245] changing pids of channel 123 (MDR Sachsen) from 2901+2901=2:2902=deu@3,2903=mis@3:2905=deu:2904 to 2801+2801=2:2802=deu@3,2803=mis@3:2805=deu:2804 Jan 1 19:03:52 vdr vdr: [16245] changing pids of channel 125 (MDR Thüringen) from 2901+2901=2:2902=deu@3,2903=mis@3:2905=deu:2904 to 3001+3001=2:3002=deu@3,3003=mis@3:3005=deu:3004 Jan 1 19:04:18 vdr earlyoom[1145]: mem avail: 7007 of 7851 MiB (89.24%), swap free: 4095 of 4095 MiB (100.00%), anon: 281 MiB ( 3.58%) Jan 1 19:04:34 vdr vdr: [16245] channel 3 (SAT.1) event So. 01.01.2023 17:50-19:55 'Pan' status 4 Jan 1 19:04:37 vdr smartd[1182]: Device: /dev/sda [SAT], SMART Usage Attribute: 194 Temperature_Celsius changed from 74 to 75 Jan 1 19:04:37 vdr smartd[1182]: Device: /dev/sdb [SAT], SMART Usage Attribute: 194 Temperature_Celsius changed from 69 to 72 Jan 1 19:05:16 vdr vdr: [16241] changing pids of channel 77 (HITRADIO OE3) from 130+130=27:131=deu@3:0:0 to 510+510=2:511=deu@3:0:505 Jan 1 19:05:16 vdr vdr: [16241] changing pids of channel 76 (ORF2E) from 170+170=2:171=deu@3:0:505 to 510+510=2:511=deu@3:0:505 Jan 1 19:05:16 vdr vdr: [16241] changing pids of channel 93 (Mei Musi) from 150+150=2:151=@3:0:0 to 0+0=0:0:0:0 Jan 1 19:05:17 vdr vdr: [16241] changing pids of channel 23 (RiC) from 190+190=2:191=deu@4:0:0 to 0+0=0:191=deu@4:0:0 Jan 1 19:06:39 vdr vdr: [16229] max. latency time 30 seconds Jan 1 19:06:47 vdr vdr: [16240] frontend 1/0 timed out while tuning to channel 117 (arte), tp 110744 Jan 1 19:11:21 vdr vdr: [16240] frontend 1/0 timed out while tuning to channel 117 (arte), tp 110744 Jan 1 19:14:23 vdr vdr: [16241] changing pids of channel 77 (HITRADIO OE3) from 510+510=2:511=deu@3:0:505 to 130+130=27:131=deu@3:0:0 Jan 1 19:14:23 vdr vdr: [16241] changing pids of channel 76 (ORF2E) from 510+510=2:511=deu@3:0:505 to 170+170=2:171=deu@3:0:505 Jan 1 19:14:23 vdr vdr: [16241] changing pids of channel 93 (Mei Musi) from 0+0=0:0:0:0 to 150+150=2:151=@3:0:0 Jan 1 19:14:23 vdr vdr: [16241] changing pids of channel 23 (RiC) from 0+0=0:191=deu@4:0:0 to 190+190=2:191=deu@4:0:0 Jan 1 19:15:54 vdr vdr: [16240] frontend 1/0 timed out while tuning to channel 117 (arte), tp 110744 Jan 1 19:16:31 vdr vdr: [16241] changing pids of channel 91 (R9 Oesterreich HD) from 3120+3120=27:0:0:0 to 3120+3120=27:3121=deu@3:0:0 Jan 1 19:16:31 vdr vdr: [16241] changing pids of channel 72 (oe24.TV HD) from 3140+3140=27:0:0:0 to 3140+3140=27:3141=deu@3:0:0 Jan 1 19:16:50 vdr vdr: [16237] channel 2 (ZDF HD) event So. 01.01.2023 19:00-19:15 (VPS: 01.01. 19:00) 'heute' status 1 Jan 1 19:16:50 vdr vdr: [16237] channel 2 (ZDF HD) event So. 01.01.2023 19:15-20:15 (VPS: 01.01. 19:15) 'Terra X' status 4 Jan 1 19:17:01 vdr CRON[17764]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly) Jan 1 19:20:27 vdr vdr: [16240] frontend 1/0 timed out while tuning to channel 117 (arte), tp 110744 Jan 1 19:24:43 vdr vdr: [16804] recording to '/video0/Ihr_letzter_Wille_kann_mich_mal!/2023-01-01.19.03.1-0.rec/00002.ts' Jan 1 19:25:00 vdr vdr: [16240] frontend 1/0 timed out while tuning to channel 117 (arte), tp 110744 Jan 1 19:28:53 vdr smartd[1182]: Device: /dev/sda [SAT], SMART Usage Attribute: 194 Temperature_Celsius changed from 75 to 74 Jan 1 19:28:53 vdr smartd[1182]: Device: /dev/sdb [SAT], SMART Usage Attribute: 194 Temperature_Celsius changed from 72 to 71 Jan 1 19:29:33 vdr vdr: [16240] frontend 1/0 timed out while tuning to channel 117 (arte), tp 110744 Jan 1 19:29:47 vdr vdr: [16237] changing pids of channel 25 (rbb Brandenburg HD) from 5311+5311=27:5312=deu@3,5313=mis@3,5317=qks@3;5316=deu@106:5315=deu:5314 to 5301+5301=27:5302=deu@3,5303=mis@3,5307=qks@3;5306=deu@106:5305=deu:5304 Jan 1 19:29:48 vdr vdr: [16237] changing pids of channel 95 (MDR Thüringen HD) from 5341+5341=27:5342=deu@3,5343=mis@3,5347=qks@3;5346=deu@106:5345=deu:5344 to 5331+5331=27:5332=deu@3,5333=mis@3,5337=qks@3;5336=deu@106:5335=deu:5334 Jan 1 19:30:50 vdr vdr: [16245] channel 26 (NDR FS HH HD) event So. 01.01.2023 18:45-19:30 (VPS: 01.01. 18:45) 'Unsere Geschichte' status 1 Jan 1 19:30:50 vdr vdr: [16245] channel 26 (NDR FS HH HD) event So. 01.01.2023 19:30-20:00 (VPS: 01.01. 19:30) 'Hamburg Journal' status 4 Jan 1 19:30:50 vdr vdr: [16245] changing pids of channel 98 (NDR FS MV HD) from 5221+5221=27:5222=deu@3,5223=mis@3,5227=qks@3;5226=deu@106:5235=deu:5224 to 5231+5231=27:5232=deu@3,5233=mis@3,5237=qks@3:5235=deu:5224 Jan 1 19:30:51 vdr vdr: [16245] changing pids of channel 26 (NDR FS HH HD) from 5221+5221=27:5222=deu@3,5223=mis@3,5227=qks@3;5226=deu@106:5245=deu:5224 to 5241+5241=27:5242=deu@3,5243=mis@3,5247=qks@3:5245=deu:5224 Jan 1 19:30:51 vdr vdr: [16245] changing pids of channel 99 (NDR FS SH HD) from 5221+5221=27:5222=deu@3,5223=mis@3,5227=qks@3;5226=deu@106:5255=deu:5224 to 5251+5251=27:5252=deu@3,5253=mis@3,5257=qks@3:5255=deu:5224 Jan 1 19:31:00 vdr vdr: [16250] EPGSearch: search timer update started Jan 1 19:31:00 vdr vdr: [16250] timer 0 (2 2015-2145 VPS 'Der Bergdoktor') set to event Do. 05.01.2023 20:15-21:45 (VPS: 05.01. 20:15) 'Der Bergdoktor' Jan 1 19:31:00 vdr vdr: [16250] timer 0 (2 2015-2145 VPS 'Der Bergdoktor') set to event Do. 05.01.2023 20:15-21:45 (VPS: 05.01. 20:15) 'Der Bergdoktor' Jan 1 19:31:00 vdr vdr: [16250] timer 0 (2 2015-2145 VPS 'Der Bergdoktor') set to event Do. 12.01.2023 20:15-21:45 (VPS: 12.01. 20:15) 'Der Bergdoktor' Jan 1 19:31:00 vdr vdr: [16250] timer 0 (2 2015-2145 VPS 'Der Bergdoktor') set to event Do. 12.01.2023 20:15-21:45 (VPS: 12.01. 20:15) 'Der Bergdoktor' Jan 1 19:31:00 vdr vdr: [16250] timer 0 (2 2015-2145 VPS 'Der Bergdoktor') set to event Do. 19.01.2023 20:15-21:45 (VPS: 19.01. 20:15) 'Der Bergdoktor' Jan 1 19:31:00 vdr vdr: [16250] timer 0 (2 2015-2145 VPS 'Der Bergdoktor') set to event Do. 19.01.2023 20:15-21:45 (VPS: 19.01. 20:15) 'Der Bergdoktor' Jan 1 19:31:01 vdr vdr: [16250] timer 0 (2 2230-2300 VPS 'heute-show spezial') set to event Fr. 20.01.2023 22:30-23:00 (VPS: 20.01. 22:30) 'heute-show spezial' Jan 1 19:31:01 vdr vdr: [16250] timer 0 (2 2230-2300 VPS 'heute-show spezial') set to event Fr. 20.01.2023 22:30-23:00 (VPS: 20.01. 22:30) 'heute-show spezial' Jan 1 19:31:01 vdr vdr: [16250] EPGSearch: search timer update finished Jan 1 19:31:10 vdr vdr: [16245] changing pids of channel 126 (rbb Brandenburg) from 601+601=2:602=deu@3,603=mis@3:0:604 to 501+501=2:502=deu@3,503=mis@3:0:504 Jan 1 19:31:10 vdr vdr: [16245] changing pids of channel 133 (NDR FS MV) from 2601+2601=2:2602=deu@3,2603=mis@3:0:2604 to 2401+2401=2:2402=deu@3,2403=mis@3:0:2604 Jan 1 19:31:10 vdr vdr: [16245] changing pids of channel 130 (NDR FS HH) from 2601+2601=2:2602=deu@3,2603=mis@3:0:2604 to 2501+2501=2:2502=deu@3,2503=mis@3:0:2604 Jan 1 19:31:10 vdr vdr: [16245] changing pids of channel 131 (NDR FS SH) from 2601+2601=2:2602=deu@3,2603=mis@3:0:2604 to 2701+2701=2:2702=deu@3,2703=mis@3:0:2604 Jan 1 19:31:10 vdr vdr: [16245] changing pids of channel 123 (MDR Sachsen) from 2801+2801=2:2802=deu@3,2803=mis@3:2805=deu:2804 to 2901+2901=2:2902=deu@3,2903=mis@3:2905=deu:2904 Jan 1 19:31:11 vdr vdr: [16245] changing pids of channel 125 (MDR Thüringen) from 3001+3001=2:3002=deu@3,3003=mis@3:3005=deu:3004 to 2901+2901=2:2902=deu@3,2903=mis@3:2905=deu:2904 Jan 1 19:33:00 vdr vdr: [16251] EPGSearch: timer conflict check started Jan 1 19:33:00 vdr vdr: [16251] EPGSearch: timer conflict check finished Jan 1 19:34:06 vdr vdr: [16240] frontend 1/0 timed out while tuning to channel 117 (arte), tp 110744 Jan 1 19:34:06 vdr vdr: [16248] frontend 3/0 timed out while tuning to channel 60 (HSE Extra HD), tp 110802 Jan 1 19:34:20 vdr vdr: [16237] changing pids of channel 24 (MDR Sachsen HD) from 5321+5321=27:5322=deu@3,5323=mis@3,5327=qks@3;5326=deu@106:5325=deu:5324 to 5331+5331=27:5332=deu@3,5333=mis@3,5337=qks@3;5336=deu@106:5335=deu:5334 Jan 1 19:38:39 vdr vdr: [16240] frontend 1/0 timed out while tuning to channel 117 (arte), tp 110744 Jan 1 19:43:12 vdr vdr: [16240] frontend 1/0 timed out while tuning to channel 117 (arte), tp 110744 Jan 1 19:46:01 vdr vdr: [16248] frontend 3/0 timed out while tuning to channel 36 (rhein main tv), tp 112633 Jan 1 19:46:18 vdr vdr: [16804] recording to '/video0/Ihr_letzter_Wille_kann_mich_mal!/2023-01-01.19.03.1-0.rec/00003.ts' Jan 1 19:47:46 vdr vdr: [16240] frontend 1/0 timed out while tuning to channel 117 (arte), tp 110744 Jan 1 19:48:42 vdr vdr: [16245] changing pids of channel 100 (SWR RP HD) from 5121+5121=27:5122=deu@3,5123=mis@3,5127=qks@3;5126=deu@106:5135=deu:5134 to 5131+5131=27:5132=deu@3,5133=mis@3,5137=qks@3;5136=deu@106:5135=deu:5134 Jan 1 19:52:18 vdr vdr: [16240] frontend 1/0 timed out while tuning to channel 117 (arte), tp 110744 Jan 1 19:56:44 vdr vdr: [16229] info: Neue Mail in Torsten, öffnen? Jan 1 19:56:44 vdr vdr: [softhddev]CreateOsd: 498, 799, 0 Jan 1 19:56:44 vdr vdr: [16229] [softhddev]OpenGl Thread not started successfully, using Dummy OSD Jan 1 19:56:44 vdr vdr: [20362] animator thread thread started (pid=16229, tid=20362, prio=high) Jan 1 19:56:48 vdr vdr: [20362] animator thread thread ended (pid=16229, tid=20362) Jan 1 19:56:51 vdr vdr: [16240] frontend 1/0 timed out while tuning to channel 117 (arte), tp 110744 Jan 1 19:57:12 vdr vdr: [16248] frontend 3/0 timed out while tuning to channel 16 (tagesschau24 HD), tp 111052 Jan 1 19:58:30 vdr vdr: [16233] channel 1 (Das Erste HD) event So. 01.01.2023 18:30-20:00 (VPS: 01.01. 18:30) 'Ihr letzter Wille kann mich mal!' status 1 Jan 1 19:58:31 vdr vdr: [16233] channel 1 (Das Erste HD) event So. 01.01.2023 20:00-20:15 (VPS: 01.01. 20:00) 'Tagesschau' status 2 Jan 1 19:58:53 vdr smartd[1182]: Device: /dev/sdb [SAT], SMART Usage Attribute: 194 Temperature_Celsius changed from 71 to 70 Jan 1 19:59:11 vdr vdr: [16245] channel 3 (SAT.1) event So. 01.01.2023 17:50-19:55 'Pan' status 1 Jan 1 19:59:11 vdr vdr: [16245] channel 3 (SAT.1) event So. 01.01.2023 19:55-20:14 'SAT.1 Nachrichten' status 4 Jan 1 20:00:04 vdr vdr: [16233] channel 1 (Das Erste HD) event So. 01.01.2023 20:00-20:15 (VPS: 01.01. 20:00) 'Tagesschau' status 4 Jan 1 20:01:00 vdr vdr: [16250] EPGSearch: search timer update started Jan 1 20:01:00 vdr vdr: [16250] timer 0 (2 2015-2145 VPS 'Der Bergdoktor') set to event Do. 05.01.2023 20:15-21:45 (VPS: 05.01. 20:15) 'Der Bergdoktor' Jan 1 20:01:00 vdr vdr: [16250] timer 0 (2 2015-2145 VPS 'Der Bergdoktor') set to event Do. 05.01.2023 20:15-21:45 (VPS: 05.01. 20:15) 'Der Bergdoktor' Jan 1 20:01:00 vdr vdr: [16250] timer 0 (2 2015-2145 VPS 'Der Bergdoktor') set to event Do. 12.01.2023 20:15-21:45 (VPS: 12.01. 20:15) 'Der Bergdoktor' Jan 1 20:01:00 vdr vdr: [16250] timer 0 (2 2015-2145 VPS 'Der Bergdoktor') set to event Do. 12.01.2023 20:15-21:45 (VPS: 12.01. 20:15) 'Der Bergdoktor' Jan 1 20:01:00 vdr vdr: [16250] timer 0 (2 2015-2145 VPS 'Der Bergdoktor') set to event Do. 19.01.2023 20:15-21:45 (VPS: 19.01. 20:15) 'Der Bergdoktor' Jan 1 20:01:00 vdr vdr: [16250] timer 0 (2 2015-2145 VPS 'Der Bergdoktor') set to event Do. 19.01.2023 20:15-21:45 (VPS: 19.01. 20:15) 'Der Bergdoktor' Jan 1 20:01:00 vdr vdr: [16250] timer 0 (2 2230-2300 VPS 'heute-show spezial') set to event Fr. 20.01.2023 22:30-23:00 (VPS: 20.01. 22:30) 'heute-show spezial' Jan 1 20:01:00 vdr vdr: [16250] timer 0 (2 2230-2300 VPS 'heute-show spezial') set to event Fr. 20.01.2023 22:30-23:00 (VPS: 20.01. 22:30) 'heute-show spezial' Jan 1 20:01:00 vdr vdr: [16250] EPGSearch: search timer update finished Jan 1 20:01:17 vdr vdr: [16258] dbus2vdr: thread-pool for handling method-calls started Jan 1 20:01:17 vdr vdr: [softhddev]Resume: Jan 1 20:01:17 vdr vdr: audio: 'alsa' output module used Jan 1 20:01:17 vdr vdr: audio/alsa: supports pause: yes Jan 1 20:01:17 vdr vdr: audio/alsa: mixer default - PCM open Jan 1 20:01:17 vdr vdr: audio/alsa: buffer size 4224 95ms, period size 1056 23ms Jan 1 20:01:17 vdr vdr: audio/alsa: state PREPARED Jan 1 20:01:17 vdr vdr: audio/alsa: buffer size 4240 96ms, period size 848 19ms Jan 1 20:01:17 vdr vdr: audio/alsa: state PREPARED Jan 1 20:01:17 vdr vdr: audio/alsa: buffer size 4224 95ms, period size 1056 23ms Jan 1 20:01:17 vdr vdr: audio/alsa: state PREPARED Jan 1 20:01:17 vdr vdr: audio/alsa: buffer size 4232 95ms, period size 184 4ms Jan 1 20:01:17 vdr vdr: audio/alsa: state PREPARED Jan 1 20:01:17 vdr vdr: audio/alsa: buffer size 4608 96ms, period size 1152 24ms Jan 1 20:01:17 vdr vdr: audio/alsa: state PREPARED Jan 1 20:01:17 vdr vdr: audio/alsa: buffer size 4608 96ms, period size 1152 24ms Jan 1 20:01:17 vdr vdr: audio/alsa: state PREPARED Jan 1 20:01:17 vdr vdr: audio/alsa: buffer size 4608 96ms, period size 1152 24ms Jan 1 20:01:17 vdr vdr: audio/alsa: state PREPARED Jan 1 20:01:17 vdr vdr: audio/alsa: buffer size 4608 96ms, period size 1152 24ms Jan 1 20:01:17 vdr vdr: audio/alsa: state PREPARED Jan 1 20:01:17 vdr vdr: audio/alsa: buffer size 18432 96ms, period size 4608 24ms Jan 1 20:01:17 vdr vdr: audio/alsa: state PREPARED Jan 1 20:01:17 vdr vdr: audio/alsa: buffer size 18432 96ms, period size 4608 24ms Jan 1 20:01:17 vdr vdr: audio/alsa: state PREPARED Jan 1 20:01:17 vdr vdr: audio/alsa: buffer size 18432 96ms, period size 4608 24ms Jan 1 20:01:17 vdr vdr: audio/alsa: state PREPARED Jan 1 20:01:17 vdr vdr: audio/alsa: buffer size 18432 96ms, period size 4608 24ms Jan 1 20:01:17 vdr vdr: audio/alsa: state PREPARED Jan 1 20:01:17 vdr vdr: audio: 44100Hz supports 2 2 4 4 6 6 8 8 channels Jan 1 20:01:17 vdr vdr: audio: 48000Hz supports 2 2 4 4 6 6 8 8 channels Jan 1 20:01:17 vdr vdr: audio: 192000Hz supports 2 2 4 4 6 6 8 8 channels Jan 1 20:01:17 vdr vdr: audio: play thread started Jan 1 20:01:17 vdr vdr: audio: wait on start condition Jan 1 20:01:17 vdr vdr: video: visual 0x21 depth 24 Jan 1 20:01:17 vdr vdr: video: crtc = 0 | x = 0 | y = 0 | w = 1920 | h = 1080 Jan 1 20:01:17 vdr vdr: video: window prepared Jan 1 20:01:17 vdr vdr: video/vdpau: VDPAU API version: 1 Jan 1 20:01:17 vdr vdr: video/vdpau: VDPAU information: NVIDIA VDPAU Driver Shared Library 470.161.03 Wed Oct 19 00:03:46 UTC 2022 Jan 1 20:01:17 vdr vdr: video/vdpau: highest supported high quality scaling 1 Jan 1 20:01:17 vdr vdr: video/vdpau: feature deinterlace temporal supported Jan 1 20:01:17 vdr vdr: video/vdpau: feature deinterlace temporal spatial supported Jan 1 20:01:17 vdr vdr: video/vdpau: attribute skip chroma deinterlace supported Jan 1 20:01:17 vdr vdr: video/vdpau: 4:2:0 chroma format with 4096x4096 supported Jan 1 20:01:17 vdr vdr: video/vdpau: 4:2:2 chroma format with 4096x4096 supported Jan 1 20:01:17 vdr vdr: video/vdpau: 4:4:4 chroma format with 4096x4096 supported Jan 1 20:01:17 vdr vdr: video/vdpau: 8bit BGRA format with 16384x16384 supported Jan 1 20:01:17 vdr vdr: video/vdpau: 10bit RGBA format with 16384x16384 supported Jan 1 20:01:17 vdr vdr: video/vdpau: created output surface 1920x1080 with id 0x00000004 Jan 1 20:01:17 vdr vdr: video/vdpau: created output surface 1920x1080 with id 0x00000005 Jan 1 20:01:17 vdr vdr: video/vdpau: created output surface 1920x1080 with id 0x00000006 Jan 1 20:01:17 vdr vdr: video/vdpau: created output surface 1920x1080 with id 0x00000007 Jan 1 20:01:17 vdr vdr: video/vdpau: created grab render output surface 1920x1080 with id 0x00000008 Jan 1 20:01:17 vdr vdr: video: screen saver extension present Jan 1 20:01:17 vdr vdr: video: dpms extension present Jan 1 20:01:17 vdr vdr: video: dpms was enabled Jan 1 20:01:17 vdr vdr: video/x11: send fullscreen message 1 172 Jan 1 20:01:17 vdr vdr: video/vdpau: created osd output surface 1920x1080 with id 0x00000009 Jan 1 20:01:17 vdr vdr: video/vdpau: osd surfaces created Jan 1 20:01:17 vdr vdr: video/vdpau: osd clear image Jan 1 20:01:17 vdr vdr: pesdemux: pes start code id 0xe0 Jan 1 20:01:17 vdr vdr: video: h264 detected Jan 1 20:01:17 vdr vdr_delayed.sh[20675]: method return time=1672599677.319869 sender=:1.82 -> destination=:1.84 serial=991 reply_serial=2 Jan 1 20:01:17 vdr vdr_delayed.sh[20675]: int32 900 Jan 1 20:01:17 vdr vdr_delayed.sh[20675]: string "SoftHdDevice is attached" Jan 1 20:01:17 vdr vdr_delayed.sh[20677]: Driver "nvidia" Jan 1 20:01:17 vdr vdr_delayed.sh[20677]: Driver "nvidia" Jan 1 20:01:17 vdr vdr: video: display thread started Jan 1 20:01:17 vdr vdr: video/event: ReparentNotify Jan 1 20:01:17 vdr vdr: pesdemux: pes start code id 0xc0 Jan 1 20:01:17 vdr vdr: pesdemux: new codec 000000 -> 0x15000 Jan 1 20:01:17 vdr vdr: codec: using audio codec ID 0x15000 (mp2) Jan 1 20:01:17 vdr vdr: codec: audio 'MP2 (MPEG audio layer 2)' Jan 1 20:01:17 vdr vdr: codec/audio: format change s16p 48000Hz *2 channels AC-3 pass-through Jan 1 20:01:17 vdr vdr: audio: setup channels 2 frequency 48000Hz Jan 1 20:01:17 vdr vdr: audio: 1 ring buffer prepared Jan 1 20:01:17 vdr vdr: codec/audio: resample s16p 48000Hz *2 -> s16 48000Hz *2 Jan 1 20:01:17 vdr vdr: audio: ----> 0ms start Jan 1 20:01:17 vdr vdr: audio: next ring buffer Jan 1 20:01:17 vdr vdr: audio: thread channels 2 frequency 48000Hz Jan 1 20:01:17 vdr vdr: audio: a/v packet size 4608 bytes Jan 1 20:01:17 vdr vdr: audio/alsa: using device 'hdmi:CARD=NVidia,DEV=3,AES0=0x04' Jan 1 20:01:17 vdr vdr: audio/alsa: buffer size 4608 96ms, period size 1152 24ms Jan 1 20:01:17 vdr vdr: audio/alsa: state PREPARED Jan 1 20:01:17 vdr vdr: audio/alsa: start delay 336ms Jan 1 20:01:17 vdr vdr: audio: a/v next buf(0, 72ms) Jan 1 20:01:17 vdr vdr: audio: wait on start condition Jan 1 20:01:17 vdr vdr: video/vdpau: created output surface 1920x1080 with id 0x00000004 Jan 1 20:01:17 vdr vdr: video/vdpau: created output surface 1920x1080 with id 0x00000005 Jan 1 20:01:17 vdr vdr: video/vdpau: created output surface 1920x1080 with id 0x00000006 Jan 1 20:01:17 vdr vdr: video/vdpau: created output surface 1920x1080 with id 0x00000007 Jan 1 20:01:17 vdr vdr: video/vdpau: created grab render output surface 1920x1080 with id 0x00000008 Jan 1 20:01:17 vdr vdr: video: aspect defaults to 1:1 Jan 1 20:01:17 vdr vdr: video: aspect 2216:2217 Jan 1 20:01:17 vdr vdr: video: aspect output 1080x1080+420+0 Jan 1 20:01:17 vdr vdr: video/vdpau: created output surface 1920x1080 with id 0x00000004 Jan 1 20:01:17 vdr systemd[1]: Started Session c14 of User torsten. Jan 1 20:01:17 vdr vdr: video/vdpau: created output surface 1920x1080 with id 0x00000005 Jan 1 20:01:17 vdr vdr: video/vdpau: created output surface 1920x1080 with id 0x00000006 Jan 1 20:01:17 vdr vdr: video/vdpau: created output surface 1920x1080 with id 0x00000007 Jan 1 20:01:17 vdr vdr: video/vdpau: created grab render output surface 1920x1080 with id 0x00000008 Jan 1 20:01:17 vdr vdr: video: aspect defaults to 1:1 Jan 1 20:01:17 vdr vdr: video: aspect 2216:2217 Jan 1 20:01:17 vdr vdr: video: aspect output 1080x1080+420+0 Jan 1 20:01:17 vdr vdr: video/event: MapNotify Jan 1 20:01:17 vdr vdr: codec: using video codec ID 0x001b (h264) Jan 1 20:01:17 vdr vdr: codec: hw decoder found Jan 1 20:01:17 vdr vdr: codec: video 'H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10' Jan 1 20:01:17 vdr vdr: codec: can use own buffer management Jan 1 20:01:17 vdr vdr: codec: can export data for HW decoding Jan 1 20:01:17 vdr vdr: video: get hwaccel context, not supported Jan 1 20:01:17 vdr vdr: video: ready --:--:--.--- 0ms/frame 2747877ms Jan 1 20:01:17 vdr vdr: get format 1280x720 Jan 1 20:01:17 vdr vdr: Vdpau_get_format: codec 27 fmts: Jan 1 20:01:17 vdr vdr: #0110x00000064 vdpau Jan 1 20:01:17 vdr vdr: #0110x00000077 cuda Jan 1 20:01:17 vdr vdr: #0110x0000002e vaapi_vld Jan 1 20:01:17 vdr vdr: #0110000000000 yuv420p Jan 1 20:01:17 vdr vdr: Vdpau_get_format: selected codec: Jan 1 20:01:17 vdr vdr: #0110x00000064 vdpau Jan 1 20:01:17 vdr vdr: video/vdpau: profile 7 with level 51, macro blocks 65536, width 4032, height 4080 supported Jan 1 20:01:17 vdr vdr: video/vdpau: create decoder profile=7 1280x720 #16 refs Jan 1 20:01:17 vdr vdr: vdpau_alloc Jan 1 20:01:17 vdr vdr: video/vdpau: VdpauCreateSurfaces: 1280x720 * 21 Jan 1 20:01:17 vdr vdr: video/vdpau: temporal deinterlace disabled Jan 1 20:01:17 vdr vdr: video/vdpau: temporal spatial deinterlace disabled Jan 1 20:01:17 vdr vdr: video/vdpau: inverse telecine disabled Jan 1 20:01:17 vdr vdr: video/vdpau: noise reduction disabled Jan 1 20:01:17 vdr vdr: video/vdpau: sharpness disabled Jan 1 20:01:17 vdr vdr: video/vdpau: high quality scaling 1 disabled Jan 1 20:01:17 vdr vdr: video/vdpau: background color 0,000000/0,000000/0,000000/0,000000 Jan 1 20:01:17 vdr vdr: video/vdpau: skip chroma deinterlace disabled Jan 1 20:01:17 vdr vdr: video/vdpau: noise reduction level 0,000 Jan 1 20:01:17 vdr vdr: video/vdpau: sharpness level +0,000 Jan 1 20:01:17 vdr vdr: video/vdpau: color space ITU-R BT.709 Jan 1 20:01:17 vdr vdr: video: aspect defaults to 1:1 Jan 1 20:01:17 vdr vdr: video: aspect 35456:19953 Jan 1 20:01:17 vdr vdr: video: aspect output 1920x1080+0+0 Jan 1 20:01:17 vdr vdr: HWACCEL init ok Jan 1 20:01:17 vdr vdr: audio: start? 96ms skip 0ms Jan 1 20:01:17 vdr vdr: audio: start? 120ms skip 0ms Jan 1 20:01:17 vdr vdr: audio: start? 144ms skip 0ms Jan 1 20:01:17 vdr vdr: audio: start? 168ms skip 0ms Jan 1 20:01:17 vdr vdr: video: new stream frame 2747908ms Jan 1 20:01:17 vdr vdr: audio: a/v sync buf(0, 168ms) 6:10:06.888| 6:10:06.380 = 508ms ready Jan 1 20:01:17 vdr vdr: video/vdpau: aspect ratio changed Jan 1 20:01:17 vdr vdr: video: aspect 35456:19953 Jan 1 20:01:17 vdr vdr: video: aspect output 1920x1080+0+0 Jan 1 20:01:17 vdr vdr: video/vdpau: temporal deinterlace disabled Jan 1 20:01:17 vdr vdr: video/vdpau: temporal spatial deinterlace disabled Jan 1 20:01:17 vdr vdr: video/vdpau: inverse telecine disabled Jan 1 20:01:17 vdr vdr: video/vdpau: noise reduction disabled Jan 1 20:01:17 vdr vdr: video/vdpau: sharpness disabled Jan 1 20:01:17 vdr vdr: video/vdpau: high quality scaling 1 disabled Jan 1 20:01:17 vdr vdr: video/vdpau: background color 0,000000/0,000000/0,000000/0,000000 Jan 1 20:01:17 vdr vdr: video/vdpau: skip chroma deinterlace disabled Jan 1 20:01:17 vdr vdr: video/vdpau: noise reduction level 0,000 Jan 1 20:01:17 vdr vdr: video/vdpau: sharpness level +0,000 Jan 1 20:01:17 vdr vdr: video/vdpau: color space ITU-R BT.709 Jan 1 20:01:17 vdr vdr: video: initial slow down video, frame 1 Jan 1 20:01:17 vdr vdr: video: 6:10:06.828+8888 0 0/\ms 10+1+0 v-buf Jan 1 20:01:17 vdr dbus-daemon[1142]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.87' (uid=1000 pid=20688 comm="/usr/lib/x86_64-linux-gnu/opera/opera --start-full" label="unconfined") Jan 1 20:01:17 vdr systemd[1]: Condition check resulted in Bluetooth service being skipped. Jan 1 20:01:17 vdr vdr: audio: start? 192ms skip 0ms Jan 1 20:01:17 vdr vdr: audio: start? 216ms skip 0ms Jan 1 20:01:17 vdr vdr: audio: start? 240ms skip 0ms Jan 1 20:01:17 vdr vdr: audio: start? 264ms skip 0ms Jan 1 20:01:17 vdr vdr_delayed.sh[20688]: [20688:20688:0101/200117.602892:ERROR:url_pattern_set.cc(287)] Invalid url pattern: chrome://startpage/ Jan 1 20:01:17 vdr vdr_delayed.sh[20688]: [20688:20688:0101/200117.603019:ERROR:url_pattern_set.cc(287)] Invalid url pattern: chrome://startpage/ Jan 1 20:01:17 vdr vdr_delayed.sh[20688]: [20688:20688:0101/200117.603056:ERROR:url_pattern_set.cc(287)] Invalid url pattern: chrome://startpage/ Jan 1 20:01:17 vdr vdr_delayed.sh[20725]: [20725:20725:0101/200117.654916:ERROR:gpu_memory_buffer_support_x11.cc(44)] dri3 extension not supported. Jan 1 20:01:17 vdr vdr: audio: start? 288ms skip 0ms Jan 1 20:01:17 vdr vdr: audio: start? 312ms skip 0ms Jan 1 20:01:17 vdr vdr: audio: start? 336ms skip 0ms Jan 1 20:01:17 vdr vdr: audio: start? 360ms skip 0ms Jan 1 20:01:17 vdr vdr: audio: ----> 360ms start Jan 1 20:01:17 vdr vdr: video: initial slow down video, frame 99 Jan 1 20:01:17 vdr vdr: video: slow down video, duping frame Jan 1 20:01:17 vdr vdr: video: 6:10:06.828 +429 341 0/\ms 12+2+1 v-buf Jan 1 20:01:17 vdr vdr: codec/audio: inital drift delay 307ms Jan 1 20:01:17 vdr vdr: [softhddev]GetVideoSize: 1280x720 1,77778 Jan 1 20:01:17 vdr vdr: [16229] skindesigner: w 1280 h 720 mode changed to 0 Jan 1 20:01:18 vdr vdr: osd2web: Client 'ip6-localhost/::1' connected (0x7f761c2420b0), ping time set to (60) Jan 1 20:01:18 vdr vdr: osd2web: Client login 'ip6-localhost/::1' (0x7f761c2420b0) [{"event":"login","object":{"type":1,"tftprio":100}}] Jan 1 20:01:18 vdr vdr: osd2web: Info: Cast to cEpgTimer_Interface_V1 failed - aussume epg2vdr not loaded Jan 1 20:01:18 vdr vdr: message repeated 7 times: [ osd2web: Info: Cast to cEpgTimer_Interface_V1 failed - aussume epg2vdr not loaded] Jan 1 20:01:18 vdr vdr: osd2web: lowest prio is (100) Jan 1 20:01:18 vdr vdr: osd2web: HTTP: Requested uri: (17) '/data/channellogo' Jan 1 20:01:20 vdr vdr_delayed.sh[20688]: [20688:20688:0101/200120.723370:ERROR:named_platform_channel_posix.cc(142)] connect /home/torsten/.config/opera/oauc_pipe_r: Connection refused (111) Jan 1 20:01:21 vdr vdr: video: slow down video, duping frame Jan 1 20:01:21 vdr vdr: video: 6:10:10.288 +98 342 0/\ms 36+2+4 v-buf Jan 1 20:01:22 vdr vdr: video/vdpau: 1672599682256630 display time 42625 Jan 1 20:01:22 vdr vdr: video: slow down video, duping frame Jan 1 20:01:22 vdr vdr: video/vdpau: missed frame (1/215) Jan 1 20:01:22 vdr vdr: video: slow down video, duping frame Jan 1 20:01:22 vdr vdr: video: 6:10:11.088 +108 272 0/\ms 31+2+2 v-buf Jan 1 20:01:24 vdr vdr: [16240] frontend 1/0 timed out while tuning to channel 117 (arte), tp 110744 Jan 1 20:01:25 vdr vdr: video: slow down video, duping frame Jan 1 20:01:25 vdr vdr: video: 6:10:14.288 +106 358 0/\ms 31+2+3 v-buf Jan 1 20:01:27 vdr vdr: codec/audio: drift( 0) 44us 21 Jan 1 20:01:29 vdr vdr: video: slow down video, duping frame Jan 1 20:01:29 vdr vdr: video: 6:10:18.228 +101 325 0/\ms 37+2+3 v-buf Jan 1 20:01:33 vdr vdr: video: slow down video, duping frame Jan 1 20:01:33 vdr vdr: video: 6:10:22.208 +108 360 0/\ms 51+2+3 v-buf Jan 1 20:01:37 vdr vdr: video: slow down video, duping frame Jan 1 20:01:37 vdr vdr: video: 6:10:26.188 +110 270 0/\ms 29+2+4 v-buf Jan 1 20:01:38 vdr vdr: [16237] changing pids of channel 25 (rbb Brandenburg HD) from 5301+5301=27:5302=deu@3,5303=mis@3,5307=qks@3;5306=deu@106:5305=deu:5304 to 5311+5311=27:5312=deu@3,5313=mis@3,5317=qks@3;5316=deu@106:5315=deu:5314 Jan 1 20:01:41 vdr vdr: video: slow down video, duping frame Jan 1 20:01:41 vdr vdr: video: 6:10:30.148 +104 336 0/\ms 43+2+4 v-buf Jan 1 20:01:41 vdr vdr: video/vdpau: 1 missed, 16734 duped, 0 dropped frames of 1168,18000 Jan 1 20:01:45 vdr vdr: video: slow down video, duping frame Jan 1 20:01:45 vdr vdr: video: 6:10:34.108 +113 297 0/\ms 37+2+4 v-buf Jan 1 20:01:45 vdr vdr: [softhddev]SetVolumeDevice: 55 Jan 1 20:01:45 vdr vdr: [16229] skindesigner: drop image cache Jan 1 20:01:45 vdr vdr: [16229] skindesigner: using channel logo path /etc/vdr/plugins/skindesigner/logos/ Jan 1 20:01:45 vdr vdr: [16229] skindesigner: using icon path /etc/vdr/plugins/skindesigner/installerskins/simplextw/themes/default/ Jan 1 20:01:45 vdr vdr: [16229] skindesigner: using skinparts path /etc/vdr/plugins/skindesigner/installerskins/simplextw/themes/default/skinparts/ Jan 1 20:01:45 vdr vdr: [16229] skindesigner: using svgtemplate path /etc/vdr/plugins/skindesigner/installerskins/simplextw/svgtemplates/ Jan 1 20:01:45 vdr vdr: [softhddev]CreateOsd: 406, 903, 0 Jan 1 20:01:45 vdr vdr: [16229] [softhddev]Trying to start OpenGL Worker Thread Jan 1 20:01:45 vdr vdr: [21268] oglThread thread started (pid=16229, tid=21268, prio=high) Jan 1 20:01:45 vdr vdr: [21268] [softhddev]OpenGL using display :0.0 Jan 1 20:01:45 vdr vdr: [21268] [softhddev]OpenGL Context initialized Jan 1 20:01:45 vdr vdr: [21268] [softhddev]Shaders initialized Jan 1 20:01:45 vdr vdr: [21268] [softhddev]vdpau interop initialized Jan 1 20:01:45 vdr vdr: [21268] [softhddev]Vertex buffers initialized Jan 1 20:01:45 vdr vdr: [21268] [softhddev]Maximum Pixmap size: 16384x16384px Jan 1 20:01:45 vdr vdr: [16229] [softhddev]OpenGL Worker Thread successfully started Jan 1 20:01:45 vdr vdr: [21269] animator thread thread started (pid=16229, tid=21269, prio=high) Jan 1 20:01:46 vdr vdr: [21269] animator thread thread ended (pid=16229, tid=21269) Jan 1 20:01:47 vdr vdr: video/vdpau: osd clear image Jan 1 20:01:47 vdr vdr: video/vdpau: 1672599707098573 display time 23292 Jan 1 20:01:47 vdr vdr: video: slow down video, duping frame Jan 1 20:01:47 vdr vdr: video/vdpau: missed frame (2/1457) Jan 1 20:01:47 vdr vdr: video: slow down video, duping frame Jan 1 20:01:47 vdr vdr: video: 6:10:35.928 +108 320 0/\ms 38+2+3 v-buf Jan 1 20:01:47 vdr vdr: [softhddev]SetVolumeDevice: 59 Jan 1 20:01:47 vdr vdr: [softhddev]CreateOsd: 406, 903, 0 Jan 1 20:01:47 vdr vdr: [21275] animator thread thread started (pid=16229, tid=21275, prio=high) Jan 1 20:01:47 vdr vdr: [softhddev]SetVolumeDevice: 63 Jan 1 20:01:47 vdr vdr: [softhddev]SetVolumeDevice: 67 Jan 1 20:01:48 vdr vdr: [21275] animator thread thread ended (pid=16229, tid=21275) Jan 1 20:01:49 vdr vdr: video/vdpau: osd clear image Jan 1 20:01:49 vdr vdr: [softhddev]CreateOsd: 498, 799, 0 Jan 1 20:01:49 vdr vdr: video/vdpau: 1672599709263422 display time 22990 Jan 1 20:01:49 vdr vdr: video: slow down video, duping frame Jan 1 20:01:49 vdr vdr: video/vdpau: missed frame (3/1565) Jan 1 20:01:49 vdr vdr: video: slow down video, duping frame Jan 1 20:01:49 vdr vdr: video: 6:10:38.088 +103 315 0/\ms 43+2+3 v-buf Jan 1 20:01:49 vdr vdr: [21285] animator thread thread started (pid=16229, tid=21285, prio=high) Jan 1 20:01:50 vdr vdr: video: slow down video, duping frame Jan 1 20:01:50 vdr vdr: video: 6:10:39.088 +98 318 0/\ms 47+2+4 v-buf Jan 1 20:01:53 vdr vdr: [21285] animator thread thread ended (pid=16229, tid=21285) Jan 1 20:01:53 vdr vdr: video/vdpau: osd clear image Jan 1 20:01:53 vdr vdr: video/vdpau: 1672599713613235 display time 22918 Jan 1 20:01:53 vdr vdr: video: slow down video, duping frame Jan 1 20:01:53 vdr vdr: video/vdpau: missed frame (4/1783) Jan 1 20:01:53 vdr vdr: video: slow down video, duping frame Jan 1 20:01:53 vdr vdr: video: 6:10:42.448 +113 285 0/\ms 32+2+3 v-buf Jan 1 20:01:55 vdr vdr: video: slow down video, duping frame Jan 1 20:01:55 vdr vdr: video: 6:10:44.208 +103 363 0/\ms 51+2+3 v-buf Jan 1 20:02:00 vdr vdr: video: slow down video, duping frame Jan 1 20:02:00 vdr vdr: video: 6:10:49.248 +108 344 0/\ms 35+2+4 v-buf Jan 1 20:02:02 vdr vdr: [softhddev]CreateOsd: 93, 73, 0 Jan 1 20:02:02 vdr vdr: [21316] detacher thread thread started (pid=16229, tid=21316, prio=high) Jan 1 20:02:02 vdr vdr: [21319] detacher thread thread started (pid=16229, tid=21319, prio=high) Jan 1 20:02:02 vdr vdr: [21320] detacher thread thread started (pid=16229, tid=21320, prio=high) Jan 1 20:02:02 vdr vdr: [21321] detacher thread thread started (pid=16229, tid=21321, prio=high) Jan 1 20:02:02 vdr vdr: [21322] detacher thread thread started (pid=16229, tid=21322, prio=high) Jan 1 20:02:02 vdr vdr: [21323] detacher thread thread started (pid=16229, tid=21323, prio=high) Jan 1 20:02:02 vdr vdr: [softhddev]ScaleVideo: 0x0+0+0 Jan 1 20:02:02 vdr vdr: [21324] animator thread thread started (pid=16229, tid=21324, prio=high) Jan 1 20:02:02 vdr vdr: [21323] detacher thread thread ended (pid=16229, tid=21323) Jan 1 20:02:02 vdr vdr: [21316] detacher thread thread ended (pid=16229, tid=21316) Jan 1 20:02:02 vdr vdr: [21320] detacher thread thread ended (pid=16229, tid=21320) Jan 1 20:02:02 vdr vdr: [21319] detacher thread thread ended (pid=16229, tid=21319) Jan 1 20:02:02 vdr vdr: [21321] detacher thread thread ended (pid=16229, tid=21321) Jan 1 20:02:02 vdr vdr: [21322] detacher thread thread ended (pid=16229, tid=21322) Jan 1 20:02:05 vdr vdr: video: slow down video, duping frame Jan 1 20:02:05 vdr vdr: video: 6:10:54.708 +95 319 0/\ms 42+1+3 v-buf Jan 1 20:02:11 vdr vdr: video: slow down video, duping frame Jan 1 20:02:11 vdr vdr: video: 6:11:00.488 +100 280 0/\ms 41+2+4 v-buf Jan 1 20:02:11 vdr vdr: video/vdpau: 4 missed, 33217 duped, 0 dropped frames of 2685,36000 Jan 1 20:02:17 vdr vdr: video: slow down video, duping frame Jan 1 20:02:17 vdr vdr: video: 6:11:06.248 +100 256 0/\ms 43+2+3 v-buf Jan 1 20:02:23 vdr vdr: video: slow down video, duping frame Jan 1 20:02:23 vdr vdr: video: 6:11:12.048 +112 324 0/\ms 43+2+4 v-buf Jan 1 20:02:29 vdr vdr: video: slow down video, duping frame Jan 1 20:02:29 vdr vdr: video: 6:11:17.808 +102 289 0/\ms 29+2+4 v-buf Jan 1 20:02:32 vdr vdr: [21324] animator thread thread ended (pid=16229, tid=21324) Jan 1 20:02:32 vdr vdr: [softhddev]ScaleVideo: 0x0+0+0 Jan 1 20:02:32 vdr vdr: video/vdpau: osd clear image Jan 1 20:02:32 vdr vdr: video/vdpau: 1672599752822592 display time 23480 Jan 1 20:02:32 vdr vdr: video: slow down video, duping frame Jan 1 20:02:32 vdr vdr: video/vdpau: missed frame (5/3743) Jan 1 20:02:32 vdr vdr: video: slow down video, duping frame Jan 1 20:02:32 vdr vdr: video: 6:11:21.648 +104 340 0/\ms 47+2+3 v-buf Jan 1 20:02:34 vdr vdr: [softhddev]CreateOsd: 93, 73, 0 Jan 1 20:02:34 vdr vdr: [21485] detacher thread thread started (pid=16229, tid=21485, prio=high) Jan 1 20:02:34 vdr vdr: [21486] detacher thread thread started (pid=16229, tid=21486, prio=high) Jan 1 20:02:34 vdr vdr: [21487] detacher thread thread started (pid=16229, tid=21487, prio=high) Jan 1 20:02:34 vdr vdr: [21488] detacher thread thread started (pid=16229, tid=21488, prio=high) Jan 1 20:02:34 vdr vdr: [21489] detacher thread thread started (pid=16229, tid=21489, prio=high) Jan 1 20:02:34 vdr vdr: [21490] detacher thread thread started (pid=16229, tid=21490, prio=high) Jan 1 20:02:34 vdr vdr: [softhddev]ScaleVideo: 0x0+0+0 Jan 1 20:02:34 vdr vdr: [21491] animator thread thread started (pid=16229, tid=21491, prio=high) Jan 1 20:02:34 vdr vdr: [21487] detacher thread thread ended (pid=16229, tid=21487) Jan 1 20:02:34 vdr vdr: [21490] detacher thread thread ended (pid=16229, tid=21490) Jan 1 20:02:34 vdr vdr: [21485] detacher thread thread ended (pid=16229, tid=21485) Jan 1 20:02:34 vdr vdr: [21486] detacher thread thread ended (pid=16229, tid=21486) Jan 1 20:02:34 vdr vdr: [21488] detacher thread thread ended (pid=16229, tid=21488) Jan 1 20:02:34 vdr vdr: [21489] detacher thread thread ended (pid=16229, tid=21489) Jan 1 20:02:34 vdr vdr: video: slow down video, duping frame Jan 1 20:02:34 vdr vdr: video: 6:11:23.408 +112 340 0/\ms 41+2+4 v-buf Jan 1 20:02:37 vdr vdr: [21491] animator thread thread ended (pid=16229, tid=21491) Jan 1 20:02:37 vdr vdr: [softhddev]ScaleVideo: 0x0+0+0 Jan 1 20:02:37 vdr vdr: video/vdpau: osd clear image Jan 1 20:02:37 vdr vdr: video/vdpau: 1672599757493856 display time 23268 Jan 1 20:02:37 vdr vdr: video: slow down video, duping frame Jan 1 20:02:37 vdr vdr: video/vdpau: missed frame (6/3977) Jan 1 20:02:37 vdr vdr: video: slow down video, duping frame Jan 1 20:02:37 vdr vdr: video: 6:11:26.328 +113 301 0/\ms 17+2+3 v-buf Jan 1 20:02:39 vdr vdr: video: slow down video, duping frame Jan 1 20:02:39 vdr vdr: video: 6:11:28.768 +95 315 0/\ms 41+1+3 v-buf Jan 1 20:02:45 vdr vdr: video: slow down video, duping frame Jan 1 20:02:45 vdr vdr: video: 6:11:33.788 +97 337 0/\ms 48+2+3 v-buf Jan 1 20:02:45 vdr vdr: video/vdpau: 6 missed, 49552 duped, 0 dropped frames of 4350,54000 Jan 1 20:02:50 vdr vdr: video: slow down video, duping frame Jan 1 20:02:50 vdr vdr: video: 6:11:38.828 +113 305 0/\ms 49+2+3 v-buf Jan 1 20:02:55 vdr vdr: video: slow down video, duping frame Jan 1 20:02:55 vdr vdr: video: 6:11:43.808 +98 326 0/\ms 25+2+4 v-buf Jan 1 20:03:00 vdr vdr: video: slow down video, duping frame Jan 1 20:03:00 vdr vdr: video: 6:11:48.828 +95 343 0/\ms 38+1+3 v-buf Jan 1 20:03:00 vdr vdr: [16251] EPGSearch: timer conflict check started Jan 1 20:03:00 vdr vdr: [16251] EPGSearch: timer conflict check finished Jan 1 20:03:05 vdr vdr: video: slow down video, duping frame Jan 1 20:03:05 vdr vdr: video: 6:11:53.888 +114 294 0/\ms 26+2+4 v-buf Jan 1 20:03:08 vdr vdr: codec/audio: drift( 0) 333us 160 Jan 1 20:03:10 vdr vdr: video: slow down video, duping frame Jan 1 20:03:10 vdr vdr: video: 6:11:58.908 +104 304 0/\ms 29+2+4 v-buf Jan 1 20:03:15 vdr vdr: video: slow down video, duping frame Jan 1 20:03:15 vdr vdr: video: 6:12:03.948 +111 287 0/\ms 26+2+4 v-buf Jan 1 20:03:15 vdr vdr: video/vdpau: 6 missed, 66044 duped, 0 dropped frames of 5858,72000 Jan 1 20:03:15 vdr vdr: [softhddev]CreateOsd: 93, 73, 0 Jan 1 20:03:15 vdr vdr: [21636] detacher thread thread started (pid=16229, tid=21636, prio=high) Jan 1 20:03:15 vdr vdr: [21637] detacher thread thread started (pid=16229, tid=21637, prio=high) Jan 1 20:03:15 vdr vdr: [21638] detacher thread thread started (pid=16229, tid=21638, prio=high) Jan 1 20:03:15 vdr vdr: [21640] detacher thread thread started (pid=16229, tid=21640, prio=high) Jan 1 20:03:15 vdr vdr: [21639] detacher thread thread started (pid=16229, tid=21639, prio=high) Jan 1 20:03:15 vdr vdr: [21641] detacher thread thread started (pid=16229, tid=21641, prio=high) Jan 1 20:03:15 vdr vdr: [softhddev]ScaleVideo: 0x0+0+0 Jan 1 20:03:15 vdr vdr: [21642] animator thread thread started (pid=16229, tid=21642, prio=high) Jan 1 20:03:15 vdr vdr: [21638] detacher thread thread ended (pid=16229, tid=21638) Jan 1 20:03:15 vdr vdr: [21641] detacher thread thread ended (pid=16229, tid=21641) Jan 1 20:03:15 vdr vdr: [21636] detacher thread thread ended (pid=16229, tid=21636) Jan 1 20:03:15 vdr vdr: [21637] detacher thread thread ended (pid=16229, tid=21637) Jan 1 20:03:15 vdr vdr: [21639] detacher thread thread ended (pid=16229, tid=21639) Jan 1 20:03:15 vdr vdr: [21640] detacher thread thread ended (pid=16229, tid=21640) Jan 1 20:03:17 vdr vdr: [21642] animator thread thread ended (pid=16229, tid=21642) Jan 1 20:03:17 vdr vdr: [softhddev]ScaleVideo: 0x0+0+0 Jan 1 20:03:17 vdr vdr: video/vdpau: osd clear image Jan 1 20:03:17 vdr vdr: video/vdpau: 1672599797556456 display time 24278 Jan 1 20:03:17 vdr vdr: video: slow down video, duping frame Jan 1 20:03:17 vdr vdr: video/vdpau: missed frame (7/5980) Jan 1 20:03:17 vdr vdr: video: slow down video, duping frame Jan 1 20:03:17 vdr vdr: video: 6:12:06.388 +111 295 0/\ms 46+2+3 v-buf Jan 1 20:03:20 vdr vdr: video: slow down video, duping frame Jan 1 20:03:20 vdr vdr: video: 6:12:09.308 +110 350 0/\ms 49+2+4 v-buf Jan 1 20:03:25 vdr vdr: video: slow down video, duping frame Jan 1 20:03:25 vdr vdr: video: 6:12:14.328 +99 359 0/\ms 44+2+4 v-buf Jan 1 20:03:30 vdr vdr: video: slow down video, duping frame Jan 1 20:03:30 vdr vdr: video: 6:12:19.368 +110 346 0/\ms 51+2+4 v-buf Jan 1 20:03:35 vdr vdr: video: slow down video, duping frame Jan 1 20:03:35 vdr vdr: video: 6:12:24.388 +104 360 0/\ms 43+2+3 v-buf Jan 1 20:03:40 vdr vdr: video: slow down video, duping frame Jan 1 20:03:40 vdr vdr: video: 6:12:29.408 +102 354 0/\ms 47+2+4 v-buf Jan 1 20:03:45 vdr vdr: video: slow down video, duping frame Jan 1 20:03:45 vdr vdr: video: 6:12:34.428 +101 349 0/\ms 48+2+3 v-buf Jan 1 20:03:45 vdr vdr: video/vdpau: 7 missed, 82520 duped, 0 dropped frames of 7382,90000 Jan 1 20:03:50 vdr vdr: video: slow down video, duping frame Jan 1 20:03:50 vdr vdr: video: 6:12:39.448 +102 346 0/\ms 49+2+4 v-buf Jan 1 20:03:55 vdr vdr: video: slow down video, duping frame Jan 1 20:03:55 vdr vdr: video: 6:12:44.468 +98 362 0/\ms 52+2+4 v-buf Jan 1 20:04:00 vdr vdr: video: slow down video, duping frame Jan 1 20:04:00 vdr vdr: video: 6:12:49.508 +102 342 0/\ms 50+2+3 v-buf Jan 1 20:04:04 vdr vdr: [softhddev]CreateOsd: 93, 73, 0 Jan 1 20:04:04 vdr vdr: [21786] detacher thread thread started (pid=16229, tid=21786, prio=high) Jan 1 20:04:04 vdr vdr: [21787] detacher thread thread started (pid=16229, tid=21787, prio=high) Jan 1 20:04:04 vdr vdr: [21788] detacher thread thread started (pid=16229, tid=21788, prio=high) Jan 1 20:04:04 vdr vdr: [21789] detacher thread thread started (pid=16229, tid=21789, prio=high) Jan 1 20:04:04 vdr vdr: [21790] detacher thread thread started (pid=16229, tid=21790, prio=high) Jan 1 20:04:04 vdr vdr: [21791] detacher thread thread started (pid=16229, tid=21791, prio=high) Jan 1 20:04:04 vdr vdr: [21792] animator thread thread started (pid=16229, tid=21792, prio=high) Jan 1 20:04:04 vdr vdr: [softhddev]ScaleVideo: 0x0+0+0 Jan 1 20:04:04 vdr vdr: [21791] detacher thread thread ended (pid=16229, tid=21791) Jan 1 20:04:04 vdr vdr: [21786] detacher thread thread ended (pid=16229, tid=21786) Jan 1 20:04:04 vdr vdr: [21788] detacher thread thread ended (pid=16229, tid=21788) Jan 1 20:04:04 vdr vdr: [21787] detacher thread thread ended (pid=16229, tid=21787) Jan 1 20:04:04 vdr vdr: [21789] detacher thread thread ended (pid=16229, tid=21789) Jan 1 20:04:04 vdr vdr: [21790] detacher thread thread ended (pid=16229, tid=21790) Jan 1 20:04:05 vdr vdr: video: slow down video, duping frame Jan 1 20:04:05 vdr vdr: video: 6:12:54.788 +101 269 0/\ms 48+2+3 v-buf Jan 1 20:04:11 vdr vdr: video: slow down video, duping frame Jan 1 20:04:11 vdr vdr: video: 6:13:00.468 +100 300 0/\ms 50+2+3 v-buf Jan 1 20:04:17 vdr vdr: video: slow down video, duping frame Jan 1 20:04:17 vdr vdr: video: 6:13:06.168 +101 337 0/\ms 49+2+3 v-buf Jan 1 20:04:17 vdr vdr: video/vdpau: 7 missed, 98933 duped, 0 dropped frames of 8969,108000 Jan 1 20:04:19 vdr earlyoom[1145]: mem avail: 6562 of 7851 MiB (83.57%), swap free: 4095 of 4095 MiB (100.00%), anon: 636 MiB ( 8.11%) Jan 1 20:04:23 vdr vdr: video: slow down video, duping frame Jan 1 20:04:23 vdr vdr: video: 6:13:11.868 +105 353 0/\ms 51+2+4 v-buf Jan 1 20:04:28 vdr vdr: video: slow down video, duping frame Jan 1 20:04:28 vdr vdr: video: 6:13:17.548 +96 280 0/\ms 42+2+4 v-buf Jan 1 20:04:34 vdr vdr: video: slow down video, duping frame Jan 1 20:04:34 vdr vdr: video: 6:13:23.248 +99 343 0/\ms 45+2+3 v-buf Jan 1 20:04:40 vdr vdr: video: slow down video, duping frame Jan 1 20:04:40 vdr vdr: video: 6:13:29.008 +98 294 0/\ms 49+2+3 v-buf Jan 1 20:04:45 vdr vdr: video: slow down video, duping frame Jan 1 20:04:45 vdr vdr: video: 6:13:34.788 +112 336 0/\ms 27+2+4 v-buf Jan 1 20:04:49 vdr vdr: codec/audio: drift( 0) 644us 309 Jan 1 20:04:51 vdr vdr: video: slow down video, duping frame Jan 1 20:04:51 vdr vdr: video: 6:13:40.548 +101 325 0/\ms 26+2+3 v-buf Jan 1 20:04:51 vdr vdr: video/vdpau: 7 missed, 115214 duped, 0 dropped frames of 10688,126000 Jan 1 20:04:57 vdr vdr: video: slow down video, duping frame Jan 1 20:04:57 vdr vdr: video: 6:13:46.308 +97 297 0/\ms 18+2+4 v-buf Jan 1 20:04:57 vdr vdr: [21792] animator thread thread ended (pid=16229, tid=21792) Jan 1 20:04:57 vdr vdr: [softhddev]ScaleVideo: 0x0+0+0 Jan 1 20:04:57 vdr vdr: video/vdpau: osd clear image Jan 1 20:04:57 vdr vdr: [softhddev]GrabImage: 32629, 1, 95, 1920x1080 Jan 1 20:04:57 vdr vdr: video: grab Jan 1 20:04:57 vdr vdr: video/vdpau: grab 1920x1080 format 0 Jan 1 20:04:57 vdr vdr: video/vdpau: grab source rect 0,0:1920,1080 dest dim 1920x1080 Jan 1 20:04:57 vdr vdr: video/vdpau: 1672599897556709 display time 22989 Jan 1 20:04:57 vdr vdr: video: slow down video, duping frame Jan 1 20:04:57 vdr vdr: video/vdpau: missed frame (8/10980) Jan 1 20:04:57 vdr vdr: video: slow down video, duping frame Jan 1 20:04:57 vdr vdr: video: 6:13:46.388 +89 305 0/\ms 23+2+2 v-buf Jan 1 20:04:57 vdr vdr: video/vdpau: 1672599897578998 display time 21640 Jan 1 20:04:57 vdr vdr: video/vdpau: missed frame (9/10981) Jan 1 20:04:57 vdr vdr: video: slow down video, duping frame Jan 1 20:04:57 vdr vdr: video: 6:13:46.408 +107 303 0/\ms 22+2+3 v-buf Jan 1 20:04:57 vdr vdr: [22144] grabbed image to /mp/images/Ihr letzter Wille kann mich mal!-20230101-001.jpg Jan 1 20:04:57 vdr vdr: [22144] screenshot: 1 image saved Jan 1 20:04:58 vdr vdr: [16229] info: OK - Image saved. Jan 1 20:04:58 vdr vdr: [softhddev]CreateOsd: 498, 799, 0 Jan 1 20:04:58 vdr vdr: [22145] animator thread thread started (pid=16229, tid=22145, prio=high) Jan 1 20:05:02 vdr vdr: [22145] animator thread thread ended (pid=16229, tid=22145) Jan 1 20:05:02 vdr vdr: video: slow down video, duping frame Jan 1 20:05:02 vdr vdr: video: 6:13:51.488 +99 327 0/\ms 23+2+4 v-buf Jan 1 20:05:02 vdr vdr: video/vdpau: osd clear image Jan 1 20:05:02 vdr vdr: video/vdpau: 1672599902894924 display time 23335 Jan 1 20:05:02 vdr vdr: video: slow down video, duping frame Jan 1 20:05:02 vdr vdr: video/vdpau: missed frame (10/11247) Jan 1 20:05:02 vdr vdr: video: slow down video, duping frame Jan 1 20:05:02 vdr vdr: video: 6:13:51.728 +112 292 0/\ms 19+2+3 v-buf Jan 1 20:05:03 vdr vdr: [softhddev]CreateOsd: 93, 73, 0 Jan 1 20:05:03 vdr vdr: [22161] detacher thread thread started (pid=16229, tid=22161, prio=high) Jan 1 20:05:03 vdr vdr: [22162] detacher thread thread started (pid=16229, tid=22162, prio=high) Jan 1 20:05:03 vdr vdr: [22163] detacher thread thread started (pid=16229, tid=22163, prio=high) Jan 1 20:05:03 vdr vdr: [22164] detacher thread thread started (pid=16229, tid=22164, prio=high) Jan 1 20:05:03 vdr vdr: [22166] detacher thread thread started (pid=16229, tid=22166, prio=high) Jan 1 20:05:03 vdr vdr: [22167] animator thread thread started (pid=16229, tid=22167, prio=high) Jan 1 20:05:03 vdr vdr: [softhddev]ScaleVideo: 0x0+0+0 Jan 1 20:05:03 vdr vdr: [22165] detacher thread thread started (pid=16229, tid=22165, prio=high) Jan 1 20:05:03 vdr vdr: [22166] detacher thread thread ended (pid=16229, tid=22166) Jan 1 20:05:03 vdr vdr: [22163] detacher thread thread ended (pid=16229, tid=22163) Jan 1 20:05:03 vdr vdr: [22161] detacher thread thread ended (pid=16229, tid=22161) Jan 1 20:05:03 vdr vdr: [22162] detacher thread thread ended (pid=16229, tid=22162) Jan 1 20:05:03 vdr vdr: [22164] detacher thread thread ended (pid=16229, tid=22164) Jan 1 20:05:03 vdr vdr: [22165] detacher thread thread ended (pid=16229, tid=22165) Jan 1 20:05:08 vdr vdr: video: slow down video, duping frame Jan 1 20:05:08 vdr vdr: video: 6:13:57.108 +95 319 0/\ms 30+1+4 v-buf Jan 1 20:05:10 vdr vdr: [22167] animator thread thread ended (pid=16229, tid=22167) Jan 1 20:05:10 vdr vdr: [softhddev]ScaleVideo: 0x0+0+0 Jan 1 20:05:10 vdr vdr: video/vdpau: osd clear image Jan 1 20:05:10 vdr vdr: video/vdpau: 1672599910836954 display time 24213 Jan 1 20:05:10 vdr vdr: video: slow down video, duping frame Jan 1 20:05:10 vdr vdr: video/vdpau: missed frame (11/11644) Jan 1 20:05:10 vdr vdr: video: slow down video, duping frame Jan 1 20:05:10 vdr vdr: video: 6:13:59.668 +110 342 0/\ms 30+2+3 v-buf Jan 1 20:05:13 vdr vdr: video: slow down video, duping frame Jan 1 20:05:13 vdr vdr: video: 6:14:02.448 +102 314 0/\ms 27+2+4 v-buf Jan 1 20:05:18 vdr vdr: video: slow down video, duping frame Jan 1 20:05:18 vdr vdr: video: 6:14:07.488 +100 288 0/\ms 24+2+4 v-buf Jan 1 20:05:23 vdr vdr: video: slow down video, duping frame Jan 1 20:05:23 vdr vdr: video: 6:14:12.528 +113 277 0/\ms 18+2+4 v-buf Jan 1 20:05:23 vdr vdr: video/vdpau: 11 missed, 131615 duped, 0 dropped frames of 12287,144000 Jan 1 20:05:28 vdr vdr: video: slow down video, duping frame Jan 1 20:05:28 vdr vdr: video: 6:14:17.548 +98 282 0/\ms 18+2+4 v-buf Jan 1 20:05:30 vdr systemd[1]: Created slice User Slice of UID 0. Jan 1 20:05:30 vdr systemd[1]: Starting User Runtime Directory /run/user/0... Jan 1 20:05:30 vdr systemd[1]: Finished User Runtime Directory /run/user/0. Jan 1 20:05:30 vdr systemd[1]: Starting User Manager for UID 0... Jan 1 20:05:30 vdr systemd[22300]: Queued start job for default target Main User Target. Jan 1 20:05:30 vdr systemd[22300]: Created slice User Application Slice. Jan 1 20:05:30 vdr systemd[22300]: Reached target Paths. Jan 1 20:05:30 vdr systemd[22300]: Reached target Timers. Jan 1 20:05:30 vdr systemd[22300]: Starting D-Bus User Message Bus Socket... Jan 1 20:05:30 vdr systemd[22300]: Listening on GnuPG network certificate management daemon. Jan 1 20:05:30 vdr systemd[22300]: Listening on GnuPG cryptographic agent and passphrase cache (access for web browsers). Jan 1 20:05:30 vdr systemd[22300]: Listening on GnuPG cryptographic agent and passphrase cache (restricted). Jan 1 20:05:30 vdr systemd[22300]: Listening on GnuPG cryptographic agent (ssh-agent emulation). Jan 1 20:05:30 vdr systemd[22300]: Listening on GnuPG cryptographic agent and passphrase cache. Jan 1 20:05:30 vdr systemd[22300]: Listening on debconf communication socket. Jan 1 20:05:30 vdr systemd[22300]: Listening on REST API socket for snapd user session agent. Jan 1 20:05:30 vdr systemd[22300]: Listening on D-Bus User Message Bus Socket. Jan 1 20:05:30 vdr systemd[22300]: Reached target Sockets. Jan 1 20:05:30 vdr systemd[22300]: Reached target Basic System. Jan 1 20:05:30 vdr systemd[22300]: Reached target Main User Target. Jan 1 20:05:30 vdr systemd[22300]: Startup finished in 102ms. Jan 1 20:05:30 vdr systemd[1]: Started User Manager for UID 0. Jan 1 20:05:30 vdr systemd[1]: Started Session 12 of User root. Jan 1 20:05:33 vdr vdr: video: slow down video, duping frame Jan 1 20:05:33 vdr vdr: video: 6:14:22.508 +101 317 0/\ms 35+2+4 v-buf Jan 1 20:05:38 vdr vdr: video: slow down video, duping frame Jan 1 20:05:38 vdr vdr: video: 6:14:27.528 +96 308 0/\ms 36+2+4 v-buf Jan 1 20:05:43 vdr vdr: video: slow down video, duping frame Jan 1 20:05:43 vdr vdr: video: 6:14:32.568 +111 323 0/\ms 23+2+4 v-buf Jan 1 20:05:48 vdr vdr: video: slow down video, duping frame Jan 1 20:05:48 vdr vdr: video: 6:14:37.588 +110 342 0/\ms 25+2+4 v-buf Jan 1 20:05:53 vdr vdr: video: slow down video, duping frame Jan 1 20:05:53 vdr vdr: video: 6:14:42.608 +106 358 0/\ms 25+2+3 v-buf Jan 1 20:05:53 vdr vdr: video/vdpau: 11 missed, 148111 duped, 0 dropped frames of 13791,162000