Thread Rating:
  • 0 Vote(s) - 0 Average
Couldn't connect to server and channel freeze
#1
All Client and server are hard wire on the same LAN,
DVBViewer DMS 2.03 and the latest DVBViewer PVR
http://paste.ubuntu.com/25717307/

What I have noticed recently is that the PVR takes time to connect to DMS, it sort of act as though its freeze, then it will connect after several attempt, also when I change from one channel to another I noticed a freeze before it display channel. 
As I am not sure what could have caused the issue, I review the log, then I noticed some errors that I thought I should report it here may be it has been reported or not. 


Appreciate if anyone have seeing this issue what is the cause ie Kodi inherent or what and what could be done on my side to fix it if any

Thanks 

19:00:22.514 T:546803020000   ERROR: CCurlFile::FillBuffer - Failed: Couldn't connect to server(7)
19:00:22.514 T:546803020000   ERROR: CCurlFile::Open failed with code 0 for http://192.168.1.104:8089/api/version.html
19:00:22.524 T:546744299744  NOTICE: ES: Starting UDP Event server on port 9777
19:00:22.525 T:546744299744  NOTICE: UDP: Listening on port 9777 (ipv6 : false)



21:29:39.014 T:547868373216 WARNING: GetAddonProperties - Addon DVBViewer:192.168.1.104 does not support timer types. It will work, but not benefit from the timer features introduced with PVR Addon API 2.0.0
21:29:39.066 T:547029512416  NOTICE: Start - EPG thread started
21:29:52.072 T:545888661728 WARNING: CSkinInfo: failed to load skin settings
21:31:27.997 T:547959181312  NOTICE: VideoPlayer: Opening: pvr://channels/tv/All channels/pvr.dvbviewer_3839.pvr
21:31:27.997 T:547959181312 WARNING: CDVDMessageQueue(player):Tongueut MSGQ_NOT_INITIALIZE



WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer

21:40:07.487 T:545402122464 WARNING: Previous line repeats 2 times.
Reply
#2
(2017-10-11, 20:41)t123thomas Wrote: and the latest DVBViewer PVR
Nitpicking: You are on Krypton, so it's not the latest. But should be irrelevant.

(2017-10-11, 20:41)t123thomas Wrote: 19:00:22.514 T:546803020000   ERROR: CCurlFile::FillBuffer - Failed: Couldn't connect to server(7)
19:00:22.514 T:546803020000 ERROR: CCurlFile::Open failed with code 0 for http://192.168.1.104:8089/api/version.html
Happens if your DMS is unreachable, e.g. if Kodi starts up before the DMS. But although it's tagged as an error it's actually just an information and will also be visible in the UI.

(2017-10-11, 20:41)t123thomas Wrote: 21:31:27.997 T:547959181312  NOTICE: VideoPlayer: Opening: pvr://channels/tv/All channels/pvr.dvbviewer_3839.pvr
WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer
21:40:07.487 T:545402122464 WARNING: Previous line repeats 2 times.

The PVR/Kodi tries to read the TS stream from the DMS but nothing gets transmitted. So this is a problem on the DMS side. E.g. happens if the channel is encrypted, the channel is not tuneable, etc..
Reply
#3
Thanks 4 ur response, what do you mean latest, I thought 17.4 Krypton is the lasted or what have missed

I understand the issue of server at sleep has to wake before the client can connect if not it creats an error.

What I do not get is when the channel changed and it takes few seconds for the live TV to respond , I am only watching free to air those channels are not encrypted.

What generic settings would recommend on the dms site to help resolve the issue.

However when I used Dvbviewer client app either cell phone wifi of lapto wifi and lan PC the channel switch respond is fast fast just a blink of an eyes, therefore, I think dms settings is fine from that point I may be incorrect.
However, I m open to corrects and suggestions

Thanks
Reply
#4
(2017-10-11, 23:20)ot123thomas Wrote: Thanks 4 ur response, what do you mean latest, I thought 17.4 Krypton is the lasted or what have missed

I understand the issue of server at sleep has to wake before the client can connect if not it creats an error.

What I do not get is when the channel changed and it takes few seconds for the live TV to respond , I am only watching free to air those channels are not encrypted.

What generic settings would recommend on the dms site to help resolve the issue.

