Movie postprocessing fails to update CouchPotato wanted list

[kerrhyphen]

Hi, this looks like a closed issue (#242), but seeing as I've got the latest version (I think), I thought I'd report it and see if it was something new.

The files get unpacked, and moved/renamed properly, but CouchPotato still has the movie on the wanted list.

08:59:57|INFO ==================== 08:59:57|INFO nzbToCouchPotato V9.2 08:59:57|INFO MAIN: Script triggered from SABnzbd, starting autoProcessMovie... 08:59:57|INFO Loading config from /usr/local/sabnzbd/var/scripts/nzbToMedia/autoProcessMedia.cfg 08:59:57|INFO Found movie id tt0266697 in name 08:59:58|INFO Found movie id 731 in CPS database for movie tt0266697 08:59:59|INFO Waiting for 65.0 seconds to allow CPS to process newly extracted files 09:06:04|ERROR Unable to open URL Traceback (most recent call last): File "/volume1/@appstore/sabnzbd/var/scripts/nzbToMedia/autoProcess/autoProcessMovie.py", line 294, in process urlObj = urllib.urlopen(url) File "/usr/local/python/lib/python2.7/urllib.py", line 87, in urlopen return opener.open(url) File "/usr/local/python/lib/python2.7/urllib.py", line 208, in open return getattr(self, name)(url) File "/usr/local/python/lib/python2.7/urllib.py", line 346, in open_http errcode, errmsg, headers = h.getreply() File "/usr/local/python/lib/python2.7/httplib.py", line 1117, in getreply response = self._conn.getresponse() File "/usr/local/python/lib/python2.7/httplib.py", line 1045, in getresponse response.begin() File "/usr/local/python/lib/python2.7/httplib.py", line 409, in begin version, status, reason = self._read_status() File "/usr/local/python/lib/python2.7/httplib.py", line 365, in _read_status line = self.fp.readline(_MAXLINE + 1) File "/usr/local/python/lib/python2.7/socket.py", line 476, in readline data = self._sock.recv(self._rbufsize) IOError: [Errno socket error] timed out 09:06:04|INFO MAIN: A problem was reported in the autoProcessMovie script.

Let me know if there's any more info needed, or if I'm missing something obvious. Thanks!

[clinton-hall]

Ok, the latest is actually v9.3 in dev branch... But this is needed for development branch of CouchPotato only.

Is CouchPotato renaming movies across different volumes/drives/network? Can you show CouchPotato logs for the rename in question?

Does this movie show in the manage list on CouchPotato?

[SJ50]

I have something similar issue but in my case cp processed the file and moved the movie from wanted to manage. I am sorry I do not know how to formate my comment.

HERE IS NZBTOMEDIA LOG

08:14:17|INFO ==================== 08:14:17|INFO nzbToCouchPotato V9.2 08:14:17|INFO MAIN: Script triggered from NZBGet (11.0 or later). 08:14:17|INFO MAIN: Script triggered from NZBGet, starting autoProcessMovie... 08:14:17|INFO Loading config from /opt/share/nzbToMedia/autoProcessMedia.cfg 08:14:18|INFO Found movie id tt1170358 in name 08:14:18|DEBUG Opening URL: http://localhost:5050/api/xxxxxxxx/media.list/?status=active&release_status=snatched&limit_offset=50,0 08:14:20|INFO Found movie id 555 in CPS database for movie tt1170358 08:14:20|DEBUG Looking for status of movie: 555 - with release sent to clientAgent: nzbget and download_id: 26aab92812e1498792e9319854e9c858 08:14:20|DEBUG Opening URL: http://localhost:5050/api/72c54129840d43fabed48822b8fb8c5d/media.get/?id=555 08:14:21|DEBUG This movie is marked as status active in CouchPotatoServer 08:14:21|DEBUG Found a single release with download_id: 26aab92812e1498792e9319854e9c858 for clientAgent: NZBGet. Release status is: snatched 08:14:21|INFO Waiting for 65.0 seconds to allow CPS to process newly extracted files 08:15:26|DEBUG Opening URL: http://localhost:5050/api/xxxxxxx/renamer.scan/?media_folder=/tmp/mnt/pendrive/Downloads//dst/Movies/The.Hobbit.The.Desolation.of.Smaug.2013.720p.BluRay.DTS.x264-PublicHD.cp%28tt1170358%29&downloader=NZBGet&download_id=26aab92812e1498792e9319854e9c858 08:25:26|ERROR Unable to open URL Traceback (most recent call last): File "/tmp/mnt/mmc/entware/share/nzbToMedia/autoProcess/autoProcessMovie.py", line 294, in process urlObj = urllib.urlopen(url) File "/opt/lib/python2.7/urllib.py", line 86, in urlopen return opener.open(url) File "/opt/lib/python2.7/urllib.py", line 207, in open return getattr(self, name)(url) File "/opt/lib/python2.7/urllib.py", line 345, in open_http errcode, errmsg, headers = h.getreply() File "/opt/lib/python2.7/httplib.py", line 1102, in getreply response = self._conn.getresponse() File "/opt/lib/python2.7/httplib.py", line 1030, in getresponse response.begin() File "/opt/lib/python2.7/httplib.py", line 407, in begin version, status, reason = self._read_status() File "/opt/lib/python2.7/httplib.py", line 365, in _read_status line = self.fp.readline() File "/opt/lib/python2.7/socket.py", line 430, in readline data = recv(1) IOError: [Errno socket error] timed out 08:25:26|INFO MAIN: A problem was reported in the autoProcessMovie script.

HERE IS CP LOG

03-28 08:15:26 INFO [tato.core.plugins.renamer] Scanning media folder /tmp/mnt/pendrive/Downloads/dst/Movies/The.Hobbit.The.Desolation.of.Smaug.2013.720p.BluRay.DTS.x264-PublicHD.cp(tt1170358)... 03-28 08:15:30 INFO [tato.core.plugins.scanner] Found 1 movies in the folder /tmp/mnt/pendrive/Downloads/dst/Movies 03-28 08:15:30 INFO [hpotato.core.plugins.base] Opening url: get https://api.couchpota.to/info/tt1170358/, data: [] 03-28 08:15:30 INFO [hpotato.core.plugins.base] Opening url: get http://www.omdbapi.com/?i=tt1170358, data: [] 03-28 08:15:31 INFO [re.providers.info.omdbapi] Found: The Hobbit: The Desolation of Smaug (2013) 03-28 08:15:40 INFO [tato.core.plugins.renamer] Renaming "/tmp/mnt/pendrive/Downloads/dst/Movies/The.Hobbit.The.Desolation.of.Smaug.2013.720p.BluRay.DTS.x264-PublicHD.cp(tt1170358)/QFRor3CNakAzni4s6gFyoEm8goQD9VzPX/tiDtzqPCAVu2rrsK5SuKw5p6.mkv" to "/mnt/My_Book/Movies/Hobbit The Desolation of Smaug, The (2013)_720p/The Hobbit The Desolation of Smaug_2013_720p.mkv" 03-28 08:25:57 INFO [tato.core.plugins.renamer] Deleting folder: /tmp/mnt/pendrive/Downloads/dst/Movies/The.Hobbit.The.Desolation.of.Smaug.2013.720p.BluRay.DTS.x264-PublicHD.cp(tt1170358) 03-28 08:25:57 INFO [e.providers.metadata.base] Creating XBMC metadata. 03-28 08:25:57 INFO [hpotato.core.plugins.base] Opening url: get https://api.couchpota.to/info/tt1170358/, data: [] 03-28 08:25:57 INFO [hpotato.core.plugins.base] Opening url: get http://www.omdbapi.com/?i=tt1170358, data: [] 03-28 08:25:58 INFO [re.providers.info.omdbapi] Found: The Hobbit: The Desolation of Smaug (2013) 03-28 08:26:05 INFO [hpotato.core.plugins.base] Opening url: get https://image.tmdb.org/t/p/original/gQCiuxGsfiXH1su6lp9n0nd0UeH.jpg, data: [] 03-28 08:26:49 INFO [hpotato.core.plugins.base] Opening url: get https://image.tmdb.org/t/p/original/hyR7Fs6Tepgu3yCQGtgO4Ilz9tY.jpg, data: [] 03-28 08:28:02 INFO [hpotato.core.plugins.base] Opening url: post https://new.boxcar.io/api/notifications, data: ['notification[long_message]', 'notification[title]', 'user_credentials'] 03-28 08:28:06 INFO [ore.notifications.boxcar2] Boxcar notification successful. 03-28 08:28:09 INFO [tato.core.plugins.scanner] Found 1 movies in the folder /mnt/My_Book/Movies/Hobbit The Desolation of Smaug, The (2013)_720p

[clinton-hall]

@frriction In your case it looks like the PostProcessing worked fine, but since CouchPotato has to move the files from one mount to another, it took about 13 minutes to move the files, and the connection timed out after 10.

In autoProcessMedia try changing [CouchPotato] wait_for to 15 (or maybe even 20) minutes to prevent this timeout.

[SJ50]

I have increased cps wait_for to 12 minute and cpsdelay to 300s. No error. What cpsdelay do? Can I reduce it to 60s?

[clinton-hall]

Cps delay makes sure files are more than 1 min old to meet requirements of CouchPotato's scanner... So leave this as 65.

If you get anymore timeouts, boost your wait_for value.

[SJ50]

I have changed cpsdelay to 65s ad wait_for to 15 minute and It worked. Thank You.