Updated PMS & Plexconnect now, not working?

Funny I can see all the movies and thumbs but as soon as I select one to play, up pops the 'ol Trailers Not Available. 

I switched back to plexconnect .4-dev from .5 and everything works just fine. So I don't believe the updated PMS is the issue

Also, when trying .5 its settings.cfg was edited to equal as it was in .4

 

Sure could use some help figuring out what has happened.

 

  • Your ATV model (2 or 3) and firmware version (found under the ATV settings > general > about > Apple TV software): ATV3 6.2

  • The DNS server set on the ATV (found under the ATV settings > general > network > DNS): 192.168.1.131

  • The local IP address of the device that PlexConnect is installed on:  192.168.1.131

  • The device and operating system (including version number) that PlexConnect is installed on: iMac 10.10.3

  • The device and operating system (including version number) that the Plex media server (PMS) is installed on: iMac 10.10.3

  • The Plex media server (PMS) version number you are running (do not put 'latest'):  0.9.11.1.678-c48ffd2 I had just upgraded from 0.9.9.14

  • The local IP address of the device that the Plex media server (PMS) is installed on: 192.168.1.131

  • The PlexConnect version number. If using Github source then a time and date of download (look at the creation date of the folder) and if you are using any non-standard setup e.g. Plexify or a fork.  Mar 30 11:27am

  • The contents of your 'Settings.cfg' file :

NOTE: I've always forced ip addresses although did also try it with the 2 False's changed to True but got same results.

Settings.cfg ver .5 

enable_plexgdm = False

ip_pms = 192.168.1.131

port_pms = 32400

enable_dnsserver = True

port_dnsserver = 53

ip_dnsmaster = 192.168.1.1

prevent_atv_update = True

enable_plexconnect_autodetect = False

ip_plexconnect = 192.168.1.131

hosttointercept = trailers.apple.com

port_webserver = 80

enable_webserver_ssl = True

port_ssl = 443

certfile = ./assets/certificates/trailers.pem

allow_gzip_atv = False

allow_gzip_pmslocal = False

allow_gzip_pmsremote = True

loglevel = Normal

logpath = .

 

Plexconnect Log:

PlexConnect.log (2.31 KB)

 

 

Traceback (most recent call last):
  File "/Users/temp1/Downloads/PlexConnect-master/WebServer.py", line 229, in do_GET
    XML = XMLConverter.XML_PMS2aTV(PMSaddress, self.path + query, options)
  File "/Users/temp1/Downloads/PlexConnect-master/XMLConverter.py", line 383, in XML_PMS2aTV
    aTVTree = etree.parse(sys.path[0]+'/assets/templates/'+XMLtemplate)
  File "", line 62, in parse
  File "", line 26, in parse
IOError: [Errno 21] Is a directory: '/Users/temp1/Downloads/PlexConnect-master/assets/templates/'

I would say, your update didn't go smooth...

Hmm... I dloaded the zip, renamed the current ver 0.4 folder then unzipped.   Could the zip file have something bad in it?

I always had "PlexConnect-master" located in the downloads folder and up through ver 0.4 it has worked perfectly.  Should it be located differently starting with ver 0.5?

No idea... the chosen path should be fine.

Variable XMLtemplate should point to the correct file for processing... I don't know why it wouldn't.

Try to unzip it again, restart PlexConnect/you aTV and post a "loglevel=High" log if the issue persists.

Some success but also a failure:

1. deleted existing plexconnect-master, unzip new copy

2. added .pem file 

3. started plexconnect via daemon

4. restarted aTv

- Go to Movies, All, select Avatar, Play, start from beginning < it PLAYS! 

- Hit menu back to listing

- Select BY Folder & wait until it populates with thumbs

- select Avatar (still in main listing, not in one of the folders) and immediately get a trailers unavailable error, it never gets to the choice screen with Play, etc... 

- backed out to main aTV menu and shut down.

Log file set to High, tried to attach its 27.8mb but even though its smaller than the max the upload fails. with error 413.