However when I used Dvbviewer client app either cell phone wifi of lapto wifi and lan PC the channel switch respond is fast fast just a blink of an eyes, therefore, I think dms settings is fine from that point I may be incorrect.
However, I m open to corrects and suggestions

Thanks
The version seems to buff alot, is there way to get old PVR, I want to try couble of version before the current version 2.4.11.1, coz I did not experienced this sort behavious even when I was using RS as fserver. Appreciate if you point me to where previous version are stored, just want to try the last two before this, accept my advance apology for any stress I may have caused by bring up this issue. it just get me crazy when the channel buff before it switch on a LAN HARD WIRE network.

Cheers!
Reply
#5
The PVR is shipped with Kodi and the latest is included in the nightly. There where no significant changes between 17.1 and 17.4 apart from translation fixes.

Try creating a debug log. Maybe this will explain a bit more. Also wipe your advancedsettings in case you have created one.
Reply
#6
(2017-10-12, 11:50)manül Wrote: The PVR is shipped with Kodi and the latest is included in the nightly. There where no significant changes between 17.1 and 17.4 apart from translation fixes.

Try creating a debug log. Maybe this will explain a bit more. Also wipe your advancedsettings in case you have created one.

Thank you, sincerely appreciated your response, there are several options in the debug, which one should I enable.

Cheers!
Reply
#7
http://kodi.wiki/view/Log_file/Easy
Reply
#8
(2017-10-12, 20:32)manül Wrote: http://kodi.wiki/view/Log_file/Easy

@Manul
Here is the new debug log and thanks for taking a look at this issue

https://paste.ubuntu.com/25728902/
Reply
#9
paste.ubuntu.com is crap. It requires you to sign in for downloading the raw text..

Anyway, I cannot find any obvious issues. Your DMS is working fine as well as the PVR. Might be platform/hardware/amlogic related.
Reply
#10
(2017-10-13, 12:31)manül Wrote: paste.ubuntu.com is crap. It requires you to sign in for downloading the raw text..

Anyway, I cannot find any obvious issues. Your DMS is working fine as well as the PVR. Might be platform/hardware/amlogic related.

After review the debug log, it seems the issue relates to FFMPEG decoder, not related to PVR, I shall report the issue in another forum for assistance.

