Skip to content
This repository has been archived by the owner on Dec 21, 2020. It is now read-only.

no data error with VNSI #97

Open
fsironman opened this issue Aug 11, 2017 · 13 comments
Open

no data error with VNSI #97

fsironman opened this issue Aug 11, 2017 · 13 comments

Comments

@fsironman
Copy link

fsironman commented Aug 11, 2017

Hello, I recently made the switch from using EasyVDR 3.0 as a frontend to Kodi v17.2 with this the vnsi plugin newest version thats in the repo.

My headless server is easyvdr 3.0 (VDR-Version: 2.2.0) with this plugin:

vdr-plugin-vnsiserver:
  Installiert:           2:1.5.2~git20170616-0easyVDR0~trusty

I use a Digital Devices GmbH Max S8 with 8 tuners in unicable mode on Astra 19.2E

After I made the switch two weeks ago I started to encounter no data errors in Kodi when trying to tune to a channel. This is sometimes randomly only once sometimes for a few minutes in a row and then it magically resolves itself again. This happens on all clients and as far as I have seen it only on one client at the time. Recordings also work fine all the time there was not a single missed/unusable one from vdr.

VNSI Server Pluging is started with -Pvnsiserver -d -t 4
I changed it from the default 10 sec timeout and no -d to see if it makes a difference.

I uploaded the whole VDR log here:
https://pastebin.com/gR7XFtTK

I tried to analyse it a bit already and my first guess was that the tuner its trying to tune to is not working somehow.

Since this was not issue for 2 years while watching with a VDR frontend my conclusion was that its somehow related to this plugin.

While writing this post and looking at all the other topics regarding the no data error I noticed that my VDR Loglevel was only on 2 I set to 3 now to get some more info out of it.

If it turns out that it is indeed an VDR problem and while the VDR frontend I never encountered the issue because it might just have switched to another tuner would it be possible for this plugin to do the same or does it rely on VDR giving out a tuner?

This is how it looks like in the logfile over the course of the evening:

cat /var/log/syslog.1 | grep -B 5 data | egrep 'data|device' | grep device -A 1
Aug 10 20:08:41 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 20:08:45 easyvdr vdr: [22374] VNSI: Channel: no data 16
--
Aug 10 21:17:24 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 21:17:28 easyvdr vdr: [22552] VNSI: Channel: no data 16
--
Aug 10 21:17:32 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 21:17:36 easyvdr vdr: [22555] VNSI: Channel: no data 16
Aug 10 21:17:38 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 21:17:42 easyvdr vdr: [22558] VNSI: Channel: no data 16
--
Aug 10 21:18:14 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 21:18:18 easyvdr vdr: [22561] VNSI: Channel: no data 16
--
Aug 10 21:18:25 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 21:18:29 easyvdr vdr: [22564] VNSI: Channel: no data 16
--
Aug 10 21:41:45 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 21:41:49 easyvdr vdr: [22639] VNSI: Channel: no data 16
--
Aug 10 21:41:58 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 21:42:02 easyvdr vdr: [22642] VNSI: Channel: no data 16
--
Aug 10 21:42:12 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 21:42:17 easyvdr vdr: [22645] VNSI: Channel: no data 16
--
Aug 10 21:42:22 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 21:42:26 easyvdr vdr: [22647] VNSI: Channel: no data 16
--
Aug 10 21:42:31 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 21:42:35 easyvdr vdr: [22651] VNSI: Channel: no data 16
--
Aug 10 21:42:50 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 21:42:54 easyvdr vdr: [22656] VNSI: Channel: no data 16
--
Aug 10 21:42:59 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 21:43:03 easyvdr vdr: [22660] VNSI: Channel: no data 16
Aug 10 21:43:06 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 21:43:10 easyvdr vdr: [22663] VNSI: Channel: no data 16
--
Aug 10 21:43:16 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 21:43:20 easyvdr vdr: [22666] VNSI: Channel: no data 16
--
Aug 10 21:57:42 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 21:57:46 easyvdr vdr: [22766] VNSI: Channel: no data 16
--
Aug 10 21:57:51 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 21:57:55 easyvdr vdr: [22769] VNSI: Channel: no data 16
--
Aug 10 23:04:37 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 23:04:41 easyvdr vdr: [22884] VNSI: Channel: no data 16
Aug 10 23:04:41 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 23:04:45 easyvdr vdr: [22887] VNSI: Channel: no data 16
--
Aug 10 23:04:56 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 23:05:00 easyvdr vdr: [22890] VNSI: Channel: no data 16
--
Aug 10 23:05:05 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 23:05:09 easyvdr vdr: [22893] VNSI: Channel: no data 16
--
Aug 10 23:05:13 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 23:05:17 easyvdr vdr: [22896] VNSI: Channel: no data 16
Aug 10 23:05:18 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 23:05:22 easyvdr vdr: [22899] VNSI: Channel: no data 16
--
Aug 10 23:05:34 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 23:05:38 easyvdr vdr: [22904] VNSI: Channel: no data 16
--
Aug 10 23:05:55 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 23:05:59 easyvdr vdr: [22911] VNSI: Channel: no data 16
--
Aug 10 23:06:04 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 23:06:08 easyvdr vdr: [22915] VNSI: Channel: no data 16
--
Aug 10 23:06:15 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 23:06:19 easyvdr vdr: [22917] VNSI: Channel: no data 16
--
Aug 10 23:06:24 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 23:06:28 easyvdr vdr: [22921] VNSI: Channel: no data 16
Aug 10 23:06:30 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 23:06:34 easyvdr vdr: [22924] VNSI: Channel: no data 16
--
Aug 10 23:06:44 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 23:06:48 easyvdr vdr: [22930] VNSI: Channel: no data 16
--
Aug 10 23:06:57 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 23:07:01 easyvdr vdr: [22934] VNSI: Channel: no data 16
--
Aug 10 23:07:07 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 23:07:11 easyvdr vdr: [22937] VNSI: Channel: no data 16
--
Aug 10 23:07:16 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 23:07:20 easyvdr vdr: [22939] VNSI: Channel: no data 16
--
Aug 10 23:07:24 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 23:07:28 easyvdr vdr: [22943] VNSI: Channel: no data 16
Aug 10 23:07:43 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 23:07:47 easyvdr vdr: [22947] VNSI: Channel: no data 16
--
Aug 10 23:11:19 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 23:11:23 easyvdr vdr: [22969] VNSI: Channel: no data 16
--
Aug 10 23:11:39 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 23:11:43 easyvdr vdr: [22973] VNSI: Channel: no data 16
--
Aug 10 23:11:47 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 23:11:51 easyvdr vdr: [22976] VNSI: Channel: no data 16
--
Aug 10 23:11:58 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 23:12:02 easyvdr vdr: [22982] VNSI: Channel: no data 16
--
Aug 10 23:14:15 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 23:14:19 easyvdr vdr: [22984] VNSI: Channel: no data 16
Aug 10 23:14:22 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 23:14:26 easyvdr vdr: [22991] VNSI: Channel: no data 16
Aug 10 23:14:30 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 23:14:34 easyvdr vdr: [22997] VNSI: Channel: no data 16
--
Aug 10 23:14:40 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 23:14:44 easyvdr vdr: [23000] VNSI: Channel: no data 16
--
Aug 10 23:15:10 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 23:15:14 easyvdr vdr: [23006] VNSI: Channel: no data 16
--
Aug 10 23:15:19 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 23:15:23 easyvdr vdr: [23009] VNSI: Channel: no data 16
Aug 10 23:15:23 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 23:15:27 easyvdr vdr: [23012] VNSI: Channel: no data 16
Aug 10 23:15:28 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 23:15:32 easyvdr vdr: [23015] VNSI: Channel: no data 16
Aug 10 23:15:43 easyvdr vdr: [22304] VNSI: Successfully found following device: 0x2897d60 (2) for receiving, priority=0
Aug 10 23:15:47 easyvdr vdr: [23018] VNSI: Channel: no data 16
--
Aug 11 00:27:59 easyvdr vdr: [23127] VNSI: Successfully found following device: 0x289e970 (3) for receiving, priority=5
Aug 11 00:28:03 easyvdr vdr: [23137] VNSI: Channel: no data 16
--
Aug 11 00:28:37 easyvdr vdr: [23145] VNSI: Successfully found following device: 0x289e970 (3) for receiving, priority=5
Aug 11 00:28:41 easyvdr vdr: [23148] VNSI: Channel: no data 16
@FernetMenta
Copy link
Owner

