OE 5.0 RPi test build

[mvallevand]

I'm going to have to do a lot more reading ;(

No worries, I actually wasn't meaning you, I was hoping that some of the many users that have reported this problem could join NYPlayer in reporting it is fixed. He's reported he's primarily a pvr.wmc user and since I can't bring myself to use the RPi much I am not the best tester either.

In your case I certainly wouldn't want to learn Kodi on the RPi either. First configure it on Windows PC and then learn how to install OpenElec on an SD card, and finally if you you have problem try my patch.

Martin

[NYPlayer]

I watched LIVETV last night and most of this morning and not one incident of a lost tuner ... on my RPI. I did heavy channel changing ETC... So I have shutdown ServerWMC and using NEXPVR exclusively now.

[mvallevand]

Ok, great that is a little more promising. Thanks for taking the time to do that.

Martin

[JavaWiz]

Preliminary results:
I've built a new disk, substituted your SYSTEM and was successful in watching LiveTV with the NextPVR plugin. I have not been able to do this for quite awhile....

I do see errors in the log on startup:

Code:

18:46:08 T:2740687936 ERROR: CCurlFile::FillBuffer - Failed: Timeout was reached(28) 18:46:08 T:2740687936 ERROR: CCurlFile::CReadState::Connect, didn't get any data from stream. 18:46:08 T:2740687936 ERROR: Open - failed to open source <http://nirvana:8866/service?method=recording.recurring.list&sid=c301eefd8776472a8d49c24002562bfd> ... 18:46:18 T:2740687936 ERROR: Open - failed to open source <http://nirvana:8866/service?method=recording.list&filter=pending&sid=c301eefd8776472a8d49c24002562bfd> ... 18:46:28 T:2740687936 ERROR: Open - failed to open source <http://nirvana:8866/service?method=recording.list&filter=ready&sid=c301eefd8776472a8d49c24002562bfd> ... 18:46:48 T:2740687936 ERROR: Open - failed to open source <http://nirvana:8866/service?method=recording.recurring.list&sid=c301eefd8776472a8d49c24002562bfd> ... 18:46:58 T:2740687936 ERROR: Open - failed to open source <http://nirvana:8866/service?method=recording.list&filter=pending&sid=c301eefd8776472a8d49c24002562bfd> ... 18:47:08 T:2740687936 ERROR: Open - failed to open source <http://nirvana:8866/service?method=recording.list&filter=ready&sid=c301eefd8776472a8d49c24002562bfd> ... 18:47:28 T:2740687936 ERROR: Open - failed to open source <http://nirvana:8866/service?method=recording.recurring.list&sid=c301eefd8776472a8d49c24002562bfd> ... 18:47:38 T:2740687936 ERROR: Open - failed to open source <http://nirvana:8866/service?method=recording.list&filter=pending&sid=c301eefd8776472a8d49c24002562bfd> ... 18:47:48 T:2740687936 ERROR: Open - failed to open source <http://nirvana:8866/service?method=recording.list&filter=ready&sid=c301eefd8776472a8d49c24002562bfd> ... 18:48:08 T:2740687936 ERROR: Open - failed to open source <http://nirvana:8866/service?method=recording.recurring.list&sid=c301eefd8776472a8d49c24002562bfd> .... 18:48:18 T:2740687936 ERROR: Open - failed to open source <http://nirvana:8866/service?method=recording.list&filter=pending&sid=c301eefd8776472a8d49c24002562bfd>

and several

Code:

18:54:49 T:2902889536 ERROR: PVR - PVRTransferTimerEntry - cannot find channel 8101 on client 1 18:54:49 T:2732299328 ERROR: Previous line repeats 26 times.

Even with these errors, channel list is fine, EPG is fine, Recordings list is fine...

Overall performance seems good, SD channels play perfectly, HD channels have lag between video and audio, but I blame that on my network connection using home-plug to the TV connection.

Great work!

Thanks

Al

[mvallevand]

Thanks JavaWiz

I'll discount

18:54:49 T:2902889536 ERROR: PVR - PVRTransferTimerEntry - cannot find channel 8101 on client 1

Since I've since it on many pvr backends.