T:545402122464   DEBUG: OnPlayBackStarted: play state was 1, starting 1
22:32:13.187 T:545402122464   DEBUG: CVideoPlayer::SetCaching - caching state 2
22:32:13.187 T:545402122464   DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000
22:32:13.188 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] SPS unavailable in decode_picture_timing
22:32:13.188 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] non-existing PPS 0 referenced
22:32:13.188 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] SPS unavailable in decode_picture_timing
22:32:13.188 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] non-existing PPS 0 referenced
22:32:13.188 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] SPS unavailable in decode_picture_timing
22:32:13.188 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] non-existing PPS 0 referenced
22:32:13.189 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] SPS unavailable in decode_picture_timing
22:32:13.189 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] non-existing PPS 0 referenced
22:32:13.196 T:547643105280   DEBUG: PlayFile: OpenFile succeed, play state 2
22:32:13.197 T:547643105280   DEBUG: OnPlayBackStarted: play state was 2, starting 0
22:32:13.197 T:545134624992   DEBUG: CDVDAudio:Tongueause - pausing audio stream
22:32:13.209 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] SPS unavailable in decode_picture_timing
22:32:13.209 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] non-existing PPS 0 referenced
22:32:13.209 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] SPS unavailable in decode_picture_timing
22:32:13.210 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] non-existing PPS 0 referenced
22:32:13.213 T:545418899680   DEBUG: CGUIInfoManager::SetCurrentMovie(pvr://channels/tv/All channels/pvr.dvbviewer_3839.pvr)
22:32:13.216 T:547643093216   DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
22:32:13.216 T:547643093216   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay
22:32:13.247 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] SPS unavailable in decode_picture_timing
22:32:13.247 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] non-existing PPS 0 referenced
22:32:13.247 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] SPS unavailable in decode_picture_timing
22:32:13.247 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] non-existing PPS 0 referenced
22:32:13.247 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] SPS unavailable in decode_picture_timing
22:32:13.247 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] non-existing PPS 0 referenced
22:32:13.247 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] SPS unavailable in decode_picture_timing
22:32:13.247 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] non-existing PPS 0 referenced
22:32:13.247 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] SPS unavailable in decode_picture_timing
22:32:13.247 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] non-existing PPS 0 referenced
22:32:13.272 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] SPS unavailable in decode_picture_timing
22:32:13.272 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] non-existing PPS 0 referenced
22:32:13.335 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] SPS unavailable in decode_picture_timing
22:32:13.336 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] non-existing PPS 0 referenced
22:32:13.336 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] SPS unavailable in decode_picture_timing
22:32:13.336 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] non-existing PPS 0 referenced
22:32:13.336 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] SPS unavailable in decode_picture_timing
22:32:13.336 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] non-existing PPS 0 referenced
22:32:13.337 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] SPS unavailable in decode_picture_timing
22:32:13.337 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] non-existing PPS 0 referenced
22:32:13.337 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] SPS unavailable in decode_picture_timing
22:32:13.337 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] non-existing PPS 0 referenced
22:32:13.360 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] SPS unavailable in decode_picture_timing
22:32:13.360 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] non-existing PPS 0 referenced
22:32:13.361 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] SPS unavailable in decode_picture_timing
22:32:13.361 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] non-existing PPS 0 referenced
22:32:13.362 T:547643105280   DEBUG: ------ Window Deinit (DialogBusy.xml) ------
22:32:13.386 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] SPS unavailable in decode_picture_timing
22:32:13.386 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] non-existing PPS 0 referenced
22:32:13.411 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] SPS unavailable in decode_picture_timing
22:32:13.411 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] non-existing PPS 0 referenced
22:32:13.412 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] SPS unavailable in decode_picture_timing
22:32:13.412 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] non-existing PPS 0 referenced
22:32:13.412 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] SPS unavailable in decode_picture_timing
22:32:13.412 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] non-existing PPS 0 referenced
22:32:13.449 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] SPS unavailable in decode_picture_timing
22:32:13.450 T:545402122464   ERROR: ffmpeg[7EFC7FF0E0]: [NULL] non-existing PPS 0 referenced
22:32:13.450 T:545402122464   DEBUG: CDVDDemuxFFmpeg::Read() fetching extradata, extradata_size(44)
22:32:13.532 T:545402122464   DEBUG: CDVDDemuxFFmpeg::AddStream ID: 0
22:32:13.532 T:545402122464  NOTICE: Opening stream: 0 source: 256
22:32:13.532 T:545402122464  NOTICE: Creating video codec with codec id: 28
Reply
#11
The error messages are expected as you're opening the stream in the middle of a sequence and ffmpeg needs to wait for various parameters for proper decoding. However they arrive a couple of milliseconds later.
Reply
#12
To be more precise. What's unusual is the time difference between opening the stream and the videoplayer start. e.g.
Quote:22:33:21.189 T:545402122464 DEBUG: AddOnLog: DVBViewer Client: StreamReader: Started; url=http://192.168.1.104:7522/upnp/channelstream/3839.ts
22:33:21.251 T:545402122464 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
22:33:21.567 T:545402122464 DEBUG: CVideoPlayer::HandleMessages - player started 1 (aka VideoPlayer_AUDIO)
22:33:28.839 T:545402122464 DEBUG: CVideoPlayer::HandleMessages - player started 2 (aka VideoPlayer_VIDEO)
That's why I said your issue might be platform/hardware/amlogic related.
Reply
#13
(2017-10-13, 19:23)manül Wrote: To be more precise. What's unusual is the time difference between opening the stream and the videoplayer start. e.g.
Quote:22:33:21.189 T:545402122464   DEBUG: AddOnLog: DVBViewer Client: StreamReader: Started; url=http://192.168.1.104:7522/upnp/channelstream/3839.ts
22:33:21.251 T:545402122464  NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
22:33:21.567 T:545402122464   DEBUG: CVideoPlayer::HandleMessages - player started 1 (aka VideoPlayer_AUDIO)
22:33:28.839 T:545402122464   DEBUG: CVideoPlayer::HandleMessages - player started 2 (aka VideoPlayer_VIDEO)
That's why I said your issue might be platform/hardware/amlogic related.

Thank you definitely an hardware issue.
Reply



Couldn't connect to server and channel freeze00