nosmokingbandit / Watcher3

Other
280 stars 60 forks source link

never stops waiting. #133

Closed phynias closed 6 years ago

phynias commented 6 years ago

I've had a couple of movies that were grabbed and finished but they still sit under waiting for weeks. When I click on the movie it shows at the bottom what was grabbed and says Finished.

nosmokingbandit commented 6 years ago

What do you have set for Settings>Search>Verify Availability? And what movies are the culprit?

nilsbebelaar commented 6 years ago

I've had this problem for ages, didn't know how to fix it or thought that my database was just too big and it was causing bugs. Now when I set Verify Availibilty to 'disabled' it works like a charm. Thanks!

theotherp commented 6 years ago

It seems the PreDB check doesn't work correctly or at least a lot of movies are missed. I've had several movies of which scene and P2P releases were out (for days) which were still in state "Waiting".

nosmokingbandit commented 6 years ago

If anyone wants me to look into this I'll need logs or literally any useful information.

theotherp commented 6 years ago

I'll post some when I'm back from vacation.

On Nov 21, 2017 17:57, "nosmokingbandit" notifications@github.com wrote:

If anyone wants me to look into this I'll need logs or literally any useful information.

— You are receiving this because you commented. Reply to this email directly, view it on GitHub https://github.com/nosmokingbandit/Watcher3/issues/133#issuecomment-346091389, or mute the thread https://github.com/notifications/unsubscribe-auth/ANtAeSkufkMOe6hWnprGHpILq4E9v8cqks5s4wENgaJpZM4PwAkj .

theotherp commented 6 years ago
INFO 2017-11-27 18:37:20,853 core.ajax.get_log_text: Dumping log file log.txt to text.
INFO 2017-11-27 18:37:15,490 CPTaskScheduler._task: == Finished Scheduled Task: Movie Search ==
DEBUG 2017-11-27 18:37:15,364 core.sqldb.execute: Executing SQL command: ['UPDATE TASKS SET last_execution=? WHERE name=?', ('2017-11-27 18:37:13', 'Movie Search')]
DEBUG 2017-11-27 18:37:15,364 core.sqldb.update: Updating last_execution to 2017-11-27 18:37:13 for rows that match name:Movie Search in TASKS.
DEBUG 2017-11-27 18:37:15,364 core.sqldb.execute: Executing SQL command: ['SELECT 1 FROM TASKS WHERE name="Movie Search"']
DEBUG 2017-11-27 18:37:15,363 core.sqldb.row_exists: Checking if name="Movie Search" exists in database table TASKS
INFO 2017-11-27 18:37:15,363 core.searcher.rss_sync: Nothing found in RSS for My Entire High School Sinking Into the Sea 2016
INFO 2017-11-27 18:37:15,363 core.searcher.rss_sync: Parsing RSS for My Entire High School Sinking Into the Sea 2016
INFO 2017-11-27 18:37:15,363 core.searcher.rss_sync: Nothing found in RSS for Justice League 2017
INFO 2017-11-27 18:37:15,363 core.searcher.rss_sync: Parsing RSS for Justice League 2017
INFO 2017-11-27 18:37:15,363 core.searcher.rss_sync: Nothing found in RSS for It 2017
INFO 2017-11-27 18:37:15,363 core.searcher.rss_sync: Parsing RSS for It 2017
INFO 2017-11-27 18:37:15,363 core.searcher.rss_sync: Nothing found in RSS for Casting JonBenet 2017
INFO 2017-11-27 18:37:15,363 core.searcher.rss_sync: Parsing RSS for Casting JonBenet 2017
INFO 2017-11-27 18:37:15,363 core.searcher.rss_sync: Nothing found in RSS for Atomic Blonde 2017
INFO 2017-11-27 18:37:15,363 core.searcher.rss_sync: Parsing RSS for Atomic Blonde 2017
INFO 2017-11-27 18:37:15,363 core.searcher.rss_sync: Nothing found in RSS for An Inconvenient Sequel: Truth to Power 2017
INFO 2017-11-27 18:37:15,363 core.searcher.rss_sync: Parsing RSS for An Inconvenient Sequel: Truth to Power 2017
INFO 2017-11-27 18:37:13,402 root._get_rss: RSS_SYNC: http://127.0.0.1:5061/nzbhydra2/api?t=movie&cat=2000&extended=1&offset=0&apikey=APIKEY
INFO 2017-11-27 18:37:13,402 root._get_rss: Fetching latest RSS from http://127.0.0.1:5061/nzbhydra2.
INFO 2017-11-27 18:37:13,401 core.searcher.rss_sync: Syncing indexer RSS feeds.
INFO 2017-11-27 18:37:13,401 core.searcher.search_all: Checking RSS feeds for 6 movies.
INFO 2017-11-27 18:37:13,401 core.searcher.verify: My Entire High School Sinking Into the Sea passes verification checks, will include title in search.
INFO 2017-11-27 18:37:13,401 core.searcher.verify: Justice League passes verification checks, will include title in search.
INFO 2017-11-27 18:37:13,401 core.searcher.verify: It passes verification checks, will include title in search.
INFO 2017-11-27 18:37:13,401 core.searcher.verify: Casting JonBenet passes verification checks, will include title in search.
INFO 2017-11-27 18:37:13,401 core.searcher.verify: Atomic Blonde passes verification checks, will include title in search.
INFO 2017-11-27 18:37:13,401 core.searcher.verify: An Inconvenient Sequel: Truth to Power passes verification checks, will include title in search.
INFO 2017-11-27 18:37:13,401 core.searcher._get_rss_movies: My Entire High School Sinking Into the Sea 2016 is Wanted. Will look for new releases in RSS feed.
INFO 2017-11-27 18:37:13,401 core.searcher._get_rss_movies: Justice League 2017 is Wanted. Will look for new releases in RSS feed.
INFO 2017-11-27 18:37:13,401 core.searcher._get_rss_movies: It 2017 is Wanted. Will look for new releases in RSS feed.
INFO 2017-11-27 18:37:13,401 core.searcher._get_rss_movies: Casting JonBenet 2017 is Wanted. Will look for new releases in RSS feed.
INFO 2017-11-27 18:37:13,401 core.searcher._get_rss_movies: Atomic Blonde 2017 was marked Finished on 2017-10-24, will keep checking RSS feed for new releases.
INFO 2017-11-27 18:37:13,401 core.searcher._get_rss_movies: An Inconvenient Sequel: Truth to Power 2017 was marked Finished on 2017-10-24, will keep checking RSS feed for new releases.
INFO 2017-11-27 18:37:13,399 core.searcher._get_rss_movies: Picking movies to look for in RSS feed.
DEBUG 2017-11-27 18:37:13,396 core.sqldb.execute: Executing SQL command: ['SELECT * FROM MOVIES  ORDER BY title ASC, sort_title ASC']
DEBUG 2017-11-27 18:37:13,396 core.sqldb.get_user_movies: Retrieving list of user's movies.
INFO 2017-11-27 18:37:13,396 core.searcher.search_all: Executing search/grab for all movies.
INFO 2017-11-27 18:37:13,396 CPTaskScheduler._task: == Executing Scheduled Task: Movie Search ==
INFO 2017-11-27 18:37:13,396 core.ajax.manual_task_execute: Manually executing task Movie Search.

