[solved] Live TV suddenly stops (1 Viewer)

[DiePlage]

Live TV and Radio frequently stop in the middle of playback. I have looked through the logfiles and found the following:
On the clients side, there ist nothing unusual in the logs. The client keeps playing allthough there is no more video / audio.
On the server, the TS is being written as if nothing happened, TsWriter.log shows nothing unusual.
However streaming server.Log shows something interesting:

11-08-2014 14:04:50.781 Stream server:Stream server: remove stream stream8.0
11-08-2014 14:04:55.336 TSBuffer::Require() - Failed to read buffer file
11-08-2014 14:04:59.689 TSBuffer::Require() - Failed to read buffer file
11-08-2014 14:04:59.689 ts:eof reached
11-08-2014 14:06:07.408 ts:dtor:a706d78

It looks like Mediaportal runs out of data in a place where it can't handle it. Timeshift buffers are written to a SSD so performance should not be an issue, there is enough free space left on the device.
This happens on all of our MP-Clients so I suppose, the problem is on the server-side.

I am out of ideas here so please help.

Thanks![DOUBLEPOST=1407762720][/DOUBLEPOST]It just happend while listening to DVBS Radio. Here are the Client logs.

 

[Vasilich]

any antivirus software installed? (at least MS Security essentials is known to make troubles)

 

[mm1352000]

Hello

When exactly did the problem occur?

The cause might be that TV Server is trying and failing to record "Junior 13:48-14:20 Wickie und die starken Männer". This "Junior" channel is encrypted, but it seems your tuners are not linked with any CI/CAM to make it possible to decrypt the channel:

[2014-08-11 13:48:04,922] [Log ] [scheduler thread] [INFO ] - dvb: DigitalDevices CI: connection to [demux] successful, CI not available or configured for this tuner.

TV Server first tries to start recording the channel at 13:48. At that time the first tuner is being used to listen to "ARD WDR 1LIVE", so TV Server starts with the second tuner... but this fails:

[2014-08-11 13:48:20,912] [Log ] [scheduler thread] [INFO ] - card: WaitForFile - no audio was found after 15,0228262 seconds
[2014-08-11 13:48:20,912] [Log ] [scheduler thread] [INFO ] - card: WaitForFile - audio and video stream is scrambled

Because the user priority configuration for the scheduler is higher than all others, TV Server then "kicks" the person who was using the first tuner to try to complete the recording:

[2014-08-11 13:48:20,959] [Log ] [scheduler thread] [INFO ] - Scheduler : card is not tuned to the same transponder and not recording, kicking all users. record on card:7 priority:4
[2014-08-11 13:48:20,959] [Log ] [scheduler thread] [INFO ] - Scheduler : kicking user:BOS-PC2

So to be clear, the "ARD WDR 1LIVE" radio stream would have stopped at that time.
Again the channel is not decrypted:

[2014-08-11 13:48:38,338] [Log ] [scheduler thread] [INFO ] - card: WaitForFile - no audio was found after 15,0072262 seconds
[2014-08-11 13:48:38,338] [Log ] [scheduler thread] [INFO ] - card: WaitForFile - audio and video stream is scrambled

TV Server continues to try to use both tuners to record the channel... and fails.

At about 14:04 it looks like somebody tries to start listening to 1LIVE again, but the same kicking thing happened again at 14:04:50 because TV Server is still trying and failing to record.

I note there are some other things that are a bit unusual in the TsWriter log:

[2014-08-11 14:06:49,388] [a5e0228] [5e8] - *** DecodeShortEventDescriptor: check1: 147 65
[2014-08-11 14:06:49,388] [a5e0228] [5e8] - *** DecodeShortEventDescriptor: check1: 179 82
[2014-08-11 14:06:50,293] [a5e0228] [5e8] - *** DecodeShortEventDescriptor: check1: 132 60
[2014-08-11 14:06:51,588] [a5e0228] [5e8] - *** epgecodeExtendedEvent check 2

These messages are not seen very often. Usually only when TsWriter encounters strange stream corruption. So, it is possible there are multiple causes for what you are seeing. Next time it would help if you could specify the exact time the problem occurs...

mm

 

[DiePlage]

Vasilich, unfortunately there is no AV product installed. That would have been an easy explanation...

mm1352000, thanks for interpreting these logs! I wouldn't have been able to do this myself. Obviously the active DVBS2 tuners were not linked to the CI Module and therefore could not use ist (this has to be done seperately with digital devices cards).
HOWEVER this error was most likely introduced by myself yesterday while trying to solve the underlying problem with live TV suddenly stopping.
I will produce clean server an client logs and repost as soon as live TV stops again.

With your help I might be able to understand more of the logs by myself!

Cheers!

 

[DiePlage]

To keep things simple, I have removed the CI Hardware and removed anything related from my configuration.
This way I hope to be able to track down some of our playback issues more easily.
You can find the corresponding post as well as logs here:
https://forum.team-mediaportal.com/threads/no-video-but-audio-on-second-stream.127487/