did you try "Avoid EPG scan while streaming"?

@fsironman
Copy link
Author

Thx for the quick answer.

In my setup.conf there was no entry.

I was reading up a bit and there's a commit with saying its the default setting doesn't that mean it should already be active or is it only the default value for the the config tool which gets written into the setup.conf

2015-09-18: Version 1.3.0
[...]

  • make avoid EPG scan while streaming default

Nevertheless I went into the VDR config and saved it:

cat /var/lib/vdr/setup.conf | grep vnsi
vnsiserver.AvoidEPGScan = 1
vnsiserver.DisableCamBlacklist = 0
vnsiserver.DisableScrambleTimeout = 0
vnsiserver.GroupRecordings = 1
vnsiserver.PlayRecording = 0
vnsiserver.PmtTimeout = 0
vnsiserver.Timeshift = 0
vnsiserver.TimeshiftBufferDir = 
vnsiserver.TimeshiftBufferFileSize = 6
vnsiserver.TimeshiftBufferSize = 5

So for now I can just wait to see if it happens again or not.

@fsironman
Copy link
Author

Update: the problem still persists
Heres the log with vdr loglevel 3:
https://pastebin.com/7qzZWakv

What I can see from the log:
Its always the same device VNSI picks 0x269f4e0 (2) when the error occurs.
This device returns no data from anywhere from 40 sec to 6 min when it happens.

Switching channels during this time works as long as VNSI select another device for the channel.

Aug 13 01:36:39 easyvdr vdr: [25862] VNSI: Successfully found following device: 0x269f4e0 (2) for  receiving, priority=0
Aug 13 01:36:39 easyvdr vdr: [25862] VNSI: Successfully switched to channel 1 - Das Erste HD
Aug 13 01:36:43 easyvdr vdr: [26019] VNSI: Channel: no data 16
Aug 13 01:36:47 easyvdr vdr: [25862] VNSI: Successfully found following device: 0x265d9e0 (1) for receiving, priority=0
Aug 13 01:36:47 easyvdr vdr: [25862] VNSI: Successfully switched to channel 4 - RTL Television
<- WORKING->
Aug 13 01:36:54 easyvdr vdr: [25862] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 13 01:36:54 easyvdr vdr: [25862] VNSI: Successfully switched to channel 52 - Disney Channel
Aug 13 01:36:56 easyvdr vdr: [26023] VNSI: Channel: no data 16

So it seems that the device might be blocked by something?
Also let me know if I'm wrong here and this a VDR related and not necessarily the VNSI plugin

This is not the complete log as pastebin limits the filesize

I did the following to show the errors over the course of the day:

grep -B 11 'no data' vdr2.log | egrep 'no data|Successfully' | grep -A 2 device