Four of my movies are shown "Wanted", two are "Finished", all the others are "Waiting". The log seems very sparse, let me know how I can help you.

Cheers.

nosmokingbandit commented 6 years ago

Which method do you have selected to verify releases?

theotherp commented 6 years ago

None.

On 1 Dec 2017 01:39, "nosmokingbandit" notifications@github.com wrote:

Which method do you have selected to verify releases?

— You are receiving this because you commented. Reply to this email directly, view it on GitHub https://github.com/nosmokingbandit/Watcher3/issues/133#issuecomment-348366898, or mute the thread https://github.com/notifications/unsubscribe-auth/ANtAeYk5VAjFul9pX8Tvzy5pa0qb_D4jks5s70rNgaJpZM4PwAkj .

nosmokingbandit commented 6 years ago

I made a few changes to the way certain flags are set in the database a few commits ago. This might fix it, but you may need to reset the affected movies. Go to library/manage, select all Waiting movies and Reset. This changes all of the flags back as if it were just added to your library. On my testing server I switched verification to Disabled, added a new movie, and it was switched over the Waiting immediately.

theotherp commented 6 years ago

That fixed it. I had to trigger a new movie search but after that movies for which I knew releases already exist were found and the others are Wanted now.

nosmokingbandit commented 6 years ago

Cool beans. Not 100% sure exactly where the problem was, but this pointed me toward a lot of improvements what will hopefully prevent it in the future.

I'm closing this, but feel free to re-open if necessary.

theotherp commented 6 years ago

All the movies for which no results were found before are back to Waiting.

Current log file: log(1).txt

nosmokingbandit commented 6 years ago

Thanks for the logs, it pointed me to the exact problem. Some remnants from back when predb was the only option and I missed converting this code block to allow for other methods.

6097d65604390bd6569e19aa5b1ea481a8bcda6c