If those errors all happen on startup I'd guess it is because it can't reach nirvana. Maybe adjust your yin and yang and configure the addon with the IP address.

Martin

[JavaWiz]

Did a little more research on this and have noticed the following...

Focusing on the recurring.list call... The following request to the PVR server (from kodi.log):

Code:

11:01:50 T:2731402304 ERROR: CCurlFile::FillBuffer - Failed: Timeout was reached(28) 11:01:50 T:2731402304 ERROR: CCurlFile::CReadState::Connect, didn't get any data from stream. 11:01:50 T:2731402304 ERROR: Open - failed to open source <http://nirvana:8866/service?method=recording.recurring.list&sid=a8364ff54a5341a494787cbfb8bf92dd>

follows a pattern and repeats 17 times in ~20 second intervals, followed by a single recurring.list&filter=pending call (these are roughly 5 minutes 30 seconds apart).

This pattern repeats consistently from boot-time.

Code:

09:06:31 T:2731402304 ERROR: Open - failed to open source <http://nirvana:8866/service?method=recording.recurring.list&sid=a8364ff54a5341a494787cbfb8bf92dd> 09:06:53 T:2731402304 ERROR: Open - failed to open source <http://nirvana:8866/service?method=recording.recurring.list&sid=a8364ff54a5341a494787cbfb8bf92dd> 09:07:13 T:2731402304 ERROR: Open - failed to open source <http://nirvana:8866/service?method=recording.recurring.list&sid=a8364ff54a5341a494787cbfb8bf92dd> 09:07:32 T:2731402304 ERROR: Open - failed to open source <http://nirvana:8866/service?method=recording.recurring.list&sid=a8364ff54a5341a494787cbfb8bf92dd> 09:07:49 T:2731402304 ERROR: Open - failed to open source <http://nirvana:8866/service?method=recording.recurring.list&sid=a8364ff54a5341a494787cbfb8bf92dd> 09:08:08 T:2731402304 ERROR: Open - failed to open source <http://nirvana:8866/service?method=recording.recurring.list&sid=a8364ff54a5341a494787cbfb8bf92dd> 09:08:27 T:2731402304 ERROR: Open - failed to open source <http://nirvana:8866/service?method=recording.recurring.list&sid=a8364ff54a5341a494787cbfb8bf92dd> 09:08:46 T:2731402304 ERROR: Open - failed to open source <http://nirvana:8866/service?method=recording.recurring.list&sid=a8364ff54a5341a494787cbfb8bf92dd> 09:09:06 T:2731402304 ERROR: Open - failed to open source <http://nirvana:8866/service?method=recording.recurring.list&sid=a8364ff54a5341a494787cbfb8bf92dd> 09:09:25 T:2731402304 ERROR: Open - failed to open source <http://nirvana:8866/service?method=recording.recurring.list&sid=a8364ff54a5341a494787cbfb8bf92dd> 09:09:44 T:2731402304 ERROR: Open - failed to open source <http://nirvana:8866/service?method=recording.recurring.list&sid=a8364ff54a5341a494787cbfb8bf92dd> 09:10:03 T:2731402304 ERROR: Open - failed to open source <http://nirvana:8866/service?method=recording.recurring.list&sid=a8364ff54a5341a494787cbfb8bf92dd> 09:10:22 T:2731402304 ERROR: Open - failed to open source <http://nirvana:8866/service?method=recording.recurring.list&sid=a8364ff54a5341a494787cbfb8bf92dd> 09:10:41 T:2731402304 ERROR: Open - failed to open source <http://nirvana:8866/service?method=recording.recurring.list&sid=a8364ff54a5341a494787cbfb8bf92dd> 09:11:00 T:2731402304 ERROR: Open - failed to open source <http://nirvana:8866/service?method=recording.recurring.list&sid=a8364ff54a5341a494787cbfb8bf92dd> 09:11:19 T:2731402304 ERROR: Open - failed to open source <http://nirvana:8866/service?method=recording.recurring.list&sid=a8364ff54a5341a494787cbfb8bf92dd> 09:11:40 T:2731402304 ERROR: Open - failed to open source <http://nirvana:8866/service?method=recording.recurring.list&sid=a8364ff54a5341a494787cbfb8bf92dd> 09:11:59 T:2902889536 ERROR: Open - failed to open source <http://nirvana:8866/service?method=recording.recurring.list&filter=pending&sid=a8364ff54a5341a494787cbfb8bf92dd>