Aug 12 14:18:03 easyvdr vdr: [23827] VNSI: Successfully found following device: 0x21e4710 (2) for receiving, priority=5
Aug 12 14:18:04 easyvdr vdr: [23827] VNSI: Successfully switched to channel 12 - ONE HD
Aug 12 14:18:05 easyvdr vdr: [23832] VNSI: Channel: no data 16
--
Aug 12 18:47:52 easyvdr vdr: [24838] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 12 18:47:52 easyvdr vdr: [24838] VNSI: Successfully switched to channel 12 - ONE HD
Aug 12 18:47:54 easyvdr vdr: [25196] VNSI: Channel: no data 16
--
Aug 12 18:47:59 easyvdr vdr: [24838] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 12 18:47:59 easyvdr vdr: [24838] VNSI: Successfully switched to channel 11 - DMAX
Aug 12 18:48:01 easyvdr vdr: [25199] VNSI: Channel: no data 16
--
Aug 12 18:48:19 easyvdr vdr: [24838] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 12 18:48:19 easyvdr vdr: [24838] VNSI: Successfully switched to channel 1 - Das Erste HD
Aug 12 18:48:21 easyvdr vdr: [25202] VNSI: Channel: no data 16
--
Aug 12 18:48:25 easyvdr vdr: [24838] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 12 18:48:25 easyvdr vdr: [24838] VNSI: Successfully switched to channel 2 - ZDF HD
Aug 12 18:48:27 easyvdr vdr: [25205] VNSI: Channel: no data 16
--
Aug 12 18:48:32 easyvdr vdr: [24838] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 12 18:48:32 easyvdr vdr: [24838] VNSI: Successfully switched to channel 3 - SAT.1
Aug 12 18:48:34 easyvdr vdr: [25208] VNSI: Channel: no data 16
Aug 12 18:49:58 easyvdr vdr: [24838] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 12 18:49:58 easyvdr vdr: [24838] VNSI: Successfully switched to channel 11 - DMAX
Aug 12 18:50:00 easyvdr vdr: [25212] VNSI: Channel: no data 16
--
Aug 12 18:50:08 easyvdr vdr: [24838] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 12 18:50:08 easyvdr vdr: [24838] VNSI: Successfully switched to channel 3 - SAT.1
Aug 12 18:50:10 easyvdr vdr: [25215] VNSI: Channel: no data 16
--
Aug 12 18:50:35 easyvdr vdr: [24838] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 12 18:50:35 easyvdr vdr: [24838] VNSI: Successfully switched to channel 3 - SAT.1
Aug 12 18:50:37 easyvdr vdr: [25221] VNSI: Channel: no data 16
--
Aug 12 21:20:48 easyvdr vdr: [25255] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 12 21:20:48 easyvdr vdr: [25255] VNSI: Successfully switched to channel 41 - rhein main tv
Aug 12 21:20:50 easyvdr vdr: [25458] VNSI: Channel: no data 16
--
Aug 12 21:20:56 easyvdr vdr: [25255] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 12 21:20:56 easyvdr vdr: [25255] VNSI: Successfully switched to channel 42 - Schau TV
Aug 12 21:20:58 easyvdr vdr: [25461] VNSI: Channel: no data 16
--
Aug 12 21:21:14 easyvdr vdr: [25255] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 12 21:21:14 easyvdr vdr: [25255] VNSI: Successfully switched to channel 6 - ProSieben
Aug 12 21:21:16 easyvdr vdr: [25465] VNSI: Channel: no data 16
--
Aug 12 21:21:44 easyvdr vdr: [25255] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 12 21:21:44 easyvdr vdr: [25255] VNSI: Successfully switched to channel 8 - kabel eins
Aug 12 21:21:46 easyvdr vdr: [25469] VNSI: Channel: no data 16
--
Aug 12 21:22:10 easyvdr vdr: [25255] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 12 21:22:10 easyvdr vdr: [25255] VNSI: Successfully switched to channel 6 - ProSieben
Aug 12 21:22:12 easyvdr vdr: [25474] VNSI: Channel: no data 16
--
Aug 12 21:22:26 easyvdr vdr: [25255] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 12 21:22:26 easyvdr vdr: [25255] VNSI: Successfully switched to channel 3 - SAT.1
Aug 12 21:22:28 easyvdr vdr: [25479] VNSI: Channel: no data 16
--
Aug 12 21:22:52 easyvdr vdr: [25255] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 12 21:22:52 easyvdr vdr: [25255] VNSI: Successfully switched to channel 6 - ProSieben
Aug 12 21:22:54 easyvdr vdr: [25484] VNSI: Channel: no data 16
--
Aug 12 21:24:47 easyvdr vdr: [25255] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 12 21:24:47 easyvdr vdr: [25255] VNSI: Successfully switched to channel 44 - Welt der Wunder
Aug 12 21:24:49 easyvdr vdr: [25496] VNSI: Channel: no data 16
--
Aug 12 21:24:56 easyvdr vdr: [25255] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 12 21:24:56 easyvdr vdr: [25255] VNSI: Successfully switched to channel 8 - kabel eins
Aug 12 21:24:58 easyvdr vdr: [25500] VNSI: Channel: no data 16
--
Aug 12 21:26:00 easyvdr vdr: [25255] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 12 21:26:00 easyvdr vdr: [25255] VNSI: Successfully switched to channel 6 - ProSieben
Aug 12 21:26:02 easyvdr vdr: [25507] VNSI: Channel: no data 16
--
Aug 12 21:26:12 easyvdr vdr: [25255] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 12 21:26:12 easyvdr vdr: [25255] VNSI: Successfully switched to channel 52 - Disney Channel
Aug 12 21:26:14 easyvdr vdr: [25511] VNSI: Channel: no data 16
--
Aug 12 21:26:22 easyvdr vdr: [25255] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 12 21:26:22 easyvdr vdr: [25255] VNSI: Successfully switched to channel 50 - KiKA HD
Aug 12 21:26:24 easyvdr vdr: [25518] VNSI: Channel: no data 16
--
Aug 12 21:26:32 easyvdr vdr: [25255] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 12 21:26:33 easyvdr vdr: [25255] VNSI: Successfully switched to channel 49 - Eurosport Deutschland
Aug 12 21:26:34 easyvdr vdr: [25520] VNSI: Channel: no data 16
--
Aug 12 21:26:43 easyvdr vdr: [25255] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 12 21:26:43 easyvdr vdr: [25255] VNSI: Successfully switched to channel 48 - SPORT1
Aug 12 21:26:45 easyvdr vdr: [25523] VNSI: Channel: no data 16
--
Aug 13 01:35:26 easyvdr vdr: [25862] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 13 01:35:26 easyvdr vdr: [25862] VNSI: Successfully switched to channel 47 - ORF2E
Aug 13 01:35:28 easyvdr vdr: [25992] VNSI: Channel: no data 16
--
Aug 13 01:35:33 easyvdr vdr: [25862] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 13 01:35:33 easyvdr vdr: [25862] VNSI: Successfully switched to channel 46 - Zee One HD
Aug 13 01:35:35 easyvdr vdr: [25995] VNSI: Channel: no data 16
--
Aug 13 01:35:43 easyvdr vdr: [25862] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 13 01:35:43 easyvdr vdr: [25862] VNSI: Successfully switched to channel 1 - Das Erste HD
Aug 13 01:35:45 easyvdr vdr: [25999] VNSI: Channel: no data 16
--
Aug 13 01:35:49 easyvdr vdr: [25862] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 13 01:35:49 easyvdr vdr: [25862] VNSI: Successfully switched to channel 2 - ZDF HD
Aug 13 01:35:51 easyvdr vdr: [26002] VNSI: Channel: no data 16
--
Aug 13 01:35:54 easyvdr vdr: [25862] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 13 01:35:54 easyvdr vdr: [25862] VNSI: Successfully switched to channel 3 - SAT.1
Aug 13 01:35:56 easyvdr vdr: [26005] VNSI: Channel: no data 16
--
Aug 13 01:36:17 easyvdr vdr: [25862] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 13 01:36:17 easyvdr vdr: [25862] VNSI: Successfully switched to channel 44 - Welt der Wunder
Aug 13 01:36:19 easyvdr vdr: [26010] VNSI: Channel: no data 16
--
Aug 13 01:36:21 easyvdr vdr: [25862] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 13 01:36:21 easyvdr vdr: [25862] VNSI: Successfully switched to channel 45 - BBC World News Europe HD
Aug 13 01:36:23 easyvdr vdr: [26013] VNSI: Channel: no data 16
--
Aug 13 01:36:39 easyvdr vdr: [25862] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 13 01:36:39 easyvdr vdr: [25862] VNSI: Successfully switched to channel 1 - Das Erste HD
Aug 13 01:36:41 easyvdr vdr: [26019] VNSI: Channel: no data 16
--
Aug 13 01:36:54 easyvdr vdr: [25862] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 13 01:36:54 easyvdr vdr: [25862] VNSI: Successfully switched to channel 52 - Disney Channel
Aug 13 01:36:56 easyvdr vdr: [26023] VNSI: Channel: no data 16
--
Aug 13 01:36:59 easyvdr vdr: [25862] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 13 01:36:59 easyvdr vdr: [25862] VNSI: Successfully switched to channel 51 - Nickelodeon
Aug 13 01:37:01 easyvdr vdr: [26026] VNSI: Channel: no data 16
--
Aug 13 01:37:05 easyvdr vdr: [25862] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 13 01:37:05 easyvdr vdr: [25862] VNSI: Successfully switched to channel 50 - KiKA HD
Aug 13 01:37:07 easyvdr vdr: [26030] VNSI: Channel: no data 16
--
Aug 13 01:37:11 easyvdr vdr: [25862] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 13 01:37:11 easyvdr vdr: [25862] VNSI: Successfully switched to channel 49 - Eurosport Deutschland
Aug 13 01:37:13 easyvdr vdr: [26033] VNSI: Channel: no data 16
--
Aug 13 01:37:16 easyvdr vdr: [25862] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 13 01:37:16 easyvdr vdr: [25862] VNSI: Successfully switched to channel 48 - SPORT1
Aug 13 01:37:18 easyvdr vdr: [26036] VNSI: Channel: no data 16
--
Aug 13 01:37:23 easyvdr vdr: [25862] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 13 01:37:23 easyvdr vdr: [25862] VNSI: Successfully switched to channel 47 - ORF2E
Aug 13 01:37:25 easyvdr vdr: [26039] VNSI: Channel: no data 16
--
Aug 13 01:37:28 easyvdr vdr: [25862] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 13 01:37:28 easyvdr vdr: [25862] VNSI: Successfully switched to channel 48 - SPORT1
Aug 13 01:37:30 easyvdr vdr: [26042] VNSI: Channel: no data 16
--
Aug 13 01:37:32 easyvdr vdr: [25862] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 13 01:37:32 easyvdr vdr: [25862] VNSI: Successfully switched to channel 47 - ORF2E
Aug 13 01:37:34 easyvdr vdr: [26045] VNSI: Channel: no data 16
--
Aug 13 01:37:37 easyvdr vdr: [25862] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 13 01:37:37 easyvdr vdr: [25862] VNSI: Successfully switched to channel 46 - Zee One HD
Aug 13 01:37:39 easyvdr vdr: [26048] VNSI: Channel: no data 16
--
Aug 13 01:39:59 easyvdr vdr: [25862] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 13 01:39:59 easyvdr vdr: [25862] VNSI: Successfully switched to channel 35 - ANIXE HD
Aug 13 01:40:01 easyvdr vdr: [26099] VNSI: Channel: no data 16
--
Aug 13 02:02:06 easyvdr vdr: [25862] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 13 02:02:06 easyvdr vdr: [25862] VNSI: Successfully switched to channel 31 - Radio Bremen TV
Aug 13 02:02:08 easyvdr vdr: [26190] VNSI: Channel: no data 16
--
Aug 13 02:02:16 easyvdr vdr: [25862] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 13 02:02:16 easyvdr vdr: [25862] VNSI: Successfully switched to channel 30 - MDR Thüringen
Aug 13 02:02:18 easyvdr vdr: [26193] VNSI: Channel: no data 16
--
Aug 13 02:02:23 easyvdr vdr: [25862] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 13 02:02:23 easyvdr vdr: [25862] VNSI: Successfully switched to channel 31 - Radio Bremen TV
Aug 13 02:02:25 easyvdr vdr: [26196] VNSI: Channel: no data 16
--
Aug 13 02:02:27 easyvdr vdr: [25862] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 13 02:02:27 easyvdr vdr: [25862] VNSI: Successfully switched to channel 30 - MDR Thüringen
Aug 13 02:02:29 easyvdr vdr: [26199] VNSI: Channel: no data 16
--
Aug 13 02:02:38 easyvdr vdr: [25862] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 13 02:02:38 easyvdr vdr: [25862] VNSI: Successfully switched to channel 32 - SR Fernsehen
Aug 13 02:02:40 easyvdr vdr: [26205] VNSI: Channel: no data 16
--
Aug 13 02:02:44 easyvdr vdr: [25862] VNSI: Successfully found following device: 0x269f4e0 (2) for receiving, priority=0
Aug 13 02:02:44 easyvdr vdr: [25862] VNSI: Successfully switched to channel 33 - Comedy Central / VIVA AT
Aug 13 02:02:46 easyvdr vdr: [26208] VNSI: Channel: no data 16

