myGBPVR: use XMBC as GBPVR FrontEnd

[Ton]

Okay,

I have added some debug-statements in the code that connects to GBPVR....

Please extract the included GBPVR_Connect.py (in the zip) to your ..../myGBPVR/resources/src directory.

Then try again and post the log-file... It should now show the authentication-object I'm sending over the wire (and which seems to not play nice with EWA) and the timestamp used to create the authentication object....

I'll be waiting for your results....

[carpeVideo]

Here is the new XBMC log and the EWA log

Code:

16:12:45 T:340 M:2092519424   DEBUG: LoadLibraryA('MSVCR71.dll')
16:12:45 T:340 M:2092519424   DEBUG: LoadLibrary('MSVCR71.dll') returning: 0181E158
16:12:45 T:340 M:2092519424   DEBUG: LoadLibrary('MSVCP71.dll') returning: 0181D500
16:12:47 T:5360 M:2093441024  NOTICE: --> AreYouThere() socket on port 7647 using ip=192.168.0.10
16:12:47 T:5360 M:2093441024  NOTICE:                   mac:00:23:54:33:f3:f3broadcast: 255.255.255.0
16:12:47 T:5360 M:2093441024  NOTICE: This got: True / 00:23:54:33:f3:f3
16:12:47 T:5360 M:2093432832  NOTICE: --> AreYouThere() returning: True
16:12:48 T:5360 M:2091634688  NOTICE: TimeString used: 30-04-2010 16:12:00
16:12:48 T:5360 M:2091520000  NOTICE: (webServiceAuthentication){
                                               R = "5JF7uo8ysp+CyxphQhrPB91QlIBR1wJ9FF+3Ph8F6TRbjvWeOboi7Qq4HLDftq0n+r9gxhNTFjYqBWnwXa27oQ==+r9gxhNTFjYqBWnwXa27oQ==000021dd8d24a440ac16b7dae03db0833479"
                                               RL = "WFPKW9S3+0cij/WKTBNuOw=="
                                               RTL = "he7bT4pWoJLB2mLH2mx7Gw=="
                                               UserName = None
                                               Password = None
                                             }
16:12:48 T:5360 M:2091487232  NOTICE: EXCEPTION: : Traceback (most recent call last):
                                              File "D:\programs\XBMC\scripts\myGBPVR\resources\src\gbpvr\home.py", line 152, in refreshOnInit
                                                self.statusData = self.gbpvr.GetGBPVRInfo(self.settings.GBPVR_USER, self.settings.GBPVR_PW)
                                              File "D:\programs\XBMC\scripts\myGBPVR\resources\src\GBPVR_Connect.py", line 134, in GetGBPVRInfo
                                                self.channels = self.getChannelList(userid, password)
                                              File "D:\programs\XBMC\scripts\myGBPVR\resources\src\GBPVR_Connect.py", line 157, in getChannelList
                                                ret_soap = client.service.getChannelListObject(soapheaders=authObj)
                                            WebFault: Server raised fault: 'Server was unable to process request. ---> String was not recognized as a valid DateTime.'