So here is the zipped version of it.PlexConnect.log.zip (1.56 MB)

Log file set to High, tried to attach its 27.8mb but even though its smaller than the max the upload fails. with error 413.

So here is the zipped version of it.attachicon.gifPlexConnect.log.zip

Could you post a smaller log file please.

Shut down PlexConnect.

Delete the PlexConnect.log file

Start PlexConnect again

Recreate the error.... don't back out to the main menu, just shutdown PlexConnect and post the log. If you back out to the main menu you'll only make the log file bigger with useless information. It's easier to find the problem if the error is the last thing in the log, nobody wants to wade through a 28MB log file to try and see what's wrong :(

Roidy, just went through following your steps.

1. shut down plexconnect

2. deleted the log file

3. started plexconnect back up

4. Trailers, Library, Movies, By Folder

5. At this point accessing stays on a lot longer than usual (i.e before switching from 0.4 to 0.5) but it finally finishes and the thumbs are present. 

6. Select Avatar (btw the movie plays fine if I use All Movies vs By Folder) and it immediately shows "Trailers is unavailable. Try again later."  It never shows the screen where you can select Play, etc...

7. With the error still on the screen I shut down Plexconnect. The log at this point is 17.1 MB.  No mater what I've tried the file size doesn't get lower than 17.1 MB.

I've tried leaving the aTV in Movies then preforming the above but it forces me the hit 'menu' and back out, essentially having to start where I did above.  

The one very noticeable difference in behavior now is that no matter what, it continually has to re-access the trailers and for a long time.  EX) Coming out of watching a movie we barely if at all use to notice this as the thumbs popped up so quickly.  I'm wondering if all this accessing is what's filling up the log file?

Just to verify I wasn't crazy, I reloaded 0.4 ver with the same settings in the cfg file (I use all dedicated ip's - btw: I also tried 0.5 with gdm on, but the results were the same).

Everything is back to normal and very perky using v0.4.  So there is something going on with v0.5 here and I just can't put a finger on it, yet!

I'll go ahead and add the large log file just in case but, if you could point me to a scenario I haven't tried maybe there is a solution to obtaining a smaller log with the High setting.

Matt

PlexConnect-2.log.zip (781 KB)

7. With the error still on the screen I shut down Plexconnect. The log at this point is 17.1 MB.  No mater what I've tried the file size doesn't get lower than 17.1 MB.

That's ok, as long as the error is at or near the end of the log it makes finding it much easier.... I'll have a look and see if I can see anything wrong.

Ok, I think I've found the problem, I've committed a fix, please grab the latest PlexConnect from github and give it a try.

As for the speed issue, there shouldn't be any real difference between v0.4 and v0.5, all I can think of is make sure that during normal day to day use that the log file is turned off in Settings.cfg:-

loglevel = Off

High level logging can really slow down PlexConnect, especially on lower powered hardware. 

You are DA' Man Roidy!  It's working and the speed is back, maybe tad better  :D

My test only involved making sure the ByFolder worked but everything seemed as usual except for the internal web server error in the log.

I've never seen any reporting of this kind up until now.  What might be causing it and should I be concerned?

Since the log is very small I'll post it right here:

11:36:13 DNSServer: DNSServer: Serving DNS on 192.168.1.131 port 53.

11:36:13 DNSServer: ***

11:36:13 WebServer: started: 11:36:13

11:36:13 WebServer: ***

11:36:13 WebServer: WebServer: Serving HTTP on 192.168.1.131 port 80.

11:36:13 WebServer: ***

11:36:13 WebServer: started: 11:36:13

11:36:13 WebServer: ***

11:36:13 WebServer: WebServer: Serving HTTPS on 192.168.1.131 port 443.

11:36:13 WebServer: ***

11:41:26 ATVSettings: add section C0HKJ5LXFF54

11:41:26 PlexAPI: ***

11:41:26 PlexAPI: looking up Plex Media Server

11:41:26 PlexAPI: ***