@FernetMenta
Copy link
Owner

Also let me know if I'm wrong here and this a VDR related and not necessarily the VNSI plugin

I think this is VDR related. "no data" means that vnsi gets no data from vdr.

@fsironman
Copy link
Author

This Weekend there was a huge thunderstorm + rain going letting me debug the messages when theres an actual outage:

Sep  2 21:28:24 easyvdr vdr: [9752] VNSI: Successfully found following device: 0xd68dd0 (3) for receiving, priority=0
Sep  2 21:28:24 easyvdr vdr: [9752] VNSI: Dummy receiver (0x7f3f5c503670) activated
Sep  2 21:28:25 easyvdr vdr: [9799] device 3 TS buffer thread ended (pid=8347, tid=9799)
Sep  2 21:28:25 easyvdr vdr: [9798] buffer stats: 0 (0%) used
Sep  2 21:28:25 easyvdr vdr: [9798] device 3 receiver thread ended (pid=8347, tid=9798)
Sep  2 21:28:25 easyvdr vdr: [9800] device 3 receiver thread started (pid=8347, tid=9800, prio=high)
Sep  2 21:28:25 easyvdr vdr: [9752] VNSI: activate live receiver: 1
Sep  2 21:28:25 easyvdr vdr: [9752] VNSI: Successfully switched to channel 14 - zdf_neo HD
Sep  2 21:28:25 easyvdr vdr: [9752] VNSI: Started streaming of channel zdf_neo HD (timeout 2 seconds)
Sep  2 21:28:25 easyvdr vdr: [9801] cLiveStreamer stream processor thread started (pid=8347, tid=9801, prio=high)
Sep  2 21:28:25 easyvdr vdr: [9802] device 3 TS buffer thread started (pid=8347, tid=9802, prio=high)
Sep  2 21:28:26 easyvdr vdr: [9756] VNSI: Channel: no data 16
Sep  2 21:28:26 easyvdr vdr: [9801] VNSI: Channel: no data 16
Sep  2 21:28:29 easyvdr vdr: [9756] VNSI: Channel: no data 16
Sep  2 21:28:29 easyvdr vdr: [9801] VNSI: Channel: no data 16
Sep  2 21:28:31 easyvdr vdr: [9756] VNSI: Channel: no data 16
Sep  2 21:28:31 easyvdr vdr: [9801] VNSI: Channel: no data 16
Sep  2 21:28:33 easyvdr vdr: [9756] VNSI: Channel: no data 16
Sep  2 21:28:33 easyvdr vdr: [9801] VNSI: Channel: no data 16
Sep  2 21:28:34 easyvdr vdr: [8359] frontend 2/0 timed out while tuning to channel 14 (zdf_neo HD), tp 111361

