Feb 1 19:55:25 rene rsyslogd: [origin software="rsyslogd" swVersion="8.32.0" x-pid="1096" x-info="http://www.rsyslog.com"] rsyslogd was HUPed Feb 1 19:55:27 rene anacron[1018]: Job `cron.daily' terminated Feb 1 19:55:27 rene anacron[1018]: Normal exit (1 job run) Feb 1 19:55:28 rene snapd[2969]: udevmon.go:190: udev monitor observed remove event for unknown device "/sys/kernel/slab/sock_inode_cache/cgroup/sock_inode_cache(739:anacron.service)" Feb 1 19:55:28 rene snapd[2969]: udevmon.go:190: udev monitor observed remove event for unknown device "/sys/kernel/slab/:A-0000256/cgroup/filp(739:anacron.service)" Feb 1 19:55:28 rene snapd[2969]: udevmon.go:190: udev monitor observed remove event for unknown device "/sys/kernel/slab/:A-0000208/cgroup/vm_area_struct(739:anacron.service)" Feb 1 19:55:28 rene snapd[2969]: udevmon.go:190: udev monitor observed remove event for unknown device "/sys/kernel/slab/:A-0002112/cgroup/mm_struct(739:anacron.service)" Feb 1 19:55:28 rene snapd[2969]: udevmon.go:190: udev monitor observed remove event for unknown device "/sys/kernel/slab/inode_cache/cgroup/inode_cache(739:anacron.service)" Feb 1 19:55:28 rene snapd[2969]: udevmon.go:190: udev monitor observed remove event for unknown device "/sys/kernel/slab/:A-0000192/cgroup/cred_jar(739:anacron.service)" Feb 1 19:55:28 rene snapd[2969]: udevmon.go:190: udev monitor observed remove event for unknown device "/sys/kernel/slab/anon_vma/cgroup/anon_vma(739:anacron.service)" Feb 1 19:55:28 rene snapd[2969]: udevmon.go:190: udev monitor observed remove event for unknown device "/sys/kernel/slab/:0000512/cgroup/kmalloc-512(739:anacron.service)" Feb 1 19:55:28 rene snapd[2969]: udevmon.go:190: udev monitor observed remove event for unknown device "/sys/kernel/slab/:0000256/cgroup/kmalloc-256(739:anacron.service)" Feb 1 19:55:28 rene snapd[2969]: udevmon.go:190: udev monitor observed remove event for unknown device "/sys/kernel/slab/:A-0000064/cgroup/pid(739:anacron.service)" Feb 1 19:55:44 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 19:55:45 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 19:55:45 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 19:55:45 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 19:55:48 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 19:55:48 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 19:55:51 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 19:55:51 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 19:55:54 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 19:55:54 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 19:55:54 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 19:55:54 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 19:55:57 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 19:55:57 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 19:55:57 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 19:55:59 rene vdr: [1778] frontend 1/0 timed out while tuning to channel 23 (DMAX), tp 212480 Feb 1 19:56:00 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 19:56:00 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 19:56:00 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 20:03:21 rene systemd[1]: Started Run anacron jobs. Feb 1 20:03:21 rene anacron[6806]: Anacron 2.3 started on 2019-02-01 Feb 1 20:03:21 rene anacron[6806]: Normal exit (0 jobs run) Feb 1 20:05:21 rene systemd[1]: Starting Cleanup of Temporary Directories... Feb 1 20:05:21 rene systemd[1]: Started Cleanup of Temporary Directories. Feb 1 20:06:21 rene systemd[1]: Starting Message of the Day... Feb 1 20:06:21 rene 50-motd-news[6871]: * 'snap info' now shows the freshness of each channel. Feb 1 20:06:21 rene 50-motd-news[6871]: Try 'snap info microk8s' for all the latest goodness. Feb 1 20:06:21 rene systemd[1]: Started Message of the Day. Feb 1 20:17:01 rene CRON[7056]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly) Feb 1 20:46:45 rene run-desktop-file[5940]: [Child 6030, MediaPlayback #3] WARNING: Decoder=7f3c10fbcc00 Decode error: NS_ERROR_DOM_MEDIA_FATAL_ERR (0x806e0005) - RefPtr, mozilla::MediaResult, true> > mozilla::MediaSourceTrackDemuxer::DoGetSamples(int32_t): manager is detached.: file /build/firefox-HN7tk_/firefox-65.0+build2/dom/media/MediaDecoderStateMachine.cpp, line 3309 Feb 1 20:46:46 rene run-desktop-file[5940]: [Child 6030, MediaPlayback #1] WARNING: Decoder=7f3c10fbcc00 Decode error: NS_ERROR_DOM_MEDIA_FATAL_ERR (0x806e0005) - RefPtr, mozilla::MediaResult, true> > mozilla::MediaSourceTrackDemuxer::DoGetSamples(int32_t): manager is detached.: file /build/firefox-HN7tk_/firefox-65.0+build2/dom/media/MediaDecoderStateMachine.cpp, line 3309 Feb 1 20:46:46 rene run-desktop-file[5940]: [Child 6030, MediaPlayback #1] WARNING: Decoder=7f3c10fbcc00 Decode error: NS_ERROR_DOM_MEDIA_FATAL_ERR (0x806e0005) - RefPtr, mozilla::MediaResult, true> > mozilla::MediaSourceTrackDemuxer::DoGetSamples(int32_t): manager is detached.: file /build/firefox-HN7tk_/firefox-65.0+build2/dom/media/MediaDecoderStateMachine.cpp, line 3309 Feb 1 21:02:09 rene systemd[1]: Started Run anacron jobs. Feb 1 21:02:09 rene anacron[7719]: Anacron 2.3 started on 2019-02-01 Feb 1 21:02:09 rene anacron[7719]: Normal exit (0 jobs run) Feb 1 21:11:09 rene vdr: [1778] frontend 1/0 timed out while tuning to channel 24 (Nickelodeon), tp 211973 Feb 1 21:16:37 rene vdr: [1778] frontend 1/0 lost lock on channel 24 (Nickelodeon), tp 211973 Feb 1 21:16:40 rene vdr: [1778] frontend 1/0 timed out while tuning to channel 24 (Nickelodeon), tp 211973 Feb 1 21:17:01 rene CRON[7903]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly) Feb 1 21:17:19 rene vdr: [1778] frontend 1/0 regained lock on channel 14 (ONE HD), tp 111052 Feb 1 21:19:33 rene vdr: [1778] frontend 1/0 timed out while tuning to channel 24 (Nickelodeon), tp 211973 Feb 1 21:33:33 rene vdr: message repeated 5 times: [ [1778] frontend 1/0 timed out while tuning to channel 24 (Nickelodeon), tp 211973] Feb 1 21:33:58 rene vdr: [1778] frontend 1/0 lost lock on channel 24 (Nickelodeon), tp 211973 Feb 1 21:34:00 rene vdr: [1778] frontend 1/0 timed out while tuning to channel 24 (Nickelodeon), tp 211973 Feb 1 21:34:06 rene vdr: [1778] frontend 1/0 regained lock on channel 14 (ONE HD), tp 111052 Feb 1 21:36:19 rene vdr: [1778] frontend 1/0 lost lock on channel 24 (Nickelodeon), tp 211973 Feb 1 21:36:21 rene vdr: [1778] frontend 1/0 timed out while tuning to channel 24 (Nickelodeon), tp 211973 Feb 1 21:36:40 rene vdr: [1778] frontend 1/0 regained lock on channel 24 (Nickelodeon), tp 211973 Feb 1 21:36:44 rene vdr: [1778] frontend 1/0 lost lock on channel 24 (Nickelodeon), tp 211973 Feb 1 21:36:46 rene vdr: [1778] frontend 1/0 timed out while tuning to channel 24 (Nickelodeon), tp 211973 Feb 1 21:36:54 rene vdr: [1778] frontend 1/0 regained lock on channel 14 (ONE HD), tp 111052 Feb 1 21:39:09 rene vdr: [1778] frontend 1/0 timed out while tuning to channel 24 (Nickelodeon), tp 211973 Feb 1 21:41:56 rene vdr: [1778] frontend 1/0 timed out while tuning to channel 24 (Nickelodeon), tp 211973 Feb 1 21:47:46 rene vdr: [1778] frontend 1/0 lost lock on channel 24 (Nickelodeon), tp 211973 Feb 1 21:47:48 rene vdr: [1778] frontend 1/0 timed out while tuning to channel 24 (Nickelodeon), tp 211973 Feb 1 21:48:05 rene vdr: [1778] frontend 1/0 regained lock on channel 14 (ONE HD), tp 111052 Feb 1 21:50:19 rene vdr: [1778] frontend 1/0 timed out while tuning to channel 24 (Nickelodeon), tp 211973 Feb 1 21:53:11 rene vdr: [1778] frontend 1/0 timed out while tuning to channel 24 (Nickelodeon), tp 211973 Feb 1 21:54:02 rene run-desktop-file[5940]: [Child 6030, MediaPlayback #4] WARNING: Decoder=7f3c10fbc600 Decode error: NS_ERROR_DOM_MEDIA_FATAL_ERR (0x806e0005) - RefPtr, mozilla::MediaResult, true> > mozilla::MediaSourceTrackDemuxer::DoGetSamples(int32_t): manager is detached.: file /build/firefox-HN7tk_/firefox-65.0+build2/dom/media/MediaDecoderStateMachine.cpp, line 3309 Feb 1 21:54:02 rene run-desktop-file[5940]: [Child 6030, MediaPlayback #2] WARNING: Decoder=7f3c10fbc600 Decode error: NS_ERROR_DOM_MEDIA_FATAL_ERR (0x806e0005) - RefPtr, mozilla::MediaResult, true> > mozilla::MediaSourceTrackDemuxer::DoGetSamples(int32_t): manager is detached.: file /build/firefox-HN7tk_/firefox-65.0+build2/dom/media/MediaDecoderStateMachine.cpp, line 3309 Feb 1 21:54:02 rene run-desktop-file[5940]: [Child 6030, MediaPlayback #1] WARNING: Decoder=7f3c10fbc600 Decode error: NS_ERROR_DOM_MEDIA_FATAL_ERR (0x806e0005) - RefPtr, mozilla::MediaResult, true> > mozilla::MediaSourceTrackDemuxer::DoGetSamples(int32_t): manager is detached.: file /build/firefox-HN7tk_/firefox-65.0+build2/dom/media/MediaDecoderStateMachine.cpp, line 3309 Feb 1 21:54:02 rene run-desktop-file[5940]: [Child 6030, MediaPlayback #2] WARNING: Decoder=7f3c10fbc600 Decode error: NS_ERROR_DOM_MEDIA_FATAL_ERR (0x806e0005) - RefPtr, mozilla::MediaResult, true> > mozilla::MediaSourceTrackDemuxer::DoGetSamples(int32_t): manager is detached.: file /build/firefox-HN7tk_/firefox-65.0+build2/dom/media/MediaDecoderStateMachine.cpp, line 3309 Feb 1 21:55:59 rene vdr: [1778] frontend 1/0 timed out while tuning to channel 24 (Nickelodeon), tp 211973 Feb 1 21:58:42 rene vdr: [1778] frontend 1/0 lost lock on channel 24 (Nickelodeon), tp 211973 Feb 1 21:58:44 rene vdr: [1778] frontend 1/0 timed out while tuning to channel 24 (Nickelodeon), tp 211973 Feb 1 21:58:59 rene vdr: [1778] frontend 1/0 regained lock on channel 24 (Nickelodeon), tp 211973 Feb 1 21:59:10 rene vdr: [1778] frontend 1/0 lost lock on channel 24 (Nickelodeon), tp 211973 Feb 1 21:59:10 rene vdr: [1778] frontend 1/0 regained lock on channel 24 (Nickelodeon), tp 211973 Feb 1 22:01:31 rene vdr: [1778] frontend 1/0 timed out while tuning to channel 24 (Nickelodeon), tp 211973 Feb 1 22:01:48 rene vdr: [1778] frontend 1/0 lost lock on channel 24 (Nickelodeon), tp 211973 Feb 1 22:01:50 rene vdr: [1778] frontend 1/0 timed out while tuning to channel 24 (Nickelodeon), tp 211973 Feb 1 22:02:05 rene vdr: [1778] frontend 1/0 regained lock on channel 14 (ONE HD), tp 111052 Feb 1 22:04:13 rene vdr: [1778] frontend 1/0 lost lock on channel 24 (Nickelodeon), tp 211973 Feb 1 22:04:15 rene vdr: [1778] frontend 1/0 timed out while tuning to channel 24 (Nickelodeon), tp 211973 Feb 1 22:04:31 rene vdr: [1778] frontend 1/0 regained lock on channel 24 (Nickelodeon), tp 211973 Feb 1 22:05:02 rene systemd[1]: Started Run anacron jobs. Feb 1 22:05:02 rene anacron[8525]: Anacron 2.3 started on 2019-02-01 Feb 1 22:05:02 rene anacron[8525]: Normal exit (0 jobs run) Feb 1 22:07:11 rene vdr: [1778] frontend 1/0 lost lock on channel 24 (Nickelodeon), tp 211973 Feb 1 22:07:13 rene vdr: [1778] frontend 1/0 timed out while tuning to channel 24 (Nickelodeon), tp 211973 Feb 1 22:07:42 rene vdr: [1778] frontend 1/0 regained lock on channel 14 (ONE HD), tp 111052 Feb 1 22:09:58 rene vdr: [1778] frontend 1/0 timed out while tuning to channel 24 (Nickelodeon), tp 211973 Feb 1 22:15:33 rene vdr: message repeated 2 times: [ [1778] frontend 1/0 timed out while tuning to channel 24 (Nickelodeon), tp 211973] Feb 1 22:17:01 rene CRON[8672]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly) Feb 1 22:18:21 rene vdr: [1778] frontend 1/0 timed out while tuning to channel 24 (Nickelodeon), tp 211973 Feb 1 22:23:57 rene vdr: message repeated 2 times: [ [1778] frontend 1/0 timed out while tuning to channel 24 (Nickelodeon), tp 211973] Feb 1 22:25:32 rene run-desktop-file[5940]: ###!!! [Child][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost Feb 1 22:25:32 rene run-desktop-file[5940]: [Parent 5944, Gecko_IOThread] WARNING: pipe error: Broken pipe: file /build/firefox-HN7tk_/firefox-65.0+build2/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 718 Feb 1 22:25:32 rene run-desktop-file[5940]: ###!!! [Child][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost Feb 1 22:25:32 rene yavdr-frontend[1947]: DEBUG:SystemdUnitFrontend:unit stopped Feb 1 22:25:32 rene yavdr-frontend[1947]: INFO:SystemdUnitFrontend:stopped, firefox, app Feb 1 22:25:32 rene yavdr-frontend[1947]: DEBUG:yaVDRFrontend:caller firefox has been stopped Feb 1 22:25:32 rene yavdr-frontend[1947]: DEBUG:yaVDRFrontend:set_background with options path: /usr/share/yavdr/images/yavdr_logo.png, fill: False Feb 1 22:25:32 rene yavdr-frontend[1947]: DEBUG:yaVDRFrontend:set_background with options path: /usr/share/yavdr/images/yavdr_logo.png, fill: False Feb 1 22:25:32 rene yavdr-frontend[1947]: DEBUG:VDRFrontend:user is active: True Feb 1 22:25:32 rene yavdr-frontend[1947]: DEBUG:yavdr_frontend.frontends.genericfrontend:check_state(): got status code: 912 Feb 1 22:25:32 rene yavdr-frontend[1947]: DEBUG:yavdr_frontend.frontends.genericfrontend:status: softhddevice is detached Feb 1 22:25:32 rene yavdr-frontend[1947]: DEBUG:yavdr_frontend.frontends.genericfrontend:check_state(): got status code: 912 Feb 1 22:25:32 rene vdr: video/vdpau: VDPAU API version: 1 Feb 1 22:25:32 rene vdr: video/vdpau: VDPAU information: NVIDIA VDPAU Driver Shared Library 340.107 Thu May 24 21:44:57 PDT 2018 Feb 1 22:25:32 rene vdr: video/vdpau: highest supported high quality scaling 1 Feb 1 22:25:32 rene vdr: video/vdpau: feature deinterlace temporal supported Feb 1 22:25:32 rene vdr: video/vdpau: feature deinterlace temporal spatial supported Feb 1 22:25:32 rene vdr: video/vdpau: attribute skip chroma deinterlace supported Feb 1 22:25:32 rene vdr: video/vdpau: 4:2:0 chroma format with 4096x4096 supported Feb 1 22:25:32 rene vdr: video/vdpau: 4:2:2 chroma format with 4096x4096 supported Feb 1 22:25:32 rene vdr: video/vdpau: 8bit BGRA format with 8192x8192 supported Feb 1 22:25:32 rene vdr: video/vdpau: 10bit RGBA format with 8192x8192 supported Feb 1 22:25:32 rene vdr: audio: 'alsa' output module used Feb 1 22:25:32 rene vdr: audio/alsa: supports pause: yes Feb 1 22:25:32 rene vdr: audio: 44100Hz supports 1 2 3 4 5 6 7 8 channels Feb 1 22:25:32 rene vdr: audio: 48000Hz supports 1 2 3 4 5 6 7 8 channels Feb 1 22:25:32 rene vdr: audio: 192000Hz supports 1 2 3 4 5 6 7 8 channels Feb 1 22:25:32 rene yavdr-frontend[1947]: DEBUG:yavdr_frontend.frontends.genericfrontend:change_state with command atta and options "-d :0" to attached Feb 1 22:25:32 rene yavdr-frontend[1947]: DEBUG:yavdr_frontend.frontends.genericfrontend:check_state(): got status code: 910 Feb 1 22:25:32 rene yavdr-frontend[1947]: DEBUG:yavdr_frontend.frontends.genericfrontend:softhddevice successfully attached Feb 1 22:25:32 rene yavdr-frontend[1947]: DEBUG:yavdr_frontend.frontends.genericfrontend:current PrimaryDevice is softhddevice-vpp (Index: 2, Number: 2, hasDecoder: True, isPrimary: True) Feb 1 22:25:32 rene yavdr-frontend[1947]: DEBUG:yavdr_frontend.frontends.genericfrontend:softhddevice is the primary device Feb 1 22:25:32 rene yavdr-frontend[1947]: DEBUG:yavdr_frontend.frontends.genericfrontend:needed 0.001 s to switch primary device Feb 1 22:25:33 rene vdr: [1717] switching to channel 23 S19.2E-133-33-63 (DMAX) Feb 1 22:25:33 rene vdr: [8822] device 1 receiver thread started (pid=1717, tid=8822, prio=high) Feb 1 22:25:33 rene vdr: [8824] device 1 TS buffer thread started (pid=1717, tid=8824, prio=high) Feb 1 22:25:35 rene vdr: audio/alsa: using device 'default' Feb 1 22:25:35 rene vdr: audio/alsa: start delay 336ms Feb 1 22:25:36 rene vdr: video/vdpau: synced after 21 frames Feb 1 22:26:26 rene vdr: video: slow down video, duping frame Feb 1 22:26:26 rene vdr: video: 3:16:45.035 +9 381 0/\ms 7+7+4 v-buf Feb 1 22:26:35 rene vdr: video: speed up video, droping frame Feb 1 22:26:35 rene vdr: video: 3:16:54.255 -26 341 0/\ms 5+6+4 v-buf Feb 1 22:26:53 rene vdr: [8834] epg data writer thread started (pid=1717, tid=8834, prio=low) Feb 1 22:26:53 rene vdr: [8834] epg data writer thread ended (pid=1717, tid=8834) Feb 1 22:27:16 rene vdr: video: speed up video, droping frame Feb 1 22:27:16 rene vdr: video: 3:17:35.135 -10 373 0/\ms 6+8+4 v-buf Feb 1 22:28:06 rene vdr: video: speed up video, droping frame Feb 1 22:28:06 rene vdr: video: 3:18:25.255 -9 389 0/\ms 7+8+4 v-buf Feb 1 22:28:35 rene vdr: video: speed up video, droping frame Feb 1 22:28:35 rene vdr: video/vdpau: missed frame (1/8962) Feb 1 22:28:35 rene vdr: video: speed up video, droping frame Feb 1 22:28:35 rene vdr: video: 3:18:54.475 -193 338 0/\ms 21+5+4 v-buf Feb 1 22:28:56 rene vdr: video: speed up video, droping frame Feb 1 22:28:56 rene vdr: video: 3:19:15.595 -6 357 0/\ms 7+7+4 v-buf Feb 1 22:28:57 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:28:58 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:28:58 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:28:58 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:28:58 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:28:58 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:28:58 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:28:59 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:29:01 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:29:01 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:29:03 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:29:03 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:29:04 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:29:04 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:29:04 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:29:04 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:29:04 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:29:05 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:29:07 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:29:07 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:29:10 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:29:10 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:29:11 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:29:11 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:29:12 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:29:12 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:29:46 rene vdr: video: speed up video, droping frame Feb 1 22:29:46 rene vdr: video: 3:20:05.715 -6 325 0/\ms 10+7+4 v-buf Feb 1 22:30:36 rene vdr: video: speed up video, droping frame Feb 1 22:30:36 rene vdr: video: 3:20:55.835 -6 413 0/\ms 17+7+4 v-buf Feb 1 22:31:26 rene vdr: video: speed up video, droping frame Feb 1 22:31:26 rene vdr: video: 3:21:45.955 -5 334 0/\ms 5+7+4 v-buf Feb 1 22:32:17 rene vdr: video: speed up video, droping frame Feb 1 22:32:17 rene vdr: video: 3:22:36.075 -5 350 0/\ms 7+7+4 v-buf Feb 1 22:33:07 rene vdr: video: speed up video, droping frame Feb 1 22:33:07 rene vdr: video: 3:23:26.195 -4 391 0/\ms 9+7+4 v-buf Feb 1 22:33:12 rene vdr: [1717] switching to channel 3 S19.2E-1-1089-12003 (RTL Television) Feb 1 22:33:12 rene vdr: [8824] device 1 TS buffer thread ended (pid=1717, tid=8824) Feb 1 22:33:12 rene vdr: [8822] buffer stats: 94000 (1%) used Feb 1 22:33:12 rene vdr: [8822] device 1 receiver thread ended (pid=1717, tid=8822) Feb 1 22:33:12 rene vdr: [8882] device 1 receiver thread started (pid=1717, tid=8882, prio=high) Feb 1 22:33:12 rene vdr: [8883] device 1 TS buffer thread started (pid=1717, tid=8883, prio=high) Feb 1 22:33:12 rene vdr: video: speed up video, droping frame Feb 1 22:33:12 rene vdr: video: decoder buffer empty, duping frame (1323/22828) 0 v-buf Feb 1 22:33:12 rene vdr: video: --:--:--.--- +0 0 0/\ms 0+5+4 v-buf Feb 1 22:33:14 rene vdr: audio/alsa: using device 'default' Feb 1 22:33:14 rene vdr: audio/alsa: start delay 336ms Feb 1 22:33:15 rene vdr: video/vdpau: synced after 37 frames Feb 1 22:33:15 rene vdr: video: decoder buffer empty, duping frame (1339/22828) 0 v-buf Feb 1 22:33:15 rene vdr: video: slow down video, duping frame Feb 1 22:33:15 rene vdr: video: 19:19:23.172 +104 472 0/\ms 10+7+4 v-buf Feb 1 22:33:22 rene vdr: [1717] switching to channel 4 S19.2E-1-1107-17500 (SAT.1) Feb 1 22:33:22 rene vdr: [8883] device 1 TS buffer thread ended (pid=1717, tid=8883) Feb 1 22:33:22 rene vdr: [8882] buffer stats: 89112 (1%) used Feb 1 22:33:22 rene vdr: [8882] device 1 receiver thread ended (pid=1717, tid=8882) Feb 1 22:33:22 rene vdr: [8886] device 1 receiver thread started (pid=1717, tid=8886, prio=high) Feb 1 22:33:22 rene vdr: [8887] device 1 TS buffer thread started (pid=1717, tid=8887, prio=high) Feb 1 22:33:22 rene vdr: video: slow down video, duping frame Feb 1 22:33:22 rene vdr: video: decoder buffer empty, duping frame (1669/358) 0 v-buf Feb 1 22:33:22 rene vdr: video: --:--:--.--- +0 0 0/\ms 0+5+4 v-buf Feb 1 22:33:23 rene vdr: audio/alsa: using device 'default' Feb 1 22:33:23 rene vdr: audio/alsa: start delay 336ms Feb 1 22:33:24 rene vdr: video: decoder buffer empty, duping frame (1686/358) 0 v-buf Feb 1 22:33:24 rene vdr: video: slow down video, duping frame Feb 1 22:33:24 rene vdr: video/vdpau: synced after 43 frames Feb 1 22:33:24 rene vdr: video: 12:02:40.726 +109 402 0/\ms 13+6+4 v-buf Feb 1 22:33:26 rene vdr: [1717] switching to channel 5 S19.2E-1-1107-17501 (ProSieben) Feb 1 22:33:26 rene vdr: [8887] device 1 TS buffer thread ended (pid=1717, tid=8887) Feb 1 22:33:26 rene vdr: [8886] buffer stats: 66364 (1%) used Feb 1 22:33:26 rene vdr: [8886] device 1 receiver thread ended (pid=1717, tid=8886) Feb 1 22:33:26 rene vdr: [8890] device 1 receiver thread started (pid=1717, tid=8890, prio=high) Feb 1 22:33:26 rene vdr: [8891] device 1 TS buffer thread started (pid=1717, tid=8891, prio=high) Feb 1 22:33:26 rene vdr: video: slow down video, duping frame Feb 1 22:33:26 rene vdr: video: decoder buffer empty, duping frame (1775/106) 0 v-buf Feb 1 22:33:26 rene vdr: video: --:--:--.--- +0 0 0/\ms 0+5+4 v-buf Feb 1 22:33:26 rene vdr: audio/alsa: using device 'default' Feb 1 22:33:26 rene vdr: audio/alsa: start delay 336ms Feb 1 22:33:27 rene vdr: video: decoder buffer empty, duping frame (1791/106) 0 v-buf Feb 1 22:33:27 rene vdr: video: slow down video, duping frame Feb 1 22:33:27 rene vdr: video/vdpau: synced after 37 frames Feb 1 22:33:27 rene vdr: video: 11:55:01.674 +98 419 0/\ms 6+6+4 v-buf Feb 1 22:33:28 rene vdr: [1717] switching to channel 4 S19.2E-1-1107-17500 (SAT.1) Feb 1 22:33:28 rene vdr: [8891] device 1 TS buffer thread ended (pid=1717, tid=8891) Feb 1 22:33:28 rene vdr: [8890] buffer stats: 76328 (1%) used Feb 1 22:33:28 rene vdr: [8890] device 1 receiver thread ended (pid=1717, tid=8890) Feb 1 22:33:28 rene vdr: [8894] device 1 receiver thread started (pid=1717, tid=8894, prio=high) Feb 1 22:33:28 rene vdr: [8895] device 1 TS buffer thread started (pid=1717, tid=8895, prio=high) Feb 1 22:33:28 rene vdr: video: slow down video, duping frame Feb 1 22:33:28 rene vdr: video: decoder buffer empty, duping frame (1851/76) 0 v-buf Feb 1 22:33:28 rene vdr: video: --:--:--.---+8888 144 0/\ms 0+5+4 v-buf Feb 1 22:33:28 rene vdr: audio/alsa: using device 'default' Feb 1 22:33:28 rene vdr: audio/alsa: start delay 336ms Feb 1 22:33:29 rene vdr: video: decoder buffer empty, duping frame (1867/76) 0 v-buf Feb 1 22:33:29 rene vdr: video: slow down video, duping frame Feb 1 22:33:29 rene vdr: video/vdpau: synced after 26 frames Feb 1 22:33:29 rene vdr: video: 12:02:46.006 +117 458 0/\ms 10+6+4 v-buf Feb 1 22:33:31 rene vdr: [1717] switching to channel 5 S19.2E-1-1107-17501 (ProSieben) Feb 1 22:33:31 rene vdr: [8895] device 1 TS buffer thread ended (pid=1717, tid=8895) Feb 1 22:33:31 rene vdr: [8894] buffer stats: 57340 (1%) used Feb 1 22:33:31 rene vdr: [8894] device 1 receiver thread ended (pid=1717, tid=8894) Feb 1 22:33:31 rene vdr: [8898] device 1 receiver thread started (pid=1717, tid=8898, prio=high) Feb 1 22:33:31 rene vdr: [8899] device 1 TS buffer thread started (pid=1717, tid=8899, prio=high) Feb 1 22:33:32 rene vdr: audio/alsa: using device 'default' Feb 1 22:33:32 rene vdr: audio/alsa: start delay 336ms Feb 1 22:33:32 rene vdr: video: slow down video, duping frame Feb 1 22:33:32 rene vdr: video: decoder buffer empty, duping frame (1967/134) 0 v-buf Feb 1 22:33:32 rene vdr: video: --:--:--.--- +0 0 0/\ms 0+5+4 v-buf Feb 1 22:33:33 rene vdr: video: decoder buffer empty, duping frame (1974/134) 0 v-buf Feb 1 22:33:33 rene vdr: video: slow down video, duping frame Feb 1 22:33:33 rene vdr: video/vdpau: synced after 43 frames Feb 1 22:33:33 rene vdr: video: 11:55:07.434 +108 405 0/\ms 19+6+4 v-buf Feb 1 22:33:33 rene vdr: [1717] switching to channel 6 S19.2E-1-1089-12020 (RTL2) Feb 1 22:33:33 rene vdr: [8899] device 1 TS buffer thread ended (pid=1717, tid=8899) Feb 1 22:33:33 rene vdr: [8898] buffer stats: 43992 (0%) used Feb 1 22:33:33 rene vdr: [8898] device 1 receiver thread ended (pid=1717, tid=8898) Feb 1 22:33:33 rene vdr: [8902] device 1 receiver thread started (pid=1717, tid=8902, prio=high) Feb 1 22:33:33 rene vdr: [8903] device 1 TS buffer thread started (pid=1717, tid=8903, prio=high) Feb 1 22:33:33 rene vdr: audio/alsa: using device 'default' Feb 1 22:33:33 rene vdr: audio/alsa: start delay 336ms Feb 1 22:33:33 rene vdr: video: slow down video, duping frame Feb 1 22:33:33 rene vdr: video: decoder buffer empty, duping frame (1978/46) 0 v-buf Feb 1 22:33:33 rene vdr: video: --:--:--.--- +0 0 0/\ms 0+5+4 v-buf Feb 1 22:33:34 rene vdr: video: decoder buffer empty, duping frame (1994/46) 0 v-buf Feb 1 22:33:34 rene vdr: video: slow down video, duping frame Feb 1 22:33:34 rene vdr: video/vdpau: synced after 37 frames Feb 1 22:33:34 rene vdr: video: 19:19:42.270 +109 388 0/\ms 16+6+4 v-buf Feb 1 22:33:36 rene vdr: [1717] switching to channel 7 S19.2E-1-1089-12040 (SUPER RTL) Feb 1 22:33:37 rene vdr: [8903] device 1 TS buffer thread ended (pid=1717, tid=8903) Feb 1 22:33:37 rene vdr: [8902] buffer stats: 47752 (0%) used Feb 1 22:33:37 rene vdr: [8902] device 1 receiver thread ended (pid=1717, tid=8902) Feb 1 22:33:37 rene vdr: [8906] device 1 receiver thread started (pid=1717, tid=8906, prio=high) Feb 1 22:33:37 rene vdr: [8907] device 1 TS buffer thread started (pid=1717, tid=8907, prio=high) Feb 1 22:33:37 rene vdr: audio/alsa: using device 'default' Feb 1 22:33:37 rene vdr: audio/alsa: start delay 336ms Feb 1 22:33:37 rene vdr: video: slow down video, duping frame Feb 1 22:33:37 rene vdr: video: decoder buffer empty, duping frame (2105/142) 0 v-buf Feb 1 22:33:37 rene vdr: video: --:--:--.--- +0 0 0/\ms 0+5+4 v-buf Feb 1 22:33:38 rene vdr: video: decoder buffer empty, duping frame (2111/142) 0 v-buf Feb 1 22:33:38 rene vdr: video: slow down video, duping frame Feb 1 22:33:38 rene vdr: video/vdpau: synced after 34 frames Feb 1 22:33:38 rene vdr: video: 19:19:45.592 +108 424 0/\ms 9+6+4 v-buf Feb 1 22:33:38 rene vdr: [1717] switching to channel 8 S19.2E-1-1107-17502 (kabel eins) Feb 1 22:33:38 rene vdr: [8907] device 1 TS buffer thread ended (pid=1717, tid=8907) Feb 1 22:33:38 rene vdr: [8906] buffer stats: 81216 (1%) used Feb 1 22:33:38 rene vdr: [8906] device 1 receiver thread ended (pid=1717, tid=8906) Feb 1 22:33:38 rene vdr: [8909] device 1 receiver thread started (pid=1717, tid=8909, prio=high) Feb 1 22:33:38 rene vdr: [8910] device 1 TS buffer thread started (pid=1717, tid=8910, prio=high) Feb 1 22:33:39 rene vdr: video: slow down video, duping frame Feb 1 22:33:39 rene vdr: video: decoder buffer empty, duping frame (2129/48) 0 v-buf Feb 1 22:33:39 rene vdr: video: --:--:--.--- +0 0 0/\ms 0+5+4 v-buf Feb 1 22:33:39 rene vdr: audio/alsa: using device 'default' Feb 1 22:33:39 rene vdr: audio/alsa: start delay 336ms Feb 1 22:33:39 rene vdr: video: decoder buffer empty, duping frame (2145/48) 0 v-buf Feb 1 22:33:39 rene vdr: video: slow down video, duping frame Feb 1 22:33:39 rene vdr: video/vdpau: synced after 28 frames Feb 1 22:33:39 rene vdr: video: 11:48:43.720 +116 335 0/\ms 7+6+4 v-buf Feb 1 22:33:40 rene vdr: [1717] switching to channel 9 S19.2E-1-1089-12060 (VOX) Feb 1 22:33:40 rene vdr: [8910] device 1 TS buffer thread ended (pid=1717, tid=8910) Feb 1 22:33:40 rene vdr: [8909] buffer stats: 43992 (0%) used Feb 1 22:33:40 rene vdr: [8909] device 1 receiver thread ended (pid=1717, tid=8909) Feb 1 22:33:40 rene vdr: [8912] device 1 receiver thread started (pid=1717, tid=8912, prio=high) Feb 1 22:33:40 rene vdr: [8913] device 1 TS buffer thread started (pid=1717, tid=8913, prio=high) Feb 1 22:33:40 rene vdr: video: slow down video, duping frame Feb 1 22:33:40 rene vdr: video: decoder buffer empty, duping frame (2157/34) 0 v-buf Feb 1 22:33:40 rene vdr: video: --:--:--.--- +0 0 0/\ms 0+5+4 v-buf Feb 1 22:33:40 rene vdr: audio/alsa: using device 'default' Feb 1 22:33:40 rene vdr: audio/alsa: start delay 336ms Feb 1 22:33:41 rene vdr: video: decoder buffer empty, duping frame (2173/34) 0 v-buf Feb 1 22:33:41 rene vdr: video: slow down video, duping frame Feb 1 22:33:41 rene vdr: video/vdpau: synced after 49 frames Feb 1 22:33:41 rene vdr: video: 19:19:49.272 +109 369 0/\ms 11+6+4 v-buf Feb 1 22:33:42 rene vdr: [1717] switching to channel 10 S19.2E-133-5-776 (SIXX) Feb 1 22:33:42 rene vdr: [8913] device 1 TS buffer thread ended (pid=1717, tid=8913) Feb 1 22:33:42 rene vdr: [8912] buffer stats: 38728 (0%) used Feb 1 22:33:42 rene vdr: [8912] device 1 receiver thread ended (pid=1717, tid=8912) Feb 1 22:33:42 rene vdr: [8915] device 1 receiver thread started (pid=1717, tid=8915, prio=high) Feb 1 22:33:42 rene vdr: [8916] device 1 TS buffer thread started (pid=1717, tid=8916, prio=high) Feb 1 22:33:42 rene vdr: video: slow down video, duping frame Feb 1 22:33:42 rene vdr: video: decoder buffer empty, duping frame (2189/48) 0 v-buf Feb 1 22:33:42 rene vdr: video: --:--:--.--- +0 0 0/\ms 0+5+4 v-buf Feb 1 22:33:42 rene vdr: audio/alsa: using device 'default' Feb 1 22:33:42 rene vdr: audio/alsa: start delay 336ms Feb 1 22:33:43 rene vdr: video: decoder buffer empty, duping frame (2202/48) 0 v-buf Feb 1 22:33:43 rene vdr: video: slow down video, duping frame Feb 1 22:33:43 rene vdr: video/vdpau: synced after 21 frames Feb 1 22:33:43 rene vdr: video: 1:07:50.538 +118 341 0/\ms 1+6+4 v-buf Feb 1 22:33:44 rene vdr: video: slow down video, duping frame Feb 1 22:33:44 rene vdr: video: decoder buffer empty, duping frame (2262/64) 0 v-buf Feb 1 22:33:44 rene vdr: video: 1:07:51.698 +108 275 0/\ms 0+5+4 v-buf Feb 1 22:33:44 rene vdr: video: slow down video, duping frame Feb 1 22:33:44 rene vdr: video: 1:07:51.698 +92 354 0/\ms 2+6+4 v-buf Feb 1 22:33:44 rene vdr: video: slow down video, duping frame Feb 1 22:33:44 rene vdr: video: decoder buffer empty, duping frame (2288/88) 0 v-buf Feb 1 22:33:44 rene vdr: video: 1:07:52.178 +87 278 0/\ms 0+5+4 v-buf Feb 1 22:33:44 rene vdr: video: slow down video, duping frame Feb 1 22:33:44 rene vdr: video: 1:07:52.178 +71 381 0/\ms 2+6+4 v-buf Feb 1 22:33:45 rene vdr: [1717] switching to channel 11 S19.2E-1-1019-10302 (arte HD) Feb 1 22:33:45 rene vdr: video: slow down video, duping frame Feb 1 22:33:45 rene vdr: video: decoder buffer empty, duping frame (2328/130) 0 v-buf Feb 1 22:33:45 rene vdr: video: --:--:--.---+8888 218 0/\ms 0+5+4 v-buf Feb 1 22:33:45 rene vdr: [8916] device 1 TS buffer thread ended (pid=1717, tid=8916) Feb 1 22:33:45 rene vdr: [8915] buffer stats: 75952 (1%) used Feb 1 22:33:45 rene vdr: [8915] device 1 receiver thread ended (pid=1717, tid=8915) Feb 1 22:33:45 rene vdr: [8918] device 1 receiver thread started (pid=1717, tid=8918, prio=high) Feb 1 22:33:45 rene vdr: [8919] device 1 TS buffer thread started (pid=1717, tid=8919, prio=high) Feb 1 22:33:46 rene vdr: audio/alsa: using device 'default' Feb 1 22:33:46 rene vdr: audio/alsa: start delay 336ms Feb 1 22:33:46 rene vdr: video: decoder buffer empty, duping frame (2345/130) 0 v-buf Feb 1 22:33:46 rene vdr: video/vdpau: missed frame (2/0) Feb 1 22:33:47 rene vdr: [1717] switching to channel 12 S19.2E-1-1051-28724 (arte) Feb 1 22:33:47 rene vdr: [8919] device 1 TS buffer thread ended (pid=1717, tid=8919) Feb 1 22:33:47 rene vdr: [8918] buffer stats: 210372 (4%) used Feb 1 22:33:47 rene vdr: [8918] device 1 receiver thread ended (pid=1717, tid=8918) Feb 1 22:33:47 rene vdr: [8922] device 1 receiver thread started (pid=1717, tid=8922, prio=high) Feb 1 22:33:47 rene vdr: [8923] device 1 TS buffer thread started (pid=1717, tid=8923, prio=high) Feb 1 22:33:47 rene vdr: video/vdpau: missed frame (5/2) Feb 1 22:33:47 rene vdr: video: decoder buffer empty, duping frame (2346/22) 0 v-buf Feb 1 22:33:47 rene vdr: video: --:--:--.--- +0 0 0/\ms 0+1+4 v-buf Feb 1 22:33:47 rene vdr: audio/alsa: using device 'default' Feb 1 22:33:47 rene vdr: audio/alsa: start delay 336ms Feb 1 22:33:48 rene vdr: [1717] switching to channel 13 S19.2E-1-1010-11150 (3sat HD) Feb 1 22:33:48 rene vdr: [8923] device 1 TS buffer thread ended (pid=1717, tid=8923) Feb 1 22:33:48 rene vdr: [8922] buffer stats: 106032 (2%) used Feb 1 22:33:48 rene vdr: [8922] device 1 receiver thread ended (pid=1717, tid=8922) Feb 1 22:33:48 rene vdr: [8925] device 1 receiver thread started (pid=1717, tid=8925, prio=high) Feb 1 22:33:48 rene vdr: [8926] device 1 TS buffer thread started (pid=1717, tid=8926, prio=high) Feb 1 22:33:49 rene vdr: audio/alsa: using device 'default' Feb 1 22:33:49 rene vdr: audio/alsa: start delay 336ms Feb 1 22:33:49 rene vdr: video: decoder buffer empty, duping frame (2364/22) 0 v-buf Feb 1 22:33:49 rene vdr: video/vdpau: missed frame (6/2) Feb 1 22:33:49 rene vdr: video: slow down video, duping frame Feb 1 22:33:49 rene vdr: video/vdpau: synced after 45 frames Feb 1 22:33:49 rene vdr: video: 1:01:38.691 +114 316 0/\ms 29+2+4 v-buf Feb 1 22:33:50 rene vdr: [1717] switching to channel 12 S19.2E-1-1051-28724 (arte) Feb 1 22:33:50 rene vdr: [8926] device 1 TS buffer thread ended (pid=1717, tid=8926) Feb 1 22:33:50 rene vdr: [8925] buffer stats: 205860 (3%) used Feb 1 22:33:50 rene vdr: [8925] device 1 receiver thread ended (pid=1717, tid=8925) Feb 1 22:33:50 rene vdr: [8928] device 1 receiver thread started (pid=1717, tid=8928, prio=high) Feb 1 22:33:50 rene vdr: [8929] device 1 TS buffer thread started (pid=1717, tid=8929, prio=high) Feb 1 22:33:50 rene vdr: video: slow down video, duping frame Feb 1 22:33:50 rene vdr: video: decoder buffer empty, duping frame (2379/47) 0 v-buf Feb 1 22:33:50 rene vdr: video: --:--:--.--- +0 0 0/\ms 0+1+4 v-buf Feb 1 22:33:52 rene vdr: audio/alsa: using device 'default' Feb 1 22:33:52 rene vdr: audio/alsa: start delay 336ms Feb 1 22:33:52 rene vdr: [1717] switching to channel 11 S19.2E-1-1019-10302 (arte HD) Feb 1 22:33:52 rene vdr: [8929] device 1 TS buffer thread ended (pid=1717, tid=8929) Feb 1 22:33:52 rene vdr: [8928] buffer stats: 99076 (1%) used Feb 1 22:33:52 rene vdr: [8928] device 1 receiver thread ended (pid=1717, tid=8928) Feb 1 22:33:52 rene vdr: [8931] device 1 receiver thread started (pid=1717, tid=8931, prio=high) Feb 1 22:33:52 rene vdr: [8932] device 1 TS buffer thread started (pid=1717, tid=8932, prio=high) Feb 1 22:33:53 rene vdr: [1717] switching to channel 12 S19.2E-1-1051-28724 (arte) Feb 1 22:33:53 rene vdr: [8932] device 1 TS buffer thread ended (pid=1717, tid=8932) Feb 1 22:33:53 rene vdr: [8931] buffer stats: 170328 (3%) used Feb 1 22:33:53 rene vdr: [8931] device 1 receiver thread ended (pid=1717, tid=8931) Feb 1 22:33:53 rene vdr: [8933] device 1 receiver thread started (pid=1717, tid=8933, prio=high) Feb 1 22:33:53 rene vdr: [8934] device 1 TS buffer thread started (pid=1717, tid=8934, prio=high) Feb 1 22:33:54 rene vdr: audio/alsa: using device 'default' Feb 1 22:33:54 rene vdr: audio/alsa: start delay 336ms Feb 1 22:33:54 rene vdr: video: decoder buffer empty, duping frame (2396/47) 0 v-buf Feb 1 22:33:54 rene vdr: video: slow down video, duping frame Feb 1 22:33:54 rene vdr: video/vdpau: synced after 29 frames Feb 1 22:33:54 rene vdr: video: 2:42:54.938 +119 334 0/\ms 5+7+4 v-buf Feb 1 22:33:55 rene vdr: [1717] switching to channel 13 S19.2E-1-1010-11150 (3sat HD) Feb 1 22:33:55 rene vdr: [8934] device 1 TS buffer thread ended (pid=1717, tid=8934) Feb 1 22:33:55 rene vdr: [8933] buffer stats: 113176 (2%) used Feb 1 22:33:55 rene vdr: [8933] device 1 receiver thread ended (pid=1717, tid=8933) Feb 1 22:33:55 rene vdr: [8936] device 1 receiver thread started (pid=1717, tid=8936, prio=high) Feb 1 22:33:55 rene vdr: [8937] device 1 TS buffer thread started (pid=1717, tid=8937, prio=high) Feb 1 22:33:55 rene vdr: video: slow down video, duping frame Feb 1 22:33:55 rene vdr: video: decoder buffer empty, duping frame (2428/46) 0 v-buf Feb 1 22:33:55 rene vdr: video: --:--:--.--- +0 0 0/\ms 0+5+4 v-buf Feb 1 22:33:55 rene vdr: audio/alsa: using device 'default' Feb 1 22:33:55 rene vdr: audio/alsa: start delay 336ms Feb 1 22:33:56 rene vdr: [1717] switching to channel 14 S19.2E-1-1039-10376 (ONE HD) Feb 1 22:33:56 rene vdr: [8937] device 1 TS buffer thread ended (pid=1717, tid=8937) Feb 1 22:33:56 rene vdr: [8936] buffer stats: 181420 (3%) used Feb 1 22:33:56 rene vdr: [8936] device 1 receiver thread ended (pid=1717, tid=8936) Feb 1 22:33:56 rene vdr: [8939] device 1 receiver thread started (pid=1717, tid=8939, prio=high) Feb 1 22:33:56 rene vdr: [8940] device 1 TS buffer thread started (pid=1717, tid=8940, prio=high) Feb 1 22:33:57 rene vdr: audio/alsa: using device 'default' Feb 1 22:33:57 rene vdr: audio/alsa: start delay 336ms Feb 1 22:33:57 rene vdr: video: decoder buffer empty, duping frame (2444/46) 0 v-buf Feb 1 22:33:57 rene vdr: video/vdpau: missed frame (7/2) Feb 1 22:33:58 rene vdr: video: slow down video, duping frame Feb 1 22:33:58 rene vdr: video/vdpau: synced after 62 frames Feb 1 22:33:58 rene vdr: video: 26:25:53.059 +118 298 0/\ms 48+2+4 v-buf Feb 1 22:33:59 rene vdr: video: slow down video, duping frame Feb 1 22:33:59 rene vdr: video: decoder buffer empty, duping frame (2472/26) 47 v-buf Feb 1 22:33:59 rene vdr: video: 26:25:53.619 +160 284 0/\ms 47+1+4 v-buf Feb 1 22:33:59 rene vdr: video: slow down video, duping frame Feb 1 22:33:59 rene vdr: video: 26:25:53.619 +137 261 0/\ms 45+1+3 v-buf Feb 1 22:34:02 rene vdr: [1717] switching to channel 15 S19.2E-1-1051-28721 (tagesschau24) Feb 1 22:34:02 rene vdr: [8940] device 1 TS buffer thread ended (pid=1717, tid=8940) Feb 1 22:34:02 rene vdr: [8939] buffer stats: 199656 (3%) used Feb 1 22:34:02 rene vdr: [8939] device 1 receiver thread ended (pid=1717, tid=8939) Feb 1 22:34:02 rene vdr: [8943] device 1 receiver thread started (pid=1717, tid=8943, prio=high) Feb 1 22:34:02 rene vdr: [8944] device 1 TS buffer thread started (pid=1717, tid=8944, prio=high) Feb 1 22:34:03 rene vdr: video: slow down video, duping frame Feb 1 22:34:03 rene vdr: video: decoder buffer empty, duping frame (2631/241) 0 v-buf Feb 1 22:34:03 rene vdr: video: --:--:--.--- +0 0 0/\ms 0+1+4 v-buf Feb 1 22:34:04 rene vdr: audio/alsa: using device 'default' Feb 1 22:34:04 rene vdr: audio/alsa: start delay 336ms Feb 1 22:34:05 rene vdr: video: decoder buffer empty, duping frame (2648/241) 0 v-buf Feb 1 22:34:05 rene vdr: video: slow down video, duping frame Feb 1 22:34:05 rene vdr: video/vdpau: synced after 35 frames Feb 1 22:34:05 rene vdr: video: 2:43:05.802 +113 503 0/\ms 10+7+4 v-buf Feb 1 22:34:06 rene vdr: [1717] switching to channel 16 S19.2E-1-1051-28722 (ONE) Feb 1 22:34:06 rene vdr: [8944] device 1 TS buffer thread ended (pid=1717, tid=8944) Feb 1 22:34:06 rene vdr: [8943] buffer stats: 105844 (2%) used Feb 1 22:34:06 rene vdr: [8943] device 1 receiver thread ended (pid=1717, tid=8943) Feb 1 22:34:06 rene vdr: [8947] device 1 receiver thread started (pid=1717, tid=8947, prio=high) Feb 1 22:34:06 rene vdr: [8948] device 1 TS buffer thread started (pid=1717, tid=8948, prio=high) Feb 1 22:34:06 rene vdr: audio/alsa: using device 'default' Feb 1 22:34:06 rene vdr: audio/alsa: start delay 336ms Feb 1 22:34:06 rene vdr: video: slow down video, duping frame Feb 1 22:34:06 rene vdr: video: decoder buffer empty, duping frame (2673/52) 0 v-buf Feb 1 22:34:06 rene vdr: video: --:--:--.--- +0 0 0/\ms 0+5+4 v-buf Feb 1 22:34:07 rene vdr: video: decoder buffer empty, duping frame (2680/52) 2 v-buf Feb 1 22:34:07 rene vdr: video: slow down video, duping frame Feb 1 22:34:07 rene vdr: video/vdpau: synced after 31 frames Feb 1 22:34:07 rene vdr: video: 2:43:07.575 +102 399 0/\ms 8+6+4 v-buf Feb 1 22:34:07 rene vdr: [1717] switching to channel 15 S19.2E-1-1051-28721 (tagesschau24) Feb 1 22:34:07 rene vdr: [8948] device 1 TS buffer thread ended (pid=1717, tid=8948) Feb 1 22:34:07 rene vdr: [8947] buffer stats: 129720 (2%) used Feb 1 22:34:07 rene vdr: [8947] device 1 receiver thread ended (pid=1717, tid=8947) Feb 1 22:34:07 rene vdr: [8951] device 1 receiver thread started (pid=1717, tid=8951, prio=high) Feb 1 22:34:07 rene vdr: [8952] device 1 TS buffer thread started (pid=1717, tid=8952, prio=high) Feb 1 22:34:08 rene vdr: video: slow down video, duping frame Feb 1 22:34:08 rene vdr: video: decoder buffer empty, duping frame (2710/46) 0 v-buf Feb 1 22:34:08 rene vdr: video: --:--:--.--- +0 0 0/\ms 0+5+4 v-buf Feb 1 22:34:08 rene vdr: audio/alsa: using device 'default' Feb 1 22:34:08 rene vdr: audio/alsa: start delay 336ms Feb 1 22:34:08 rene vdr: video: decoder buffer empty, duping frame (2721/46) 0 v-buf Feb 1 22:34:08 rene vdr: video: slow down video, duping frame Feb 1 22:34:08 rene vdr: video/vdpau: synced after 34 frames Feb 1 22:34:08 rene vdr: video: 2:43:09.182 +106 309 0/\ms 7+6+4 v-buf Feb 1 22:34:46 rene vdr: [1717] switching to channel 16 S19.2E-1-1051-28722 (ONE) Feb 1 22:34:46 rene vdr: [8952] device 1 TS buffer thread ended (pid=1717, tid=8952) Feb 1 22:34:46 rene vdr: [8951] buffer stats: 112424 (2%) used Feb 1 22:34:46 rene vdr: [8951] device 1 receiver thread ended (pid=1717, tid=8951) Feb 1 22:34:46 rene vdr: [8958] device 1 receiver thread started (pid=1717, tid=8958, prio=high) Feb 1 22:34:46 rene vdr: [8959] device 1 TS buffer thread started (pid=1717, tid=8959, prio=high) Feb 1 22:34:47 rene vdr: video: slow down video, duping frame Feb 1 22:34:47 rene vdr: video: decoder buffer empty, duping frame (3737/1920) 0 v-buf Feb 1 22:34:47 rene vdr: video: --:--:--.--- +0 0 0/\ms 0+5+3 v-buf Feb 1 22:34:47 rene vdr: audio/alsa: using device 'default' Feb 1 22:34:47 rene vdr: audio/alsa: start delay 336ms Feb 1 22:34:47 rene vdr: video: decoder buffer empty, duping frame (3739/1920) 0 v-buf Feb 1 22:34:47 rene vdr: video: slow down video, duping frame Feb 1 22:34:47 rene vdr: video/vdpau: synced after 32 frames Feb 1 22:34:47 rene vdr: video: 2:43:48.135 +110 359 0/\ms 5+6+4 v-buf Feb 1 22:34:59 rene vdr: [1717] switching to channel 17 S19.2E-1-1079-28008 (KiKA) Feb 1 22:34:59 rene vdr: [8959] device 1 TS buffer thread ended (pid=1717, tid=8959) Feb 1 22:34:59 rene vdr: [8958] buffer stats: 120884 (2%) used Feb 1 22:34:59 rene vdr: [8958] device 1 receiver thread ended (pid=1717, tid=8958) Feb 1 22:34:59 rene vdr: [8962] device 1 receiver thread started (pid=1717, tid=8962, prio=high) Feb 1 22:34:59 rene vdr: [8963] device 1 TS buffer thread started (pid=1717, tid=8963, prio=high) Feb 1 22:34:59 rene vdr: video: slow down video, duping frame Feb 1 22:34:59 rene vdr: video: decoder buffer empty, duping frame (4315/592) 0 v-buf Feb 1 22:34:59 rene vdr: video: --:--:--.--- +0 0 0/\ms 0+5+4 v-buf Feb 1 22:35:01 rene vdr: audio/alsa: using device 'default' Feb 1 22:35:01 rene vdr: audio/alsa: start delay 336ms Feb 1 22:35:02 rene vdr: video: decoder buffer empty, duping frame (4332/592) 0 v-buf Feb 1 22:35:02 rene vdr: video: slow down video, duping frame Feb 1 22:35:02 rene vdr: video/vdpau: synced after 37 frames Feb 1 22:35:02 rene vdr: video: 21:13:42.169 +112 402 0/\ms 8+6+4 v-buf Feb 1 22:35:02 rene vdr: [1717] switching to channel 18 S19.2E-1-1051-28725 (PHOENIX) Feb 1 22:35:02 rene vdr: [8963] device 1 TS buffer thread ended (pid=1717, tid=8963) Feb 1 22:35:02 rene vdr: [8962] buffer stats: 76516 (1%) used Feb 1 22:35:02 rene vdr: [8962] device 1 receiver thread ended (pid=1717, tid=8962) Feb 1 22:35:02 rene vdr: [8966] device 1 receiver thread started (pid=1717, tid=8966, prio=high) Feb 1 22:35:02 rene vdr: [8967] device 1 TS buffer thread started (pid=1717, tid=8967, prio=high) Feb 1 22:35:03 rene vdr: video: slow down video, duping frame Feb 1 22:35:03 rene vdr: video: decoder buffer empty, duping frame (4337/28) 0 v-buf Feb 1 22:35:03 rene vdr: video: --:--:--.--- +0 0 0/\ms 0+5+4 v-buf Feb 1 22:35:03 rene vdr: audio/alsa: using device 'default' Feb 1 22:35:03 rene vdr: audio/alsa: start delay 336ms Feb 1 22:35:04 rene vdr: video: decoder buffer empty, duping frame (4354/28) 0 v-buf Feb 1 22:35:04 rene vdr: video: slow down video, duping frame Feb 1 22:35:04 rene vdr: video/vdpau: synced after 37 frames Feb 1 22:35:04 rene vdr: video: 2:44:04.624 +114 435 0/\ms 9+6+4 v-buf Feb 1 22:35:04 rene vdr: [1717] switching to channel 19 S19.2E-1-1010-11170 (ZDFinfo HD) Feb 1 22:35:05 rene vdr: [8967] device 1 TS buffer thread ended (pid=1717, tid=8967) Feb 1 22:35:05 rene vdr: [8966] buffer stats: 98888 (1%) used Feb 1 22:35:05 rene vdr: [8966] device 1 receiver thread ended (pid=1717, tid=8966) Feb 1 22:35:05 rene vdr: [8969] device 1 receiver thread started (pid=1717, tid=8969, prio=high) Feb 1 22:35:05 rene vdr: [8970] device 1 TS buffer thread started (pid=1717, tid=8970, prio=high) Feb 1 22:35:05 rene vdr: video: slow down video, duping frame Feb 1 22:35:05 rene vdr: video: decoder buffer empty, duping frame (4379/50) 0 v-buf Feb 1 22:35:05 rene vdr: video: --:--:--.--- +0 0 0/\ms 0+5+4 v-buf Feb 1 22:35:05 rene vdr: audio/alsa: using device 'default' Feb 1 22:35:05 rene vdr: audio/alsa: start delay 336ms Feb 1 22:35:05 rene vdr: video: decoder buffer empty, duping frame (4395/50) 0 v-buf Feb 1 22:35:05 rene vdr: video/vdpau: missed frame (8/2) Feb 1 22:35:06 rene vdr: [1717] switching to channel 20 S19.2E-1-1011-11130 (zdf_neo HD) Feb 1 22:35:06 rene vdr: [8970] device 1 TS buffer thread ended (pid=1717, tid=8970) Feb 1 22:35:06 rene vdr: [8969] buffer stats: 206988 (3%) used Feb 1 22:35:06 rene vdr: [8969] device 1 receiver thread ended (pid=1717, tid=8969) Feb 1 22:35:06 rene vdr: [8972] device 1 receiver thread started (pid=1717, tid=8972, prio=high) Feb 1 22:35:06 rene vdr: [8973] device 1 TS buffer thread started (pid=1717, tid=8973, prio=high) Feb 1 22:35:07 rene vdr: video: decoder buffer empty, duping frame (4396/34) 0 v-buf Feb 1 22:35:07 rene vdr: video: --:--:--.--- +0 0 0/\ms 0+1+4 v-buf Feb 1 22:35:07 rene vdr: audio/alsa: using device 'default' Feb 1 22:35:07 rene vdr: audio/alsa: start delay 336ms Feb 1 22:35:08 rene vdr: video: decoder buffer empty, duping frame (4414/34) 0 v-buf Feb 1 22:35:08 rene vdr: video/vdpau: missed frame (9/2) Feb 1 22:35:08 rene vdr: video: slow down video, duping frame Feb 1 22:35:08 rene vdr: video/vdpau: synced after 39 frames Feb 1 22:35:08 rene vdr: video: 1:05:10.209 +116 362 0/\ms 32+1+4 v-buf Feb 1 22:35:08 rene vdr: [1717] switching to channel 21 S19.2E-1-1089-12061 (NITRO) Feb 1 22:35:08 rene vdr: [8973] device 1 TS buffer thread ended (pid=1717, tid=8973) Feb 1 22:35:08 rene vdr: [8972] buffer stats: 206048 (3%) used Feb 1 22:35:08 rene vdr: [8972] device 1 receiver thread ended (pid=1717, tid=8972) Feb 1 22:35:08 rene vdr: [8975] device 1 receiver thread started (pid=1717, tid=8975, prio=high) Feb 1 22:35:08 rene vdr: [8976] device 1 TS buffer thread started (pid=1717, tid=8976, prio=high) Feb 1 22:35:09 rene vdr: video: slow down video, duping frame Feb 1 22:35:09 rene vdr: video: decoder buffer empty, duping frame (4421/41) 0 v-buf Feb 1 22:35:09 rene vdr: video: --:--:--.--- +0 0 0/\ms 0+1+4 v-buf Feb 1 22:35:10 rene vdr: audio/alsa: using device 'default' Feb 1 22:35:10 rene vdr: audio/alsa: start delay 336ms Feb 1 22:35:10 rene vdr: video: decoder buffer empty, duping frame (4439/41) 0 v-buf Feb 1 22:35:10 rene vdr: video: slow down video, duping frame Feb 1 22:35:10 rene vdr: video/vdpau: synced after 37 frames Feb 1 22:35:10 rene vdr: video: 17:51:00.693 +90 372 0/\ms 10+7+4 v-buf Feb 1 22:35:11 rene vdr: [1717] switching to channel 22 S19.2E-133-5-1793 (Disney Channel) Feb 1 22:35:11 rene vdr: [8976] device 1 TS buffer thread ended (pid=1717, tid=8976) Feb 1 22:35:11 rene vdr: [8975] buffer stats: 115432 (2%) used Feb 1 22:35:11 rene vdr: [8975] device 1 receiver thread ended (pid=1717, tid=8975) Feb 1 22:35:11 rene vdr: [8978] device 1 receiver thread started (pid=1717, tid=8978, prio=high) Feb 1 22:35:11 rene vdr: [8979] device 1 TS buffer thread started (pid=1717, tid=8979, prio=high) Feb 1 22:35:11 rene vdr: video: slow down video, duping frame Feb 1 22:35:11 rene vdr: video: decoder buffer empty, duping frame (4466/40) 0 v-buf Feb 1 22:35:11 rene vdr: video: --:--:--.---+8888 174 0/\ms 0+5+4 v-buf Feb 1 22:35:12 rene vdr: audio/alsa: using device 'default' Feb 1 22:35:12 rene vdr: audio/alsa: start delay 336ms Feb 1 22:35:13 rene vdr: [1717] switching to channel 23 S19.2E-133-33-63 (DMAX) Feb 1 22:35:13 rene vdr: [8979] device 1 TS buffer thread ended (pid=1717, tid=8979) Feb 1 22:35:13 rene vdr: [8978] buffer stats: 76328 (1%) used Feb 1 22:35:13 rene vdr: [8978] device 1 receiver thread ended (pid=1717, tid=8978) Feb 1 22:35:13 rene vdr: [8981] device 1 receiver thread started (pid=1717, tid=8981, prio=high) Feb 1 22:35:13 rene vdr: [8982] device 1 TS buffer thread started (pid=1717, tid=8982, prio=high) Feb 1 22:35:15 rene vdr: audio/alsa: using device 'default' Feb 1 22:35:15 rene vdr: audio/alsa: start delay 336ms Feb 1 22:35:16 rene vdr: video: decoder buffer empty, duping frame (4500/16) 0 v-buf Feb 1 22:35:16 rene vdr: video: slow down video, duping frame Feb 1 22:35:16 rene vdr: video/vdpau: synced after 41 frames Feb 1 22:35:16 rene vdr: video: 3:25:35.715 +114 398 0/\ms 10+6+4 v-buf Feb 1 22:35:16 rene vdr: [1717] switching to channel 24 S19.2E-1-1078-28680 (Nickelodeon) Feb 1 22:35:16 rene vdr: [8982] device 1 TS buffer thread ended (pid=1717, tid=8982) Feb 1 22:35:16 rene vdr: [8981] buffer stats: 32148 (0%) used Feb 1 22:35:16 rene vdr: [8981] device 1 receiver thread ended (pid=1717, tid=8981) Feb 1 22:35:16 rene vdr: [8984] device 1 receiver thread started (pid=1717, tid=8984, prio=high) Feb 1 22:35:16 rene vdr: [8985] device 1 TS buffer thread started (pid=1717, tid=8985, prio=high) Feb 1 22:35:17 rene vdr: video: slow down video, duping frame Feb 1 22:35:17 rene vdr: video: decoder buffer empty, duping frame (4510/40) 0 v-buf Feb 1 22:35:17 rene vdr: video: --:--:--.--- +0 0 0/\ms 0+5+4 v-buf Feb 1 22:35:17 rene vdr: audio/alsa: using device 'default' Feb 1 22:35:17 rene vdr: audio/alsa: start delay 336ms Feb 1 22:35:18 rene vdr: video: decoder buffer empty, duping frame (4527/40) 0 v-buf Feb 1 22:35:18 rene vdr: video: slow down video, duping frame Feb 1 22:35:18 rene vdr: video/vdpau: synced after 37 frames Feb 1 22:35:18 rene vdr: video: 19:59:44.988 +111 392 0/\ms 10+6+4 v-buf Feb 1 22:35:19 rene vdr: [1717] switching to channel 25 S19.2E-133-33-51 (TELE 5) Feb 1 22:35:19 rene vdr: [8985] device 1 TS buffer thread ended (pid=1717, tid=8985) Feb 1 22:35:19 rene vdr: [8984] buffer stats: 54144 (1%) used Feb 1 22:35:19 rene vdr: [8984] device 1 receiver thread ended (pid=1717, tid=8984) Feb 1 22:35:19 rene vdr: [8988] device 1 receiver thread started (pid=1717, tid=8988, prio=high) Feb 1 22:35:19 rene vdr: [8989] device 1 TS buffer thread started (pid=1717, tid=8989, prio=high) Feb 1 22:35:19 rene vdr: video: slow down video, duping frame Feb 1 22:35:19 rene vdr: video: decoder buffer empty, duping frame (4564/60) 0 v-buf Feb 1 22:35:19 rene vdr: video: --:--:--.--- +0 0 0/\ms 0+5+4 v-buf Feb 1 22:35:20 rene vdr: audio/alsa: using device 'default' Feb 1 22:35:20 rene vdr: audio/alsa: start delay 336ms Feb 1 22:35:21 rene vdr: video: decoder buffer empty, duping frame (4580/60) 0 v-buf Feb 1 22:35:21 rene vdr: video: slow down video, duping frame Feb 1 22:35:21 rene vdr: video/vdpau: synced after 37 frames Feb 1 22:35:21 rene vdr: video: 3:46:08.124 +104 310 0/\ms 7+6+4 v-buf Feb 1 22:35:22 rene vdr: [1717] switching to channel 26 S19.2E-1-1107-17505 (Pro7 MAXX) Feb 1 22:35:22 rene vdr: [8989] device 1 TS buffer thread ended (pid=1717, tid=8989) Feb 1 22:35:22 rene vdr: [8988] buffer stats: 32900 (0%) used Feb 1 22:35:22 rene vdr: [8988] device 1 receiver thread ended (pid=1717, tid=8988) Feb 1 22:35:22 rene vdr: [8991] device 1 receiver thread started (pid=1717, tid=8991, prio=high) Feb 1 22:35:22 rene vdr: [8992] device 1 TS buffer thread started (pid=1717, tid=8992, prio=high) Feb 1 22:35:22 rene vdr: video: slow down video, duping frame Feb 1 22:35:22 rene vdr: video: decoder buffer empty, duping frame (4641/82) 0 v-buf Feb 1 22:35:22 rene vdr: video: --:--:--.--- +0 0 0/\ms 0+5+4 v-buf Feb 1 22:35:22 rene vdr: audio/alsa: using device 'default' Feb 1 22:35:22 rene vdr: audio/alsa: start delay 336ms Feb 1 22:35:23 rene vdr: video: decoder buffer empty, duping frame (4657/82) 2 v-buf Feb 1 22:35:23 rene vdr: video: slow down video, duping frame Feb 1 22:35:23 rene vdr: video/vdpau: synced after 37 frames Feb 1 22:35:23 rene vdr: video: 11:30:47.249 +101 592 0/\ms 10+6+4 v-buf Feb 1 22:35:24 rene vdr: [1717] switching to channel 27 S19.2E-1-1089-12090 (n-tv) Feb 1 22:35:24 rene vdr: [8992] device 1 TS buffer thread ended (pid=1717, tid=8992) Feb 1 22:35:24 rene vdr: [8991] buffer stats: 116936 (2%) used Feb 1 22:35:24 rene vdr: [8991] device 1 receiver thread ended (pid=1717, tid=8991) Feb 1 22:35:24 rene vdr: [8994] device 1 receiver thread started (pid=1717, tid=8994, prio=high) Feb 1 22:35:24 rene vdr: [8995] device 1 TS buffer thread started (pid=1717, tid=8995, prio=high) Feb 1 22:35:24 rene vdr: video: slow down video, duping frame Feb 1 22:35:24 rene vdr: video: decoder buffer empty, duping frame (4683/48) 0 v-buf Feb 1 22:35:24 rene vdr: video: --:--:--.---+8888 141 0/\ms 0+5+4 v-buf Feb 1 22:35:25 rene vdr: audio/alsa: using device 'default' Feb 1 22:35:25 rene vdr: audio/alsa: start delay 336ms Feb 1 22:35:26 rene vdr: video: decoder buffer empty, duping frame (4700/48) 0 v-buf Feb 1 22:35:26 rene vdr: video: slow down video, duping frame Feb 1 22:35:26 rene vdr: video/vdpau: synced after 37 frames Feb 1 22:35:26 rene vdr: video: 17:51:15.913 +104 418 0/\ms 11+6+4 v-buf Feb 1 22:36:15 rene vdr: video: slow down video, duping frame Feb 1 22:36:15 rene vdr: video: 17:52:05.313 +3 333 0/\ms 13+7+4 v-buf Feb 1 22:36:18 rene vdr: [1717] switching to channel 28 S19.2E-1-1107-17503 (N24) Feb 1 22:36:18 rene vdr: [8995] device 1 TS buffer thread ended (pid=1717, tid=8995) Feb 1 22:36:18 rene vdr: [8994] buffer stats: 95316 (1%) used Feb 1 22:36:18 rene vdr: [8994] device 1 receiver thread ended (pid=1717, tid=8994) Feb 1 22:36:18 rene vdr: [9004] device 1 receiver thread started (pid=1717, tid=9004, prio=high) Feb 1 22:36:18 rene vdr: [9005] device 1 TS buffer thread started (pid=1717, tid=9005, prio=high) Feb 1 22:36:18 rene vdr: video: decoder buffer empty, duping frame (5886/2636) 0 v-buf Feb 1 22:36:18 rene vdr: video: --:--:--.--- +0 0 0/\ms 0+5+4 v-buf Feb 1 22:36:19 rene vdr: audio/alsa: using device 'default' Feb 1 22:36:19 rene vdr: audio/alsa: start delay 336ms Feb 1 22:36:20 rene vdr: video/vdpau: synced after 55 frames Feb 1 22:36:20 rene vdr: video: decoder buffer empty, duping frame (5902/2636) 0 v-buf Feb 1 22:36:20 rene vdr: video: slow down video, duping frame Feb 1 22:36:20 rene vdr: video: 11:44:13.793 +117 408 0/\ms 5+7+4 v-buf Feb 1 22:36:20 rene vdr: [1717] switching to channel 29 S19.2E-1-1078-28676 (Comedy Central/VIVA) Feb 1 22:36:20 rene vdr: [9005] device 1 TS buffer thread ended (pid=1717, tid=9005) Feb 1 22:36:20 rene vdr: [9004] buffer stats: 72568 (1%) used Feb 1 22:36:20 rene vdr: [9004] device 1 receiver thread ended (pid=1717, tid=9004) Feb 1 22:36:20 rene vdr: [9007] device 1 receiver thread started (pid=1717, tid=9007, prio=high) Feb 1 22:36:20 rene vdr: [9008] device 1 TS buffer thread started (pid=1717, tid=9008, prio=high) Feb 1 22:36:20 rene vdr: video: slow down video, duping frame Feb 1 22:36:20 rene vdr: video: decoder buffer empty, duping frame (5919/34) 0 v-buf Feb 1 22:36:20 rene vdr: video: --:--:--.---+8888 209 0/\ms 0+5+4 v-buf Feb 1 22:36:22 rene vdr: audio/alsa: using device 'default' Feb 1 22:36:22 rene vdr: audio/alsa: start delay 336ms Feb 1 22:36:23 rene vdr: video: decoder buffer empty, duping frame (5936/34) 0 v-buf Feb 1 22:36:23 rene vdr: video: slow down video, duping frame Feb 1 22:36:23 rene vdr: video/vdpau: synced after 29 frames Feb 1 22:36:23 rene vdr: video: 20:00:57.173 +118 327 0/\ms 7+6+4 v-buf Feb 1 22:36:29 rene vdr: [1717] switching to channel 3 S19.2E-1-1089-12003 (RTL Television) Feb 1 22:36:29 rene vdr: [9008] device 1 TS buffer thread ended (pid=1717, tid=9008) Feb 1 22:36:29 rene vdr: [9007] buffer stats: 57152 (1%) used Feb 1 22:36:29 rene vdr: [9007] device 1 receiver thread ended (pid=1717, tid=9007) Feb 1 22:36:29 rene vdr: [9011] device 1 receiver thread started (pid=1717, tid=9011, prio=high) Feb 1 22:36:29 rene vdr: [9012] device 1 TS buffer thread started (pid=1717, tid=9012, prio=high) Feb 1 22:36:30 rene vdr: video: slow down video, duping frame Feb 1 22:36:30 rene vdr: video: decoder buffer empty, duping frame (6240/340) 0 v-buf Feb 1 22:36:30 rene vdr: video: --:--:--.--- +0 0 0/\ms 0+5+4 v-buf Feb 1 22:36:31 rene vdr: audio/alsa: using device 'default' Feb 1 22:36:31 rene vdr: audio/alsa: start delay 336ms Feb 1 22:36:32 rene vdr: [1717] switching to channel 4 S19.2E-1-1107-17500 (SAT.1) Feb 1 22:36:32 rene vdr: [9012] device 1 TS buffer thread ended (pid=1717, tid=9012) Feb 1 22:36:32 rene vdr: [9011] buffer stats: 98136 (1%) used Feb 1 22:36:32 rene vdr: [9011] device 1 receiver thread ended (pid=1717, tid=9011) Feb 1 22:36:32 rene vdr: [9015] device 1 receiver thread started (pid=1717, tid=9015, prio=high) Feb 1 22:36:32 rene vdr: [9016] device 1 TS buffer thread started (pid=1717, tid=9016, prio=high) Feb 1 22:36:33 rene vdr: audio/alsa: using device 'default' Feb 1 22:36:33 rene vdr: audio/alsa: start delay 336ms Feb 1 22:36:34 rene vdr: video: decoder buffer empty, duping frame (6274/10) 0 v-buf Feb 1 22:36:34 rene vdr: video: slow down video, duping frame Feb 1 22:36:34 rene vdr: video/vdpau: synced after 37 frames Feb 1 22:36:34 rene vdr: video: 12:05:50.806 +106 375 0/\ms 7+6+4 v-buf Feb 1 22:36:40 rene vdr: [1717] switching to channel 5 S19.2E-1-1107-17501 (ProSieben) Feb 1 22:36:40 rene vdr: [9016] device 1 TS buffer thread ended (pid=1717, tid=9016) Feb 1 22:36:40 rene vdr: [9015] buffer stats: 115432 (2%) used Feb 1 22:36:40 rene vdr: [9015] device 1 receiver thread ended (pid=1717, tid=9015) Feb 1 22:36:40 rene vdr: [9019] device 1 receiver thread started (pid=1717, tid=9019, prio=high) Feb 1 22:36:40 rene vdr: [9020] device 1 TS buffer thread started (pid=1717, tid=9020, prio=high) Feb 1 22:36:40 rene vdr: audio/alsa: using device 'default' Feb 1 22:36:40 rene vdr: audio/alsa: start delay 336ms Feb 1 22:36:40 rene vdr: video: slow down video, duping frame Feb 1 22:36:40 rene vdr: video: decoder buffer empty, duping frame (6562/328) 0 v-buf Feb 1 22:36:40 rene vdr: video: --:--:--.--- +0 0 0/\ms 0+5+4 v-buf Feb 1 22:36:41 rene vdr: video: decoder buffer empty, duping frame (6563/328) 2 v-buf Feb 1 22:36:41 rene vdr: video: slow down video, duping frame Feb 1 22:36:41 rene vdr: video/vdpau: synced after 37 frames Feb 1 22:36:41 rene vdr: video: 11:58:15.594 +105 594 0/\ms 8+6+4 v-buf Feb 1 22:36:43 rene vdr: [1717] switching to channel 6 S19.2E-1-1089-12020 (RTL2) Feb 1 22:36:43 rene vdr: [9020] device 1 TS buffer thread ended (pid=1717, tid=9020) Feb 1 22:36:43 rene vdr: [9019] buffer stats: 114680 (2%) used Feb 1 22:36:43 rene vdr: [9019] device 1 receiver thread ended (pid=1717, tid=9019) Feb 1 22:36:43 rene vdr: [9022] device 1 receiver thread started (pid=1717, tid=9022, prio=high) Feb 1 22:36:43 rene vdr: [9023] device 1 TS buffer thread started (pid=1717, tid=9023, prio=high) Feb 1 22:36:43 rene vdr: video: slow down video, duping frame Feb 1 22:36:43 rene vdr: video: decoder buffer empty, duping frame (6659/116) 0 v-buf Feb 1 22:36:43 rene vdr: video: --:--:--.---+8888 212 0/\ms 0+5+4 v-buf Feb 1 22:36:44 rene vdr: audio/alsa: using device 'default' Feb 1 22:36:44 rene vdr: audio/alsa: start delay 336ms Feb 1 22:36:45 rene vdr: video: decoder buffer empty, duping frame (6675/116) 0 v-buf Feb 1 22:36:45 rene vdr: video: slow down video, duping frame Feb 1 22:36:45 rene vdr: video/vdpau: synced after 43 frames Feb 1 22:36:45 rene vdr: video: 19:22:52.590 +115 418 0/\ms 10+6+4 v-buf Feb 1 22:37:34 rene vdr: video: slow down video, duping frame Feb 1 22:37:34 rene vdr: video: 19:23:41.890 +14 457 0/\ms 14+8+4 v-buf Feb 1 22:37:46 rene vdr: video: speed up video, droping frame Feb 1 22:37:46 rene vdr: video: 19:23:53.210 -26 496 0/\ms 22+6+4 v-buf Feb 1 22:38:00 rene vdr: [9031] epg data writer thread started (pid=1717, tid=9031, prio=low) Feb 1 22:38:00 rene vdr: [9031] epg data writer thread ended (pid=1717, tid=9031) Feb 1 22:38:24 rene vdr: video: speed up video, droping frame Feb 1 22:38:24 rene vdr: video: 19:24:31.990 -5 449 0/\ms 13+7+4 v-buf Feb 1 22:38:27 rene vdr: [1778] frontend 1/0 timed out while tuning to channel 24 (Nickelodeon), tp 211973 Feb 1 22:38:43 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:38:43 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:38:46 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:38:46 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:38:48 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:38:49 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:38:51 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:38:51 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:38:52 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:38:52 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:38:54 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:38:54 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:38:54 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:38:55 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:38:57 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:38:57 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:38:57 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:38:57 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:38:57 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:38:57 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:39:14 rene vdr: video: speed up video, droping frame Feb 1 22:39:14 rene vdr: video: 19:25:22.110 -5 465 0/\ms 17+7+4 v-buf Feb 1 22:40:05 rene vdr: video: speed up video, droping frame Feb 1 22:40:05 rene vdr: video: 19:26:12.230 -4 434 0/\ms 15+7+4 v-buf Feb 1 22:40:55 rene vdr: video: speed up video, droping frame Feb 1 22:40:55 rene vdr: video: 19:27:02.350 -4 474 0/\ms 17+7+4 v-buf Feb 1 22:41:45 rene vdr: video: speed up video, droping frame Feb 1 22:41:45 rene vdr: video: 19:27:52.470 -3 491 0/\ms 18+7+4 v-buf Feb 1 22:42:35 rene vdr: video: speed up video, droping frame Feb 1 22:42:35 rene vdr: video: 19:28:42.590 -3 411 0/\ms 11+7+4 v-buf Feb 1 22:43:25 rene vdr: video: speed up video, droping frame Feb 1 22:43:25 rene vdr: video: 19:29:32.710 -3 451 0/\ms 13+7+4 v-buf Feb 1 22:43:42 rene vdr: [1778] frontend 1/0 timed out while tuning to channel 24 (Nickelodeon), tp 211973 Feb 1 22:43:56 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:43:56 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:43:56 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:43:57 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:43:59 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:43:59 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:43:59 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:43:59 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:43:59 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:44:00 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:44:00 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:44:00 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:44:05 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:44:06 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:44:08 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:44:08 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:44:11 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:44:11 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:44:11 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:44:11 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:44:11 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:44:11 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:44:15 rene vdr: video: speed up video, droping frame Feb 1 22:44:15 rene vdr: video: 19:30:22.830 -2 468 0/\ms 15+7+4 v-buf Feb 1 22:45:05 rene vdr: video: speed up video, droping frame Feb 1 22:45:05 rene vdr: video: 19:31:12.950 -2 460 0/\ms 18+7+4 v-buf Feb 1 22:45:55 rene vdr: video: speed up video, droping frame Feb 1 22:45:55 rene vdr: video: 19:32:03.070 -1 429 0/\ms 16+7+4 v-buf Feb 1 22:46:45 rene vdr: video: speed up video, droping frame Feb 1 22:46:45 rene vdr: video: 19:32:53.190 -1 397 0/\ms 15+7+4 v-buf Feb 1 22:47:36 rene vdr: video: speed up video, droping frame Feb 1 22:47:36 rene vdr: video: 19:33:43.310 -1 485 0/\ms 17+7+4 v-buf Feb 1 22:48:01 rene vdr: [9107] epg data writer thread started (pid=1717, tid=9107, prio=low) Feb 1 22:48:01 rene vdr: [9107] epg data writer thread ended (pid=1717, tid=9107) Feb 1 22:48:26 rene vdr: video: speed up video, droping frame Feb 1 22:48:26 rene vdr: video: 19:34:33.430 +0 430 0/\ms 17+7+4 v-buf Feb 1 22:48:56 rene vdr: [1778] frontend 1/0 timed out while tuning to channel 24 (Nickelodeon), tp 211973 Feb 1 22:49:10 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:49:11 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:49:11 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:49:11 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:49:11 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:49:11 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:49:11 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:49:11 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:49:13 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:49:13 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:49:16 rene vdr: video: speed up video, droping frame Feb 1 22:49:16 rene vdr: video: 19:35:23.550 +0 494 0/\ms 22+7+4 v-buf Feb 1 22:49:17 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:49:17 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:49:17 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:49:17 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:49:25 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:49:26 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:49:28 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:49:30 rene vdr: [1778] frontend 1/0 regained lock on channel 12 (arte), tp 110743 Feb 1 22:50:06 rene vdr: video: speed up video, droping frame Feb 1 22:50:06 rene vdr: video: 19:36:13.670 +0 438 0/\ms 16+7+4 v-buf Feb 1 22:50:56 rene vdr: video: speed up video, droping frame Feb 1 22:50:56 rene vdr: video: 19:37:03.790 +0 431 0/\ms 15+7+4 v-buf Feb 1 22:51:46 rene vdr: video: speed up video, droping frame Feb 1 22:51:46 rene vdr: video: 19:37:53.910 +0 447 0/\ms 12+7+4 v-buf Feb 1 22:52:36 rene vdr: video: speed up video, droping frame Feb 1 22:52:36 rene vdr: video: 19:38:44.030 +1 488 0/\ms 15+7+4 v-buf Feb 1 22:53:26 rene vdr: video: speed up video, droping frame Feb 1 22:53:26 rene vdr: video: 19:39:34.150 +1 480 0/\ms 16+7+4 v-buf Feb 1 22:54:12 rene vdr: [1778] frontend 1/0 timed out while tuning to channel 24 (Nickelodeon), tp 211973 Feb 1 22:54:17 rene vdr: video: speed up video, droping frame Feb 1 22:54:17 rene vdr: video: 19:40:24.270 +1 496 0/\ms 20+7+4 v-buf Feb 1 22:54:27 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:54:27 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:54:27 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:54:29 rene vdr: [1778] frontend 1/0 timed out while tuning to channel 23 (DMAX), tp 212480 Feb 1 22:54:29 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:54:30 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:54:32 rene vdr: [1778] frontend 1/0 timed out while tuning to channel 23 (DMAX), tp 212480 Feb 1 22:54:34 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:54:36 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:54:36 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:54:36 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:54:37 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:54:42 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:54:42 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:54:42 rene vdr: [1778] frontend 1/0 lost lock on channel 23 (DMAX), tp 212480 Feb 1 22:54:42 rene vdr: [1778] frontend 1/0 regained lock on channel 23 (DMAX), tp 212480 Feb 1 22:55:07 rene vdr: video: speed up video, droping frame Feb 1 22:55:07 rene vdr: video: 19:41:14.410 -1 465 0/\ms 14+8+4 v-buf Feb 1 22:55:57 rene vdr: video: speed up video, droping frame Feb 1 22:55:57 rene vdr: video: 19:42:04.530 -1 481 0/\ms 15+8+4 v-buf Feb 1 22:56:47 rene vdr: video: speed up video, droping frame Feb 1 22:56:47 rene vdr: video: 19:42:54.650 +0 426 0/\ms 17+8+4 v-buf Feb 1 22:57:37 rene vdr: video: speed up video, droping frame Feb 1 22:57:37 rene vdr: video: 19:43:44.770 +0 418 0/\ms 13+8+4 v-buf Feb 1 22:58:02 rene vdr: [9184] epg data writer thread started (pid=1717, tid=9184, prio=low) Feb 1 22:58:02 rene vdr: [9184] epg data writer thread ended (pid=1717, tid=9184) Feb 1 22:58:27 rene vdr: video: speed up video, droping frame Feb 1 22:58:27 rene vdr: video: 19:44:34.890 +0 410 0/\ms 15+8+4 v-buf Feb 1 22:59:17 rene vdr: video: speed up video, droping frame Feb 1 22:59:17 rene vdr: video: 19:45:25.010 +0 403 0/\ms 17+8+4 v-buf Feb 1 23:00:07 rene vdr: video: speed up video, droping frame Feb 1 23:00:07 rene vdr: video: 19:46:15.130 +0 395 0/\ms 15+8+4 v-buf Feb 1 23:00:57 rene vdr: video: speed up video, droping frame Feb 1 23:00:57 rene vdr: video: 19:47:05.250 +1 436 0/\ms 19+8+4 v-buf Feb 1 23:00:57 rene systemd[1]: Started Run anacron jobs. Feb 1 23:00:57 rene anacron[9206]: Anacron 2.3 started on 2019-02-01 Feb 1 23:00:57 rene anacron[9206]: Normal exit (0 jobs run) Feb 1 23:01:48 rene vdr: video: speed up video, droping frame Feb 1 23:01:48 rene vdr: video: 19:47:55.370 +1 404 0/\ms 16+8+4 v-buf Feb 1 23:02:38 rene vdr: video: speed up video, droping frame Feb 1 23:02:38 rene vdr: video: 19:48:45.490 +1 468 0/\ms 16+8+4 v-buf Feb 1 23:03:28 rene vdr: video: speed up video, droping frame Feb 1 23:03:28 rene vdr: video: 19:49:35.610 +2 389 0/\ms 15+8+4 v-buf Feb 1 23:04:18 rene vdr: video: speed up video, droping frame Feb 1 23:04:18 rene vdr: video: 19:50:25.730 +2 453 0/\ms 13+8+4 v-buf Feb 1 23:05:08 rene vdr: video: speed up video, droping frame Feb 1 23:05:08 rene vdr: video: 19:51:15.850 +3 446 0/\ms 20+8+4 v-buf Feb 1 23:05:58 rene vdr: video: speed up video, droping frame Feb 1 23:05:58 rene vdr: video: 19:52:05.970 +3 390 0/\ms 15+8+4 v-buf Feb 1 23:06:48 rene vdr: video: speed up video, droping frame Feb 1 23:06:48 rene vdr: video: 19:52:56.090 +3 454 0/\ms 20+8+4 v-buf Feb 1 23:07:38 rene vdr: video: speed up video, droping frame Feb 1 23:07:38 rene vdr: video: 19:53:46.210 +4 471 0/\ms 17+8+4 v-buf Feb 1 23:08:03 rene vdr: [9277] epg data writer thread started (pid=1717, tid=9277, prio=low) Feb 1 23:08:03 rene vdr: [9277] epg data writer thread ended (pid=1717, tid=9277) Feb 1 23:08:29 rene vdr: video: speed up video, droping frame Feb 1 23:08:29 rene vdr: video: 19:54:36.330 +4 415 0/\ms 15+8+4 v-buf Feb 1 23:09:19 rene vdr: video: speed up video, droping frame Feb 1 23:09:19 rene vdr: video: 19:55:26.450 +5 456 0/\ms 17+8+4 v-buf Feb 1 23:10:09 rene vdr: video: speed up video, droping frame Feb 1 23:10:09 rene vdr: video: 19:56:16.570 +5 472 0/\ms 20+8+4 v-buf Feb 1 23:10:59 rene vdr: video: speed up video, droping frame Feb 1 23:10:59 rene vdr: video: 19:57:06.690 +5 392 0/\ms 15+8+4 v-buf Feb 1 23:11:49 rene vdr: video: speed up video, droping frame Feb 1 23:11:49 rene vdr: video: 19:57:56.810 +6 457 0/\ms 16+8+4 v-buf Feb 1 23:12:39 rene vdr: video: speed up video, droping frame Feb 1 23:12:39 rene vdr: video: 19:58:46.930 +6 425 0/\ms 14+8+4 v-buf Feb 1 23:13:29 rene vdr: video: speed up video, droping frame Feb 1 23:13:29 rene vdr: video: 19:59:37.050 +7 466 0/\ms 23+8+4 v-buf Feb 1 23:14:19 rene vdr: video: speed up video, droping frame Feb 1 23:14:19 rene vdr: video: 20:00:27.150 -12 386 0/\ms 12+7+4 v-buf Feb 1 23:15:10 rene vdr: video: speed up video, droping frame Feb 1 23:15:10 rene vdr: video: 20:01:17.270 -12 450 0/\ms 18+7+4 v-buf Feb 1 23:16:00 rene vdr: video: speed up video, droping frame Feb 1 23:16:00 rene vdr: video: 20:02:07.390 -11 419 0/\ms 20+7+4 v-buf Feb 1 23:16:50 rene vdr: video: speed up video, droping frame Feb 1 23:16:50 rene vdr: video: 20:02:57.510 -11 459 0/\ms 18+7+4 v-buf Feb 1 23:17:01 rene CRON[9345]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly) Feb 1 23:17:40 rene vdr: video: speed up video, droping frame Feb 1 23:17:40 rene vdr: video: 20:03:47.630 -10 476 0/\ms 21+7+4 v-buf Feb 1 23:18:04 rene vdr: [9354] epg data writer thread started (pid=1717, tid=9354, prio=low) Feb 1 23:18:04 rene vdr: [9354] epg data writer thread ended (pid=1717, tid=9354) Feb 1 23:18:30 rene vdr: video: speed up video, droping frame Feb 1 23:18:30 rene vdr: video: 20:04:37.750 -10 396 0/\ms 16+7+4 v-buf Feb 1 23:19:20 rene vdr: video: speed up video, droping frame Feb 1 23:19:20 rene vdr: video: 20:05:27.870 -10 484 0/\ms 15+7+4 v-buf Feb 1 23:20:10 rene vdr: video: speed up video, droping frame Feb 1 23:20:10 rene vdr: video: 20:06:17.990 -9 477 0/\ms 19+7+4 v-buf Feb 1 23:21:00 rene vdr: video: speed up video, droping frame Feb 1 23:21:00 rene vdr: video: 20:07:08.110 -9 445 0/\ms 14+7+4 v-buf Feb 1 23:21:50 rene vdr: video: speed up video, droping frame Feb 1 23:21:50 rene vdr: video: 20:07:58.230 -8 414 0/\ms 16+7+4 v-buf Feb 1 23:22:41 rene vdr: video: speed up video, droping frame Feb 1 23:22:41 rene vdr: video: 20:08:48.350 -8 382 0/\ms 15+7+4 v-buf Feb 1 23:23:31 rene vdr: video: speed up video, droping frame Feb 1 23:23:31 rene vdr: video: 20:09:38.470 -8 446 0/\ms 18+7+4 v-buf Feb 1 23:23:41 rene vdr: [1717] Power button pressed Feb 1 23:23:41 rene vdr: [1717] confirm: Taste drücken, um Ausschalten abzubrechen Feb 1 23:23:41 rene vdr: [1717] warning: Taste drücken, um Ausschalten abzubrechen Feb 1 23:23:47 rene vdr: [1717] confirmed Feb 1 23:23:47 rene vdr: [1717] executing '/usr/lib/vdr/vdr-shutdown.wrapper 0 0 0 "" 1' Feb 1 23:23:47 rene vdr: [1717] saved setup to /var/lib/vdr/setup.conf Feb 1 23:23:47 rene vdr-shutdown: executing /usr/share/vdr/shutdown-hooks/S90.acpiwakeup as shell script Feb 1 23:23:47 rene vdr-addon-acpiwakeup: Resetting ACPI alarm time Feb 1 23:23:47 rene vdr-addon-acpiwakeup: Writing 0 to /sys/class/rtc/rtc0/wakealarm Feb 1 23:23:47 rene vdr-shutdown: executing /usr/share/vdr/shutdown-hooks/S90.custom as shell script Feb 1 23:23:47 rene systemd[1]: Stopped target RPC Port Mapper. Feb 1 23:23:47 rene systemd[1]: Closed Load/Save RF Kill Switch Status /dev/rfkill Watch. Feb 1 23:23:47 rene systemd[1]: Stopping Save/Restore Sound Card State... Feb 1 23:23:47 rene systemd[1]: Stopping Availability of block devices... Feb 1 23:23:47 rene systemd[1]: Stopping Authorization Manager... Feb 1 23:23:47 rene systemd[1]: Stopping pNFS block layout mapping daemon... Feb 1 23:23:47 rene systemd[1]: Stopping Session 1 of user vdr. Feb 1 23:23:47 rene systemd[1]: Stopped Stop ureadahead data collection 45s after completed startup. Feb 1 23:23:47 rene blkmapd[511]: exit on signal(15) Feb 1 23:23:47 rene systemd[1667]: Stopped target yaVDR Desktop. Feb 1 23:23:47 rene systemd[1667]: Stopping manage VDR frontends... Feb 1 23:23:47 rene systemd[1667]: Removed slice app.slice. Feb 1 23:23:47 rene systemd[1667]: Stopping LIRC command handler... Feb 1 23:23:47 rene yavdr-frontend[1947]: DEBUG:yaVDRFrontend:called stop(extern=True) Feb 1 23:23:47 rene yavdr-frontend[1947]: DEBUG:yaVDRFrontend:set_background with options path: /usr/share/yavdr/images/yaVDR_background_shutdown.png, fill: True Feb 1 23:23:47 rene systemd[1667]: Stopped target Default. Feb 1 23:23:47 rene systemd[1667]: Stopping Sound Service... Feb 1 23:23:47 rene systemd[1667]: Stopping Start tmux in detached session... Feb 1 23:23:47 rene systemd[1667]: Stopping exit window manager gracefully... Feb 1 23:23:47 rene systemd[1667]: Stopped Detect second DISPLAY using xrandr. Feb 1 23:23:47 rene systemd[1]: Stopping User Manager for UID 666... Feb 1 23:23:47 rene systemd[1]: Stopped target Cloud-init target. Feb 1 23:23:47 rene systemd[1]: Stopped target Host and Network Name Lookups. Feb 1 23:23:47 rene systemd[1]: Stopped target Graphical Interface. Feb 1 23:23:47 rene systemd[1]: Stopped Start a X session and a systemd user session for the vdr user. Feb 1 23:23:47 rene systemd[1]: Stopping Direct X login for user vdr... Feb 1 23:23:47 rene systemd[1]: Stopped target Sound Card. Feb 1 23:23:47 rene systemd[1667]: Stopped LIRC command handler. Feb 1 23:23:47 rene systemd[1]: Stopped Execute cloud user/final scripts. Feb 1 23:23:47 rene systemd[1]: Stopped Apply the settings specified in cloud-config. Feb 1 23:23:47 rene systemd[1]: Stopped target Cloud-config availability. Feb 1 23:23:47 rene systemd[1]: Stopped target Multi-User System. Feb 1 23:23:47 rene tmux[9433]: can't find session vdr Feb 1 23:23:47 rene systemd[1]: Stopping irqbalance daemon... Feb 1 23:23:47 rene systemd[1]: Stopping Samba SMB Daemon... Feb 1 23:23:47 rene systemd[1667]: tmux.service: Control process exited, code=exited status=1 Feb 1 23:23:47 rene systemd[1]: Stopping FUSE filesystem for LXC... Feb 1 23:23:47 rene systemd[1]: Stopping LSB: automatic crash report generation... Feb 1 23:23:47 rene systemd[1]: Stopping Regular background program processing daemon... Feb 1 23:23:47 rene systemd[1]: Stopping prevent-umount-on-pause.service... Feb 2 12:21:25 rene systemd[1]: Mounted Huge Pages File System. Feb 2 12:21:25 rene systemd[1]: Started Remount Root and Kernel File Systems. Feb 2 12:21:25 rene systemd[1]: Mounted RPC Pipe File System. Feb 2 12:21:25 rene systemd[1]: Mounted Kernel Debug File System. Feb 2 12:21:25 rene systemd[1]: Mounted POSIX Message Queue File System. Feb 2 12:21:25 rene systemd[1]: Starting pNFS block layout mapping daemon... Feb 2 12:21:25 rene systemd[1]: Starting Initial cloud-init job (pre-networking)... Feb 2 12:21:25 rene systemd[1]: Activating swap /swap.img... Feb 2 12:21:25 rene systemd[1]: Starting Load/Save Random Seed... Feb 2 12:21:25 rene systemd[1]: Starting Flush Journal to Persistent Storage... Feb 2 12:21:25 rene systemd[1]: Mounted NFSD configuration filesystem. Feb 2 12:21:25 rene systemd-modules-load[470]: Inserted module 'iscsi_tcp' Feb 2 12:21:25 rene systemd[1]: Started udev Coldplug all Devices. Feb 2 12:21:25 rene systemd-modules-load[470]: Inserted module 'ib_iser' Feb 2 12:21:25 rene kernel: [ 0.000000] microcode: microcode updated early to revision 0x2e, date = 2018-04-10 Feb 2 12:21:25 rene systemd[1]: Started Load Kernel Modules. Feb 2 12:21:25 rene kernel: [ 0.000000] Linux version 4.15.0-45-generic (buildd@lgw01-amd64-031) (gcc version 7.3.0 (Ubuntu 7.3.0-16ubuntu3)) #48-Ubuntu SMP Tue Jan 29 16:28:13 UTC 2019 (Ubuntu 4.15.0-45.48-generic 4.15.18) Feb 2 12:21:25 rene kernel: [ 0.000000] Command line: BOOT_IMAGE=/boot/vmlinuz-4.15.0-45-generic root=UUID=91216e8b-0f41-11e9-bdb8-386077032362 ro Feb 2 12:21:25 rene kernel: [ 0.000000] KERNEL supported cpus: Feb 2 12:21:25 rene kernel: [ 0.000000] Intel GenuineIntel Feb 2 12:21:25 rene kernel: [ 0.000000] AMD AuthenticAMD Feb 2 12:21:25 rene kernel: [ 0.000000] Centaur CentaurHauls Feb 2 12:21:25 rene systemd[1]: Started Uncomplicated firewall. Feb 2 12:21:25 rene kernel: [ 0.000000] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Feb 2 12:21:25 rene kernel: [ 0.000000] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Feb 2 12:21:25 rene kernel: [ 0.000000] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Feb 2 12:21:25 rene kernel: [ 0.000000] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Feb 2 12:21:25 rene kernel: [ 0.000000] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. Feb 2 12:21:25 rene kernel: [ 0.000000] e820: BIOS-provided physical RAM map: Feb 2 12:21:25 rene kernel: [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable Feb 2 12:21:25 rene kernel: [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000bf0b9fff] usable Feb 2 12:21:25 rene systemd[1]: Mounting Kernel Configuration File System... Feb 2 12:21:25 rene kernel: [ 0.000000] BIOS-e820: [mem 0x00000000bf0ba000-0x00000000bf10efff] ACPI NVS Feb 2 12:21:25 rene kernel: [ 0.000000] BIOS-e820: [mem 0x00000000bf10f000-0x00000000bf345fff] reserved Feb 2 12:21:25 rene kernel: [ 0.000000] BIOS-e820: [mem 0x00000000bf346000-0x00000000bf346fff] type 20 Feb 2 12:21:25 rene kernel: [ 0.000000] BIOS-e820: [mem 0x00000000bf347000-0x00000000bf358fff] reserved Feb 2 12:21:25 rene kernel: [ 0.000000] BIOS-e820: [mem 0x00000000bf359000-0x00000000bf359fff] type 20 Feb 2 12:21:25 rene kernel: [ 0.000000] BIOS-e820: [mem 0x00000000bf35a000-0x00000000bf35bfff] reserved Feb 2 12:21:25 rene kernel: [ 0.000000] BIOS-e820: [mem 0x00000000bf35c000-0x00000000bf35dfff] usable Feb 2 12:21:25 rene kernel: [ 0.000000] BIOS-e820: [mem 0x00000000bf35e000-0x00000000bf35efff] reserved Feb 2 12:21:25 rene kernel: [ 0.000000] BIOS-e820: [mem 0x00000000bf35f000-0x00000000bf368fff] ACPI NVS Feb 2 12:21:25 rene systemd[1]: Mounting FUSE Control File System... Feb 2 12:21:25 rene kernel: [ 0.000000] BIOS-e820: [mem 0x00000000bf369000-0x00000000bf36bfff] type 20 Feb 2 12:21:25 rene kernel: [ 0.000000] BIOS-e820: [mem 0x00000000bf36c000-0x00000000bf3b0fff] reserved Feb 2 12:21:25 rene kernel: [ 0.000000] BIOS-e820: [mem 0x00000000bf3b1000-0x00000000bf3befff] type 20 Feb 2 12:21:25 rene kernel: [ 0.000000] BIOS-e820: [mem 0x00000000bf3bf000-0x00000000bf3c1fff] reserved Feb 2 12:21:25 rene kernel: [ 0.000000] BIOS-e820: [mem 0x00000000bf3c2000-0x00000000bf404fff] ACPI NVS Feb 2 12:21:25 rene kernel: [ 0.000000] BIOS-e820: [mem 0x00000000bf405000-0x00000000bf7fffff] usable Feb 2 12:21:25 rene kernel: [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved Feb 2 12:21:25 rene kernel: [ 0.000000] BIOS-e820: [mem 0x00000000ff000000-0x00000000ffffffff] reserved Feb 2 12:21:25 rene systemd[1]: Starting Apply Kernel Variables... Feb 2 12:21:25 rene kernel: [ 0.000000] BIOS-e820: [mem 0x0000000100000000-0x000000033f7fffff] usable Feb 2 12:21:25 rene kernel: [ 0.000000] NX (Execute Disable) protection: active Feb 2 12:21:25 rene kernel: [ 0.000000] efi: EFI v2.10 by American Megatrends Feb 2 12:21:25 rene kernel: [ 0.000000] efi: SMBIOS=0xbf3c0d98 ACPI=0xbf107000 ACPI 2.0=0xbf107000 MPS=0xfc9c0 Feb 2 12:21:25 rene kernel: [ 0.000000] secureboot: Secure boot could not be determined (mode 0) Feb 2 12:21:25 rene kernel: [ 0.000000] SMBIOS 2.6 present. Feb 2 12:21:25 rene systemd[1]: Mounted Kernel Configuration File System. Feb 2 12:21:25 rene kernel: [ 0.000000] DMI: Hewlett-Packard h8-1036de/2AB5, BIOS 7.12 10/12/2011 Feb 2 12:21:25 rene kernel: [ 0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Feb 2 12:21:25 rene kernel: [ 0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable Feb 2 12:21:25 rene kernel: [ 0.000000] e820: last_pfn = 0x33f800 max_arch_pfn = 0x400000000 Feb 2 12:21:25 rene kernel: [ 0.000000] MTRR default type: uncachable Feb 2 12:21:25 rene kernel: [ 0.000000] MTRR fixed ranges enabled: Feb 2 12:21:25 rene kernel: [ 0.000000] 00000-9FFFF write-back Feb 2 12:21:25 rene systemd[1]: Mounted FUSE Control File System. Feb 2 12:21:25 rene kernel: [ 0.000000] A0000-BFFFF uncachable Feb 2 12:21:25 rene kernel: [ 0.000000] C0000-CFFFF write-protect Feb 2 12:21:25 rene kernel: [ 0.000000] D0000-DFFFF uncachable Feb 2 12:21:25 rene kernel: [ 0.000000] E0000-E7FFF write-through Feb 2 12:21:25 rene kernel: [ 0.000000] E8000-FFFFF write-protect Feb 2 12:21:25 rene systemd[1]: Started LVM2 metadata daemon. Feb 2 12:21:25 rene kernel: [ 0.000000] MTRR variable ranges enabled: Feb 2 12:21:25 rene kernel: [ 0.000000] 0 base 000000000 mask E00000000 write-back Feb 2 12:21:25 rene kernel: [ 0.000000] 1 base 200000000 mask F00000000 write-back Feb 2 12:21:25 rene kernel: [ 0.000000] 2 base 300000000 mask FC0000000 write-back Feb 2 12:21:25 rene kernel: [ 0.000000] 3 base 0C0000000 mask FC0000000 uncachable Feb 2 12:21:25 rene kernel: [ 0.000000] 4 base 33F800000 mask FFF800000 uncachable Feb 2 12:21:25 rene kernel: [ 0.000000] 5 disabled Feb 2 12:21:25 rene kernel: [ 0.000000] 6 disabled Feb 2 12:21:25 rene systemd[1]: Started Create list of required static device nodes for the current kernel. Feb 2 12:21:25 rene kernel: [ 0.000000] 7 disabled Feb 2 12:21:25 rene kernel: [ 0.000000] 8 disabled Feb 2 12:21:25 rene kernel: [ 0.000000] 9 disabled Feb 2 12:21:25 rene kernel: [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Feb 2 12:21:25 rene kernel: [ 0.000000] total RAM covered: 12280M Feb 2 12:21:25 rene kernel: [ 0.000000] Found optimal setting for mtrr clean up Feb 2 12:21:25 rene kernel: [ 0.000000] gran_size: 64K chunk_size: 16M num_reg: 6 lose cover RAM: 0G Feb 2 12:21:25 rene systemd[1]: Starting Create Static Device Nodes in /dev... Feb 2 12:21:25 rene kernel: [ 0.000000] e820: update [mem 0xc0000000-0xffffffff] usable ==> reserved Feb 2 12:21:25 rene kernel: [ 0.000000] e820: last_pfn = 0xbf800 max_arch_pfn = 0x400000000 Feb 2 12:21:25 rene kernel: [ 0.000000] found SMP MP-table at [mem 0x000fcd40-0x000fcd4f] mapped at [ (ptrval)] Feb 2 12:21:25 rene kernel: [ 0.000000] Scanning 1 areas for low memory corruption Feb 2 12:21:25 rene kernel: [ 0.000000] Base memory trampoline at [ (ptrval)] 94000 size 24576 Feb 2 12:21:25 rene kernel: [ 0.000000] BRK [0x25ff3f000, 0x25ff3ffff] PGTABLE Feb 2 12:21:25 rene kernel: [ 0.000000] BRK [0x25ff40000, 0x25ff40fff] PGTABLE Feb 2 12:21:25 rene kernel: [ 0.000000] BRK [0x25ff41000, 0x25ff41fff] PGTABLE Feb 2 12:21:25 rene kernel: [ 0.000000] BRK [0x25ff42000, 0x25ff42fff] PGTABLE Feb 2 12:21:25 rene kernel: [ 0.000000] BRK [0x25ff43000, 0x25ff43fff] PGTABLE Feb 2 12:21:25 rene kernel: [ 0.000000] BRK [0x25ff44000, 0x25ff44fff] PGTABLE Feb 2 12:21:25 rene blkmapd[497]: open pipe file /run/rpc_pipefs/nfs/blocklayout failed: No such file or directory Feb 2 12:21:25 rene kernel: [ 0.000000] BRK [0x25ff45000, 0x25ff45fff] PGTABLE Feb 2 12:21:25 rene kernel: [ 0.000000] BRK [0x25ff46000, 0x25ff46fff] PGTABLE Feb 2 12:21:25 rene kernel: [ 0.000000] BRK [0x25ff47000, 0x25ff47fff] PGTABLE Feb 2 12:21:25 rene kernel: [ 0.000000] BRK [0x25ff48000, 0x25ff48fff] PGTABLE Feb 2 12:21:25 rene kernel: [ 0.000000] RAMDISK: [mem 0x30ebd000-0x34755fff] Feb 2 12:21:25 rene kernel: [ 0.000000] ACPI: Early table checksum verification disabled Feb 2 12:21:25 rene systemd[1]: Started pNFS block layout mapping daemon. Feb 2 12:21:25 rene kernel: [ 0.000000] ACPI: RSDP 0x00000000BF107000 000024 (v02 HPQOEM) Feb 2 12:21:25 rene kernel: [ 0.000000] ACPI: XSDT 0x00000000BF107070 00005C (v01 HPQOEM SLIC-CPC 01072009 AMI 00010013) Feb 2 12:21:25 rene kernel: [ 0.000000] ACPI: FACP 0x00000000BF10DCA0 0000F4 (v04 HPQOEM SLIC-CPC 01072009 AMI 00010013) Feb 2 12:21:25 rene kernel: [ 0.000000] ACPI: DSDT 0x00000000BF107158 006B47 (v02 HPQOEM SLIC-CPC 00000000 INTL 20051117) Feb 2 12:21:25 rene kernel: [ 0.000000] ACPI: FACS 0x00000000BF360F80 000040 Feb 2 12:21:25 rene kernel: [ 0.000000] ACPI: APIC 0x00000000BF10DD98 000092 (v03 HPQOEM SLIC-CPC 01072009 AMI 00010013) Feb 2 12:21:25 rene kernel: [ 0.000000] ACPI: SSDT 0x00000000BF10DE30 0001D6 (v01 HPQOEM SLIC-CPC 00000001 MSFT 03000001) Feb 2 12:21:25 rene systemd[1]: Activated swap /swap.img. Feb 2 12:21:25 rene kernel: [ 0.000000] ACPI: MCFG 0x00000000BF10E008 00003C (v01 HPQOEM SLIC-CPC 01072009 MSFT 00000097) Feb 2 12:21:25 rene kernel: [ 0.000000] ACPI: SLIC 0x00000000BF10E048 000176 (v01 HPQOEM SLIC-CPC 01072009 AMI 00010013) Feb 2 12:21:25 rene kernel: [ 0.000000] ACPI: HPET 0x00000000BF10E1C0 000038 (v01 HPQOEM SLIC-CPC 01072009 AMI. 00000004) Feb 2 12:21:25 rene kernel: [ 0.000000] ACPI: DBGP 0x00000000BF10E1F8 000034 (v01 HPQOEM SLIC-CPC 01072009 AMI 00010013) Feb 2 12:21:25 rene kernel: [ 0.000000] ACPI: Local APIC address 0xfee00000 Feb 2 12:21:25 rene kernel: [ 0.000000] No NUMA configuration found Feb 2 12:21:25 rene kernel: [ 0.000000] Faking a node at [mem 0x0000000000000000-0x000000033f7fffff] Feb 2 12:21:25 rene systemd[1]: Reached target Swap. Feb 2 12:21:25 rene kernel: [ 0.000000] NODE_DATA(0) allocated [mem 0x33f7cd000-0x33f7f7fff] Feb 2 12:21:25 rene kernel: [ 0.000000] tsc: Fast TSC calibration using PIT Feb 2 12:21:25 rene kernel: [ 0.000000] Zone ranges: Feb 2 12:21:25 rene kernel: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] Feb 2 12:21:25 rene kernel: [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] Feb 2 12:21:25 rene kernel: [ 0.000000] Normal [mem 0x0000000100000000-0x000000033f7fffff] Feb 2 12:21:25 rene kernel: [ 0.000000] Device empty Feb 2 12:21:25 rene systemd[1]: Started Create Static Device Nodes in /dev. Feb 2 12:21:25 rene kernel: [ 0.000000] Movable zone start for each node Feb 2 12:21:25 rene kernel: [ 0.000000] Early memory node ranges Feb 2 12:21:25 rene kernel: [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009ffff] Feb 2 12:21:25 rene kernel: [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bf0b9fff] Feb 2 12:21:25 rene kernel: [ 0.000000] node 0: [mem 0x00000000bf35c000-0x00000000bf35dfff] Feb 2 12:21:25 rene kernel: [ 0.000000] node 0: [mem 0x00000000bf405000-0x00000000bf7fffff] Feb 2 12:21:25 rene systemd[1]: Starting udev Kernel Device Manager... Feb 2 12:21:25 rene kernel: [ 0.000000] node 0: [mem 0x0000000100000000-0x000000033f7fffff] Feb 2 12:21:25 rene kernel: [ 0.000000] Reserved but unavailable: 2986 pages Feb 2 12:21:25 rene kernel: [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x000000033f7fffff] Feb 2 12:21:25 rene kernel: [ 0.000000] On node 0 totalpages: 3140694 Feb 2 12:21:25 rene kernel: [ 0.000000] DMA zone: 64 pages used for memmap Feb 2 12:21:25 rene kernel: [ 0.000000] DMA zone: 30 pages reserved Feb 2 12:21:25 rene kernel: [ 0.000000] DMA zone: 3999 pages, LIFO batch:0 Feb 2 12:21:25 rene kernel: [ 0.000000] DMA32 zone: 12179 pages used for memmap Feb 2 12:21:25 rene kernel: [ 0.000000] DMA32 zone: 779447 pages, LIFO batch:31 Feb 2 12:21:25 rene systemd[1]: Started Load/Save Random Seed. Feb 2 12:21:25 rene systemd[1]: Started Monitoring of LVM2 mirrors, snapshots etc. using dmeventd or progress polling. Feb 2 12:21:25 rene systemd[1]: Started udev Kernel Device Manager. Feb 2 12:21:25 rene systemd[1]: Started Apply Kernel Variables. Feb 2 12:21:25 rene systemd[1]: Started Set the console keyboard layout. Feb 2 12:21:25 rene systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Feb 2 12:21:25 rene systemd[1]: Reached target Local Encrypted Volumes. Feb 2 12:21:25 rene systemd[1]: Reached target Local File Systems (Pre). Feb 2 12:21:25 rene systemd[1]: Mounting Mount unit for core, revision 6130... Feb 2 12:21:25 rene systemd[1]: Mounting Mount unit for core, revision 6350... Feb 2 12:21:25 rene systemd[1]: Mounting Mount unit for core, revision 6259... Feb 2 12:21:25 rene systemd[1]: Mounted Mount unit for core, revision 6130. Feb 2 12:21:25 rene systemd[1]: Mounted Mount unit for core, revision 6350. Feb 2 12:21:25 rene systemd[1]: Mounted Mount unit for core, revision 6259. Feb 2 12:21:25 rene kernel: [ 0.000000] Normal zone: 36832 pages used for memmap Feb 2 12:21:25 rene kernel: [ 0.000000] Normal zone: 2357248 pages, LIFO batch:31 Feb 2 12:21:25 rene kernel: [ 0.000000] ACPI: PM-Timer IO Port: 0x408 Feb 2 12:21:25 rene kernel: [ 0.000000] ACPI: Local APIC address 0xfee00000 Feb 2 12:21:25 rene systemd-udevd[521]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Feb 2 12:21:25 rene kernel: [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] high edge lint[0x1]) Feb 2 12:21:25 rene kernel: [ 0.000000] IOAPIC[0]: apic_id 0, version 32, address 0xfec00000, GSI 0-23 Feb 2 12:21:25 rene kernel: [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Feb 2 12:21:25 rene kernel: [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Feb 2 12:21:25 rene kernel: [ 0.000000] ACPI: IRQ0 used by override. Feb 2 12:21:25 rene kernel: [ 0.000000] ACPI: IRQ9 used by override. Feb 2 12:21:25 rene kernel: [ 0.000000] Using ACPI (MADT) for SMP configuration information Feb 2 12:21:25 rene kernel: [ 0.000000] ACPI: HPET id: 0x8086a701 base: 0xfed00000 Feb 2 12:21:25 rene kernel: [ 0.000000] smpboot: Allowing 8 CPUs, 0 hotplug CPUs Feb 2 12:21:25 rene kernel: [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] Feb 2 12:21:25 rene kernel: [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000fffff] Feb 2 12:21:25 rene kernel: [ 0.000000] PM: Registered nosave memory: [mem 0xbf0ba000-0xbf10efff] Feb 2 12:21:25 rene kernel: [ 0.000000] PM: Registered nosave memory: [mem 0xbf10f000-0xbf345fff] Feb 2 12:21:25 rene systemd-udevd[512]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Feb 2 12:21:25 rene kernel: [ 0.000000] PM: Registered nosave memory: [mem 0xbf346000-0xbf346fff] Feb 2 12:21:25 rene kernel: [ 0.000000] PM: Registered nosave memory: [mem 0xbf347000-0xbf358fff] Feb 2 12:21:25 rene kernel: [ 0.000000] PM: Registered nosave memory: [mem 0xbf359000-0xbf359fff] Feb 2 12:21:25 rene kernel: [ 0.000000] PM: Registered nosave memory: [mem 0xbf35a000-0xbf35bfff] Feb 2 12:21:25 rene kernel: [ 0.000000] PM: Registered nosave memory: [mem 0xbf35e000-0xbf35efff] Feb 2 12:21:25 rene kernel: [ 0.000000] PM: Registered nosave memory: [mem 0xbf35f000-0xbf368fff] Feb 2 12:21:25 rene kernel: [ 0.000000] PM: Registered nosave memory: [mem 0xbf369000-0xbf36bfff] Feb 2 12:21:25 rene kernel: [ 0.000000] PM: Registered nosave memory: [mem 0xbf36c000-0xbf3b0fff] Feb 2 12:21:25 rene systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Feb 2 12:21:25 rene kernel: [ 0.000000] PM: Registered nosave memory: [mem 0xbf3b1000-0xbf3befff] Feb 2 12:21:25 rene kernel: [ 0.000000] PM: Registered nosave memory: [mem 0xbf3bf000-0xbf3c1fff] Feb 2 12:21:25 rene kernel: [ 0.000000] PM: Registered nosave memory: [mem 0xbf3c2000-0xbf404fff] Feb 2 12:21:25 rene kernel: [ 0.000000] PM: Registered nosave memory: [mem 0xbf800000-0xfed1bfff] Feb 2 12:21:25 rene kernel: [ 0.000000] PM: Registered nosave memory: [mem 0xfed1c000-0xfed1ffff] Feb 2 12:21:25 rene kernel: [ 0.000000] PM: Registered nosave memory: [mem 0xfed20000-0xfeffffff] Feb 2 12:21:25 rene kernel: [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xffffffff] Feb 2 12:21:25 rene systemd[1]: Started Flush Journal to Persistent Storage. Feb 2 12:21:25 rene kernel: [ 0.000000] e820: [mem 0xbf800000-0xfed1bfff] available for PCI devices Feb 2 12:21:25 rene kernel: [ 0.000000] Booting paravirtualized kernel on bare hardware Feb 2 12:21:25 rene kernel: [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns Feb 2 12:21:25 rene kernel: [ 0.000000] random: get_random_bytes called from start_kernel+0x99/0x4fd with crng_init=0 Feb 2 12:21:25 rene kernel: [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:8 nr_cpu_ids:8 nr_node_ids:1 Feb 2 12:21:25 rene kernel: [ 0.000000] percpu: Embedded 46 pages/cpu @ (ptrval) s151552 r8192 d28672 u262144 Feb 2 12:21:25 rene kernel: [ 0.000000] pcpu-alloc: s151552 r8192 d28672 u262144 alloc=1*2097152 Feb 2 12:21:25 rene systemd[1]: Reached target Sound Card. Feb 2 12:21:25 rene kernel: [ 0.000000] pcpu-alloc: [0] 0 1 2 3 4 5 6 7 Feb 2 12:21:25 rene kernel: [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 3091589 Feb 2 12:21:25 rene kernel: [ 0.000000] Policy zone: Normal Feb 2 12:21:25 rene kernel: [ 0.000000] Kernel command line: BOOT_IMAGE=/boot/vmlinuz-4.15.0-45-generic root=UUID=91216e8b-0f41-11e9-bdb8-386077032362 ro Feb 2 12:21:25 rene kernel: [ 0.000000] Calgary: detecting Calgary via BIOS EBDA area Feb 2 12:21:25 rene kernel: [ 0.000000] Calgary: Unable to locate Rio Grande table in EBDA - bailing! Feb 2 12:21:25 rene kernel: [ 0.000000] Memory: 12192188K/12562776K available (12300K kernel code, 2473K rwdata, 4252K rodata, 2408K init, 2416K bss, 370588K reserved, 0K cma-reserved) Feb 2 12:21:25 rene kernel: [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=8, Nodes=1 Feb 2 12:21:25 rene kernel: [ 0.000000] Kernel/User page tables isolation: enabled Feb 2 12:21:25 rene kernel: [ 0.000000] ftrace: allocating 39194 entries in 154 pages Feb 2 12:21:25 rene kernel: [ 0.000000] Hierarchical RCU implementation. Feb 2 12:21:25 rene systemd-udevd[512]: Process '/bin/systemctl start --no-block nvidia-persistenced.service' failed with exit code 5. Feb 2 12:21:25 rene kernel: [ 0.000000] RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=8. Feb 2 12:21:25 rene kernel: [ 0.000000] Tasks RCU enabled. Feb 2 12:21:25 rene kernel: [ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=8 Feb 2 12:21:25 rene kernel: [ 0.000000] NR_IRQS: 524544, nr_irqs: 488, preallocated irqs: 16 Feb 2 12:21:25 rene kernel: [ 0.000000] Console: colour dummy device 80x25 Feb 2 12:21:25 rene kernel: [ 0.000000] console [tty0] enabled Feb 2 12:21:25 rene systemd-udevd[525]: Process '/bin/systemctl start --no-block nvidia-persistenced.service' failed with exit code 5. Feb 2 12:21:25 rene kernel: [ 0.000000] ACPI: Core revision 20170831 Feb 2 12:21:25 rene kernel: [ 0.000000] ACPI: 2 ACPI AML tables successfully acquired and loaded Feb 2 12:21:25 rene kernel: [ 0.000000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 133484882848 ns Feb 2 12:21:25 rene kernel: [ 0.000000] hpet clockevent registered Feb 2 12:21:25 rene kernel: [ 0.000000] APIC: Switch to symmetric I/O mode setup Feb 2 12:21:25 rene cloud-init[481]: Cloud-init v. 18.4-0ubuntu1~18.04.1 running 'init-local' at Sat, 02 Feb 2019 11:21:18 +0000. Up 6.07 seconds. Feb 2 12:21:25 rene kernel: [ 0.000000] x2apic: IRQ remapping doesn't support X2APIC mode Feb 2 12:21:25 rene kernel: [ 0.000000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Feb 2 12:21:25 rene systemd[1]: Started Initial cloud-init job (pre-networking). Feb 2 12:21:25 rene kernel: [ 0.020000] tsc: Fast TSC calibration using PIT Feb 2 12:21:25 rene kernel: [ 0.024000] tsc: Detected 3392.216 MHz processor Feb 2 12:21:25 rene kernel: [ 0.024000] Calibrating delay loop (skipped), value calculated using timer frequency.. 6784.43 BogoMIPS (lpj=13568864) Feb 2 12:21:25 rene kernel: [ 0.024000] pid_max: default: 32768 minimum: 301 Feb 2 12:21:25 rene kernel: [ 0.028023] Security Framework initialized Feb 2 12:21:25 rene kernel: [ 0.028025] Yama: becoming mindful. Feb 2 12:21:25 rene systemd[1]: Found device ADATA_SSD_S599_64GB 1. Feb 2 12:21:25 rene kernel: [ 0.028045] AppArmor: AppArmor initialized Feb 2 12:21:25 rene kernel: [ 0.029948] Dentry cache hash table entries: 2097152 (order: 12, 16777216 bytes) Feb 2 12:21:25 rene kernel: [ 0.032743] Inode-cache hash table entries: 1048576 (order: 11, 8388608 bytes) Feb 2 12:21:25 rene kernel: [ 0.032795] Mount-cache hash table entries: 32768 (order: 6, 262144 bytes) Feb 2 12:21:25 rene kernel: [ 0.032829] Mountpoint-cache hash table entries: 32768 (order: 6, 262144 bytes) Feb 2 12:21:25 rene kernel: [ 0.033002] ENERGY_PERF_BIAS: Set to 'normal', was 'performance' Feb 2 12:21:25 rene systemd[1]: Mounting /boot/efi... Feb 2 12:21:25 rene kernel: [ 0.033004] ENERGY_PERF_BIAS: View and update with x86_energy_perf_policy(8) Feb 2 12:21:25 rene kernel: [ 0.033009] mce: CPU supports 9 MCE banks Feb 2 12:21:25 rene kernel: [ 0.033017] CPU0: Thermal monitoring enabled (TM1) Feb 2 12:21:25 rene kernel: [ 0.033026] process: using mwait in idle threads Feb 2 12:21:25 rene kernel: [ 0.033029] Last level iTLB entries: 4KB 512, 2MB 8, 4MB 8 Feb 2 12:21:25 rene systemd[1]: Mounted /boot/efi. Feb 2 12:21:25 rene kernel: [ 0.033031] Last level dTLB entries: 4KB 512, 2MB 32, 4MB 32, 1GB 0 Feb 2 12:21:25 rene kernel: [ 0.033033] Spectre V2 : Mitigation: Full generic retpoline Feb 2 12:21:25 rene systemd[1]: Found device Hitachi_HDS722020ALA330 5. Feb 2 12:21:25 rene kernel: [ 0.033035] Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch Feb 2 12:21:25 rene kernel: [ 0.033037] Spectre V2 : Spectre v2 mitigation: Enabling Indirect Branch Prediction Barrier Feb 2 12:21:25 rene kernel: [ 0.033039] Spectre V2 : Enabling Restricted Speculation for firmware calls Feb 2 12:21:25 rene kernel: [ 0.033041] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl and seccomp Feb 2 12:21:25 rene kernel: [ 0.033120] Freeing SMP alternatives memory: 36K Feb 2 12:21:25 rene systemd[1]: srv.mount: Directory /srv to mount over is not empty, mounting anyway. Feb 2 12:21:25 rene kernel: [ 0.036461] TSC deadline timer enabled Feb 2 12:21:25 rene systemd[1]: Mounting /srv... Feb 2 12:21:25 rene kernel: [ 0.036463] smpboot: CPU0: Intel(R) Core(TM) i7-2600 CPU @ 3.40GHz (family: 0x6, model: 0x2a, stepping: 0x7) Feb 2 12:21:25 rene kernel: [ 0.036520] Performance Events: PEBS fmt1+, SandyBridge events, 16-deep LBR, full-width counters, Intel PMU driver. Feb 2 12:21:25 rene kernel: [ 0.036541] ... version: 3 Feb 2 12:21:25 rene kernel: [ 0.036542] ... bit width: 48 Feb 2 12:21:25 rene kernel: [ 0.036544] ... generic registers: 4 Feb 2 12:21:25 rene kernel: [ 0.036545] ... value mask: 0000ffffffffffff Feb 2 12:21:25 rene systemd[1]: Mounted /srv. Feb 2 12:21:25 rene kernel: [ 0.036547] ... max period: 00007fffffffffff Feb 2 12:21:25 rene kernel: [ 0.036549] ... fixed-purpose events: 3 Feb 2 12:21:25 rene kernel: [ 0.036550] ... event mask: 000000070000000f Feb 2 12:21:25 rene kernel: [ 0.036583] Hierarchical SRCU implementation. Feb 2 12:21:25 rene kernel: [ 0.037408] NMI watchdog: Enabled. Permanently consumes one hw-PMU counter. Feb 2 12:21:25 rene kernel: [ 0.037423] smp: Bringing up secondary CPUs ... Feb 2 12:21:25 rene systemd[1]: Mounting /media/Musik... Feb 2 12:21:25 rene kernel: [ 0.037482] x86: Booting SMP configuration: Feb 2 12:21:25 rene kernel: [ 0.037485] .... node #0, CPUs: #1 #2 #3 #4 #5 #6 #7 Feb 2 12:21:25 rene kernel: [ 0.052051] smp: Brought up 1 node, 8 CPUs Feb 2 12:21:25 rene systemd[1]: Mounting /media/Video... Feb 2 12:21:25 rene kernel: [ 0.052051] smpboot: Max logical packages: 1 Feb 2 12:21:25 rene kernel: [ 0.052051] smpboot: Total of 8 processors activated (54275.45 BogoMIPS) Feb 2 12:21:25 rene kernel: [ 0.056369] devtmpfs: initialized Feb 2 12:21:25 rene kernel: [ 0.056369] x86/mm: Memory block size: 128MB Feb 2 12:21:25 rene kernel: [ 0.056771] evm: security.selinux Feb 2 12:21:25 rene systemd[1]: Mounting /media/Bilder... Feb 2 12:21:25 rene kernel: [ 0.056773] evm: security.SMACK64 Feb 2 12:21:25 rene kernel: [ 0.056774] evm: security.SMACK64EXEC Feb 2 12:21:25 rene kernel: [ 0.056775] evm: security.SMACK64TRANSMUTE Feb 2 12:21:25 rene kernel: [ 0.056777] evm: security.SMACK64MMAP Feb 2 12:21:25 rene kernel: [ 0.056778] evm: security.apparmor Feb 2 12:21:25 rene systemd[1]: Mounting /media/Sonstige... Feb 2 12:21:25 rene kernel: [ 0.056780] evm: security.ima Feb 2 12:21:25 rene kernel: [ 0.056781] evm: security.capability Feb 2 12:21:25 rene kernel: [ 0.056794] PM: Registering ACPI NVS region [mem 0xbf0ba000-0xbf10efff] (348160 bytes) Feb 2 12:21:25 rene systemd[1]: Mounted /media/Musik. Feb 2 12:21:25 rene kernel: [ 0.056794] PM: Registering ACPI NVS region [mem 0xbf35f000-0xbf368fff] (40960 bytes) Feb 2 12:21:25 rene systemd[1]: Mounted /media/Video. Feb 2 12:21:25 rene systemd[1]: Mounted /media/Bilder. Feb 2 12:21:25 rene systemd[1]: Mounted /media/Sonstige. Feb 2 12:21:25 rene systemd[1]: Reached target Local File Systems. Feb 2 12:21:25 rene systemd[1]: Starting Create Volatile Files and Directories... Feb 2 12:21:25 rene systemd[1]: Starting Set console font and keymap... Feb 2 12:21:25 rene systemd[1]: Starting ebtables ruleset management... Feb 2 12:21:25 rene systemd[1]: Starting AppArmor initialization... Feb 2 12:21:25 rene systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Feb 2 12:21:25 rene systemd[1]: Starting Preprocess NFS configuration... Feb 2 12:21:25 rene systemd[1]: Started Set console font and keymap. Feb 2 12:21:25 rene systemd[1]: Started Create Volatile Files and Directories. Feb 2 12:21:25 rene systemd[1]: Starting RPC bind portmap service... Feb 2 12:21:25 rene systemd[1]: Starting Network Time Synchronization... Feb 2 12:21:25 rene systemd[1]: Starting Update UTMP about System Boot/Shutdown... Feb 2 12:21:25 rene systemd[1]: Started RPC bind portmap service. Feb 2 12:21:25 rene systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Feb 2 12:21:25 rene systemd[1]: Started Preprocess NFS configuration. Feb 2 12:21:25 rene systemd[1]: Reached target NFS client services. Feb 2 12:21:25 rene systemd[1]: Starting NFSv4 ID-name mapping service... Feb 2 12:21:25 rene kernel: [ 0.056794] PM: Registering ACPI NVS region [mem 0xbf3c2000-0xbf404fff] (274432 bytes) Feb 2 12:21:25 rene kernel: [ 0.056794] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns Feb 2 12:21:25 rene systemd[1]: Reached target RPC Port Mapper. Feb 2 12:21:25 rene kernel: [ 0.056794] futex hash table entries: 2048 (order: 5, 131072 bytes) Feb 2 12:21:25 rene systemd[1]: Started Update UTMP about System Boot/Shutdown. Feb 2 12:21:25 rene kernel: [ 0.056794] pinctrl core: initialized pinctrl subsystem Feb 2 12:21:25 rene kernel: [ 0.056794] RTC time: 11:21:11, date: 02/02/19 Feb 2 12:21:25 rene kernel: [ 0.056794] NET: Registered protocol family 16 Feb 2 12:21:25 rene kernel: [ 0.056794] audit: initializing netlink subsys (disabled) Feb 2 12:21:25 rene kernel: [ 0.056794] audit: type=2000 audit(1549106471.056:1): state=initialized audit_enabled=0 res=1 Feb 2 12:21:25 rene kernel: [ 0.056794] cpuidle: using governor ladder Feb 2 12:21:25 rene kernel: [ 0.056794] cpuidle: using governor menu Feb 2 12:21:25 rene systemd[1]: Started NFSv4 ID-name mapping service. Feb 2 12:21:25 rene kernel: [ 0.056794] ACPI FADT declares the system doesn't support PCIe ASPM, so disable it Feb 2 12:21:25 rene kernel: [ 0.056794] ACPI: bus type PCI registered Feb 2 12:21:25 rene kernel: [ 0.056794] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Feb 2 12:21:25 rene systemd[1]: Started ebtables ruleset management. Feb 2 12:21:25 rene kernel: [ 0.056794] PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xe0000000-0xefffffff] (base 0xe0000000) Feb 2 12:21:25 rene kernel: [ 0.056794] PCI: not using MMCONFIG Feb 2 12:21:25 rene kernel: [ 0.056794] PCI: Using configuration type 1 for base access Feb 2 12:21:25 rene systemd[1]: Reached target Network (Pre). Feb 2 12:21:25 rene kernel: [ 0.056794] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on Feb 2 12:21:25 rene kernel: [ 0.057058] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Feb 2 12:21:25 rene kernel: [ 0.057058] ACPI: Added _OSI(Module Device) Feb 2 12:21:25 rene kernel: [ 0.057058] ACPI: Added _OSI(Processor Device) Feb 2 12:21:25 rene kernel: [ 0.057058] ACPI: Added _OSI(3.0 _SCP Extensions) Feb 2 12:21:25 rene kernel: [ 0.057058] ACPI: Added _OSI(Processor Aggregator Device) Feb 2 12:21:25 rene apparmor[746]: * Starting AppArmor profiles Feb 2 12:21:25 rene kernel: [ 0.057058] ACPI: Added _OSI(Linux-Dell-Video) Feb 2 12:21:25 rene kernel: [ 0.057058] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Feb 2 12:21:25 rene systemd[1]: Starting Network Service... Feb 2 12:21:25 rene kernel: [ 0.057058] ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Feb 2 12:21:25 rene kernel: [ 0.057058] ACPI: Executed 1 blocks of module-level executable AML code Feb 2 12:21:25 rene kernel: [ 0.063158] ACPI: Dynamic OEM Table Load: Feb 2 12:21:25 rene kernel: [ 0.063165] ACPI: SSDT 0xFFFF9279F08F9000 0006F4 (v01 AMI IST 00000001 MSFT 03000001) Feb 2 12:21:25 rene kernel: [ 0.063538] ACPI: Dynamic OEM Table Load: Feb 2 12:21:25 rene kernel: [ 0.063542] ACPI: SSDT 0xFFFF9279F0416000 0000E4 (v01 AMI CST 00000001 MSFT 03000001) Feb 2 12:21:25 rene systemd-networkd[770]: Enumeration completed Feb 2 12:21:25 rene kernel: [ 0.064734] ACPI: Interpreter enabled Feb 2 12:21:25 rene kernel: [ 0.064749] ACPI: (supports S0 S3 S4 S5) Feb 2 12:21:25 rene kernel: [ 0.064751] ACPI: Using IOAPIC for interrupt routing Feb 2 12:21:25 rene kernel: [ 0.064780] PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xe0000000-0xefffffff] (base 0xe0000000) Feb 2 12:21:25 rene kernel: [ 0.064855] PCI: MMCONFIG at [mem 0xe0000000-0xefffffff] reserved in ACPI motherboard resources Feb 2 12:21:25 rene kernel: [ 0.064871] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Feb 2 12:21:25 rene systemd[1]: Started Network Service. Feb 2 12:21:25 rene kernel: [ 0.065020] ACPI: Enabled 7 GPEs in block 00 to 3F Feb 2 12:21:25 rene kernel: [ 0.065313] ACPI: [Firmware Bug]: BIOS _OSI(Linux) query ignored Feb 2 12:21:25 rene systemd-networkd[770]: lo: Link is not managed by us Feb 2 12:21:25 rene kernel: [ 0.070501] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Feb 2 12:21:25 rene kernel: [ 0.070508] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI] Feb 2 12:21:25 rene kernel: [ 0.070690] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug PME] Feb 2 12:21:25 rene kernel: [ 0.070861] acpi PNP0A08:00: _OSC: OS now controls [AER PCIeCapability] Feb 2 12:21:25 rene systemd-networkd[770]: enp6s0: IPv6 successfully enabled Feb 2 12:21:25 rene kernel: [ 0.070863] acpi PNP0A08:00: FADT indicates ASPM is unsupported, using BIOS configuration Feb 2 12:21:25 rene kernel: [ 0.071155] PCI host bridge to bus 0000:00 Feb 2 12:21:25 rene systemd[1]: Starting Wait for Network to be Configured... Feb 2 12:21:25 rene kernel: [ 0.071159] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Feb 2 12:21:25 rene kernel: [ 0.071161] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Feb 2 12:21:25 rene kernel: [ 0.071164] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Feb 2 12:21:25 rene kernel: [ 0.071167] pci_bus 0000:00: root bus resource [mem 0x000c8000-0x000dffff window] Feb 2 12:21:25 rene kernel: [ 0.071169] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xffffffff window] Feb 2 12:21:25 rene systemd[1]: Starting Network Name Resolution... Feb 2 12:21:25 rene kernel: [ 0.071172] pci_bus 0000:00: root bus resource [bus 00-ff] Feb 2 12:21:25 rene kernel: [ 0.071180] pci 0000:00:00.0: [8086:0100] type 00 class 0x060000 Feb 2 12:21:25 rene apparmor[746]: Skipping profile in /etc/apparmor.d/disable: usr.bin.firefox Feb 2 12:21:25 rene kernel: [ 0.071257] pci 0000:00:01.0: [8086:0101] type 01 class 0x060400 Feb 2 12:21:25 rene kernel: [ 0.071284] pci 0000:00:01.0: PME# supported from D0 D3hot D3cold Feb 2 12:21:25 rene kernel: [ 0.071372] pci 0000:00:16.0: [8086:1c3a] type 00 class 0x078000 Feb 2 12:21:25 rene kernel: [ 0.071397] pci 0000:00:16.0: reg 0x10: [mem 0xfb308000-0xfb30800f 64bit] Feb 2 12:21:25 rene apparmor[746]: Skipping profile in /etc/apparmor.d/disable: usr.sbin.rsyslogd Feb 2 12:21:25 rene kernel: [ 0.071466] pci 0000:00:16.0: PME# supported from D0 D3hot D3cold Feb 2 12:21:25 rene apparmor[746]: ...done. Feb 2 12:21:25 rene kernel: [ 0.071536] pci 0000:00:1a.0: [8086:1c2d] type 00 class 0x0c0320 Feb 2 12:21:25 rene kernel: [ 0.071557] pci 0000:00:1a.0: reg 0x10: [mem 0xfb307000-0xfb3073ff] Feb 2 12:21:25 rene kernel: [ 0.071634] pci 0000:00:1a.0: PME# supported from D0 D3hot D3cold Feb 2 12:21:25 rene kernel: [ 0.071702] pci 0000:00:1b.0: [8086:1c20] type 00 class 0x040300 Feb 2 12:21:25 rene kernel: [ 0.071720] pci 0000:00:1b.0: reg 0x10: [mem 0xfb300000-0xfb303fff 64bit] Feb 2 12:21:25 rene systemd[1]: Started AppArmor initialization. Feb 2 12:21:25 rene kernel: [ 0.071779] pci 0000:00:1b.0: PME# supported from D0 D3hot D3cold Feb 2 12:21:25 rene systemd-networkd-wait-online[817]: ignoring: lo Feb 2 12:21:25 rene kernel: [ 0.071847] pci 0000:00:1c.0: [8086:1c10] type 01 class 0x060400 Feb 2 12:21:25 rene kernel: [ 0.071924] pci 0000:00:1c.0: PME# supported from D0 D3hot D3cold Feb 2 12:21:25 rene kernel: [ 0.072006] pci 0000:00:1c.1: [8086:1c12] type 01 class 0x060400 Feb 2 12:21:25 rene kernel: [ 0.072083] pci 0000:00:1c.1: PME# supported from D0 D3hot D3cold Feb 2 12:21:25 rene kernel: [ 0.072157] pci 0000:00:1c.2: [8086:1c14] type 01 class 0x060400 Feb 2 12:21:25 rene kernel: [ 0.072233] pci 0000:00:1c.2: PME# supported from D0 D3hot D3cold Feb 2 12:21:25 rene kernel: [ 0.072305] pci 0000:00:1c.3: [8086:1c16] type 01 class 0x060400 Feb 2 12:21:25 rene kernel: [ 0.072382] pci 0000:00:1c.3: PME# supported from D0 D3hot D3cold Feb 2 12:21:25 rene kernel: [ 0.072453] pci 0000:00:1c.4: [8086:1c18] type 01 class 0x060400 Feb 2 12:21:25 rene kernel: [ 0.072530] pci 0000:00:1c.4: PME# supported from D0 D3hot D3cold Feb 2 12:21:25 rene kernel: [ 0.072601] pci 0000:00:1c.5: [8086:1c1a] type 01 class 0x060400 Feb 2 12:21:25 rene kernel: [ 0.072677] pci 0000:00:1c.5: PME# supported from D0 D3hot D3cold Feb 2 12:21:25 rene kernel: [ 0.072748] pci 0000:00:1c.6: [8086:1c1c] type 01 class 0x060400 Feb 2 12:21:25 rene kernel: [ 0.072825] pci 0000:00:1c.6: PME# supported from D0 D3hot D3cold Feb 2 12:21:25 rene kernel: [ 0.072897] pci 0000:00:1c.7: [8086:1c1e] type 01 class 0x060400 Feb 2 12:21:25 rene kernel: [ 0.072974] pci 0000:00:1c.7: PME# supported from D0 D3hot D3cold Feb 2 12:21:25 rene kernel: [ 0.073045] pci 0000:00:1d.0: [8086:1c26] type 00 class 0x0c0320 Feb 2 12:21:25 rene kernel: [ 0.073065] pci 0000:00:1d.0: reg 0x10: [mem 0xfb306000-0xfb3063ff] Feb 2 12:21:25 rene kernel: [ 0.073143] pci 0000:00:1d.0: PME# supported from D0 D3hot D3cold Feb 2 12:21:25 rene kernel: [ 0.073211] pci 0000:00:1f.0: [8086:1c4a] type 00 class 0x060100 Feb 2 12:21:25 rene kernel: [ 0.073372] pci 0000:00:1f.2: [8086:1c02] type 00 class 0x010601 Feb 2 12:21:25 rene kernel: [ 0.073389] pci 0000:00:1f.2: reg 0x10: [io 0xf070-0xf077] Feb 2 12:21:25 rene kernel: [ 0.073395] pci 0000:00:1f.2: reg 0x14: [io 0xf060-0xf063] Feb 2 12:21:25 rene kernel: [ 0.073402] pci 0000:00:1f.2: reg 0x18: [io 0xf050-0xf057] Feb 2 12:21:25 rene systemd-networkd-wait-online[817]: message repeated 4 times: [ ignoring: lo] Feb 2 12:21:25 rene kernel: [ 0.073409] pci 0000:00:1f.2: reg 0x1c: [io 0xf040-0xf043] Feb 2 12:21:25 rene systemd[1]: Started Network Time Synchronization. Feb 2 12:21:25 rene kernel: [ 0.073416] pci 0000:00:1f.2: reg 0x20: [io 0xf020-0xf03f] Feb 2 12:21:25 rene systemd[1]: Reached target System Time Synchronized. Feb 2 12:21:25 rene kernel: [ 0.073423] pci 0000:00:1f.2: reg 0x24: [mem 0xfb305000-0xfb3057ff] Feb 2 12:21:25 rene kernel: [ 0.073459] pci 0000:00:1f.2: PME# supported from D3hot Feb 2 12:21:25 rene kernel: [ 0.073521] pci 0000:00:1f.3: [8086:1c22] type 00 class 0x0c0500 Feb 2 12:21:25 rene kernel: [ 0.073538] pci 0000:00:1f.3: reg 0x10: [mem 0xfb304000-0xfb3040ff 64bit] Feb 2 12:21:25 rene kernel: [ 0.073557] pci 0000:00:1f.3: reg 0x20: [io 0xf000-0xf01f] Feb 2 12:21:25 rene systemd-networkd-wait-online[817]: ignoring: lo Feb 2 12:21:25 rene kernel: [ 0.073654] pci 0000:01:00.0: [10de:0a23] type 00 class 0x030000 Feb 2 12:21:25 rene kernel: [ 0.073668] pci 0000:01:00.0: reg 0x10: [mem 0xfa000000-0xfaffffff] Feb 2 12:21:25 rene systemd-resolved[818]: Positive Trust Anchors: Feb 2 12:21:25 rene kernel: [ 0.073676] pci 0000:01:00.0: reg 0x14: [mem 0xc0000000-0xcfffffff 64bit pref] Feb 2 12:21:25 rene kernel: [ 0.073684] pci 0000:01:00.0: reg 0x1c: [mem 0xd0000000-0xd1ffffff 64bit pref] Feb 2 12:21:25 rene kernel: [ 0.073689] pci 0000:01:00.0: reg 0x24: [io 0xe000-0xe07f] Feb 2 12:21:25 rene kernel: [ 0.073694] pci 0000:01:00.0: reg 0x30: [mem 0xfb000000-0xfb07ffff pref] Feb 2 12:21:25 rene kernel: [ 0.073699] pci 0000:01:00.0: enabling Extended Tags Feb 2 12:21:25 rene systemd-resolved[818]: . IN DS 19036 8 2 49aac11d7b6f6446702e54a1607371607a1a41855200fd2ce1cdde32f24e8fb5 Feb 2 12:21:25 rene kernel: [ 0.073709] pci 0000:01:00.0: BAR 3: assigned to efifb Feb 2 12:21:25 rene kernel: [ 0.073769] pci 0000:01:00.1: [10de:0be2] type 00 class 0x040300 Feb 2 12:21:25 rene systemd-resolved[818]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Feb 2 12:21:25 rene kernel: [ 0.073779] pci 0000:01:00.1: reg 0x10: [mem 0xfb080000-0xfb083fff] Feb 2 12:21:25 rene kernel: [ 0.073802] pci 0000:01:00.1: enabling Extended Tags Feb 2 12:21:25 rene kernel: [ 0.084023] pci 0000:00:01.0: PCI bridge to [bus 01] Feb 2 12:21:25 rene kernel: [ 0.084031] pci 0000:00:01.0: bridge window [io 0xe000-0xefff] Feb 2 12:21:25 rene kernel: [ 0.084034] pci 0000:00:01.0: bridge window [mem 0xfa000000-0xfb0fffff] Feb 2 12:21:25 rene kernel: [ 0.084039] pci 0000:00:01.0: bridge window [mem 0xc0000000-0xd1ffffff 64bit pref] Feb 2 12:21:25 rene systemd-resolved[818]: Negative trust anchors: 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test Feb 2 12:21:25 rene kernel: [ 0.084094] pci 0000:00:1c.0: PCI bridge to [bus 02] Feb 2 12:21:25 rene systemd-resolved[818]: Using system hostname 'rene'. Feb 2 12:21:25 rene kernel: [ 0.084140] pci 0000:00:1c.1: PCI bridge to [bus 03] Feb 2 12:21:25 rene kernel: [ 0.084206] pci 0000:04:00.0: [18c3:0720] type 00 class 0x040000 Feb 2 12:21:25 rene kernel: [ 0.084240] pci 0000:04:00.0: reg 0x10: [mem 0xfb210000-0xfb21ffff] Feb 2 12:21:25 rene systemd[1]: Started Network Name Resolution. Feb 2 12:21:25 rene systemd[1]: Reached target Host and Network Name Lookups. Feb 2 12:21:25 rene systemd-networkd-wait-online[817]: ignoring: lo Feb 2 12:21:25 rene systemd-networkd[770]: enp6s0: Gained carrier Feb 2 12:21:25 rene systemd-networkd-wait-online[817]: ignoring: lo Feb 2 12:21:25 rene systemd-timesyncd[757]: Network configuration changed, trying to establish connection. Feb 2 12:21:25 rene systemd-networkd-wait-online[817]: ignoring: lo Feb 2 12:21:25 rene systemd-timesyncd[757]: Synchronized to time server 91.189.89.198:123 (ntp.ubuntu.com). Feb 2 12:21:25 rene systemd-udevd[517]: Process '/usr/sbin/alsactl -E HOME=/run/alsa restore 1' failed with exit code 99. Feb 2 12:21:25 rene systemd-udevd[512]: Process '/usr/bin/nvidia-smi' failed with exit code 11. Feb 2 12:21:25 rene systemd-udevd[517]: Process '/bin/systemctl stop --no-block nvidia-persistenced' failed with exit code 5. Feb 2 12:21:25 rene systemd-networkd[770]: enp6s0: Gained IPv6LL Feb 2 12:21:25 rene systemd-networkd[770]: enp6s0: Configured Feb 2 12:21:25 rene systemd-timesyncd[757]: Network configuration changed, trying to establish connection. Feb 2 12:21:25 rene systemd-networkd-wait-online[817]: ignoring: lo Feb 2 12:21:25 rene systemd-networkd-wait-online[817]: managing: enp6s0 Feb 2 12:21:25 rene systemd[1]: Started Wait for Network to be Configured. Feb 2 12:21:25 rene systemd[1]: Starting Initial cloud-init job (metadata service crawler)... Feb 2 12:21:25 rene systemd-timesyncd[757]: Synchronized to time server 91.189.89.198:123 (ntp.ubuntu.com). Feb 2 12:21:25 rene cloud-init[870]: Cloud-init v. 18.4-0ubuntu1~18.04.1 running 'init' at Sat, 02 Feb 2019 11:21:24 +0000. Up 11.73 seconds. Feb 2 12:21:25 rene cloud-init[870]: ci-info: +++++++++++++++++++++++++++++++++++++++Net device info+++++++++++++++++++++++++++++++++++++++ Feb 2 12:21:25 rene cloud-init[870]: ci-info: +--------+------+------------------------------+---------------+--------+-------------------+ Feb 2 12:21:25 rene cloud-init[870]: ci-info: | Device | Up | Address | Mask | Scope | Hw-Address | Feb 2 12:21:25 rene cloud-init[870]: ci-info: +--------+------+------------------------------+---------------+--------+-------------------+ Feb 2 12:21:25 rene kernel: [ 0.084260] pci 0000:04:00.0: reg 0x14: [mem 0xfb200000-0xfb20ffff 64bit] Feb 2 12:21:25 rene kernel: [ 0.096031] pci 0000:00:1c.2: PCI bridge to [bus 04] Feb 2 12:21:25 rene cloud-init[870]: ci-info: | enp6s0 | True | 192.168.0.2 | 255.255.255.0 | global | 38:60:77:03:23:62 | Feb 2 12:21:25 rene cloud-init[870]: ci-info: | enp6s0 | True | fe80::3a60:77ff:fe03:2362/64 | . | link | 38:60:77:03:23:62 | Feb 2 12:21:25 rene cloud-init[870]: ci-info: | lo | True | 127.0.0.1 | 255.0.0.0 | host | . | Feb 2 12:21:25 rene cloud-init[870]: ci-info: | lo | True | ::1/128 | . | host | . | Feb 2 12:21:25 rene kernel: [ 0.096044] pci 0000:00:1c.2: bridge window [mem 0xfb200000-0xfb2fffff] Feb 2 12:21:25 rene kernel: [ 0.096100] pci 0000:00:1c.3: PCI bridge to [bus 05] Feb 2 12:21:25 rene kernel: [ 0.096174] pci 0000:06:00.0: [10ec:8168] type 00 class 0x020000 Feb 2 12:21:25 rene kernel: [ 0.096208] pci 0000:06:00.0: reg 0x10: [io 0xd000-0xd0ff] Feb 2 12:21:25 rene kernel: [ 0.096240] pci 0000:06:00.0: reg 0x18: [mem 0xd2104000-0xd2104fff 64bit pref] Feb 2 12:21:25 rene kernel: [ 0.096260] pci 0000:06:00.0: reg 0x20: [mem 0xd2100000-0xd2103fff 64bit pref] Feb 2 12:21:25 rene cloud-init[870]: ci-info: +--------+------+------------------------------+---------------+--------+-------------------+ Feb 2 12:21:25 rene kernel: [ 0.096370] pci 0000:06:00.0: supports D1 D2 Feb 2 12:21:25 rene kernel: [ 0.096371] pci 0000:06:00.0: PME# supported from D0 D1 D2 D3hot D3cold Feb 2 12:21:25 rene kernel: [ 0.108033] pci 0000:00:1c.4: PCI bridge to [bus 06] Feb 2 12:21:25 rene kernel: [ 0.108043] pci 0000:00:1c.4: bridge window [io 0xd000-0xdfff] Feb 2 12:21:25 rene kernel: [ 0.108054] pci 0000:00:1c.4: bridge window [mem 0xd2100000-0xd21fffff 64bit pref] Feb 2 12:21:25 rene kernel: [ 0.108121] pci 0000:07:00.0: [104c:8241] type 00 class 0x0c0330 Feb 2 12:21:25 rene kernel: [ 0.108157] pci 0000:07:00.0: reg 0x10: [mem 0xfb100000-0xfb10ffff 64bit] Feb 2 12:21:25 rene kernel: [ 0.108176] pci 0000:07:00.0: reg 0x18: [mem 0xfb110000-0xfb111fff 64bit] Feb 2 12:21:25 rene kernel: [ 0.108289] pci 0000:07:00.0: supports D1 D2 Feb 2 12:21:25 rene kernel: [ 0.108290] pci 0000:07:00.0: PME# supported from D0 D1 D2 D3hot D3cold Feb 2 12:21:25 rene kernel: [ 0.120029] pci 0000:00:1c.5: PCI bridge to [bus 07] Feb 2 12:21:25 rene kernel: [ 0.120042] pci 0000:00:1c.5: bridge window [mem 0xfb100000-0xfb1fffff] Feb 2 12:21:25 rene kernel: [ 0.120095] pci 0000:00:1c.6: PCI bridge to [bus 08] Feb 2 12:21:25 rene kernel: [ 0.120140] pci 0000:00:1c.7: PCI bridge to [bus 09] Feb 2 12:21:25 rene kernel: [ 0.120507] ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 5 6 7 *10), disabled. Feb 2 12:21:25 rene kernel: [ 0.120569] ACPI: PCI Interrupt Link [LNKB] (IRQs *3 4 5 6 7 10 11 12 14 15), disabled. Feb 2 12:21:25 rene kernel: [ 0.120632] ACPI: PCI Interrupt Link [LNKC] (IRQs 3 *4 5 6 10 11 12 14 15), disabled. Feb 2 12:21:25 rene kernel: [ 0.120693] ACPI: PCI Interrupt Link [LNKD] (IRQs 3 4 5 6 10 *11 12 14 15), disabled. Feb 2 12:21:25 rene kernel: [ 0.120755] ACPI: PCI Interrupt Link [LNKE] (IRQs 3 4 5 6 7 10 11 12 14 15) *0, disabled. Feb 2 12:21:25 rene kernel: [ 0.120817] ACPI: PCI Interrupt Link [LNKF] (IRQs 3 4 5 6 7 10 11 12 14 15) *0, disabled. Feb 2 12:21:25 rene kernel: [ 0.120879] ACPI: PCI Interrupt Link [LNKG] (IRQs 3 4 *5 6 7 10 11 12 14 15), disabled. Feb 2 12:21:25 rene kernel: [ 0.120941] ACPI: PCI Interrupt Link [LNKH] (IRQs *11 12 14 15), disabled. Feb 2 12:21:25 rene kernel: [ 0.121161] SCSI subsystem initialized Feb 2 12:21:25 rene kernel: [ 0.121174] libata version 3.00 loaded. Feb 2 12:21:25 rene kernel: [ 0.121174] pci 0000:01:00.0: vgaarb: setting as boot VGA device Feb 2 12:21:25 rene kernel: [ 0.121174] pci 0000:01:00.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Feb 2 12:21:25 rene kernel: [ 0.121174] pci 0000:01:00.0: vgaarb: bridge control possible Feb 2 12:21:25 rene kernel: [ 0.121174] vgaarb: loaded Feb 2 12:21:25 rene kernel: [ 0.121174] ACPI: bus type USB registered Feb 2 12:21:25 rene kernel: [ 0.121174] usbcore: registered new interface driver usbfs Feb 2 12:21:25 rene kernel: [ 0.121174] usbcore: registered new interface driver hub Feb 2 12:21:25 rene kernel: [ 0.121174] usbcore: registered new device driver usb Feb 2 12:21:25 rene kernel: [ 0.121174] EDAC MC: Ver: 3.0.0 Feb 2 12:21:25 rene kernel: [ 0.121174] Registered efivars operations Feb 2 12:21:25 rene kernel: [ 0.149219] PCI: Using ACPI for IRQ routing Feb 2 12:21:25 rene kernel: [ 0.155105] PCI: pci_cache_line_size set to 64 bytes Feb 2 12:21:25 rene kernel: [ 0.155157] e820: reserve RAM buffer [mem 0xbf0ba000-0xbfffffff] Feb 2 12:21:25 rene kernel: [ 0.155159] e820: reserve RAM buffer [mem 0xbf35e000-0xbfffffff] Feb 2 12:21:25 rene kernel: [ 0.155160] e820: reserve RAM buffer [mem 0xbf800000-0xbfffffff] Feb 2 12:21:25 rene kernel: [ 0.155160] e820: reserve RAM buffer [mem 0x33f800000-0x33fffffff] Feb 2 12:21:25 rene kernel: [ 0.155226] NetLabel: Initializing Feb 2 12:21:25 rene kernel: [ 0.155228] NetLabel: domain hash size = 128 Feb 2 12:21:25 rene kernel: [ 0.155229] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO Feb 2 12:21:25 rene kernel: [ 0.155242] NetLabel: unlabeled traffic allowed by default Feb 2 12:21:25 rene kernel: [ 0.155255] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0, 0, 0, 0, 0, 0 Feb 2 12:21:25 rene kernel: [ 0.155255] hpet0: 8 comparators, 64-bit 14.318180 MHz counter Feb 2 12:21:25 rene kernel: [ 0.156004] clocksource: Switched to clocksource hpet Feb 2 12:21:25 rene kernel: [ 0.163867] VFS: Disk quotas dquot_6.6.0 Feb 2 12:21:25 rene kernel: [ 0.163867] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Feb 2 12:21:25 rene kernel: [ 0.163867] AppArmor: AppArmor Filesystem Enabled Feb 2 12:21:25 rene kernel: [ 0.163867] pnp: PnP ACPI init Feb 2 12:21:25 rene kernel: [ 0.163867] system 00:00: [mem 0xfed10000-0xfed19fff] has been reserved Feb 2 12:21:25 rene kernel: [ 0.163867] system 00:00: [mem 0xe0000000-0xefffffff] has been reserved Feb 2 12:21:25 rene kernel: [ 0.163867] system 00:00: [mem 0xfed90000-0xfed93fff] has been reserved Feb 2 12:21:25 rene kernel: [ 0.163867] system 00:00: [mem 0xfed20000-0xfed3ffff] has been reserved Feb 2 12:21:25 rene kernel: [ 0.163867] system 00:00: [mem 0xfee00000-0xfee0ffff] has been reserved Feb 2 12:21:25 rene kernel: [ 0.163867] system 00:00: Plug and Play ACPI device, IDs PNP0c01 (active) Feb 2 12:21:25 rene kernel: [ 0.163867] system 00:01: [io 0x0200-0x0201] has been reserved Feb 2 12:21:25 rene kernel: [ 0.163867] system 00:01: Plug and Play ACPI device, IDs PNP0c02 (active) Feb 2 12:21:25 rene kernel: [ 0.163867] pnp 00:02: Plug and Play ACPI device, IDs PNP0b00 (active) Feb 2 12:21:25 rene kernel: [ 0.163867] system 00:03: [io 0x04d0-0x04d1] has been reserved Feb 2 12:21:25 rene kernel: [ 0.163867] system 00:03: Plug and Play ACPI device, IDs PNP0c02 (active) Feb 2 12:21:25 rene kernel: [ 0.163867] system 00:04: [io 0x0400-0x0453] has been reserved Feb 2 12:21:25 rene kernel: [ 0.163867] system 00:04: [io 0x0458-0x047f] has been reserved Feb 2 12:21:25 rene kernel: [ 0.163867] system 00:04: [io 0x1180-0x119f] has been reserved Feb 2 12:21:25 rene kernel: [ 0.163867] system 00:04: [io 0x0500-0x057f] has been reserved Feb 2 12:21:25 rene kernel: [ 0.163867] system 00:04: [mem 0xfed1c000-0xfed1ffff] has been reserved Feb 2 12:21:25 rene kernel: [ 0.163867] system 00:04: [mem 0xfec00000-0xfecfffff] could not be reserved Feb 2 12:21:25 rene kernel: [ 0.163867] system 00:04: [mem 0xfed08000-0xfed08fff] has been reserved Feb 2 12:21:25 rene kernel: [ 0.163867] system 00:04: [mem 0xff000000-0xffffffff] has been reserved Feb 2 12:21:25 rene kernel: [ 0.163867] system 00:04: Plug and Play ACPI device, IDs PNP0c01 (active) Feb 2 12:21:25 rene kernel: [ 0.163867] system 00:05: [io 0x0454-0x0457] has been reserved Feb 2 12:21:25 rene kernel: [ 0.163867] system 00:05: Plug and Play ACPI device, IDs INT3f0d PNP0c02 (active) Feb 2 12:21:25 rene kernel: [ 0.163867] pnp: PnP ACPI: found 6 devices Feb 2 12:21:25 rene kernel: [ 0.170125] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Feb 2 12:21:25 rene kernel: [ 0.170125] pci 0000:00:01.0: PCI bridge to [bus 01] Feb 2 12:21:25 rene kernel: [ 0.170125] pci 0000:00:01.0: bridge window [io 0xe000-0xefff] Feb 2 12:21:25 rene kernel: [ 0.170125] pci 0000:00:01.0: bridge window [mem 0xfa000000-0xfb0fffff] Feb 2 12:21:25 rene kernel: [ 0.170125] pci 0000:00:01.0: bridge window [mem 0xc0000000-0xd1ffffff 64bit pref] Feb 2 12:21:25 rene kernel: [ 0.170125] pci 0000:00:1c.0: PCI bridge to [bus 02] Feb 2 12:21:25 rene kernel: [ 0.170125] pci 0000:00:1c.1: PCI bridge to [bus 03] Feb 2 12:21:25 rene kernel: [ 0.170125] pci 0000:00:1c.2: PCI bridge to [bus 04] Feb 2 12:21:25 rene kernel: [ 0.170125] pci 0000:00:1c.2: bridge window [mem 0xfb200000-0xfb2fffff] Feb 2 12:21:25 rene kernel: [ 0.170125] pci 0000:00:1c.3: PCI bridge to [bus 05] Feb 2 12:21:25 rene kernel: [ 0.170125] pci 0000:00:1c.4: PCI bridge to [bus 06] Feb 2 12:21:25 rene kernel: [ 0.170125] pci 0000:00:1c.4: bridge window [io 0xd000-0xdfff] Feb 2 12:21:25 rene kernel: [ 0.170125] pci 0000:00:1c.4: bridge window [mem 0xd2100000-0xd21fffff 64bit pref] Feb 2 12:21:25 rene kernel: [ 0.170125] pci 0000:00:1c.5: PCI bridge to [bus 07] Feb 2 12:21:25 rene kernel: [ 0.170125] pci 0000:00:1c.5: bridge window [mem 0xfb100000-0xfb1fffff] Feb 2 12:21:25 rene kernel: [ 0.170125] pci 0000:00:1c.6: PCI bridge to [bus 08] Feb 2 12:21:25 rene kernel: [ 0.170125] pci 0000:00:1c.7: PCI bridge to [bus 09] Feb 2 12:21:25 rene kernel: [ 0.170125] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Feb 2 12:21:25 rene kernel: [ 0.170125] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Feb 2 12:21:25 rene kernel: [ 0.170125] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Feb 2 12:21:25 rene kernel: [ 0.170125] pci_bus 0000:00: resource 7 [mem 0x000c8000-0x000dffff window] Feb 2 12:21:25 rene kernel: [ 0.170125] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xffffffff window] Feb 2 12:21:25 rene kernel: [ 0.170125] pci_bus 0000:01: resource 0 [io 0xe000-0xefff] Feb 2 12:21:25 rene kernel: [ 0.170125] pci_bus 0000:01: resource 1 [mem 0xfa000000-0xfb0fffff] Feb 2 12:21:25 rene kernel: [ 0.170125] pci_bus 0000:01: resource 2 [mem 0xc0000000-0xd1ffffff 64bit pref] Feb 2 12:21:25 rene kernel: [ 0.170125] pci_bus 0000:04: resource 1 [mem 0xfb200000-0xfb2fffff] Feb 2 12:21:25 rene kernel: [ 0.170125] pci_bus 0000:06: resource 0 [io 0xd000-0xdfff] Feb 2 12:21:25 rene kernel: [ 0.170125] pci_bus 0000:06: resource 2 [mem 0xd2100000-0xd21fffff 64bit pref] Feb 2 12:21:25 rene kernel: [ 0.170125] pci_bus 0000:07: resource 1 [mem 0xfb100000-0xfb1fffff] Feb 2 12:21:25 rene kernel: [ 0.170125] NET: Registered protocol family 2 Feb 2 12:21:25 rene kernel: [ 0.170125] TCP established hash table entries: 131072 (order: 8, 1048576 bytes) Feb 2 12:21:25 rene kernel: [ 0.170125] TCP bind hash table entries: 65536 (order: 8, 1048576 bytes) Feb 2 12:21:25 rene kernel: [ 0.170125] TCP: Hash tables configured (established 131072 bind 65536) Feb 2 12:21:25 rene kernel: [ 0.170125] UDP hash table entries: 8192 (order: 6, 262144 bytes) Feb 2 12:21:25 rene kernel: [ 0.170125] UDP-Lite hash table entries: 8192 (order: 6, 262144 bytes) Feb 2 12:21:25 rene kernel: [ 0.170125] NET: Registered protocol family 1 Feb 2 12:21:25 rene kernel: [ 0.412112] pci 0000:01:00.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Feb 2 12:21:25 rene kernel: [ 0.412247] PCI: CLS 64 bytes, default 64 Feb 2 12:21:25 rene kernel: [ 0.412276] Unpacking initramfs... Feb 2 12:21:25 rene kernel: [ 1.060745] Freeing initrd memory: 57956K Feb 2 12:21:25 rene kernel: [ 1.060796] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) Feb 2 12:21:25 rene kernel: [ 1.060800] software IO TLB [mem 0xbb0ba000-0xbf0ba000] (64MB) mapped at [ (ptrval)- (ptrval)] Feb 2 12:21:25 rene kernel: [ 1.061107] Scanning for low memory corruption every 60 seconds Feb 2 12:21:25 rene kernel: [ 1.061621] Initialise system trusted keyrings Feb 2 12:21:25 rene kernel: [ 1.061631] Key type blacklist registered Feb 2 12:21:25 rene kernel: [ 1.061658] workingset: timestamp_bits=36 max_order=22 bucket_order=0 Feb 2 12:21:25 rene kernel: [ 1.062476] zbud: loaded Feb 2 12:21:25 rene kernel: [ 1.062829] squashfs: version 4.0 (2009/01/31) Phillip Lougher Feb 2 12:21:25 rene kernel: [ 1.062926] fuse init (API version 7.26) Feb 2 12:21:25 rene kernel: [ 1.063968] Key type asymmetric registered Feb 2 12:21:25 rene kernel: [ 1.063970] Asymmetric key parser 'x509' registered Feb 2 12:21:25 rene kernel: [ 1.063992] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 246) Feb 2 12:21:25 rene kernel: [ 1.064038] io scheduler noop registered Feb 2 12:21:25 rene kernel: [ 1.064041] io scheduler deadline registered Feb 2 12:21:25 rene kernel: [ 1.064076] io scheduler cfq registered (default) Feb 2 12:21:25 rene kernel: [ 1.064964] efifb: probing for efifb Feb 2 12:21:25 rene kernel: [ 1.064972] efifb: framebuffer at 0xd1000000, using 1920k, total 1920k Feb 2 12:21:25 rene kernel: [ 1.064975] efifb: mode is 800x600x32, linelength=3200, pages=1 Feb 2 12:21:25 rene kernel: [ 1.064976] efifb: scrolling: redraw Feb 2 12:21:25 rene kernel: [ 1.064978] efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Feb 2 12:21:25 rene kernel: [ 1.065999] Console: switching to colour frame buffer device 100x37 Feb 2 12:21:25 rene kernel: [ 1.066958] fb0: EFI VGA frame buffer device Feb 2 12:21:25 rene kernel: [ 1.066979] intel_idle: MWAIT substates: 0x1120 Feb 2 12:21:25 rene kernel: [ 1.066980] intel_idle: v0.4.1 model 0x2A Feb 2 12:21:25 rene kernel: [ 1.067175] intel_idle: lapic_timer_reliable_states 0xffffffff Feb 2 12:21:25 rene kernel: [ 1.067234] input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Feb 2 12:21:25 rene kernel: [ 1.067284] ACPI: Power Button [PWRB] Feb 2 12:21:25 rene kernel: [ 1.067323] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input1 Feb 2 12:21:25 rene kernel: [ 1.067361] ACPI: Power Button [PWRF] Feb 2 12:21:25 rene kernel: [ 1.068388] Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled Feb 2 12:21:25 rene kernel: [ 1.069923] Linux agpgart interface v0.103 Feb 2 12:21:25 rene kernel: [ 1.071320] loop: module loaded Feb 2 12:21:25 rene kernel: [ 1.071447] libphy: Fixed MDIO Bus: probed Feb 2 12:21:25 rene kernel: [ 1.071462] tun: Universal TUN/TAP device driver, 1.6 Feb 2 12:21:25 rene kernel: [ 1.071501] PPP generic driver version 2.4.2 Feb 2 12:21:25 rene kernel: [ 1.071543] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver Feb 2 12:21:25 rene kernel: [ 1.072099] ehci-pci: EHCI PCI platform driver Feb 2 12:21:25 rene kernel: [ 1.072705] ehci-pci 0000:00:1a.0: EHCI Host Controller Feb 2 12:21:25 rene kernel: [ 1.073244] ehci-pci 0000:00:1a.0: new USB bus registered, assigned bus number 1 Feb 2 12:21:25 rene kernel: [ 1.073789] ehci-pci 0000:00:1a.0: debug port 2 Feb 2 12:21:25 rene kernel: [ 1.078202] ehci-pci 0000:00:1a.0: cache line size of 64 is not supported Feb 2 12:21:25 rene kernel: [ 1.078211] ehci-pci 0000:00:1a.0: irq 16, io mem 0xfb307000 Feb 2 12:21:25 rene kernel: [ 1.092061] ehci-pci 0000:00:1a.0: USB 2.0 started, EHCI 1.00 Feb 2 12:21:25 rene kernel: [ 1.092621] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 Feb 2 12:21:25 rene kernel: [ 1.093144] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Feb 2 12:21:25 rene kernel: [ 1.093665] usb usb1: Product: EHCI Host Controller Feb 2 12:21:25 rene kernel: [ 1.094174] usb usb1: Manufacturer: Linux 4.15.0-45-generic ehci_hcd Feb 2 12:21:25 rene kernel: [ 1.094689] usb usb1: SerialNumber: 0000:00:1a.0 Feb 2 12:21:25 rene kernel: [ 1.095344] hub 1-0:1.0: USB hub found Feb 2 12:21:25 rene kernel: [ 1.095860] hub 1-0:1.0: 2 ports detected Feb 2 12:21:25 rene kernel: [ 1.096524] ehci-pci 0000:00:1d.0: EHCI Host Controller Feb 2 12:21:25 rene kernel: [ 1.097027] ehci-pci 0000:00:1d.0: new USB bus registered, assigned bus number 2 Feb 2 12:21:25 rene kernel: [ 1.097535] ehci-pci 0000:00:1d.0: debug port 2 Feb 2 12:21:25 rene kernel: [ 1.101913] ehci-pci 0000:00:1d.0: cache line size of 64 is not supported Feb 2 12:21:25 rene kernel: [ 1.101920] ehci-pci 0000:00:1d.0: irq 23, io mem 0xfb306000 Feb 2 12:21:25 rene kernel: [ 1.116053] ehci-pci 0000:00:1d.0: USB 2.0 started, EHCI 1.00 Feb 2 12:21:25 rene kernel: [ 1.116606] usb usb2: New USB device found, idVendor=1d6b, idProduct=0002 Feb 2 12:21:25 rene kernel: [ 1.117114] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Feb 2 12:21:25 rene kernel: [ 1.117622] usb usb2: Product: EHCI Host Controller Feb 2 12:21:25 rene kernel: [ 1.118122] usb usb2: Manufacturer: Linux 4.15.0-45-generic ehci_hcd Feb 2 12:21:25 rene kernel: [ 1.118627] usb usb2: SerialNumber: 0000:00:1d.0 Feb 2 12:21:25 rene kernel: [ 1.119268] hub 2-0:1.0: USB hub found Feb 2 12:21:25 rene kernel: [ 1.119772] hub 2-0:1.0: 2 ports detected Feb 2 12:21:25 rene kernel: [ 1.120357] ehci-platform: EHCI generic platform driver Feb 2 12:21:25 rene kernel: [ 1.120845] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver Feb 2 12:21:25 rene kernel: [ 1.121325] ohci-pci: OHCI PCI platform driver Feb 2 12:21:25 rene kernel: [ 1.121799] ohci-platform: OHCI generic platform driver Feb 2 12:21:25 rene kernel: [ 1.122265] uhci_hcd: USB Universal Host Controller Interface driver Feb 2 12:21:25 rene kernel: [ 1.122796] xhci_hcd 0000:07:00.0: xHCI Host Controller Feb 2 12:21:25 rene kernel: [ 1.123263] xhci_hcd 0000:07:00.0: new USB bus registered, assigned bus number 3 Feb 2 12:21:25 rene kernel: [ 1.123889] xhci_hcd 0000:07:00.0: hcc params 0x0270f06d hci version 0x96 quirks 0x0000000004000000 Feb 2 12:21:25 rene kernel: [ 1.125074] usb usb3: New USB device found, idVendor=1d6b, idProduct=0002 Feb 2 12:21:25 rene kernel: [ 1.125572] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Feb 2 12:21:25 rene kernel: [ 1.126066] usb usb3: Product: xHCI Host Controller Feb 2 12:21:25 rene kernel: [ 1.126551] usb usb3: Manufacturer: Linux 4.15.0-45-generic xhci-hcd Feb 2 12:21:25 rene kernel: [ 1.127043] usb usb3: SerialNumber: 0000:07:00.0 Feb 2 12:21:25 rene kernel: [ 1.127669] hub 3-0:1.0: USB hub found Feb 2 12:21:25 rene kernel: [ 1.128175] hub 3-0:1.0: 2 ports detected Feb 2 12:21:25 rene kernel: [ 1.128727] xhci_hcd 0000:07:00.0: xHCI Host Controller Feb 2 12:21:25 rene kernel: [ 1.129216] xhci_hcd 0000:07:00.0: new USB bus registered, assigned bus number 4 Feb 2 12:21:25 rene kernel: [ 1.129710] xhci_hcd 0000:07:00.0: Host supports USB 3.0 SuperSpeed Feb 2 12:21:25 rene kernel: [ 1.130212] usb usb4: We don't know the algorithms for LPM for this host, disabling LPM. Feb 2 12:21:25 rene kernel: [ 1.130725] usb usb4: New USB device found, idVendor=1d6b, idProduct=0003 Feb 2 12:21:25 rene kernel: [ 1.131227] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Feb 2 12:21:25 rene kernel: [ 1.131730] usb usb4: Product: xHCI Host Controller Feb 2 12:21:25 rene kernel: [ 1.132238] usb usb4: Manufacturer: Linux 4.15.0-45-generic xhci-hcd Feb 2 12:21:25 rene kernel: [ 1.132750] usb usb4: SerialNumber: 0000:07:00.0 Feb 2 12:21:25 rene kernel: [ 1.133392] hub 4-0:1.0: USB hub found Feb 2 12:21:25 rene kernel: [ 1.133905] hub 4-0:1.0: 2 ports detected Feb 2 12:21:25 rene kernel: [ 1.134490] i8042: PNP: No PS/2 controller found. Feb 2 12:21:25 rene kernel: [ 1.135180] mousedev: PS/2 mouse device common for all mice Feb 2 12:21:25 rene kernel: [ 1.135866] rtc_cmos 00:02: RTC can wake from S4 Feb 2 12:21:25 rene kernel: [ 1.136520] rtc_cmos 00:02: rtc core: registered rtc_cmos as rtc0 Feb 2 12:21:25 rene kernel: [ 1.137049] rtc_cmos 00:02: alarms up to one month, y3k, 114 bytes nvram, hpet irqs Feb 2 12:21:25 rene kernel: [ 1.137561] i2c /dev entries driver Feb 2 12:21:25 rene kernel: [ 1.138067] pcie_mp2_amd: AMD(R) PCI-E MP2 Communication Driver Version: 1.0 Feb 2 12:21:25 rene kernel: [ 1.138627] device-mapper: uevent: version 1.0.3 Feb 2 12:21:25 rene kernel: [ 1.139225] device-mapper: ioctl: 4.37.0-ioctl (2017-09-20) initialised: dm-devel@redhat.com Feb 2 12:21:25 rene kernel: [ 1.139770] intel_pstate: Intel P-state driver initializing Feb 2 12:21:25 rene kernel: [ 1.140901] ledtrig-cpu: registered to indicate activity on CPUs Feb 2 12:21:25 rene kernel: [ 1.141420] EFI Variables Facility v0.08 2004-May-17 Feb 2 12:21:25 rene kernel: [ 1.356585] NET: Registered protocol family 10 Feb 2 12:21:25 rene kernel: [ 1.360464] Segment Routing with IPv6 Feb 2 12:21:25 rene kernel: [ 1.360990] NET: Registered protocol family 17 Feb 2 12:21:25 rene kernel: [ 1.361588] Key type dns_resolver registered Feb 2 12:21:25 rene kernel: [ 1.362669] RAS: Correctable Errors collector initialized. Feb 2 12:21:25 rene kernel: [ 1.363191] microcode: sig=0x206a7, pf=0x2, revision=0x2e Feb 2 12:21:25 rene kernel: [ 1.363848] microcode: Microcode Update Driver: v2.2. Feb 2 12:21:25 rene kernel: [ 1.363855] sched_clock: Marking stable (1363844586, 0)->(1534315489, -170470903) Feb 2 12:21:25 rene kernel: [ 1.365087] registered taskstats version 1 Feb 2 12:21:25 rene kernel: [ 1.365598] Loading compiled-in X.509 certificates Feb 2 12:21:25 rene kernel: [ 1.367953] Loaded X.509 cert 'Build time autogenerated kernel key: e3b8f44ffaaceef3e3a84cfaebd8e5a9acebeaad' Feb 2 12:21:25 rene kernel: [ 1.385356] Couldn't get size: 0x800000000000000e Feb 2 12:21:25 rene kernel: [ 1.385876] MODSIGN: Couldn't get UEFI db list Feb 2 12:21:25 rene kernel: [ 1.394567] Couldn't get size: 0x800000000000000e Feb 2 12:21:25 rene kernel: [ 1.395078] MODSIGN: Couldn't get UEFI MokListRT Feb 2 12:21:25 rene kernel: [ 1.403758] Couldn't get size: 0x800000000000000e Feb 2 12:21:25 rene kernel: [ 1.404286] MODSIGN: Couldn't get UEFI dbx list Feb 2 12:21:25 rene kernel: [ 1.404792] zswap: loaded using pool lzo/zbud Feb 2 12:21:25 rene kernel: [ 1.407628] Key type big_key registered Feb 2 12:21:25 rene kernel: [ 1.408145] Key type trusted registered Feb 2 12:21:25 rene kernel: [ 1.409730] Key type encrypted registered Feb 2 12:21:25 rene kernel: [ 1.410220] AppArmor: AppArmor sha1 policy hashing enabled Feb 2 12:21:25 rene kernel: [ 1.410715] ima: No TPM chip found, activating TPM-bypass! (rc=-19) Feb 2 12:21:25 rene kernel: [ 1.411221] ima: Allocated hash algorithm: sha1 Feb 2 12:21:25 rene kernel: [ 1.411734] evm: HMAC attrs: 0x1 Feb 2 12:21:25 rene kernel: [ 1.412499] Magic number: 7:113:377 Feb 2 12:21:25 rene kernel: [ 1.413105] rtc_cmos 00:02: setting system clock to 2019-02-02 11:21:13 UTC (1549106473) Feb 2 12:21:25 rene kernel: [ 1.413768] BIOS EDD facility v0.16 2004-Jun-25, 0 devices found Feb 2 12:21:25 rene kernel: [ 1.414281] EDD information not available. Feb 2 12:21:25 rene kernel: [ 1.416501] Freeing unused kernel memory: 2408K Feb 2 12:21:25 rene kernel: [ 1.456066] Write protecting the kernel read-only data: 20480k Feb 2 12:21:25 rene kernel: [ 1.457121] Freeing unused kernel memory: 2008K Feb 2 12:21:25 rene kernel: [ 1.460601] Freeing unused kernel memory: 1892K Feb 2 12:21:25 rene kernel: [ 1.465881] x86/mm: Checked W+X mappings: passed, no W+X pages found. Feb 2 12:21:25 rene kernel: [ 1.466341] x86/mm: Checking user space page tables Feb 2 12:21:25 rene kernel: [ 1.471427] x86/mm: Checked W+X mappings: passed, no W+X pages found. Feb 2 12:21:25 rene kernel: [ 1.529412] i801_smbus 0000:00:1f.3: enabling device (0101 -> 0103) Feb 2 12:21:25 rene kernel: [ 1.530186] r8169 Gigabit Ethernet driver 2.3LK-NAPI loaded Feb 2 12:21:25 rene kernel: [ 1.530255] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Feb 2 12:21:25 rene kernel: [ 1.531518] r8169 0000:06:00.0: can't disable ASPM; OS doesn't have ASPM control Feb 2 12:21:25 rene kernel: [ 1.532289] ahci 0000:00:1f.2: version 3.0 Feb 2 12:21:25 rene kernel: [ 1.532488] ahci 0000:00:1f.2: AHCI 0001.0300 32 slots 6 ports 6 Gbps 0x3f impl SATA mode Feb 2 12:21:25 rene kernel: [ 1.532644] r8169 0000:06:00.0 eth0: RTL8168e/8111e at 0x (ptrval), 38:60:77:03:23:62, XID 0c200000 IRQ 33 Feb 2 12:21:25 rene kernel: [ 1.532646] r8169 0000:06:00.0 eth0: jumbo features [frames: 9200 bytes, tx checksumming: ko] Feb 2 12:21:25 rene kernel: [ 1.535472] ahci 0000:00:1f.2: flags: 64bit ncq sntf pm led clo pio slum part ems apst Feb 2 12:21:25 rene kernel: [ 1.542705] AVX version of gcm_enc/dec engaged. Feb 2 12:21:25 rene kernel: [ 1.543476] AES CTR mode by8 optimization enabled Feb 2 12:21:25 rene kernel: [ 1.554501] r8169 0000:06:00.0 enp6s0: renamed from eth0 Feb 2 12:21:25 rene kernel: [ 1.588056] usb 1-1: new high-speed USB device number 2 using ehci-pci Feb 2 12:21:25 rene kernel: [ 1.588611] usb 2-1: new high-speed USB device number 2 using ehci-pci Feb 2 12:21:25 rene kernel: [ 1.604503] scsi host0: ahci Feb 2 12:21:25 rene kernel: [ 1.605093] scsi host1: ahci Feb 2 12:21:25 rene kernel: [ 1.605666] scsi host2: ahci Feb 2 12:21:25 rene kernel: [ 1.606233] scsi host3: ahci Feb 2 12:21:25 rene kernel: [ 1.606785] scsi host4: ahci Feb 2 12:21:25 rene kernel: [ 1.607343] scsi host5: ahci Feb 2 12:21:25 rene kernel: [ 1.607854] ata1: SATA max UDMA/133 abar m2048@0xfb305000 port 0xfb305100 irq 32 Feb 2 12:21:25 rene kernel: [ 1.608372] ata2: SATA max UDMA/133 abar m2048@0xfb305000 port 0xfb305180 irq 32 Feb 2 12:21:25 rene kernel: [ 1.608852] ata3: SATA max UDMA/133 abar m2048@0xfb305000 port 0xfb305200 irq 32 Feb 2 12:21:25 rene kernel: [ 1.609326] ata4: SATA max UDMA/133 abar m2048@0xfb305000 port 0xfb305280 irq 32 Feb 2 12:21:25 rene kernel: [ 1.609797] ata5: SATA max UDMA/133 abar m2048@0xfb305000 port 0xfb305300 irq 32 Feb 2 12:21:25 rene kernel: [ 1.610253] ata6: SATA max UDMA/133 abar m2048@0xfb305000 port 0xfb305380 irq 32 Feb 2 12:21:25 rene kernel: [ 1.744505] usb 2-1: New USB device found, idVendor=8087, idProduct=0024 Feb 2 12:21:25 rene kernel: [ 1.744947] usb 2-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 Feb 2 12:21:25 rene kernel: [ 1.745413] usb 1-1: New USB device found, idVendor=8087, idProduct=0024 Feb 2 12:21:25 rene kernel: [ 1.745849] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 Feb 2 12:21:25 rene kernel: [ 1.746449] hub 2-1:1.0: USB hub found Feb 2 12:21:25 rene kernel: [ 1.746927] hub 1-1:1.0: USB hub found Feb 2 12:21:25 rene kernel: [ 1.747371] hub 2-1:1.0: 8 ports detected Feb 2 12:21:25 rene kernel: [ 1.747793] hub 1-1:1.0: 6 ports detected Feb 2 12:21:25 rene kernel: [ 1.922915] ata6: SATA link down (SStatus 0 SControl 300) Feb 2 12:21:25 rene kernel: [ 1.923392] ata4: SATA link down (SStatus 0 SControl 300) Feb 2 12:21:25 rene kernel: [ 1.923844] ata5: SATA link up 3.0 Gbps (SStatus 123 SControl 300) Feb 2 12:21:25 rene kernel: [ 1.924307] ata3: SATA link down (SStatus 0 SControl 300) Feb 2 12:21:25 rene kernel: [ 1.924891] ata2: SATA link up 3.0 Gbps (SStatus 123 SControl 300) Feb 2 12:21:25 rene kernel: [ 1.925826] ata5.00: ATA-8: Hitachi HDS722020ALA330, JKAOA20N, max UDMA/133 Feb 2 12:21:25 rene kernel: [ 1.926262] ata5.00: 3907029168 sectors, multi 16: LBA48 NCQ (depth 31/32), AA Feb 2 12:21:25 rene kernel: [ 1.926942] ata1: SATA link down (SStatus 0 SControl 300) Feb 2 12:21:25 rene kernel: [ 1.928396] ata5.00: configured for UDMA/133 Feb 2 12:21:25 rene kernel: [ 1.978437] ata2.00: ATA-8: ADATA SSD S599 64GB, 3.1.0, max UDMA/133 Feb 2 12:21:25 rene kernel: [ 1.978855] ata2.00: 117231408 sectors, multi 16: LBA48 NCQ (depth 31/32), AA Feb 2 12:21:25 rene kernel: [ 2.028521] ata2.00: configured for UDMA/133 Feb 2 12:21:25 rene kernel: [ 2.029128] scsi 1:0:0:0: Direct-Access ATA ADATA SSD S599 6 0 PQ: 0 ANSI: 5 Feb 2 12:21:25 rene kernel: [ 2.029817] sd 1:0:0:0: Attached scsi generic sg0 type 0 Feb 2 12:21:25 rene kernel: [ 2.030139] sd 1:0:0:0: [sda] 117231408 512-byte logical blocks: (60.0 GB/55.9 GiB) Feb 2 12:21:25 rene kernel: [ 2.030192] sd 1:0:0:0: [sda] Write Protect is off Feb 2 12:21:25 rene kernel: [ 2.030194] sd 1:0:0:0: [sda] Mode Sense: 00 3a 00 00 Feb 2 12:21:25 rene kernel: [ 2.030295] sd 1:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Feb 2 12:21:25 rene kernel: [ 2.032421] scsi 4:0:0:0: Direct-Access ATA Hitachi HDS72202 A20N PQ: 0 ANSI: 5 Feb 2 12:21:25 rene kernel: [ 2.032943] sda: sda1 sda2 Feb 2 12:21:25 rene kernel: [ 2.033001] sd 4:0:0:0: Attached scsi generic sg1 type 0 Feb 2 12:21:25 rene kernel: [ 2.033127] sd 4:0:0:0: [sdb] 3907029168 512-byte logical blocks: (2.00 TB/1.82 TiB) Feb 2 12:21:25 rene kernel: [ 2.033145] sd 4:0:0:0: [sdb] Write Protect is off Feb 2 12:21:25 rene kernel: [ 2.033146] sd 4:0:0:0: [sdb] Mode Sense: 00 3a 00 00 Feb 2 12:21:25 rene kernel: [ 2.033208] sd 4:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Feb 2 12:21:25 rene kernel: [ 2.036028] usb 2-1.1: new full-speed USB device number 3 using ehci-pci Feb 2 12:21:25 rene kernel: [ 2.036039] sd 1:0:0:0: [sda] Attached SCSI disk Feb 2 12:21:25 rene kernel: [ 2.043971] sdb: sdb1 < sdb5 > Feb 2 12:21:25 rene kernel: [ 2.045171] sd 4:0:0:0: [sdb] Attached SCSI disk Feb 2 12:21:25 rene kernel: [ 2.080032] tsc: Refined TSC clocksource calibration: 3392.297 MHz Feb 2 12:21:25 rene kernel: [ 2.080638] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x30e5e240547, max_idle_ns: 440795346476 ns Feb 2 12:21:25 rene kernel: [ 2.152782] usb 2-1.1: New USB device found, idVendor=24ae, idProduct=1005 Feb 2 12:21:25 rene kernel: [ 2.153363] usb 2-1.1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Feb 2 12:21:25 rene kernel: [ 2.153916] usb 2-1.1: Product: Rapoo 2.4G Wireless Touchpad Keyboard Feb 2 12:21:25 rene kernel: [ 2.154473] usb 2-1.1: Manufacturer: RAPOO Feb 2 12:21:25 rene kernel: [ 2.158229] hidraw: raw HID events driver (C) Jiri Kosina Feb 2 12:21:25 rene kernel: [ 2.163832] usbcore: registered new interface driver usbhid Feb 2 12:21:25 rene kernel: [ 2.164494] usbhid: USB HID core driver Feb 2 12:21:25 rene kernel: [ 2.166705] input: RAPOO Rapoo 2.4G Wireless Touchpad Keyboard as /devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.1/2-1.1:1.0/0003:24AE:1005.0001/input/input2 Feb 2 12:21:25 rene kernel: [ 2.168025] hid-generic 0003:24AE:1005.0001: input,hidraw0: USB HID v1.10 Mouse [RAPOO Rapoo 2.4G Wireless Touchpad Keyboard] on usb-0000:00:1d.0-1.1/input0 Feb 2 12:21:25 rene kernel: [ 2.169425] input: RAPOO Rapoo 2.4G Wireless Touchpad Keyboard as /devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.1/2-1.1:1.1/0003:24AE:1005.0002/input/input3 Feb 2 12:21:25 rene kernel: [ 2.228298] hid-generic 0003:24AE:1005.0002: input,hiddev0,hidraw1: USB HID v1.10 Device [RAPOO Rapoo 2.4G Wireless Touchpad Keyboard] on usb-0000:00:1d.0-1.1/input1 Feb 2 12:21:25 rene kernel: [ 2.229782] input: RAPOO Rapoo 2.4G Wireless Touchpad Keyboard as /devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.1/2-1.1:1.2/0003:24AE:1005.0003/input/input4 Feb 2 12:21:25 rene kernel: [ 2.288277] hid-generic 0003:24AE:1005.0003: input,hidraw2: USB HID v1.10 Keyboard [RAPOO Rapoo 2.4G Wireless Touchpad Keyboard] on usb-0000:00:1d.0-1.1/input2 Feb 2 12:21:25 rene kernel: [ 3.104254] clocksource: Switched to clocksource tsc Feb 2 12:21:25 rene kernel: [ 3.428023] raid6: sse2x1 gen() 10999 MB/s Feb 2 12:21:25 rene kernel: [ 3.476018] raid6: sse2x1 xor() 7635 MB/s Feb 2 12:21:25 rene kernel: [ 3.524022] raid6: sse2x2 gen() 13082 MB/s Feb 2 12:21:25 rene kernel: [ 3.572022] raid6: sse2x2 xor() 8881 MB/s Feb 2 12:21:25 rene kernel: [ 3.620020] raid6: sse2x4 gen() 15540 MB/s Feb 2 12:21:25 rene kernel: [ 3.668020] raid6: sse2x4 xor() 10406 MB/s Feb 2 12:21:25 rene kernel: [ 3.668647] raid6: using algorithm sse2x4 gen() 15540 MB/s Feb 2 12:21:25 rene kernel: [ 3.669258] raid6: .... xor() 10406 MB/s, rmw enabled Feb 2 12:21:25 rene kernel: [ 3.669864] raid6: using ssse3x2 recovery algorithm Feb 2 12:21:25 rene kernel: [ 3.671423] xor: automatically using best checksumming function avx Feb 2 12:21:25 rene kernel: [ 3.672908] async_tx: api initialized (async) Feb 2 12:21:25 rene kernel: [ 3.711699] Btrfs loaded, crc32c=crc32c-intel Feb 2 12:21:25 rene kernel: [ 3.720737] random: fast init done Feb 2 12:21:25 rene kernel: [ 3.738166] random: wait-for-root: uninitialized urandom read (16 bytes read) Feb 2 12:21:25 rene kernel: [ 3.738796] random: wait-for-root: uninitialized urandom read (16 bytes read) Feb 2 12:21:25 rene kernel: [ 3.739391] random: wait-for-root: uninitialized urandom read (16 bytes read) Feb 2 12:21:25 rene kernel: [ 3.748963] EXT4-fs (sda2): mounted filesystem with ordered data mode. Opts: (null) Feb 2 12:21:25 rene kernel: [ 3.892469] ip_tables: (C) 2000-2006 Netfilter Core Team Feb 2 12:21:25 rene kernel: [ 4.572868] systemd[1]: systemd 237 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid) Feb 2 12:21:25 rene kernel: [ 4.592381] systemd[1]: Detected architecture x86-64. Feb 2 12:21:25 rene kernel: [ 4.598328] systemd[1]: Set hostname to . Feb 2 12:21:25 rene kernel: [ 4.756918] systemd[1]: Reached target User and Group Name Lookups. Feb 2 12:21:25 rene kernel: [ 4.758788] systemd[1]: Created slice System Slice. Feb 2 12:21:25 rene kernel: [ 4.759908] systemd[1]: Listening on Journal Socket. Feb 2 12:21:25 rene kernel: [ 4.761595] systemd[1]: Mounting Huge Pages File System... Feb 2 12:21:25 rene kernel: [ 4.762773] systemd[1]: Listening on udev Kernel Socket. Feb 2 12:21:25 rene kernel: [ 4.763976] systemd[1]: Listening on Journal Socket (/dev/log). Feb 2 12:21:25 rene kernel: [ 4.765235] systemd[1]: Listening on Network Service Netlink Socket. Feb 2 12:21:25 rene kernel: [ 4.788709] EXT4-fs (sda2): re-mounted. Opts: (null) Feb 2 12:21:25 rene kernel: [ 4.805673] RPC: Registered named UNIX socket transport module. Feb 2 12:21:25 rene kernel: [ 4.806496] RPC: Registered udp transport module. Feb 2 12:21:25 rene kernel: [ 4.806496] RPC: Registered tcp transport module. Feb 2 12:21:25 rene kernel: [ 4.806497] RPC: Registered tcp NFSv4.1 backchannel transport module. Feb 2 12:21:25 rene kernel: [ 4.823755] Installing knfsd (copyright (C) 1996 okir@monad.swb.de). Feb 2 12:21:25 rene kernel: [ 4.835738] Loading iSCSI transport class v2.0-870. Feb 2 12:21:25 rene kernel: [ 4.840812] iscsi: registered transport (tcp) Feb 2 12:21:25 rene kernel: [ 4.855101] iscsi: registered transport (iser) Feb 2 12:21:25 rene kernel: [ 4.978695] systemd-journald[460]: Received request to flush runtime journal from PID 1 Feb 2 12:21:25 rene kernel: [ 4.981991] Adding 4194300k swap on /swap.img. Priority:-2 extents:7 across:4726780k SSFS Feb 2 12:21:25 rene kernel: [ 5.424504] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 Feb 2 12:21:25 rene kernel: [ 5.424650] RAPL PMU: API unit is 2^-32 Joules, 3 fixed counters, 163840 ms ovfl timer Feb 2 12:21:25 rene kernel: [ 5.424651] RAPL PMU: hw unit of domain pp0-core 2^-16 Joules Feb 2 12:21:25 rene kernel: [ 5.424652] RAPL PMU: hw unit of domain package 2^-16 Joules Feb 2 12:21:25 rene kernel: [ 5.424653] RAPL PMU: hw unit of domain pp1-gpu 2^-16 Joules Feb 2 12:21:25 rene kernel: [ 5.555969] kvm: disabled by bios Feb 2 12:21:25 rene kernel: [ 5.709154] snd_hda_intel 0000:00:1b.0: enabling device (0100 -> 0102) Feb 2 12:21:25 rene kernel: [ 5.709389] snd_hda_intel 0000:01:00.1: enabling device (0100 -> 0102) Feb 2 12:21:25 rene kernel: [ 5.709428] snd_hda_intel 0000:01:00.1: Disabling MSI Feb 2 12:21:25 rene kernel: [ 5.709434] snd_hda_intel 0000:01:00.1: Handle vga_switcheroo audio client Feb 2 12:21:25 rene kernel: [ 5.712379] gpio_ich: GPIO from 436 to 511 on gpio_ich Feb 2 12:21:25 rene kernel: [ 5.713080] cxd2099: module is from the staging directory, the quality is unknown, you have been warned. Feb 2 12:21:25 rene kernel: [ 5.713098] cxd2099: module verification failed: signature and/or required key missing - tainting kernel Feb 2 12:21:25 rene kernel: [ 5.728288] nGene PCIE bridge driver, Copyright (C) 2005-2007 Micronas Feb 2 12:21:25 rene kernel: [ 5.728317] ngene 0000:04:00.0: enabling device (0100 -> 0102) Feb 2 12:21:25 rene kernel: [ 5.728386] ngene: Found Mystique SaTiX-S2 Dual (v2) Feb 2 12:21:25 rene kernel: [ 5.728709] ngene: Device version 1 Feb 2 12:21:25 rene kernel: [ 5.741659] snd_hda_codec_idt hdaudioC0D0: autoconfig for 92HD89E2: line_outs=4 (0xd/0xf/0x10/0x11/0x0) type:speaker Feb 2 12:21:25 rene kernel: [ 5.741661] snd_hda_codec_idt hdaudioC0D0: speaker_outs=0 (0x0/0x0/0x0/0x0/0x0) Feb 2 12:21:25 rene kernel: [ 5.741662] snd_hda_codec_idt hdaudioC0D0: hp_outs=1 (0xa/0x0/0x0/0x0/0x0) Feb 2 12:21:25 rene kernel: [ 5.741663] snd_hda_codec_idt hdaudioC0D0: mono: mono_out=0x0 Feb 2 12:21:25 rene kernel: [ 5.741664] snd_hda_codec_idt hdaudioC0D0: dig-out=0x22/0x0 Feb 2 12:21:25 rene kernel: [ 5.741665] snd_hda_codec_idt hdaudioC0D0: inputs: Feb 2 12:21:25 rene kernel: [ 5.741666] snd_hda_codec_idt hdaudioC0D0: Rear Mic=0xe Feb 2 12:21:25 rene kernel: [ 5.741667] snd_hda_codec_idt hdaudioC0D0: Front Mic=0xb Feb 2 12:21:25 rene kernel: [ 5.741669] snd_hda_codec_idt hdaudioC0D0: Line=0x12 Feb 2 12:21:25 rene kernel: [ 5.781402] input: HDA Intel PCH Rear Mic as /devices/pci0000:00/0000:00:1b.0/sound/card0/input5 Feb 2 12:21:25 rene kernel: [ 5.781446] input: HDA Intel PCH Front Mic as /devices/pci0000:00/0000:00:1b.0/sound/card0/input6 Feb 2 12:21:25 rene kernel: [ 5.781485] input: HDA Intel PCH Speaker Front as /devices/pci0000:00/0000:00:1b.0/sound/card0/input7 Feb 2 12:21:25 rene kernel: [ 5.781529] input: HDA Intel PCH Speaker Surround as /devices/pci0000:00/0000:00:1b.0/sound/card0/input8 Feb 2 12:21:25 rene kernel: [ 5.781591] input: HDA Intel PCH Speaker CLFE as /devices/pci0000:00/0000:00:1b.0/sound/card0/input9 Feb 2 12:21:25 rene kernel: [ 5.781664] input: HDA Intel PCH Speaker Side as /devices/pci0000:00/0000:00:1b.0/sound/card0/input10 Feb 2 12:21:25 rene kernel: [ 5.781736] input: HDA Intel PCH Front Headphone as /devices/pci0000:00/0000:00:1b.0/sound/card0/input11 Feb 2 12:21:25 rene kernel: [ 5.853244] intel_rapl: Found RAPL domain package Feb 2 12:21:25 rene kernel: [ 5.853245] intel_rapl: Found RAPL domain core Feb 2 12:21:25 rene kernel: [ 5.853246] intel_rapl: Found RAPL domain uncore Feb 2 12:21:25 rene kernel: [ 5.853251] intel_rapl: RAPL package 0 domain package locked by BIOS Feb 2 12:21:25 rene kernel: [ 5.873092] ngene: Loading firmware file ngene_18.fw. Feb 2 12:21:25 rene kernel: [ 5.896078] i2c i2c-1: error in i2c_read_reg Feb 2 12:21:25 rene kernel: [ 5.896554] i2c i2c-1: No CXD2099 detected at 40 Feb 2 12:21:25 rene kernel: [ 5.938387] PKCS#7 signature not signed with a trusted key Feb 2 12:21:25 rene kernel: [ 5.938842] nvidia: loading out-of-tree module taints kernel. Feb 2 12:21:25 rene kernel: [ 5.938847] nvidia: module license 'NVIDIA' taints kernel. Feb 2 12:21:25 rene kernel: [ 5.938848] Disabling lock debugging due to kernel taint Feb 2 12:21:25 rene kernel: [ 5.946399] nvidia 0000:01:00.0: vgaarb: changed VGA decodes: olddecodes=io+mem,decodes=none:owns=io+mem Feb 2 12:21:25 rene kernel: [ 5.946607] [drm] Initialized nvidia-drm 0.0.0 20150116 for 0000:01:00.0 on minor 0 Feb 2 12:21:25 rene kernel: [ 5.946611] NVRM: loading NVIDIA UNIX x86_64 Kernel Module 340.107 Thu May 24 21:54:01 PDT 2018 Feb 2 12:21:25 rene kernel: [ 6.001635] PKCS#7 signature not signed with a trusted key Feb 2 12:21:25 rene kernel: [ 6.002664] nvidia_uvm: Loaded the UVM driver, major device number 243 Feb 2 12:21:25 rene kernel: [ 6.206522] resource sanity check: requesting [mem 0x000c0000-0x000fffff], which spans more than PCI Bus 0000:00 [mem 0x000c8000-0x000dffff window] Feb 2 12:21:25 rene kernel: [ 6.206607] caller os_map_kernel_space+0x86/0xb0 [nvidia] mapping multiple BARs Feb 2 12:21:25 rene kernel: [ 6.351881] LNBx2x attached on addr=a Feb 2 12:21:25 rene kernel: [ 6.354562] stv6110x_attach: Attaching STV6110x Feb 2 12:21:25 rene kernel: [ 6.354563] dvbdev: DVB: registering new adapter (nGene) Feb 2 12:21:25 rene kernel: [ 6.354566] ngene 0000:04:00.0: DVB: registering adapter 0 frontend 0 (STV090x Multistandard)... Feb 2 12:21:25 rene kernel: [ 6.412717] LNBx2x attached on addr=8 Feb 2 12:21:25 rene kernel: [ 6.412723] stv6110x_attach: Attaching STV6110x Feb 2 12:21:25 rene kernel: [ 6.412724] dvbdev: DVB: registering new adapter (nGene) Feb 2 12:21:25 rene kernel: [ 6.412729] ngene 0000:04:00.0: DVB: registering adapter 1 frontend 0 (STV090x Multistandard)... Feb 2 12:21:25 rene kernel: [ 6.414023] No demod found on chan 2 Feb 2 12:21:25 rene kernel: [ 6.414984] No demod found on chan 3 Feb 2 12:21:25 rene kernel: [ 6.895152] NVRM: GPU at 0000:01:00.0 has fallen off the bus. Feb 2 12:21:25 rene kernel: [ 7.152138] random: crng init done Feb 2 12:21:25 rene kernel: [ 7.152140] random: 7 urandom warning(s) missed due to ratelimiting Feb 2 12:21:25 rene kernel: [ 7.155578] FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Feb 2 12:21:25 rene kernel: [ 7.326099] SGI XFS with ACLs, security attributes, realtime, no debug enabled Feb 2 12:21:25 rene kernel: [ 7.339027] XFS (sdb5): Mounting V4 Filesystem Feb 2 12:21:25 rene kernel: [ 7.497047] XFS (sdb5): Ending clean mount Feb 2 12:21:25 rene kernel: [ 7.737050] audit: type=1400 audit(1549106479.819:2): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/bin/lxc-start" pid=835 comm="apparmor_parser" Feb 2 12:21:25 rene kernel: [ 7.737662] audit: type=1400 audit(1549106479.819:3): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/bin/man" pid=836 comm="apparmor_parser" Feb 2 12:21:25 rene kernel: [ 7.737665] audit: type=1400 audit(1549106479.819:4): apparmor="STATUS" operation="profile_load" profile="unconfined" name="man_filter" pid=836 comm="apparmor_parser" Feb 2 12:21:25 rene kernel: [ 7.737668] audit: type=1400 audit(1549106479.819:5): apparmor="STATUS" operation="profile_load" profile="unconfined" name="man_groff" pid=836 comm="apparmor_parser" Feb 2 12:21:25 rene kernel: [ 7.738383] audit: type=1400 audit(1549106479.819:6): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/snapd/snap-confine" pid=837 comm="apparmor_parser" Feb 2 12:21:25 rene cloud-init[870]: ci-info: +++++++++++++++++++++++++++++Route IPv4 info+++++++++++++++++++++++++++++ Feb 2 12:21:25 rene cloud-init[870]: ci-info: +-------+-------------+-------------+---------------+-----------+-------+ Feb 2 12:21:25 rene cloud-init[870]: ci-info: | Route | Destination | Gateway | Genmask | Interface | Flags | Feb 2 12:21:25 rene cloud-init[870]: ci-info: +-------+-------------+-------------+---------------+-----------+-------+ Feb 2 12:21:25 rene cloud-init[870]: ci-info: | 0 | 0.0.0.0 | 192.168.0.1 | 0.0.0.0 | enp6s0 | UG | Feb 2 12:21:25 rene cloud-init[870]: ci-info: | 1 | 192.168.0.0 | 0.0.0.0 | 255.255.255.0 | enp6s0 | U | Feb 2 12:21:25 rene cloud-init[870]: ci-info: +-------+-------------+-------------+---------------+-----------+-------+ Feb 2 12:21:25 rene cloud-init[870]: ci-info: +++++++++++++++++++Route IPv6 info+++++++++++++++++++ Feb 2 12:21:25 rene kernel: [ 7.738385] audit: type=1400 audit(1549106479.819:7): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/snapd/snap-confine//mount-namespace-capture-helper" pid=837 comm="apparmor_parser" Feb 2 12:21:25 rene kernel: [ 7.739813] audit: type=1400 audit(1549106479.819:8): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/sbin/tcpdump" pid=839 comm="apparmor_parser" Feb 2 12:21:25 rene kernel: [ 7.741929] audit: type=1400 audit(1549106479.823:9): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/sbin/dhclient" pid=833 comm="apparmor_parser" Feb 2 12:21:25 rene cloud-init[870]: ci-info: +-------+-------------+---------+-----------+-------+ Feb 2 12:21:25 rene kernel: [ 7.741931] audit: type=1400 audit(1549106479.823:10): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/NetworkManager/nm-dhcp-client.action" pid=833 comm="apparmor_parser" Feb 2 12:21:25 rene cloud-init[870]: ci-info: | Route | Destination | Gateway | Interface | Flags | Feb 2 12:21:25 rene kernel: [ 7.741933] audit: type=1400 audit(1549106479.823:11): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/NetworkManager/nm-dhcp-helper" pid=833 comm="apparmor_parser" Feb 2 12:21:25 rene kernel: [ 7.878798] r8169 0000:06:00.0 enp6s0: link down Feb 2 12:21:25 rene kernel: [ 7.878809] r8169 0000:06:00.0 enp6s0: link down Feb 2 12:21:25 rene kernel: [ 7.878862] IPv6: ADDRCONF(NETDEV_UP): enp6s0: link is not ready Feb 2 12:21:25 rene kernel: [ 9.826562] r8169 0000:06:00.0 enp6s0: link up Feb 2 12:21:25 rene cloud-init[870]: ci-info: +-------+-------------+---------+-----------+-------+ Feb 2 12:21:25 rene kernel: [ 9.826571] IPv6: ADDRCONF(NETDEV_CHANGE): enp6s0: link becomes ready Feb 2 12:21:25 rene cloud-init[870]: ci-info: | 1 | fe80::/64 | :: | enp6s0 | U | Feb 2 12:21:25 rene kernel: [ 9.888065] snd_hda_intel 0000:01:00.1: azx_get_response timeout, switching to polling mode: last cmd=0x005f0200 Feb 2 12:21:25 rene kernel: [ 10.896029] snd_hda_intel 0000:01:00.1: azx_get_response timeout, switching to single_cmd mode: last cmd=0x005f0200 Feb 2 12:21:25 rene kernel: [ 11.096438] snd_hda_codec_hdmi hdaudioC1D0: HDMI: invalid ELD buf size -1 Feb 2 12:21:25 rene kernel: [ 11.096931] snd_hda_codec_hdmi hdaudioC1D1: HDMI: failed to get afg sub nodes Feb 2 12:21:25 rene cloud-init[870]: ci-info: | 3 | local | :: | enp6s0 | U | Feb 2 12:21:25 rene kernel: [ 11.096946] snd_hda_codec_hdmi: probe of hdaudioC1D1 failed with error -22 Feb 2 12:21:25 rene kernel: [ 11.097791] snd_hda_codec_hdmi hdaudioC1D1: HDMI: failed to get afg sub nodes Feb 2 12:21:25 rene cloud-init[870]: ci-info: | 4 | ff00::/8 | :: | enp6s0 | U | Feb 2 12:21:25 rene kernel: [ 11.097800] snd_hda_codec_hdmi: probe of hdaudioC1D1 failed with error -22 Feb 2 12:21:25 rene kernel: [ 11.098539] snd_hda_codec_hdmi hdaudioC1D1: HDMI: failed to get afg sub nodes Feb 2 12:21:25 rene kernel: [ 11.098549] snd_hda_codec_hdmi: probe of hdaudioC1D1 failed with error -22 Feb 2 12:21:25 rene kernel: [ 11.099322] snd_hda_codec_generic hdaudioC1D1: autoconfig for Generic: line_outs=0 (0x0/0x0/0x0/0x0/0x0) type:line Feb 2 12:21:25 rene kernel: [ 11.099323] snd_hda_codec_generic hdaudioC1D1: speaker_outs=0 (0x0/0x0/0x0/0x0/0x0) Feb 2 12:21:25 rene cloud-init[870]: ci-info: +-------+-------------+---------+-----------+-------+ Feb 2 12:21:25 rene kernel: [ 11.099325] snd_hda_codec_generic hdaudioC1D1: hp_outs=0 (0x0/0x0/0x0/0x0/0x0) Feb 2 12:21:25 rene kernel: [ 11.099326] snd_hda_codec_generic hdaudioC1D1: mono: mono_out=0x0 Feb 2 12:21:25 rene systemd[1]: Started Initial cloud-init job (metadata service crawler). Feb 2 12:21:25 rene kernel: [ 11.099327] snd_hda_codec_generic hdaudioC1D1: dig-out=0x5/0x0 Feb 2 12:21:25 rene kernel: [ 11.099327] snd_hda_codec_generic hdaudioC1D1: inputs: Feb 2 12:21:25 rene kernel: [ 11.099999] snd_hda_codec_generic: probe of hdaudioC1D1 failed with error -5 Feb 2 12:21:25 rene kernel: [ 11.100001] hdaudio hdaudioC1D1: Unable to bind the codec Feb 2 12:21:25 rene kernel: [ 11.100546] snd_hda_codec_hdmi hdaudioC1D2: HDMI: failed to get afg sub nodes Feb 2 12:21:25 rene kernel: [ 11.100554] snd_hda_codec_hdmi: probe of hdaudioC1D2 failed with error -22 Feb 2 12:21:25 rene systemd[1]: Reached target System Initialization. Feb 2 12:21:25 rene kernel: [ 11.101352] snd_hda_codec_hdmi hdaudioC1D2: HDMI: failed to get afg sub nodes Feb 2 12:21:25 rene kernel: [ 11.101363] snd_hda_codec_hdmi: probe of hdaudioC1D2 failed with error -22 Feb 2 12:21:25 rene kernel: [ 11.102117] snd_hda_codec_hdmi hdaudioC1D2: HDMI: failed to get afg sub nodes Feb 2 12:21:25 rene kernel: [ 11.102127] snd_hda_codec_hdmi: probe of hdaudioC1D2 failed with error -22 Feb 2 12:21:25 rene systemd[1]: Listening on Open-iSCSI iscsid Socket. Feb 2 12:21:25 rene kernel: [ 11.102864] snd_hda_codec_generic hdaudioC1D2: autoconfig for Generic: line_outs=0 (0x0/0x0/0x0/0x0/0x0) type:line Feb 2 12:21:25 rene kernel: [ 11.102865] snd_hda_codec_generic hdaudioC1D2: speaker_outs=0 (0x0/0x0/0x0/0x0/0x0) Feb 2 12:21:25 rene systemd[1]: Listening on eventlircd.socket. Feb 2 12:21:25 rene kernel: [ 11.102866] snd_hda_codec_generic hdaudioC1D2: hp_outs=0 (0x0/0x0/0x0/0x0/0x0) Feb 2 12:21:25 rene kernel: [ 11.102867] snd_hda_codec_generic hdaudioC1D2: mono: mono_out=0x0 Feb 2 12:21:25 rene kernel: [ 11.102868] snd_hda_codec_generic hdaudioC1D2: dig-out=0x5/0x0 Feb 2 12:21:25 rene kernel: [ 11.102869] snd_hda_codec_generic hdaudioC1D2: inputs: Feb 2 12:21:25 rene systemd[1]: Starting LXD - unix socket. Feb 2 12:21:25 rene kernel: [ 11.103524] snd_hda_codec_generic: probe of hdaudioC1D2 failed with error -5 Feb 2 12:21:25 rene kernel: [ 11.103526] hdaudio hdaudioC1D2: Unable to bind the codec Feb 2 12:21:25 rene kernel: [ 11.104078] snd_hda_codec_hdmi hdaudioC1D3: HDMI: failed to get afg sub nodes Feb 2 12:21:25 rene systemd[1]: Started Daily apt download activities. Feb 2 12:21:25 rene kernel: [ 11.104086] snd_hda_codec_hdmi: probe of hdaudioC1D3 failed with error -22 Feb 2 12:21:25 rene kernel: [ 11.104859] snd_hda_codec_hdmi hdaudioC1D3: HDMI: failed to get afg sub nodes Feb 2 12:21:25 rene kernel: [ 11.104870] snd_hda_codec_hdmi: probe of hdaudioC1D3 failed with error -22 Feb 2 12:21:25 rene kernel: [ 11.105602] snd_hda_codec_hdmi hdaudioC1D3: HDMI: failed to get afg sub nodes Feb 2 12:21:25 rene kernel: [ 11.105612] snd_hda_codec_hdmi: probe of hdaudioC1D3 failed with error -22 Feb 2 12:21:25 rene systemd[1]: Started Daily apt upgrade and clean activities. Feb 2 12:21:25 rene kernel: [ 11.106332] snd_hda_codec_generic hdaudioC1D3: autoconfig for Generic: line_outs=0 (0x0/0x0/0x0/0x0/0x0) type:line Feb 2 12:21:25 rene kernel: [ 11.106334] snd_hda_codec_generic hdaudioC1D3: speaker_outs=0 (0x0/0x0/0x0/0x0/0x0) Feb 2 12:21:25 rene systemd[1]: Started Trigger anacron every hour. Feb 2 12:21:25 rene kernel: [ 11.106335] snd_hda_codec_generic hdaudioC1D3: hp_outs=0 (0x0/0x0/0x0/0x0/0x0) Feb 2 12:21:25 rene kernel: [ 11.106336] snd_hda_codec_generic hdaudioC1D3: mono: mono_out=0x0 Feb 2 12:21:25 rene kernel: [ 11.106337] snd_hda_codec_generic hdaudioC1D3: dig-out=0x5/0x0 Feb 2 12:21:25 rene kernel: [ 11.106338] snd_hda_codec_generic hdaudioC1D3: inputs: Feb 2 12:21:25 rene kernel: [ 11.107007] snd_hda_codec_generic: probe of hdaudioC1D3 failed with error -5 Feb 2 12:21:25 rene kernel: [ 11.107009] hdaudio hdaudioC1D3: Unable to bind the codec Feb 2 12:21:25 rene systemd[1]: Listening on ACPID Listen Socket. Feb 2 12:21:25 rene kernel: [ 11.107734] input: HDA NVidia HDMI/DP,pcm=3 as /devices/pci0000:00/0000:00:01.0/0000:01:00.1/sound/card1/input12 Feb 2 12:21:25 rene kernel: [ 11.215045] snd_hda_codec_hdmi hdaudioC1D0: Unable to sync register 0x5f0800. -5 Feb 2 12:21:25 rene kernel: [ 11.215591] snd_hda_codec_hdmi hdaudioC1D0: HDMI: invalid ELD buf size -1 Feb 2 12:21:25 rene kernel: [ 11.307507] NVRM: RmInitAdapter failed! (0x12:0x2b:1915) Feb 2 12:21:25 rene kernel: [ 11.307519] NVRM: rm_init_adapter failed for device bearing minor number 0 Feb 2 12:21:25 rene kernel: [ 11.307541] NVRM: nvidia_frontend_open: minor 0, module->open() failed, error -5 Feb 2 12:21:25 rene systemd[1]: Started ACPI Events Check. Feb 2 12:21:25 rene kernel: [ 11.520116] snd_hda_codec_hdmi hdaudioC1D0: HDMI: invalid ELD buf size -1 Feb 2 12:21:25 rene kernel: [ 11.840109] snd_hda_codec_hdmi hdaudioC1D0: HDMI: invalid ELD buf size -1 Feb 2 12:21:25 rene kernel: [ 12.098392] new mount options do not match the existing superblock, will be ignored Feb 2 12:21:25 rene kernel: [ 12.160199] snd_hda_codec_hdmi hdaudioC1D0: HDMI: invalid ELD buf size -1 Feb 2 12:21:25 rene systemd[1]: Reached target Paths. Feb 2 12:21:25 rene systemd[1]: Listening on UUID daemon activation socket. Feb 2 12:21:25 rene systemd[1]: Started Daily Cleanup of Temporary Directories. Feb 2 12:21:25 rene systemd[1]: Starting Socket activation for snappy daemon. Feb 2 12:21:25 rene systemd[1]: Started Discard unused blocks once a week. Feb 2 12:21:25 rene systemd[1]: Listening on D-Bus System Message Bus Socket. Feb 2 12:21:25 rene systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Feb 2 12:21:25 rene systemd[1]: Started Message of the Day. Feb 2 12:21:25 rene systemd[1]: Reached target Timers. Feb 2 12:21:25 rene systemd[1]: Reached target Cloud-config availability. Feb 2 12:21:25 rene systemd[1]: Listening on LXD - unix socket. Feb 2 12:21:25 rene systemd[1]: Listening on Socket activation for snappy daemon. Feb 2 12:21:25 rene systemd[1]: Reached target Sockets. Feb 2 12:21:25 rene systemd[1]: Reached target Basic System. Feb 2 12:21:25 rene systemd[1]: Starting lircd(8) initialization helper tool... Feb 2 12:21:25 rene systemd[1]: Starting LSB: Record successful boot for GRUB... Feb 2 12:21:25 rene systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Feb 2 12:21:25 rene systemd[1]: Starting Daily apt upgrade and clean activities... Feb 2 12:21:25 rene systemd[1]: Started Run anacron jobs. Feb 2 12:21:25 rene avahi-daemon[926]: Found user 'avahi' (UID 113) and group 'avahi' (GID 115). Feb 2 12:21:25 rene avahi-daemon[926]: Successfully dropped root privileges. Feb 2 12:21:25 rene systemd[1]: Starting Snappy daemon... Feb 2 12:21:25 rene avahi-daemon[926]: avahi-daemon 0.7 starting up. Feb 2 12:21:25 rene systemd[1]: Started Regular background program processing daemon. Feb 2 12:21:25 rene anacron[935]: Anacron 2.3 started on 2019-02-02 Feb 2 12:21:25 rene systemd[1]: Started FUSE filesystem for LXC. Feb 2 12:21:25 rene anacron[935]: Will run job `cron.daily' in 5 min. Feb 2 12:21:25 rene systemd[1]: Started Set the CPU Frequency Scaling governor. Feb 2 12:21:25 rene anacron[935]: Jobs will be executed sequentially Feb 2 12:21:25 rene systemd[1]: Started "eventlircd reads from kernel input devices and generates key presses on a lircd socket". Feb 2 12:21:25 rene systemd[1]: Starting Dispatcher daemon for systemd-networkd... Feb 2 12:21:25 rene systemd[1]: Started D-Bus System Message Bus. Feb 2 12:21:25 rene cron[973]: (CRON) INFO (pidfile fd = 3) Feb 2 12:21:25 rene lxcfs[975]: mount namespace: 5 Feb 2 12:21:25 rene lxcfs[975]: hierarchies: Feb 2 12:21:25 rene lxcfs[975]: 0: fd: 6: pids Feb 2 12:21:25 rene lxcfs[975]: 1: fd: 7: devices Feb 2 12:21:25 rene lxcfs[975]: 2: fd: 8: memory Feb 2 12:21:25 rene lxcfs[975]: 3: fd: 9: hugetlb Feb 2 12:21:25 rene lxcfs[975]: 4: fd: 10: cpu,cpuacct Feb 2 12:21:25 rene lxcfs[975]: 5: fd: 11: cpuset Feb 2 12:21:25 rene lxcfs[975]: 6: fd: 12: perf_event Feb 2 12:21:25 rene lxcfs[975]: 7: fd: 13: freezer Feb 2 12:21:25 rene lxcfs[975]: 8: fd: 14: blkio Feb 2 12:21:25 rene lxcfs[975]: 9: fd: 15: net_cls,net_prio Feb 2 12:21:25 rene lxcfs[975]: 10: fd: 16: rdma Feb 2 12:21:25 rene lxcfs[975]: 11: fd: 17: name=systemd Feb 2 12:21:25 rene lxcfs[975]: 12: fd: 18: unified Feb 2 12:21:25 rene cron[973]: (CRON) INFO (Running @reboot jobs) Feb 2 12:21:25 rene snapd[968]: AppArmor status: apparmor is enabled and all features are available Feb 2 12:21:25 rene dbus-daemon[988]: dbus[988]: Unknown group "power" in message bus configuration file Feb 2 12:21:25 rene dbus-daemon[988]: [system] AppArmor D-Bus mediation is enabled Feb 2 12:21:25 rene avahi-daemon[926]: Successfully called chroot(). Feb 2 12:21:25 rene avahi-daemon[926]: Successfully dropped remaining capabilities. Feb 2 12:21:25 rene avahi-daemon[926]: Loading service file /services/yavdr-audio.service. Feb 2 12:21:25 rene avahi-daemon[926]: Loading service file /services/yavdr-backups.service. Feb 2 12:21:25 rene systemd[1]: Started irqbalance daemon. Feb 2 12:21:25 rene avahi-daemon[926]: Loading service file /services/yavdr-files.service. Feb 2 12:21:25 rene avahi-daemon[926]: Loading service file /services/yavdr-pictures.service. Feb 2 12:21:25 rene avahi-daemon[926]: Loading service file /services/yavdr-recordings.service. Feb 2 12:21:25 rene avahi-daemon[926]: Loading service file /services/yavdr-video.service. Feb 2 12:21:25 rene avahi-daemon[926]: Joining mDNS multicast group on interface enp6s0.IPv6 with address fe80::3a60:77ff:fe03:2362. Feb 2 12:21:25 rene avahi-daemon[926]: New relevant interface enp6s0.IPv6 for mDNS. Feb 2 12:21:25 rene avahi-daemon[926]: Joining mDNS multicast group on interface enp6s0.IPv4 with address 192.168.0.2. Feb 2 12:21:25 rene avahi-daemon[926]: New relevant interface enp6s0.IPv4 for mDNS. Feb 2 12:21:25 rene avahi-daemon[926]: Joining mDNS multicast group on interface lo.IPv6 with address ::1. Feb 2 12:21:25 rene avahi-daemon[926]: New relevant interface lo.IPv6 for mDNS. Feb 2 12:21:25 rene avahi-daemon[926]: Joining mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. Feb 2 12:21:25 rene avahi-daemon[926]: New relevant interface lo.IPv4 for mDNS. Feb 2 12:21:25 rene grub-common[921]: * Recording successful boot for GRUB Feb 2 12:21:25 rene systemd[1]: Started Handle events from IR remotes decoded by lircd(8). Feb 2 12:21:25 rene avahi-daemon[926]: Network interface enumeration completed. Feb 2 12:21:25 rene systemd[1]: Starting WPA supplicant... Feb 2 12:21:25 rene avahi-daemon[926]: Registering new address record for fe80::3a60:77ff:fe03:2362 on enp6s0.*. Feb 2 12:21:25 rene systemd[1]: Starting Thermal Daemon Service... Feb 2 12:21:25 rene avahi-daemon[926]: Registering new address record for 192.168.0.2 on enp6s0.IPv4. Feb 2 12:21:25 rene systemd[1]: Starting Save/Restore Sound Card State... Feb 2 12:21:25 rene avahi-daemon[926]: Registering new address record for ::1 on lo.*. Feb 2 12:21:25 rene systemd[1]: Starting LXD - container startup/shutdown... Feb 2 12:21:25 rene avahi-daemon[926]: Registering new address record for 127.0.0.1 on lo.IPv4. Feb 2 12:21:25 rene systemd[1]: Started Deferred execution scheduler. Feb 2 12:21:25 rene systemd[1]: Starting Login Service... Feb 2 12:21:25 rene systemd[1]: Starting Accounts Service... Feb 2 12:21:25 rene systemd[1]: Starting System Logging Service... Feb 2 12:21:25 rene systemd[1]: Started lircd(8) initialization helper tool. Feb 2 12:21:25 rene alsactl[1084]: Found hardware: "HDA-Intel" "Nvidia GPU 0a HDMI/DP" "HDA:10de000a,10de0101,00100100" "0x1043" "0x834e" Feb 2 12:21:25 rene alsactl[1084]: Hardware is initialized using a generic method Feb 2 12:21:25 rene alsactl[1084]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #8 (No such file or directory) Feb 2 12:21:25 rene alsactl[1084]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #9 (No such file or directory) Feb 2 12:21:25 rene alsactl[1084]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #10 (No such file or directory) Feb 2 12:21:25 rene alsactl[1084]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #11 (No such file or directory) Feb 2 12:21:25 rene alsactl[1084]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #12 (No such file or directory) Feb 2 12:21:25 rene alsactl[1084]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #13 (No such file or directory) Feb 2 12:21:25 rene alsactl[1084]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #14 (No such file or directory) Feb 2 12:21:25 rene alsactl[1084]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #15 (No such file or directory) Feb 2 12:21:25 rene alsactl[1084]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #16 (No such file or directory) Feb 2 12:21:25 rene alsactl[1084]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #17 (No such file or directory) Feb 2 12:21:25 rene alsactl[1084]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #18 (No such file or directory) Feb 2 12:21:25 rene alsactl[1084]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #19 (No such file or directory) Feb 2 12:21:25 rene alsactl[1084]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #20 (No such file or directory) Feb 2 12:21:25 rene alsactl[1084]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #21 (No such file or directory) Feb 2 12:21:25 rene alsactl[1084]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #22 (No such file or directory) Feb 2 12:21:25 rene alsactl[1084]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #23 (No such file or directory) Feb 2 12:21:25 rene alsactl[1084]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #24 (No such file or directory) Feb 2 12:21:25 rene alsactl[1084]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #25 (No such file or directory) Feb 2 12:21:25 rene systemd[1]: Started Avahi mDNS/DNS-SD Stack. Feb 2 12:21:25 rene alsactl[1084]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #26 (No such file or directory) Feb 2 12:21:25 rene alsactl[1084]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #27 (No such file or directory) Feb 2 12:21:25 rene alsactl[1084]: /usr/sbin/alsactl: set_control:1325: failed to obtain info for control #28 (No such file or directory) Feb 2 12:21:25 rene systemd[1]: Started Save/Restore Sound Card State. Feb 2 12:21:25 rene rsyslogd: imuxsock: Acquired UNIX socket '/run/systemd/journal/syslog' (fd 3) from systemd. [v8.32.0] Feb 2 12:21:25 rene systemd[1]: Started System Logging Service. Feb 2 12:21:25 rene networkd-dispatcher[983]: No valid path found for iwconfig Feb 2 12:21:25 rene rsyslogd: rsyslogd's groupid changed to 106 Feb 2 12:21:25 rene thermald[1062]: 13 CPUID levels; family:model:stepping 0x6:2a:7 (6:42:7) Feb 2 12:21:25 rene thermald[1062]: Polling mode is enabled: 4 Feb 2 12:21:25 rene systemd[1]: Started Thermal Daemon Service. Feb 2 12:21:25 rene rsyslogd: rsyslogd's userid changed to 102 Feb 2 12:21:25 rene systemd[1]: Started WPA supplicant. Feb 2 12:21:25 rene rsyslogd: [origin software="rsyslogd" swVersion="8.32.0" x-pid="1082" x-info="http://www.rsyslog.com"] start Feb 2 12:21:25 rene systemd[1]: Reached target Network. Feb 2 12:21:25 rene thermald[1062]: sysfs write failed /sys/devices/virtual/powercap/intel-rapl/intel-rapl:0/enabled Feb 2 12:21:25 rene wpa_supplicant[1058]: Successfully initialized wpa_supplicant Feb 2 12:21:25 rene grub-common[921]: ...done. Feb 2 12:21:25 rene systemd[1]: Reached target Network is Online. Feb 2 12:21:25 rene systemd[1]: Starting Availability of block devices... Feb 2 12:21:25 rene kernel: [ 12.480155] snd_hda_codec_hdmi hdaudioC1D0: HDMI: invalid ELD buf size -1 Feb 2 12:21:25 rene systemd[1]: Starting Samba NMB Daemon... Feb 2 12:21:25 rene systemd[1]: Starting OpenBSD Secure Shell server... Feb 2 12:21:25 rene systemd[1]: Starting NFS Mount Daemon... Feb 2 12:21:25 rene systemd[1]: Started Dispatcher daemon for systemd-networkd. Feb 2 12:21:25 rene systemd[1]: Started LSB: Record successful boot for GRUB. Feb 2 12:21:25 rene systemd[1]: Started Availability of block devices. Feb 2 12:21:25 rene rpc.mountd[1226]: Version 1.3.3 starting Feb 2 12:21:25 rene systemd[1]: Started NFS Mount Daemon. Feb 2 12:21:25 rene systemd[1]: Starting NFS server and services... Feb 2 12:21:25 rene dbus-daemon[988]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.7' (uid=0 pid=1079 comm="/usr/lib/accountsservice/accounts-daemon " label="unconfined") Feb 2 12:21:25 rene exportfs[1232]: exportfs: Failed to stat /srv/backups: No such file or directory Feb 2 12:21:25 rene exportfs[1232]: exportfs: Failed to stat /srv/video: No such file or directory Feb 2 12:21:25 rene exportfs[1232]: exportfs: Failed to stat /srv/files: No such file or directory Feb 2 12:21:25 rene systemd[1]: nfs-server.service: Control process exited, code=exited status=1 Feb 2 12:21:25 rene systemd[1]: Starting Authorization Manager... Feb 2 12:21:25 rene systemd[1]: Started OpenBSD Secure Shell server. Feb 2 12:21:25 rene systemd[1]: nfs-server.service: Failed with result 'exit-code'. Feb 2 12:21:25 rene systemd[1]: Stopped NFS server and services. Feb 2 12:21:25 rene systemd[1]: Reached target Remote File Systems (Pre). Feb 2 12:21:25 rene systemd[1]: Reached target Remote File Systems. Feb 2 12:21:25 rene polkitd[1257]: started daemon version 0.105 using authority implementation `local' version `0.105' Feb 2 12:21:25 rene systemd[1]: Starting LSB: automatic crash report generation... Feb 2 12:21:25 rene dbus-daemon[988]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Feb 2 12:21:25 rene accounts-daemon[1079]: started daemon version 0.6.45 Feb 2 12:21:25 rene systemd[1]: Starting Automounts filesystems on demand... Feb 2 12:21:25 rene systemd[1]: Starting Permit User Sessions... Feb 2 12:21:25 rene systemd[1]: Stopping NFSv4 ID-name mapping service... Feb 2 12:21:25 rene systemd[1]: Stopping NFS Mount Daemon... Feb 2 12:21:25 rene rpc.mountd[1226]: Caught signal 15, un-registering and exiting. Feb 2 12:21:25 rene systemd[1]: Stopped NFSv4 ID-name mapping service. Feb 2 12:21:25 rene systemd[1]: Stopped NFS Mount Daemon. Feb 2 12:21:25 rene systemd[1]: Started Authorization Manager. Feb 2 12:21:25 rene systemd[1]: Started Accounts Service. Feb 2 12:21:25 rene apport[1267]: * Starting automatic crash report generation: apport Feb 2 12:21:26 rene kernel: [ 12.800153] azx_single_send_cmd: 101 callbacks suppressed Feb 2 12:21:26 rene kernel: [ 12.800157] snd_hda_codec_hdmi hdaudioC1D0: HDMI: invalid ELD buf size -1 Feb 2 12:21:26 rene systemd[1]: Started LXD - container startup/shutdown. Feb 2 12:21:26 rene systemd[1]: Started Login Service. Feb 2 12:21:26 rene systemd[1]: Started Unattended Upgrades Shutdown. Feb 2 12:21:26 rene systemd[1]: Started Samba NMB Daemon. Feb 2 12:21:26 rene systemd[1]: Starting Samba SMB Daemon... Feb 2 12:21:26 rene systemd[1]: Started Permit User Sessions. Feb 2 12:21:26 rene systemd[1]: Starting Hold until boot process finishes up... Feb 2 12:21:26 rene systemd[1]: Starting Terminate Plymouth Boot Screen... Feb 2 12:21:26 rene systemd[1]: Started Hold until boot process finishes up. Feb 2 12:21:26 rene systemd[1]: Starting Set console scheme... Feb 2 12:21:26 rene systemd[1]: Started Terminate Plymouth Boot Screen. Feb 2 12:21:26 rene systemd[1]: Starting X on vt7... Feb 2 12:21:26 rene apport[1267]: ...done. Feb 2 12:21:26 rene systemd[1]: Started LSB: automatic crash report generation. Feb 2 12:21:26 rene systemd[1]: Started Set console scheme. Feb 2 12:21:26 rene systemd[1]: Created slice system-getty.slice. Feb 2 12:21:26 rene systemd[1]: Started Getty on tty1. Feb 2 12:21:26 rene systemd[1]: Reached target Login Prompts. Feb 2 12:21:26 rene x-daemon[1436]: X.Org X Server 1.19.6 Feb 2 12:21:26 rene x-daemon[1436]: Release Date: 2017-12-20 Feb 2 12:21:26 rene x-daemon[1436]: X Protocol Version 11, Revision 0 Feb 2 12:21:26 rene x-daemon[1436]: Build Operating System: Linux 4.4.0-138-generic x86_64 Ubuntu Feb 2 12:21:26 rene x-daemon[1436]: Current Operating System: Linux rene 4.15.0-45-generic #48-Ubuntu SMP Tue Jan 29 16:28:13 UTC 2019 x86_64 Feb 2 12:21:26 rene x-daemon[1436]: Kernel command line: BOOT_IMAGE=/boot/vmlinuz-4.15.0-45-generic root=UUID=91216e8b-0f41-11e9-bdb8-386077032362 ro Feb 2 12:21:26 rene x-daemon[1436]: Build Date: 25 October 2018 04:11:27PM Feb 2 12:21:26 rene x-daemon[1436]: xorg-server 2:1.19.6-1ubuntu4.2 (For technical support please see http://www.ubuntu.com/support) Feb 2 12:21:26 rene x-daemon[1436]: Current version of pixman: 0.34.0 Feb 2 12:21:26 rene x-daemon[1436]: #011Before reporting problems, check http://wiki.x.org Feb 2 12:21:26 rene x-daemon[1436]: #011to make sure that you have the latest version. Feb 2 12:21:26 rene x-daemon[1436]: Markers: (--) probed, (**) from config file, (==) default setting, Feb 2 12:21:26 rene x-daemon[1436]: #011(++) from command line, (!!) notice, (II) informational, Feb 2 12:21:26 rene x-daemon[1436]: #011(WW) warning, (EE) error, (NI) not implemented, (??) unknown. Feb 2 12:21:26 rene x-daemon[1436]: (==) Log file: "/var/log/Xorg.0.log", Time: Sat Feb 2 12:21:26 2019 Feb 2 12:21:26 rene x-daemon[1436]: (==) Using config file: "/etc/X11/xorg.conf" Feb 2 12:21:26 rene x-daemon[1436]: (==) Using config directory: "/etc/X11/xorg.conf.d" Feb 2 12:21:26 rene x-daemon[1436]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Feb 2 12:21:26 rene systemd[1]: Started Samba SMB Daemon. Feb 2 12:21:26 rene kernel: [ 13.120160] snd_hda_codec_hdmi hdaudioC1D0: HDMI: invalid ELD buf size -1 Feb 2 12:21:26 rene systemd[1]: Started Automounts filesystems on demand. Feb 2 12:21:26 rene systemd[1]: Started Avahi linker. Feb 2 12:21:26 rene systemd[1]: Started prevent-umount-on-pause.service. Feb 2 12:21:26 rene systemd[1]: Started vdr-update-monitor. Feb 2 12:21:26 rene avahi-daemon[926]: Server startup complete. Host name is rene.local. Local service cookie is 3102710318. Feb 2 12:21:26 rene snapd[968]: AppArmor status: apparmor is enabled and all features are available Feb 2 12:21:26 rene kernel: [ 13.440165] snd_hda_codec_hdmi hdaudioC1D0: HDMI: invalid ELD buf size -1 Feb 2 12:21:26 rene systemd-udevd[1529]: Process '/bin/systemctl start --no-block nvidia-persistenced.service' failed with exit code 5. Feb 2 12:21:26 rene kernel: [ 13.492293] resource sanity check: requesting [mem 0x000c0000-0x000fffff], which spans more than PCI Bus 0000:00 [mem 0x000c8000-0x000dffff window] Feb 2 12:21:26 rene kernel: [ 13.492372] caller os_map_kernel_space+0x86/0xb0 [nvidia] mapping multiple BARs Feb 2 12:21:26 rene snapd[968]: daemon.go:379: started snapd/2.37.1 (series 16; classic) ubuntu/18.04 (amd64) linux/4.15.0-45-generic. Feb 2 12:21:26 rene avahi-linker[1484]: 2019-02-02 12:21:26,747 INFO Started avahi-linker Feb 2 12:21:27 rene avahi-linker[1484]: 2019-02-02 12:21:27,015 INFO skip local service 'Video on rene' type '_nfs._tcp' domain 'local' Feb 2 12:21:27 rene avahi-linker[1484]: 2019-02-02 12:21:27,016 INFO skip local service 'Audio on rene' type '_nfs._tcp' domain 'local' Feb 2 12:21:27 rene avahi-linker[1484]: 2019-02-02 12:21:27,016 INFO skip local service 'Backups on rene' type '_nfs._tcp' domain 'local' Feb 2 12:21:27 rene avahi-linker[1484]: 2019-02-02 12:21:27,016 INFO skip local service 'Files on rene' type '_nfs._tcp' domain 'local' Feb 2 12:21:27 rene avahi-linker[1484]: 2019-02-02 12:21:27,016 INFO skip local service 'Pictures on rene' type '_nfs._tcp' domain 'local' Feb 2 12:21:27 rene avahi-linker[1484]: 2019-02-02 12:21:27,016 INFO skip local service 'Recordings on rene' type '_nfs._tcp' domain 'local' Feb 2 12:21:27 rene avahi-linker[1484]: 2019-02-02 12:21:27,016 INFO skip local service 'Recordings on rene' type '_nfs._tcp' domain 'local' Feb 2 12:21:27 rene avahi-linker[1484]: 2019-02-02 12:21:27,016 INFO skip local service 'Audio on rene' type '_nfs._tcp' domain 'local' Feb 2 12:21:27 rene avahi-linker[1484]: 2019-02-02 12:21:27,016 INFO skip local service 'Backups on rene' type '_nfs._tcp' domain 'local' Feb 2 12:21:27 rene avahi-linker[1484]: 2019-02-02 12:21:27,017 INFO skip local service 'Files on rene' type '_nfs._tcp' domain 'local' Feb 2 12:21:27 rene avahi-linker[1484]: 2019-02-02 12:21:27,017 INFO skip local service 'Pictures on rene' type '_nfs._tcp' domain 'local' Feb 2 12:21:27 rene avahi-linker[1484]: 2019-02-02 12:21:27,017 INFO skip local service 'Video on rene' type '_nfs._tcp' domain 'local' Feb 2 12:21:27 rene avahi-linker[1484]: 2019-02-02 12:21:27,017 INFO skip local service 'Video on rene' type '_nfs._tcp' domain 'local' Feb 2 12:21:27 rene avahi-linker[1484]: 2019-02-02 12:21:27,017 INFO skip local service 'Audio on rene' type '_nfs._tcp' domain 'local' Feb 2 12:21:27 rene avahi-linker[1484]: 2019-02-02 12:21:27,017 INFO skip local service 'Backups on rene' type '_nfs._tcp' domain 'local' Feb 2 12:21:27 rene avahi-linker[1484]: 2019-02-02 12:21:27,017 INFO skip local service 'Files on rene' type '_nfs._tcp' domain 'local' Feb 2 12:21:27 rene avahi-linker[1484]: 2019-02-02 12:21:27,017 INFO skip local service 'Pictures on rene' type '_nfs._tcp' domain 'local' Feb 2 12:21:27 rene avahi-linker[1484]: 2019-02-02 12:21:27,017 INFO skip local service 'Recordings on rene' type '_nfs._tcp' domain 'local' Feb 2 12:21:27 rene avahi-daemon[926]: Service "Video on rene" (/services/yavdr-video.service) successfully established. Feb 2 12:21:27 rene avahi-daemon[926]: Service "Recordings on rene" (/services/yavdr-recordings.service) successfully established. Feb 2 12:21:27 rene avahi-daemon[926]: Service "Pictures on rene" (/services/yavdr-pictures.service) successfully established. Feb 2 12:21:27 rene avahi-daemon[926]: Service "Files on rene" (/services/yavdr-files.service) successfully established. Feb 2 12:21:27 rene avahi-daemon[926]: Service "Backups on rene" (/services/yavdr-backups.service) successfully established. Feb 2 12:21:27 rene avahi-daemon[926]: Service "Audio on rene" (/services/yavdr-audio.service) successfully established. Feb 2 12:21:30 rene set-cpufreq[979]: Setting powersave scheduler for all CPUs Feb 2 12:21:32 rene systemd[1]: Started Daily apt upgrade and clean activities. Feb 2 12:22:26 rene systemd-udevd[504]: seq 5002 '/devices/virtual/vc/vcs7' is taking a long time Feb 2 12:22:55 rene systemd[1]: snapd.service: Start operation timed out. Terminating. Feb 2 12:22:56 rene systemd[1]: x@vt7.service: Start operation timed out. Terminating. Feb 2 12:24:25 rene systemd[1]: snapd.service: State 'stop-sigterm' timed out. Killing. Feb 2 12:24:25 rene systemd[1]: snapd.service: Killing process 968 (snapd) with signal SIGKILL. Feb 2 12:24:25 rene systemd[1]: snapd.service: Killing process 1538 (umount) with signal SIGKILL. Feb 2 12:24:25 rene systemd[1]: snapd.service: Killing process 1519 (snapd) with signal SIGKILL. Feb 2 12:24:25 rene systemd[1]: snapd.service: Main process exited, code=killed, status=9/KILL Feb 2 12:24:26 rene systemd[1]: x@vt7.service: State 'stop-final-sigterm' timed out. Killing. Feb 2 12:24:26 rene systemd[1]: x@vt7.service: Killing process 1443 (Xorg) with signal SIGKILL. Feb 2 12:24:26 rene systemd-udevd[504]: seq 5002 '/devices/virtual/vc/vcs7' killed Feb 2 12:24:26 rene systemd-udevd[504]: worker [1528] terminated by signal 9 (KILL) Feb 2 12:24:26 rene systemd-udevd[504]: worker [1528] failed while handling '/devices/virtual/vc/vcs7' Feb 2 12:25:29 rene systemd[1]: Created slice User Slice of root. Feb 2 12:25:29 rene systemd[1]: Starting User Manager for UID 0... Feb 2 12:25:29 rene systemd[1]: Started Session 1 of user root. Feb 2 12:25:29 rene systemd[1626]: Listening on GnuPG cryptographic agent (ssh-agent emulation). Feb 2 12:25:29 rene systemd[1626]: Listening on GnuPG cryptographic agent and passphrase cache (restricted). Feb 2 12:25:29 rene systemd[1626]: Listening on GnuPG network certificate management daemon. Feb 2 12:25:29 rene systemd[1626]: Starting D-Bus User Message Bus Socket. Feb 2 12:25:29 rene systemd[1626]: Listening on GnuPG cryptographic agent and passphrase cache (access for web browsers). Feb 2 12:25:29 rene systemd[1626]: Reached target Timers. Feb 2 12:25:29 rene systemd[1626]: Listening on GnuPG cryptographic agent and passphrase cache. Feb 2 12:25:29 rene systemd[1626]: Reached target Paths. Feb 2 12:25:29 rene systemd[1626]: Listening on D-Bus User Message Bus Socket. Feb 2 12:25:29 rene systemd[1626]: Reached target Sockets. Feb 2 12:25:29 rene systemd[1626]: Reached target Basic System. Feb 2 12:25:29 rene systemd[1626]: Reached target Default. Feb 2 12:25:29 rene systemd[1626]: Startup finished in 60ms. Feb 2 12:25:29 rene systemd[1]: Started User Manager for UID 0. Feb 2 12:25:55 rene systemd[1]: snapd.service: State 'stop-final-sigterm' timed out. Killing. Feb 2 12:25:55 rene systemd[1]: snapd.service: Killing process 1538 (umount) with signal SIGKILL. Feb 2 12:25:56 rene systemd[1]: x@vt7.service: Processes still around after final SIGKILL. Entering failed mode. Feb 2 12:25:56 rene systemd[1]: x@vt7.service: Failed with result 'timeout'. Feb 2 12:25:56 rene systemd[1]: Failed to start X on vt7. Feb 2 12:25:56 rene systemd[1]: Dependency failed for Start a X session and a systemd user session for the vdr user. Feb 2 12:25:56 rene systemd[1]: yavdr-xorg.service: Job yavdr-xorg.service/start failed with result 'dependency'. Feb 2 12:25:56 rene systemd[1]: Dependency failed for Direct X login for user vdr. Feb 2 12:25:56 rene systemd[1]: xlogin@vdr.service: Job xlogin@vdr.service/start failed with result 'dependency'. Feb 2 12:25:56 rene systemd[1]: Starting Video Disk Recorder... Feb 2 12:25:56 rene vdr: [1805] VDR version 2.4.0 started Feb 2 12:25:56 rene vdr: [1805] switched to user 'vdr' Feb 2 12:25:56 rene vdr: [1805] codeset is 'UTF-8' - known Feb 2 12:25:56 rene vdr: [1805] found 28 locales in /usr/share/locale Feb 2 12:25:56 rene vdr: [1805] loading plugin: /usr/lib/vdr/plugins/libvdr-dbus2vdr.so.2.4.0 Feb 2 12:25:56 rene vdr: [1805] dbus2vdr: use shutdown-hooks in /usr/share/vdr/shutdown-hooks Feb 2 12:25:56 rene vdr: [1805] dbus2vdr: use shutdown-hooks-wrapper /usr/share/vdr-plugin-dbus2vdr/shutdown-wrapper Feb 2 12:25:56 rene vdr: [1805] loading plugin: /usr/lib/vdr/plugins/libvdr-desktop.so.2.4.0 Feb 2 12:25:56 rene vdr: [1805] loading plugin: /usr/lib/vdr/plugins/libvdr-devstatus.so.2.4.0 Feb 2 12:25:56 rene vdr: [1805] loading plugin: /usr/lib/vdr/plugins/libvdr-markad.so.2.4.0 Feb 2 12:25:56 rene vdr: [1805] loading plugin: /usr/lib/vdr/plugins/libvdr-osd2web.so.2.4.0 Feb 2 12:25:56 rene vdr: [1805] loading plugin: /usr/lib/vdr/plugins/libvdr-pulsecontrol.so.2.4.0 Feb 2 12:25:56 rene vdr: [1805] loading plugin: /usr/lib/vdr/plugins/libvdr-softhddevice.so.2.4.0 Feb 2 12:25:56 rene vdr: [1805] loading /var/lib/vdr/setup.conf Feb 2 12:25:56 rene vdr: [1805] loading /var/lib/vdr/sources.conf Feb 2 12:25:56 rene vdr: [1805] loading /var/lib/vdr/diseqc.conf Feb 2 12:25:56 rene vdr: [1805] loading /var/lib/vdr/scr.conf Feb 2 12:25:56 rene vdr: [1805] loading /var/lib/vdr/channels.conf Feb 2 12:25:56 rene vdr: [1805] loading /var/lib/vdr/timers.conf Feb 2 12:25:56 rene vdr: [1805] loading /var/lib/vdr/commands.conf Feb 2 12:25:56 rene vdr: [1805] loading /var/lib/vdr/reccmds.conf Feb 2 12:25:56 rene vdr: [1805] loading /var/lib/vdr/svdrphosts.conf Feb 2 12:25:56 rene vdr: [1805] loading /var/lib/vdr/remote.conf Feb 2 12:25:56 rene vdr: [1805] loading /var/lib/vdr/keymacros.conf Feb 2 12:25:56 rene vdr: [1805] ERROR: unknown plugin 'yaepghd' Feb 2 12:25:56 rene vdr: [1805] ERROR: empty key macro Feb 2 12:25:56 rene vdr: [1805] registered source parameters for 'A - ATSC' Feb 2 12:25:56 rene vdr: [1809] video directory scanner thread started (pid=1805, tid=1809, prio=low) Feb 2 12:25:57 rene vdr: [1805] registered source parameters for 'C - DVB-C' Feb 2 12:25:57 rene vdr: [1810] epg data reader thread started (pid=1805, tid=1810, prio=high) Feb 2 12:25:57 rene vdr: [1805] registered source parameters for 'S - DVB-S' Feb 2 12:25:57 rene vdr: [1805] registered source parameters for 'T - DVB-T' Feb 2 12:25:57 rene vdr: [1810] reading EPG data from /var/cache/vdr/epg.data Feb 2 12:25:57 rene vdr: [1805] probing /dev/dvb/adapter0/frontend0 Feb 2 12:25:57 rene vdr: [1805] creating cDvbDevice Feb 2 12:25:57 rene vdr: [1805] new device number 1 Feb 2 12:25:57 rene vdr: [1805] DVB API version is 0x050A (VDR was built with 0x050A) Feb 2 12:25:57 rene vdr: [1805] frontend 0/0 provides DVB-S,DVB-S2,DSS with QPSK ("STV090x Multistandard") Feb 2 12:25:57 rene vdr: [1805] cTimeMs: using monotonic clock (resolution is 1 ns) Feb 2 12:25:57 rene vdr: [1813] frontend 0/0 tuner thread started (pid=1805, tid=1813, prio=high) Feb 2 12:25:57 rene vdr: [1814] device 1 section handler thread started (pid=1805, tid=1814, prio=low) Feb 2 12:25:57 rene vdr: [1805] probing /dev/dvb/adapter1/frontend0 Feb 2 12:25:57 rene vdr: [1805] creating cDvbDevice Feb 2 12:25:57 rene vdr: [1805] new device number 2 Feb 2 12:25:57 rene vdr: [1805] frontend 1/0 provides DVB-S,DVB-S2,DSS with QPSK ("STV090x Multistandard") Feb 2 12:25:57 rene vdr: [1805] found 2 DVB devices Feb 2 12:25:57 rene vdr: [1816] frontend 1/0 tuner thread started (pid=1805, tid=1816, prio=high) Feb 2 12:25:57 rene vdr: [1817] device 2 section handler thread started (pid=1805, tid=1817, prio=low) Feb 2 12:25:57 rene vdr: [1805] initializing plugin: dbus2vdr (31): Steuerung des VDR über D-Bus Feb 2 12:25:57 rene vdr: [1805] initializing plugin: desktop (0.0.3): desktop apps menu Feb 2 12:25:57 rene vdr: [1805] initializing plugin: devstatus (0.4.1): DVB-Gerätestatus Feb 2 12:25:57 rene vdr: [1805] initializing plugin: markad (0.1.6): Markiere Werbung Feb 2 12:25:57 rene avahi-linker[1484]: 2019-02-02 12:25:57,115 INFO VDR started Feb 2 12:25:57 rene vdr[1805]: vdr: error while reading '/var/lib/vdr/plugins/pulsecontrol/startup.script' Feb 2 12:25:57 rene vdr: [1805] initializing plugin: osd2web (0.2.48-GIT): osd2web plugin Feb 2 12:25:57 rene vdr: [1805] initializing plugin: pulsecontrol (0.2.1): Pulseaudio über das OSD steuern Feb 2 12:25:57 rene vdr: [1805] initializing plugin: softhddevice (0.7.0): Ein Software und GPU emulieres HD-Gerät Feb 2 12:25:57 rene vdr: [1805] new device number 3 Feb 2 12:25:57 rene vdr: [1805] setting primary device to 3 Feb 2 12:25:57 rene vdr: [1805] assuming manual start of VDR Feb 2 12:25:57 rene vdr: [1805] setting current skin to "lcars" Feb 2 12:25:57 rene vdr: [1805] loading /var/lib/vdr/themes/lcars-default.theme Feb 2 12:25:57 rene vdr: [1805] starting plugin: dbus2vdr Feb 2 12:25:57 rene vdr: [1818] dbus2vdr: mainloop started Feb 2 12:25:57 rene vdr: [1805] starting plugin: desktop Feb 2 12:25:57 rene vdr: [1805] starting plugin: devstatus Feb 2 12:25:57 rene vdr: [1805] starting plugin: markad Feb 2 12:25:57 rene vdr: [1805] starting plugin: osd2web Feb 2 12:25:57 rene vdr: [1805] starting plugin: pulsecontrol Feb 2 12:25:57 rene vdr: [1805] pulsecontrol: error on reading script /var/lib/vdr/plugins/pulsecontrol/startup.script Feb 2 12:25:57 rene vdr: [1805] starting plugin: softhddevice Feb 2 12:25:57 rene vdr: osd2web: osd2web plugin thread started (pid=1805) Feb 2 12:25:57 rene vdr: [1818] dbus2vdr: System: connected with unique name :1.17 Feb 2 12:25:57 rene vdr: [1818] dbus2vdr: thread-pool for handling signal-emits started Feb 2 12:25:57 rene vdr: osd2web: Listener at port (4444) established Feb 2 12:25:57 rene vdr: osd2web: using libwebsocket version '2.4.1 unknown-build-hash' Feb 2 12:25:57 rene vdr: [softhddev] ready detached Feb 2 12:25:57 rene vdr: [1805] remote control LIRC - keys known Feb 2 12:25:57 rene vdr: [1824] LIRC remote control thread started (pid=1805, tid=1824, prio=high) Feb 2 12:25:57 rene vdr: [1805] loading /var/cache/vdr/cam.data Feb 2 12:25:57 rene vdr: [1810] epg data reader thread ended (pid=1805, tid=1810) Feb 2 12:25:57 rene vdr: [1805] switching to channel 6 S19.2E-1-1089-12020 (RTL2) Feb 2 12:25:57 rene vdr: [1827] device 1 receiver thread started (pid=1805, tid=1827, prio=high) Feb 2 12:25:57 rene systemd[1]: Started Video Disk Recorder. Feb 2 12:25:57 rene vdr: [1828] SVDRP server handler thread started (pid=1805, tid=1828, prio=low) Feb 2 12:25:57 rene vdr: [1828] SVDRP rene opening port 6419/tcp Feb 2 12:25:57 rene vdr: [1829] device 1 TS buffer thread started (pid=1805, tid=1829, prio=high) Feb 2 12:25:57 rene vdr: [1828] SVDRP rene listening on port 6419/tcp Feb 2 12:25:57 rene systemd[1]: Started vdr-net-monitor. Feb 2 12:25:57 rene vdr: [1805] OSD size changed to 1280x720 @ 1 Feb 2 12:25:57 rene vdr: [1809] video directory scanner thread ended (pid=1805, tid=1809) Feb 2 12:25:57 rene vdr: [1818] dbus2vdr: thread-pool for handling method-calls started Feb 2 12:25:57 rene vdr: [1840] video directory scanner thread started (pid=1805, tid=1840, prio=low) Feb 2 12:25:57 rene avahi-linker[1484]: 2019-02-02 12:25:57,835 INFO Update recdir via dbus: 0 update of recordings triggered Feb 2 12:25:57 rene vdr: [1840] video directory scanner thread ended (pid=1805, tid=1840) Feb 2 12:26:25 rene anacron[935]: Job `cron.daily' started Feb 2 12:26:25 rene anacron[1856]: Updated timestamp for job `cron.daily' to 2019-02-02