16:12:48 T:5360 M:2091487232    INFO: Loading skin file: DialogOK.xml
16:12:48 T:5360 M:2091610112   DEBUG: Load DialogOK.xml: 16.35ms
16:12:48 T:340 M:2091610112   DEBUG: ------ Window Init (DialogOK.xml) ------
16:12:48 T:340 M:2091610112   DEBUG: Alloc resources: 0.41ms (0.00 ms skin load)
16:12:50 T:340 M:2091249664   DEBUG: ------ Window Deinit (DialogOK.xml) ------
16:12:50 T:340 M:2091307008   DEBUG: Activating window ID: 10020
16:12:50 T:340 M:2091307008   DEBUG: Checking if window ID 10020 is locked.
16:12:50 T:340 M:2091307008   DEBUG: ------ Window Deinit (D:\programs\XBMC\scripts\myGBPVR\resources\skins\Default\720p\gbpvr_home.xml) ------
16:12:51 T:340 M:2091167744   DEBUG: ------ Window Init (MyScripts.xml) ------
16:12:51 T:340 M:2091167744    INFO: Loading skin file: MyScripts.xml
16:12:51 T:340 M:2091134976   DEBUG: Load MyScripts.xml: 21.46ms
16:12:51 T:340 M:2090881024   DEBUG: Alloc resources: 25.64ms (21.54 ms skin load)
16:12:51 T:340 M:2090881024   DEBUG: CGUIMediaWindow::GetDirectory (special://home/scripts)
16:12:51 T:340 M:2090881024   DEBUG:   ParentPath = [special://home/scripts]
16:12:51 T:340 M:2085974016    INFO:   msg: Corrupt JPEG data: 78 extraneous bytes before marker 0xd1
16:12:51 T:340 M:2085949440    INFO:   msg: Corrupt JPEG data: 78 extraneous bytes before marker 0xd1
16:12:51 T:5360 M:2087280640    INFO: Scriptresult: Success
16:12:51 T:5360 M:2086555648    INFO: Python script stopped
16:12:51 T:5360 M:2086555648   DEBUG: Thread 5360 terminating
16:12:51 T:340 M:2086617088   DEBUG: python thread 1 destructed
16:12:51 T:340 M:2086617088    INFO: Python, unloading python24.dll because no scripts are running anymore
16:12:51 T:340 M:2086617088   ERROR: CLocalizeStrings::ClearBlock: Trying to clear non existent block D:\programs\XBMC\scripts\myGBPVR
16:12:51 T:340 M:2087358464   DEBUG: XBPython::UnloadExtensionLibs, clearing python extension libraries
16:12:51 T:340 M:2087358464   DEBUG: Win32DllLoader::Unload DLLs\zlib.pyd
16:12:51 T:340 M:2087358464   DEBUG: FreeLibrary(python24.dll) -> 027AFBF0
16:12:51 T:340 M:2087358464   DEBUG: FreeLibrary(MSVCR71.dll) -> 0181E158
16:12:51 T:340 M:2087419904   DEBUG: Win32DllLoader::Unload DLLs\_socket.pyd
16:12:51 T:340 M:2087419904   DEBUG: FreeLibrary(python24.dll) -> 027AFBF0
16:12:51 T:340 M:2087419904   DEBUG: FreeLibrary(MSVCR71.dll) -> 0181E158
16:12:51 T:340 M:2087464960   DEBUG: Win32DllLoader::Unload DLLs\_ssl.pyd
16:12:51 T:340 M:2087464960   DEBUG: FreeLibrary(python24.dll) -> 027AFBF0
16:12:51 T:340 M:2087464960   DEBUG: FreeLibrary(MSVCR71.dll) -> 0181E158
16:12:51 T:340 M:2087890944   DEBUG: Win32DllLoader::Unload DLLs\pyexpat.pyd
16:12:51 T:340 M:2087890944   DEBUG: FreeLibrary(python24.dll) -> 027AFBF0
16:12:51 T:340 M:2087890944   DEBUG: FreeLibrary(MSVCR71.dll) -> 0181E158
16:12:51 T:340 M:2087993344   DEBUG: Win32DllLoader::Unload D:\programs\XBMC\scripts\myGBPVR\resources\lib\Crypto\Cipher\AES.pyd
16:12:51 T:340 M:2087993344   DEBUG: FreeLibrary(python24.dll) -> 027AFBF0
16:12:51 T:340 M:2087993344   DEBUG: FreeLibrary(MSVCR71.dll) -> 0181E158
16:12:51 T:340 M:2088034304   DEBUG: Win32DllLoader::Unload python24.dll
16:12:51 T:340 M:2088034304   DEBUG: FreeLibrary(MSVCR71.dll) -> 0181E158
16:12:51 T:340 M:2089029632   DEBUG: CGUIMediaWindow::GetDirectory (special://home/scripts)
16:12:51 T:340 M:2089029632   DEBUG:   ParentPath = [special://home/scripts]

Code:

2010-04-30 15:54:13.829    INFO    [4]    *********************
2010-04-30 15:54:13.829    INFO    [4]    * Validating Incomming Web Service
2010-04-30 15:54:13.829    INFO    [4]    *
2010-04-30 15:54:13.829    INFO    [4]    User Name = gbpvr
2010-04-30 15:54:13.829    INFO    [4]    User Password = gbpvr
2010-04-30 15:54:13.829    INFO    [4]    *
2010-04-30 15:54:13.829    INFO    [4]    *
2010-04-30 15:54:13.829    INFO    [4]    Checking credential timestamp....
2010-04-30 15:54:13.829    INFO    [4]    nowTime = 4/30/2010 8:54:13 PM
2010-04-30 15:54:13.829    INFO    [4]    Credential time string = 30-04-2010 15:54:00
2010-04-30 15:54:27.199    INFO    [4]    In writing of file
2010-04-30 15:54:27.199    INFO    [4]    readcount = 10258

[Ton]

Anything more in the EWA log-file??
This:

Code:

WebFault: Server raised fault: 'Server was unable to process request. ---> String was not recognized as a valid DateTime.'

tells me the server raises a fault..., I would expect something in the EWA log about that....

Also, what's the geographical date-time setting on your GBPVR server? Is it mm-dd-yy (seems to, from the log-file)?

[carpeVideo]

No but changing the python code to this fixed it:

timeString = datetime.now().strftime("%m/%d/%Y %H:%M:00")

[Ton]

Hi,

No but changing the python code to this fixed it:

timeString = datetime.now().strftime("%m/%d/%Y %H:%M:00")

Yeah, we were on the same track! Good work! So it is related to .NET parsing the timestamp based on it's own regional settings....
I have it now so it uses ISO format (Y-M-D) and that seems to work (on my end). Could you try that too?
It is:

Code:

timeString = datetime.now().strftime("%Y-%m-%d %H:%M:00")

Or even better (It's what I'm using in the epg):

Code:

timeString = datetime.now().strftime("%Y-%m-%dT%H:%M:00")

That way we can make it independant on regional settings on xbmc and GBPVR...

Have you been able to try out the "play" function as well?

[dljones8053]

capeVideo

Thanks for the fix, I was going crazy trying to figure out why mind stop working, I also posted before and after the change so others know what to look for.

Log before the fix
2010-04-30 19:29:06.844 INFO [4] Checking credential timestamp....
2010-04-30 19:29:06.844 INFO [4] nowTime = 4/30/2010 11:29:06 PM
2010-04-30 19:29:06.844 INFO [4] Credential time string = 30-04-2010 19:29:00

Log after the fix
2010-04-30 19:34:32.938 INFO [4] Checking credential timestamp....
2010-04-30 19:34:32.938 INFO [4] nowTime = 4/30/2010 11:34:32 PM
2010-04-30 19:34:32.938 INFO [4] Credential time string = 04/30/2010 19:34:00
2010-04-30 19:34:32.938 INFO [4] Credential time converted = 4/30/2010 7:34:00 PM

DJ

[carpeVideo]

Hi,

Yeah, we were on the same track! Good work! So it is related to .NET parsing the timestamp based on it's own regional settings....
I have it now so it uses ISO format (Y-M-D) and that seems to work (on my end). Could you try that too?
It is:

Code:

timeString = datetime.now().strftime("%Y-%m-%d %H:%M:00")

Or even better (It's what I'm using in the epg):

Code:

timeString = datetime.now().strftime("%Y-%m-%dT%H:%M:00")

That way we can make it independant on regional settings on xbmc and GBPVR...

Have you been able to try out the "play" function as well?

I will give it a try tomorrow - as to the play function - I still can't get that far, for some reason that and a few other screens seem to freeze or time out, I am not sure why the webservices would be so slow. I'll post those logs as well.

Thanks for the help

[Ton]

I will give it a try tomorrow - as to the play function - I still can't get that far, for some reason that and a few other screens seem to freeze or time out, I am not sure why the webservices would be so slow. I'll post those logs as well.

Thanks for the help

Thanks, that will allow me to put ths in my next release..
As far as the freezes and timeouts are concerned, not sure if it's related, but sometimes XBMC seems to get confused when you make changes to scripts. Sometimes that makes it necessary (for me) to restart XBMC....

[carpeVideo]

The second (datetime.now().strftime("%Y-%m-%dT%H:%M:00") ) returns this:

Code:

msvcrt.dll incomplete function _fdopen(...) called
08:28:47 T:3124 M:2052808704  NOTICE: TimeString 2 used: 2010-05-01T08:28:00
08:28:47 T:3124 M:2052997120   DEBUG: LoadLibraryExA called with flags:
                                             - LOAD_WITH_ALTERED_SEARCH_PATH
08:28:47 T:3124 M:2052997120   DEBUG: LoadLibraryA('AES.pyd')
08:28:47 T:3124 M:2052997120   DEBUG: Win32DllLoader::Load(D:\programs\XBMC\scripts\myGBPVR\resources\lib\Crypto\Cipher\AES.pyd)
08:28:47 T:3124 M:2053132288   DEBUG: LoadLibraryA('python24.dll')
08:28:47 T:3124 M:2053132288   DEBUG: LoadLibrary('python24.dll') returning: 026A1D70
08:28:47 T:3124 M:2053132288   DEBUG: LoadLibraryA('MSVCR71.dll')
08:28:47 T:3124 M:2053132288   DEBUG: LoadLibrary('MSVCR71.dll') returning: 0181E458
08:28:47 T:3124 M:2053132288   DEBUG: LoadLibrary('AES.pyd') returning: 02578068
08:28:47 T:3124 M:2053046272  NOTICE: (webServiceAuthentication){
                                               R = "Snk3CwPvENLKJ/RjNrKHdiSRMFP3rILHc8qhpvEGymuCDfeeLgleL+LwRuxDO2w87QzPY1hIRmh1Mv9hgko2nw==7QzPY1hIRmh1Mv9hgko2nw==0000799ebd6fd6bcb17dd4ed28fe7d617f9d"
                                               RL = "vxvDRlhjr8AzzAVinsqmYQ=="
                                               RTL = "QyyeO0O3vk0yaP4VwYRXBw=="
                                               UserName = None
                                               Password = None
                                             }
08:28:47 T:3124 M:2053013504  NOTICE: No handlers could be found for logger "suds.client"
08:28:47 T:3124 M:2053013504  NOTICE: EXCEPTION: : Traceback (most recent call last):
                                              File "D:\programs\XBMC\scripts\myGBPVR\resources\src\gbpvr\home.py", line 152, in refreshOnInit
                                                self.statusData = self.gbpvr.GetGBPVRInfo(self.settings.GBPVR_USER, self.settings.GBPVR_PW)
                                              File "D:\programs\XBMC\scripts\myGBPVR\resources\src\GBPVR_Connect.py", line 134, in GetGBPVRInfo
                                                self.channels = self.getChannelList(userid, password)
                                              File "D:\programs\XBMC\scripts\myGBPVR\resources\src\GBPVR_Connect.py", line 157, in getChannelList
                                                ret_soap = client.service.getChannelListObject(soapheaders=authObj)
                                            WebFault: Server raised fault: 'Unauthorized - Timeout'
08:28:47 T:3124 M:2053009408    INFO: Loading skin file: DialogOK.xml
08:28:47 T:312

However removing the T : datetime.now().strftime("%Y-%m-%d %H:%M:00") seems to make it work.

The freeze part seems to be due to a file error:

Code:

08:41:33 T:5260 M:1962680320    INFO: Skin version is: 2.1
08:41:33 T:5260 M:1962672128    INFO: Loading skin includes from D:\programs\XBMC\scripts\myGBPVR\resources\skins\Default\720p\includes.xml
08:41:33 T:5260 M:1962668032    INFO: Error loading includes.xml file (D:\programs\XBMC\scripts\myGBPVR\resources\skins\Default\720p\includes.xml): Failed to open file (row=0, col=0)
08:41:33 T:4540 M:1962643456   DEBUG: ------ Window Init (D:\programs\XBMC\scripts\myGBPVR\resources\skins\Default\720p\gbpvr_details.xml) ------
08:41:33 T:4540 M:1962643456    INFO: Loading skin file: D:\programs\XBMC\scripts\myGBPVR\resources\skins\Default\720p\gbpvr_details.xml
08:41:33 T:4540 M:1962467328   DEBUG: Load D:\programs\XBMC\scripts\myGBPVR\resources\skins\Default\720p\gbpvr_details.xml: 8.12ms
08:41:33 T:4540 M:1962500096   DEBUG: Alloc resources: 10.85ms (8.25 ms skin load)
08:41:33 T:4540 M:1962496000   DEBUG: CGUIMediaWindow::GetDirectory (?)

includes.xml - was that in the update for the "play" button?

[dljones8053]

capeVideo

I have a question while setting up the XBMC Library for some reason it will not pick up the recordings the the format GBPVR writes them out, just wondering if you have seen this as well.

thanks
DJ