So for I have concluded that on an actual outage vdr reports the frontend timing out while on my error this does not happen und somewhere between vdr and vnsi the data gets lost.

I also made a Thread at http://www.easy-vdr.de/thread-18130.html to get some more exposure and Ideas.

@AndreyPavlenko
Copy link

I'm getting the same error and then, after a few seconds, this one:
VNSI-Error: cParser::AddPESPacket - max buffer size reached, pid: 201

Streamdev works just fine, but vnsi does not play even non-encrypted channels.
Here is my setup:
vdr 2.3.9 git ff4c0a8
vdr-plugin-vnsiserver 1.6.0 git 8c898d9
vdr-plugin-dvbapi 2.2.4 git 7d51cc4

@FernetMenta
Copy link
Owner

VNSI-Error: cParser::AddPESPacket - max buffer size reached, pid: 201

means the parser is not able to detect beginning and end of a PES packet. is this a scrambled stream?

@FernetMenta
Copy link
Owner

could you create a short recording of this channel and make this available to me?

@AndreyPavlenko
Copy link

Sorry for late reply, for some reason I did not receive a notification from github.
It fails to play any stream, either scrambled or not. Please find the recordings attached.

recordings.zip

@AndreyPavlenko
Copy link

I've fixed this issue by adding video codec =27: to all VPIDs in the list. If the codec is not specified, it's substituted with =2: and vnsi fails with the above error. Streamdev works properly in both cases.