On the pi, if I do a wget or curl with that URL I get the following:

Code:

RaspPi2:~/.kodi/temp # wget -O - http://nirvana:8866/service?method=recording.recurring.list&sid=a8364ff54a5341a494787cbfb8bf92dd RaspPi2:~/.kodi/temp # Connecting to nirvana:8866 (192.168.1.30:8866) <?xml version="1.0" encoding="utf-8" ?> <rsp stat="fail"> <err code="8" msg="Invalid Session" /> </rsp>

If I do the same wget call on my windows (NPVR Server) box I get the same/similar result:

Code:

$ wget -O - http://192.168.1.30:8866/service?method=recording.recurring.list&sid=a8364ff54a5341a494787cbfb8bf92dd [1] 3640 Nirvana: /home/adamico $ --2015-01-24 11:31:12-- http://192.168.1.30:8866/service?method=recording.recurring.list Connecting to 192.168.1.30:8866... connected. HTTP request sent, awaiting response... 200 OK Length: 110 [application/xml] Saving to: ‘STDOUT’ - 0%[ ] 0 --.-KB/s <?xml version="1.0" encoding="utf-8" ?> <rsp stat="fail"> <err code="8" msg="Invalid Session" /> </rsp> - 100%[====================================>] 110 --.-KB/s in 0s 2015-01-24 11:31:12 (9.15 MB/s) - written to stdout [110/110]

However, if I use the same request string in a browser, the list xml comes back successfully.

any ideas?

[mvallevand]

What if you try a different sid with wget ie sid=javawiz

Martin

[JavaWiz]

Same thing...

Code:

RaspPi2:~ # wget -O - http://nirvana:8866/service?method=recording.recurring.list&sid=javawiz RaspPi2:~ # Connecting to nirvana:8866 (192.168.1.30:8866) <?xml version="1.0" encoding="utf-8" ?> <rsp stat="fail"> <err code="8" msg="Invalid Session" /> </rsp> - 100% |***************************************************| 110 0:00:00 ETA

what's weird, if I look in the npvr web.log I see the some requests being successful... (though not the javawiz sid call...)

Code:

2015-01-24 12:13:47.235 [DEBUG][17] Got Web Request (192.168.1.227): /service method=recording.list&filter=ready&sid=a8364ff54a5341a494787cbfb8bf92dd 2015-01-24 12:13:47.235 [DEBUG][17] method=recording.list 2015-01-24 12:13:47.235 [DEBUG][17] parameters: 2015-01-24 12:13:47.235 [DEBUG][17] method: recording.list 2015-01-24 12:13:47.235 [DEBUG][17] filter: ready 2015-01-24 12:13:47.235 [DEBUG][17] sid: a8364ff54a5341a494787cbfb8bf92dd 2015-01-24 12:13:47.235 [DEBUG][17] client_ip: 192.168.1.227 2015-01-24 12:13:47.235 [DEBUG][17] host_callback: nirvana:8866 2015-01-24 12:13:47.235 [DEBUG][17] physical_path: C:\Users\Public\NPVR\web\ 2015-01-24 12:13:47.235 [DEBUG][17] user_agent: Kodi/14.0 (X11; Linux armv6l) OpenELEC/5.0 HW_RaspberryPi/1.0 App_Bitness/32 Version/14.0-Git:ad747d9 2015-01-24 12:13:47.235 [DEBUG][17] range: bytes=0- 2015-01-24 12:13:47.235 [DEBUG][17] requested_path: /service 2015-01-24 12:13:47.235 [DEBUG][17] verb: GET

[JavaWiz]

Looking in the NPVR web.log, I see the npvr server getting hit with these requests about every 11 seconds over and over. Is this expected?

Code:

$ grep 'Got Web Request' web.log 2015-01-24 12:28:39.988 [DEBUG][3] Got Web Request (192.168.1.227): /service method=recording.recurring.list&sid=a8364ff54a5341a494787cbfb8bf92dd 2015-01-24 12:28:40.129 [DEBUG][22] Got Web Request (192.168.1.227): /service method=recording.list&filter=pending&sid=a8364ff54a5341a494787cbfb8bf92dd 2015-01-24 12:28:40.269 [DEBUG][8] Got Web Request (192.168.1.227): /service method=recording.list&filter=ready&sid=a8364ff54a5341a494787cbfb8bf92dd 2015-01-24 12:28:51.098 [DEBUG][8] Got Web Request (192.168.1.227): /service method=recording.recurring.list&sid=a8364ff54a5341a494787cbfb8bf92dd 2015-01-24 12:28:51.223 [DEBUG][17] Got Web Request (192.168.1.227): /service method=recording.list&filter=pending&sid=a8364ff54a5341a494787cbfb8bf92dd 2015-01-24 12:28:51.348 [DEBUG][3] Got Web Request (192.168.1.227): /service method=recording.list&filter=ready&sid=a8364ff54a5341a494787cbfb8bf92dd 2015-01-24 12:29:02.238 [DEBUG][3] Got Web Request (192.168.1.227): /service method=recording.recurring.list&sid=a8364ff54a5341a494787cbfb8bf92dd 2015-01-24 12:29:02.379 [DEBUG][7] Got Web Request (192.168.1.227): /service method=recording.list&filter=pending&sid=a8364ff54a5341a494787cbfb8bf92dd 2015-01-24 12:29:02.519 [DEBUG][21] Got Web Request (192.168.1.227): /service method=recording.list&filter=ready&sid=a8364ff54a5341a494787cbfb8bf92dd 2015-01-24 12:29:13.613 [DEBUG][17] Got Web Request (192.168.1.227): /service method=recording.recurring.list&sid=a8364ff54a5341a494787cbfb8bf92dd 2015-01-24 12:29:13.738 [DEBUG][8] Got Web Request (192.168.1.227): /service method=recording.list&filter=pending&sid=a8364ff54a5341a494787cbfb8bf92dd 2015-01-24 12:29:13.863 [DEBUG][4] Got Web Request (192.168.1.227): /service method=recording.list&filter=ready&sid=a8364ff54a5341a494787cbfb8bf92dd 2015-01-24 12:29:24.723 [DEBUG][22] Got Web Request (192.168.1.227): /service method=recording.recurring.list&sid=a8364ff54a5341a494787cbfb8bf92dd 2015-01-24 12:29:24.832 [DEBUG][4] Got Web Request (192.168.1.227): /service method=recording.list&filter=pending&sid=a8364ff54a5341a494787cbfb8bf92dd 2015-01-24 12:29:24.973 [DEBUG][7] Got Web Request (192.168.1.227): /service method=recording.list&filter=ready&sid=a8364ff54a5341a494787cbfb8bf92dd 2015-01-24 12:29:35.863 [DEBUG][3] Got Web Request (192.168.1.227): /service method=recording.recurring.list&sid=a8364ff54a5341a494787cbfb8bf92dd 2015-01-24 12:29:35.988 [DEBUG][21] Got Web Request (192.168.1.227): /service method=recording.list&filter=pending&sid=a8364ff54a5341a494787cbfb8bf92dd 2015-01-24 12:29:36.144 [DEBUG][8] Got Web Request (192.168.1.227): /service method=recording.list&filter=ready&sid=a8364ff54a5341a494787cbfb8bf92dd 2015-01-24 12:29:46.988 [DEBUG][4] Got Web Request (192.168.1.227): /service method=recording.recurring.list&sid=a8364ff54a5341a494787cbfb8bf92dd 2015-01-24 12:29:47.113 [DEBUG][8] Got Web Request (192.168.1.227): /service method=recording.list&filter=pending&sid=a8364ff54a5341a494787cbfb8bf92dd 2015-01-24 12:29:47.269 [DEBUG][22] Got Web Request (192.168.1.227): /service method=recording.list&filter=ready&sid=a8364ff54a5341a494787cbfb8bf92dd ...

[mvallevand]

For your wget call what if you add quotes around the entire url?

I didn't make any changes to the code that gets the recording list in the SYSTEM I posted. The might have been blocked calls that got freed?

Martin