11:41:27 PlexAPI: GDM: Servers discovered: 1

11:41:27 PlexAPI: Servers (local, plex.tv, MyPlex): 2

11:42:48 PlexAPI: MyPlex Sign In successfull

11:42:48 PlexAPI: ***

11:42:48 PlexAPI: looking up Plex Media Server

11:42:48 PlexAPI: ***

11:42:49 PlexAPI: GDM: Servers discovered: 1

11:42:50 PlexAPI: Servers (local, plex.tv, MyPlex): 2

11:47:09 WebServer: Internal Server Error:

Traceback (most recent call last):

  File "/Users/temp1/Downloads/PlexConnect-master/WebServer.py", line 222, in do_GET

    XML = Subtitle.getSubtitleJSON(PMSaddress, self.path + query, options)

  File "/Users/temp1/Downloads/PlexConnect-master/Subtitle.py", line 57, in getSubtitleJSON

    response = urllib2.urlopen(request, timeout=20)

  File "/System/Library/Frameworks/Python.framework/Versions/2.7/lib/python2.7/urllib2.py", line 127, in urlopen

    return _opener.open(url, data, timeout)

  File "/System/Library/Frameworks/Python.framework/Versions/2.7/lib/python2.7/urllib2.py", line 404, in open

    response = self._open(req, data)

  File "/System/Library/Frameworks/Python.framework/Versions/2.7/lib/python2.7/urllib2.py", line 422, in _open

    '_open', req)

  File "/System/Library/Frameworks/Python.framework/Versions/2.7/lib/python2.7/urllib2.py", line 382, in _call_chain

    result = func(*args)

  File "/System/Library/Frameworks/Python.framework/Versions/2.7/lib/python2.7/urllib2.py", line 1214, in http_open

    return self.do_open(httplib.HTTPConnection, req)

  File "/System/Library/Frameworks/Python.framework/Versions/2.7/lib/python2.7/urllib2.py", line 1153, in do_open

    h = http_class(host, timeout=req.timeout) # will parse host:port

  File "/System/Library/Frameworks/Python.framework/Versions/2.7/lib/python2.7/httplib.py", line 704, in __init__

    self._set_hostport(host, port)

  File "/System/Library/Frameworks/Python.framework/Versions/2.7/lib/python2.7/httplib.py", line 732, in _set_hostport

    raise InvalidURL("nonnumeric port: '%s'" % host[i+1:])

InvalidURL: nonnumeric port: '32400&encoding=utf-8'

 

11:51:50 PlexConnect: Shutting down.

11:51:50 PlexConnect: Shutting down.

11:51:50 PlexConnect: Shutting down.

11:51:50 PlexConnect: Shutting down.

11:51:50 PlexConnect: Shutting down.

11:51:50 DNSServer: Shutting down.

11:51:51 WebServer: Shutting down (HTTP).

11:51:51 WebServer: Shutting down (HTTPS).

11:51:51 PlexConnect: shutdown

I've never seen any reporting of this kind up until now.  What might be causing it and should I be concerned?

Umm... looking at the traceback it seems to originate in the subtitle code... I know nothing about how the subtitle code works, sorry. This would be Baa's area of expertise. What exactly are you doing when the error occurs?

Nothing that I know of.  In this particular case I went directly to Movies, ByFolder select a movie and played it for a couple of minutes, then backed out to aTV and shut down plexconnect.

While I'm on the topic of ByFolder.  V0.5 appears to have changed the coding, putting in folders under Templates and going from file MovieSectionTopLevel.xml to folder 'Movie' and file NavigationBar.xml.  I had made a change in the old ver to force ByFolder to be the default. The coding in the new ver file appears similar so I attempted the same change but 'All Movies' still remains the default.

Line in question (new ver right after at the top) is this:

 
The default is '1' where '2' is shown.  The '2' did it in the old file but not in this one.  I've tried 3 & 4 but no change.  So, how can we make ByFolder the default view in Movies?
 
Matt