@FernetMenta
Copy link
Owner

vnsi uses the parameters it gets from vdr. vdr extracts it from PAT/PMT and updates channels.conf. do you allow vdr to update this file?

@gtrdriver
Copy link

Hi

im still playing around with my 3 Boxes (Kodi) and since 1 Hour i have exact this issue - and i dont know why ...

I allow VDR to make Changes on Channels.conf - i have restarted VDR / Restartet all Boxes - tryed to delete Channels.conf - and replace it with a old one -

Jan 18 23:10:34 vdrserver vdr: [1159] VNSI: Client with ID 8 connected: 192.168.1.251:63374
Jan 18 23:10:34 vdrserver vdr: [1205] VNSI: Welcome client 'XBMC Media Center' with protocol version '13'
Jan 18 23:10:34 vdrserver vdr: [1160] VNSI: removing client with ID 8 from client list
Jan 18 23:10:34 vdrserver vdr: [1204] VNSI: Channel: no data 16
Jan 18 23:10:34 vdrserver vdr: [1204] VNSI: Created stream for pid=101 and type=7
Jan 18 23:10:34 vdrserver vdr: [1204] VNSI: Created stream for pid=106 and type=1
Jan 18 23:10:34 vdrserver vdr: [1204] VNSI: Created stream for pid=102 and type=2
Jan 18 23:10:34 vdrserver vdr: [1204] VNSI: Created stream for pid=103 and type=2
Jan 18 23:10:34 vdrserver vdr: [1204] VNSI: Created stream for pid=105 and type=10
Jan 18 23:10:34 vdrserver vdr: [1204] VNSI: Created stream for pid=104 and type=12
Jan 18 23:10:34 vdrserver vdr: [1204] VNSI: Audio stream change, pid: 103, channels: 2, samplerate: 48000
Jan 18 23:10:34 vdrserver vdr: [1204] VNSI: Audio stream change, pid: 102, channels: 2, samplerate: 48000
Jan 18 23:10:34 vdrserver vdr: [1204] VNSI: Channel: no data 16
Jan 18 23:10:34 vdrserver vdr: [1204] VNSI: Audio stream change, pid: 106, channels: 2, samplerate: 48000
Jan 18 23:10:34 vdrserver vdr: [1204] VNSI: Channel: no data 16
Jan 18 23:10:34 vdrserver vdr: [1204] VNSI: Channel: no data 16
Jan 18 23:10:34 vdrserver vdr: [1204] VNSI: Video stream change, pid: 101, width: 720, height: 576, aspect: 1,777778
Jan 18 23:10:34 vdrserver vdr: [1204] VNSI: Channel: no data 16
Jan 18 23:10:34 vdrserver vdr: [1204] VNSI: Channel: no data 16
Jan 18 23:10:34 vdrserver vdr: [1204] VNSI: Channel: no data 16
Jan 18 23:10:34 vdrserver vdr: [1204] VNSI: Channel: no data 16
Jan 18 23:10:35 vdrserver vdr: [1204] VNSI: Channel: no data 16
Jan 18 23:10:35 vdrserver vdr: [1204] VNSI: Channel: no data 16
Jan 18 23:10:35 vdrserver vdr: [1204] VNSI: Channel: no data 16
Jan 18 23:10:35 vdrserver vdr: [1204] VNSI: Channel: no data 16
Jan 18 23:10:35 vdrserver vdr: [1204] VNSI: Channel: no data 16

I dont Understand tis issue - i play around with Plugin and Kodi since some Weeks but never seen this messages on Kodi or on VDR log

I Hope anyone can help me

@gtrdriver
Copy link

I have a Additional Information to this Issue:

This only happen when switching off "Add Transponder or add Channels" in VDR Setup.
As soon you switch to "only UPdate PID and Names" then this Error will flood your Logfile and display on Kodi.

Sign up for free to subscribe to this conversation on GitHub. Already have an account? Sign in.
Labels
None yet
Projects
None yet
Development

No branches or pull requests

4 participants