Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Email Notification fails to send when auto cacher marks as available #1702

Closed
filoor opened this issue Nov 10, 2017 · 12 comments
Closed

Email Notification fails to send when auto cacher marks as available #1702

filoor opened this issue Nov 10, 2017 · 12 comments

Comments

@filoor
Copy link

filoor commented Nov 10, 2017

Ombi build Version:

V 3.0.2336

Update Branch:

Open Beta

Media Sever:

Emby

Media Server Version:

Operating System:

Arch Linux (Docker container)

Problem Description:

Email notification works with test email and when i mark a movie manual as available but when its automatically go to available withe the media cacher it will not send a mail

Reproduction Steps:

Set up email notifications, make sure New Request is enabled and request a new tv show or movie.

@tidusjar
Copy link
Member

Logs?

@filoor
Copy link
Author

filoor commented Nov 11, 2017

Hi ,

Wanted to replicate the problem but after the last update
v3.23.43
It wont catch new movies

2017-11-11 11:58:12.821 +00:00 [Error] Error occurred during execution of 'Worker #5fa12b50' process. Execution will be retried (attempt #191) in 00:05:00 seconds. System.Threading.LockRecursionException: Recursive write lock acquisitions not allowed in this mode. at System.Threading.ReaderWriterLockSlim.TryEnterWriteLockCore(TimeoutTracker timeout) at Hangfire.SQLite.SQLiteStorage.CreateAndOpenConnection(Boolean isWriteLock) at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func2 func, Boolean isWriteLock)
at Hangfire.SQLite.SQLiteStorage.UseConnection(Action1 action, Boolean isWriteLock) at Hangfire.SQLite.SQLiteJobQueue.Dequeue(String[] queues, CancellationToken cancellationToken) at Hangfire.SQLite.SQLiteStorageConnection.FetchNextJob(String[] queues, CancellationToken cancellationToken) at Hangfire.Server.Worker.Execute(BackgroundProcessContext context) at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)

@filoor
Copy link
Author

filoor commented Nov 12, 2017

After restart of the container it scans again
But it looks like it scans only one literary in emby.

2017-11-12 12:10:01.536 +00:00 [Error] Provider Id on movie "Molenbeek Part3 FLEMISH 720p HDTV x264-SPAROOD" is null
2017-11-12 12:10:03.597 +00:00 [Error] Provider Id on movie "Spongebob Squarepants - Terug In de tijd" is null
2017-11-12 12:10:03.773 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 3" is null
2017-11-12 12:10:05.137 +00:00 [Error] Provider Id on movie "Buurman en Buurman - deel 8" is null
2017-11-12 12:10:06.272 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 5" is null
2017-11-12 12:10:07.586 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 4" is null
2017-11-12 12:10:10.865 +00:00 [Error] Provider Id on movie "Molenbeek Part4 FLEMISH 720p HDTV x264-SPAROOD" is null
2017-11-12 12:10:11.164 +00:00 [Error] Provider Id on movie "F1-Life On The Limit" is null
2017-11-12 12:10:15.219 +00:00 [Error] Provider Id on movie "Optimized for Mobile" is null
2017-11-12 12:10:19.450 +00:00 [Error] Provider Id on movie "Theo Maassen: Van Kwaad Tot Erger" is null
2017-11-12 12:10:20.013 +00:00 [Error] Provider Id on movie "Molenbeek Part2 FLEMISH 720p HDTV x264-SPAROOD" is null
2017-11-12 12:10:22.456 +00:00 [Error] Provider Id on movie "Emma wil leven" is null
2017-11-12 12:10:25.419 +00:00 [Error] Provider Id on tv "Plex2csv" is null
2017-11-12 12:10:25.425 +00:00 [Error] Provider Id on tv "How Do They Do It? Met Thijs En Joep" is null
2017-11-12 12:10:25.429 +00:00 [Error] Provider Id on tv "Grab Networks" is null
2017-11-12 12:10:26.171 +00:00 [Error] Provider Id on tv "De Rijdende Rechter" is null
2017-11-12 12:10:26.217 +00:00 [Error] Provider Id on tv "Grab Networks" is null
2017-11-12 12:13:06.910 +00:00 [Error] Provider Id on movie "Buurman en Buurman - deel 9" is null
2017-11-12 12:13:11.326 +00:00 [Error] Provider Id on movie "Buurman en Buurman - deel 7" is null
2017-11-12 12:13:11.838 +00:00 [Error] Provider Id on movie "André Hazes: Bloed, Zweet en Tranen (Zijn Verhaal)" is null
2017-11-12 12:13:12.021 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 1" is null
2017-11-12 12:13:15.600 +00:00 [Error] Provider Id on movie "I’ll See You in My Dreams (2015)" is null
2017-11-12 12:13:18.490 +00:00 [Error] Provider Id on movie "Zembla Internationaal - Mishandeld in de jeugdgevangenis (VARA 26-10-2016) x264 HDTV 720p" is null
2017-11-12 12:13:19.784 +00:00 [Error] Provider Id on movie "2Doc- Google en het Wereldbrein" is null
2017-11-12 12:13:21.146 +00:00 [Error] Provider Id on movie "2Doc; Levenseindekliniek (2016) 720p HDTV DD5 1 x264" is null
2017-11-12 12:13:27.749 +00:00 [Error] Provider Id on movie "Spongebob Squarepants - Plaag van het wilde westen" is null
2017-11-12 12:13:41.005 +00:00 [Error] Provider Id on movie "Jerry Maquire (1996)" is null
2017-11-12 12:13:56.471 +00:00 [Error] Provider Id on movie "Optimized for TV" is null
2017-11-12 12:13:56.987 +00:00 [Error] Provider Id on movie "Blaze En De Monster Machines - Blaze Of Glory" is null
2017-11-12 12:14:04.555 +00:00 [Error] Provider Id on movie "Roué Verveer: In zeer goede staat" is null
2017-11-12 12:14:19.583 +00:00 [Error] Provider Id on movie "Katt Williams - Pimp Chronicles Part 1" is null
2017-11-12 12:14:23.840 +00:00 [Error] Provider Id on movie "Roué Verveer: Mans Genoeg" is null
2017-11-12 12:14:25.253 +00:00 [Error] Provider Id on movie "2Doc Going Clear Scientology and the Prison of Belief 2015 (1080i HDTV)" is null
2017-11-12 12:14:26.105 +00:00 [Error] Provider Id on movie "De nieuwe wereld met Bianca Krijgsman" is null
2017-11-12 12:14:33.989 +00:00 [Error] Provider Id on movie "7pDivX" is null
2017-11-12 12:14:37.998 +00:00 [Error] Provider Id on movie "9-11 The Greatest Lie Ever Sold (2005)" is null
2017-11-12 12:14:38.555 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 6" is null
2017-11-12 12:14:40.678 +00:00 [Error] Provider Id on movie "Molenbeek Part1 FLEMISH 720p HDTV x264-SPAROOD" is null
2017-11-12 12:14:45.639 +00:00 [Error] Provider Id on movie "Zdoc-Het Wiskundemysterie DUTCH 720p HDTV x264-iFH" is null
2017-11-12 12:14:48.444 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 2" is null
2017-11-12 12:14:53.714 +00:00 [Error] Provider Id on movie "Molenbeek Part3 FLEMISH 720p HDTV x264-SPAROOD" is null
2017-11-12 12:15:00.007 +00:00 [Error] Provider Id on movie "Spongebob Squarepants - Terug In de tijd" is null
2017-11-12 12:15:00.415 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 3" is null
2017-11-12 12:15:05.078 +00:00 [Error] Provider Id on movie "Buurman en Buurman - deel 8" is null
2017-11-12 12:15:09.156 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 5" is null
2017-11-12 12:15:12.828 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 4" is null
2017-11-12 12:15:23.590 +00:00 [Error] Provider Id on movie "Molenbeek Part4 FLEMISH 720p HDTV x264-SPAROOD" is null
2017-11-12 12:15:24.560 +00:00 [Error] Provider Id on movie "F1-Life On The Limit" is null
2017-11-12 12:15:32.134 +00:00 [Error] Provider Id on movie "Optimized for Mobile" is null
2017-11-12 12:15:40.463 +00:00 [Error] Provider Id on movie "Theo Maassen: Van Kwaad Tot Erger" is null
2017-11-12 12:15:41.385 +00:00 [Error] Provider Id on movie "Molenbeek Part2 FLEMISH 720p HDTV x264-SPAROOD" is null
2017-11-12 12:15:49.451 +00:00 [Error] Provider Id on movie "Emma wil leven" is null
2017-11-12 12:16:01.512 +00:00 [Error] Provider Id on tv "Plex2csv" is null
2017-11-12 12:16:01.527 +00:00 [Error] Provider Id on tv "How Do They Do It? Met Thijs En Joep" is null
2017-11-12 12:16:01.539 +00:00 [Error] Provider Id on tv "Grab Networks" is null
2017-11-12 12:16:04.227 +00:00 [Error] Provider Id on tv "De Rijdende Rechter" is null
2017-11-12 12:16:04.429 +00:00 [Error] Provider Id on tv "Grab Networks" is null
2017-11-12 12:18:46.478 +00:00 [Error] Provider Id on movie "Buurman en Buurman - deel 9" is null
2017-11-12 12:18:51.493 +00:00 [Error] Provider Id on movie "Buurman en Buurman - deel 7" is null
2017-11-12 12:18:51.891 +00:00 [Error] Provider Id on movie "André Hazes: Bloed, Zweet en Tranen (Zijn Verhaal)" is null
2017-11-12 12:18:52.049 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 1" is null
2017-11-12 12:18:55.302 +00:00 [Error] Provider Id on movie "I’ll See You in My Dreams (2015)" is null
2017-11-12 12:18:58.947 +00:00 [Error] Provider Id on movie "Zembla Internationaal - Mishandeld in de jeugdgevangenis (VARA 26-10-2016) x264 HDTV 720p" is null
2017-11-12 12:19:01.393 +00:00 [Error] Provider Id on movie "2Doc- Google en het Wereldbrein" is null
2017-11-12 12:19:03.277 +00:00 [Error] Provider Id on movie "2Doc; Levenseindekliniek (2016) 720p HDTV DD5 1 x264" is null
2017-11-12 12:19:11.206 +00:00 [Error] Provider Id on movie "Spongebob Squarepants - Plaag van het wilde westen" is null
2017-11-12 12:19:23.798 +00:00 [Error] Provider Id on movie "Jerry Maquire (1996)" is null
2017-11-12 12:19:39.171 +00:00 [Error] Provider Id on movie "Optimized for TV" is null
2017-11-12 12:19:39.706 +00:00 [Error] Provider Id on movie "Blaze En De Monster Machines - Blaze Of Glory" is null
2017-11-12 12:19:45.292 +00:00 [Error] Provider Id on movie "Roué Verveer: In zeer goede staat" is null
2017-11-12 12:19:59.894 +00:00 [Error] Provider Id on movie "Katt Williams - Pimp Chronicles Part 1" is null
2017-11-12 12:20:06.109 +00:00 [Error] Provider Id on movie "Roué Verveer: Mans Genoeg" is null
2017-11-12 12:20:08.613 +00:00 [Error] Provider Id on movie "2Doc Going Clear Scientology and the Prison of Belief 2015 (1080i HDTV)" is null
2017-11-12 12:20:09.434 +00:00 [Error] Provider Id on movie "De nieuwe wereld met Bianca Krijgsman" is null
2017-11-12 12:20:16.010 +00:00 [Error] Provider Id on movie "7pDivX" is null
2017-11-12 12:20:22.571 +00:00 [Error] Provider Id on movie "9-11 The Greatest Lie Ever Sold (2005)" is null
2017-11-12 12:20:23.141 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 6" is null
2017-11-12 12:20:25.118 +00:00 [Error] Provider Id on movie "Molenbeek Part1 FLEMISH 720p HDTV x264-SPAROOD" is null
2017-11-12 12:20:29.190 +00:00 [Error] Provider Id on movie "Zdoc-Het Wiskundemysterie DUTCH 720p HDTV x264-iFH" is null
2017-11-12 12:20:31.877 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 2" is null
2017-11-12 12:20:36.100 +00:00 [Error] Provider Id on movie "Molenbeek Part3 FLEMISH 720p HDTV x264-SPAROOD" is null
2017-11-12 12:20:42.369 +00:00 [Error] Provider Id on movie "Spongebob Squarepants - Terug In de tijd" is null
2017-11-12 12:20:42.724 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 3" is null
2017-11-12 12:20:46.135 +00:00 [Error] Provider Id on movie "Buurman en Buurman - deel 8" is null
2017-11-12 12:20:49.773 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 5" is null
2017-11-12 12:20:53.686 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 4" is null
2017-11-12 12:21:06.253 +00:00 [Error] Provider Id on movie "Molenbeek Part4 FLEMISH 720p HDTV x264-SPAROOD" is null
2017-11-12 12:21:07.061 +00:00 [Error] Provider Id on movie "F1-Life On The Limit" is null
2017-11-12 12:21:13.248 +00:00 [Error] Provider Id on movie "Optimized for Mobile" is null
2017-11-12 12:21:23.758 +00:00 [Error] Provider Id on movie "Theo Maassen: Van Kwaad Tot Erger" is null
2017-11-12 12:21:24.843 +00:00 [Error] Provider Id on movie "Molenbeek Part2 FLEMISH 720p HDTV x264-SPAROOD" is null
2017-11-12 12:21:32.592 +00:00 [Error] Provider Id on movie "Emma wil leven" is null
2017-11-12 12:21:41.775 +00:00 [Error] Provider Id on tv "Plex2csv" is null
2017-11-12 12:21:41.800 +00:00 [Error] Provider Id on tv "How Do They Do It? Met Thijs En Joep" is null
2017-11-12 12:21:41.821 +00:00 [Error] Provider Id on tv "Grab Networks" is null
2017-11-12 12:21:44.528 +00:00 [Error] Provider Id on tv "De Rijdende Rechter" is null
2017-11-12 12:21:44.683 +00:00 [Error] Provider Id on tv "Grab Networks" is null
2017-11-12 12:24:50.838 +00:00 [Error] Provider Id on movie "Buurman en Buurman - deel 9" is null
2017-11-12 12:24:54.986 +00:00 [Error] Provider Id on movie "Buurman en Buurman - deel 7" is null
2017-11-12 12:24:55.430 +00:00 [Error] Provider Id on movie "André Hazes: Bloed, Zweet en Tranen (Zijn Verhaal)" is null
2017-11-12 12:24:55.661 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 1" is null
2017-11-12 12:24:59.044 +00:00 [Error] Provider Id on movie "I’ll See You in My Dreams (2015)" is null
2017-11-12 12:25:03.843 +00:00 [Error] Provider Id on movie "Zembla Internationaal - Mishandeld in de jeugdgevangenis (VARA 26-10-2016) x264 HDTV 720p" is null
2017-11-12 12:25:05.259 +00:00 [Error] Provider Id on movie "2Doc- Google en het Wereldbrein" is null
2017-11-12 12:25:06.965 +00:00 [Error] Provider Id on movie "2Doc; Levenseindekliniek (2016) 720p HDTV DD5 1 x264" is null
2017-11-12 12:25:13.493 +00:00 [Error] Provider Id on movie "Spongebob Squarepants - Plaag van het wilde westen" is null
2017-11-12 12:25:23.241 +00:00 [Error] Provider Id on movie "Jerry Maquire (1996)" is null
2017-11-12 12:25:38.176 +00:00 [Error] Provider Id on movie "Optimized for TV" is null
2017-11-12 12:25:38.704 +00:00 [Error] Provider Id on movie "Blaze En De Monster Machines - Blaze Of Glory" is null
2017-11-12 12:25:43.608 +00:00 [Error] Provider Id on movie "Roué Verveer: In zeer goede staat" is null
2017-11-12 12:25:56.662 +00:00 [Error] Provider Id on movie "Katt Williams - Pimp Chronicles Part 1" is null
2017-11-12 12:26:05.040 +00:00 [Error] Provider Id on movie "Roué Verveer: Mans Genoeg" is null
2017-11-12 12:26:06.511 +00:00 [Error] Provider Id on movie "2Doc Going Clear Scientology and the Prison of Belief 2015 (1080i HDTV)" is null
2017-11-12 12:26:07.455 +00:00 [Error] Provider Id on movie "De nieuwe wereld met Bianca Krijgsman" is null
2017-11-12 12:26:14.088 +00:00 [Error] Provider Id on movie "7pDivX" is null
2017-11-12 12:26:19.690 +00:00 [Error] Provider Id on movie "9-11 The Greatest Lie Ever Sold (2005)" is null
2017-11-12 12:26:20.181 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 6" is null
2017-11-12 12:26:22.050 +00:00 [Error] Provider Id on movie "Molenbeek Part1 FLEMISH 720p HDTV x264-SPAROOD" is null
2017-11-12 12:26:26.902 +00:00 [Error] Provider Id on movie "Zdoc-Het Wiskundemysterie DUTCH 720p HDTV x264-iFH" is null
2017-11-12 12:26:30.745 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 2" is null
2017-11-12 12:26:37.703 +00:00 [Error] Provider Id on movie "Molenbeek Part3 FLEMISH 720p HDTV x264-SPAROOD" is null
2017-11-12 12:26:43.049 +00:00 [Error] Provider Id on movie "Spongebob Squarepants - Terug In de tijd" is null
2017-11-12 12:26:43.543 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 3" is null
2017-11-12 12:26:49.339 +00:00 [Error] Provider Id on movie "Buurman en Buurman - deel 8" is null
2017-11-12 12:26:52.803 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 5" is null
2017-11-12 12:26:56.666 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 4" is null
2017-11-12 12:27:08.821 +00:00 [Error] Provider Id on movie "Molenbeek Part4 FLEMISH 720p HDTV x264-SPAROOD" is null
2017-11-12 12:27:09.855 +00:00 [Error] Provider Id on movie "F1-Life On The Limit" is null
2017-11-12 12:27:16.331 +00:00 [Error] Provider Id on movie "Optimized for Mobile" is null
2017-11-12 12:27:25.704 +00:00 [Error] Provider Id on movie "Theo Maassen: Van Kwaad Tot Erger" is null
2017-11-12 12:27:26.761 +00:00 [Error] Provider Id on movie "Molenbeek Part2 FLEMISH 720p HDTV x264-SPAROOD" is null
2017-11-12 12:27:36.250 +00:00 [Error] Provider Id on movie "Emma wil leven" is null
2017-11-12 12:27:45.625 +00:00 [Error] Provider Id on tv "Plex2csv" is null
2017-11-12 12:27:45.650 +00:00 [Error] Provider Id on tv "How Do They Do It? Met Thijs En Joep" is null
2017-11-12 12:27:45.665 +00:00 [Error] Provider Id on tv "Grab Networks" is null
2017-11-12 12:27:49.112 +00:00 [Error] Provider Id on tv "De Rijdende Rechter" is null
2017-11-12 12:27:49.272 +00:00 [Error] Provider Id on tv "Grab Networks" is null
2017-11-12 12:30:30.668 +00:00 [Error] Provider Id on movie "Buurman en Buurman - deel 9" is null
2017-11-12 12:30:34.694 +00:00 [Error] Provider Id on movie "Buurman en Buurman - deel 7" is null
2017-11-12 12:30:35.110 +00:00 [Error] Provider Id on movie "André Hazes: Bloed, Zweet en Tranen (Zijn Verhaal)" is null
2017-11-12 12:30:35.295 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 1" is null
2017-11-12 12:30:39.635 +00:00 [Error] Provider Id on movie "I’ll See You in My Dreams (2015)" is null
2017-11-12 12:30:42.439 +00:00 [Error] Provider Id on movie "Zembla Internationaal - Mishandeld in de jeugdgevangenis (VARA 26-10-2016) x264 HDTV 720p" is null
2017-11-12 12:30:43.816 +00:00 [Error] Provider Id on movie "2Doc- Google en het Wereldbrein" is null
2017-11-12 12:30:45.540 +00:00 [Error] Provider Id on movie "2Doc; Levenseindekliniek (2016) 720p HDTV DD5 1 x264" is null
2017-11-12 12:30:51.456 +00:00 [Error] Provider Id on movie "Spongebob Squarepants - Plaag van het wilde westen" is null
2017-11-12 12:31:03.082 +00:00 [Error] Provider Id on movie "Jerry Maquire (1996)" is null
2017-11-12 12:31:21.750 +00:00 [Error] Provider Id on movie "Optimized for TV" is null
2017-11-12 12:31:22.809 +00:00 [Error] Provider Id on movie "Blaze En De Monster Machines - Blaze Of Glory" is null
2017-11-12 12:31:35.496 +00:00 [Error] Provider Id on movie "Roué Verveer: In zeer goede staat" is null
2017-11-12 12:31:58.952 +00:00 [Error] Provider Id on movie "Katt Williams - Pimp Chronicles Part 1" is null
2017-11-12 12:32:03.538 +00:00 [Error] Provider Id on movie "Roué Verveer: Mans Genoeg" is null
2017-11-12 12:32:04.162 +00:00 [Error] Provider Id on movie "2Doc Going Clear Scientology and the Prison of Belief 2015 (1080i HDTV)" is null
2017-11-12 12:32:04.494 +00:00 [Error] Provider Id on movie "De nieuwe wereld met Bianca Krijgsman" is null
2017-11-12 12:32:09.124 +00:00 [Error] Provider Id on movie "7pDivX" is null
2017-11-12 12:32:11.669 +00:00 [Error] Provider Id on movie "9-11 The Greatest Lie Ever Sold (2005)" is null
2017-11-12 12:32:11.876 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 6" is null
2017-11-12 12:32:12.700 +00:00 [Error] Provider Id on movie "Molenbeek Part1 FLEMISH 720p HDTV x264-SPAROOD" is null
2017-11-12 12:32:15.377 +00:00 [Error] Provider Id on movie "Zdoc-Het Wiskundemysterie DUTCH 720p HDTV x264-iFH" is null
2017-11-12 12:32:18.154 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 2" is null
2017-11-12 12:32:21.118 +00:00 [Error] Provider Id on movie "Molenbeek Part3 FLEMISH 720p HDTV x264-SPAROOD" is null
2017-11-12 12:32:24.223 +00:00 [Error] Provider Id on movie "Spongebob Squarepants - Terug In de tijd" is null
2017-11-12 12:32:24.686 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 3" is null
2017-11-12 12:32:26.193 +00:00 [Error] Provider Id on movie "Buurman en Buurman - deel 8" is null
2017-11-12 12:32:28.572 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 5" is null
2017-11-12 12:32:30.581 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 4" is null
2017-11-12 12:32:34.545 +00:00 [Error] Provider Id on movie "Molenbeek Part4 FLEMISH 720p HDTV x264-SPAROOD" is null
2017-11-12 12:32:35.033 +00:00 [Error] Provider Id on movie "F1-Life On The Limit" is null
2017-11-12 12:32:40.194 +00:00 [Error] Provider Id on movie "Optimized for Mobile" is null
2017-11-12 12:32:43.448 +00:00 [Error] Provider Id on movie "Theo Maassen: Van Kwaad Tot Erger" is null
2017-11-12 12:32:43.884 +00:00 [Error] Provider Id on movie "Molenbeek Part2 FLEMISH 720p HDTV x264-SPAROOD" is null
2017-11-12 12:32:48.340 +00:00 [Error] Provider Id on movie "Emma wil leven" is null
2017-11-12 12:33:05.819 +00:00 [Error] Provider Id on tv "Plex2csv" is null
2017-11-12 12:33:05.835 +00:00 [Error] Provider Id on tv "How Do They Do It? Met Thijs En Joep" is null
2017-11-12 12:33:05.838 +00:00 [Error] Provider Id on tv "Grab Networks" is null
2017-11-12 12:33:10.838 +00:00 [Error] Provider Id on tv "De Rijdende Rechter" is null
2017-11-12 12:33:11.007 +00:00 [Error] Provider Id on tv "Grab Networks" is null
2017-11-12 12:35:41.545 +00:00 [Error] Provider Id on movie "Buurman en Buurman - deel 9" is null
2017-11-12 12:35:42.994 +00:00 [Error] Provider Id on movie "Buurman en Buurman - deel 7" is null
2017-11-12 12:35:43.174 +00:00 [Error] Provider Id on movie "André Hazes: Bloed, Zweet en Tranen (Zijn Verhaal)" is null
2017-11-12 12:35:43.241 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 1" is null
2017-11-12 12:35:44.478 +00:00 [Error] Provider Id on movie "I’ll See You in My Dreams (2015)" is null
2017-11-12 12:35:45.481 +00:00 [Error] Provider Id on movie "Zembla Internationaal - Mishandeld in de jeugdgevangenis (VARA 26-10-2016) x264 HDTV 720p" is null
2017-11-12 12:35:45.997 +00:00 [Error] Provider Id on movie "2Doc- Google en het Wereldbrein" is null
2017-11-12 12:35:46.657 +00:00 [Error] Provider Id on movie "2Doc; Levenseindekliniek (2016) 720p HDTV DD5 1 x264" is null
2017-11-12 12:35:49.942 +00:00 [Error] Provider Id on movie "Spongebob Squarepants - Plaag van het wilde westen" is null
2017-11-12 12:35:53.483 +00:00 [Error] Provider Id on movie "Jerry Maquire (1996)" is null
2017-11-12 12:35:59.340 +00:00 [Error] Provider Id on movie "Optimized for TV" is null
2017-11-12 12:35:59.532 +00:00 [Error] Provider Id on movie "Blaze En De Monster Machines - Blaze Of Glory" is null
2017-11-12 12:36:02.304 +00:00 [Error] Provider Id on movie "Roué Verveer: In zeer goede staat" is null
2017-11-12 12:36:06.501 +00:00 [Error] Provider Id on movie "Katt Williams - Pimp Chronicles Part 1" is null
2017-11-12 12:36:09.113 +00:00 [Error] Provider Id on movie "Roué Verveer: Mans Genoeg" is null
2017-11-12 12:36:09.668 +00:00 [Error] Provider Id on movie "2Doc Going Clear Scientology and the Prison of Belief 2015 (1080i HDTV)" is null
2017-11-12 12:36:09.954 +00:00 [Error] Provider Id on movie "De nieuwe wereld met Bianca Krijgsman" is null
2017-11-12 12:36:12.381 +00:00 [Error] Provider Id on movie "7pDivX" is null
2017-11-12 12:36:13.686 +00:00 [Error] Provider Id on movie "9-11 The Greatest Lie Ever Sold (2005)" is null
2017-11-12 12:36:13.898 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 6" is null
2017-11-12 12:36:14.697 +00:00 [Error] Provider Id on movie "Molenbeek Part1 FLEMISH 720p HDTV x264-SPAROOD" is null
2017-11-12 12:36:16.613 +00:00 [Error] Provider Id on movie "Zdoc-Het Wiskundemysterie DUTCH 720p HDTV x264-iFH" is null
2017-11-12 12:36:18.830 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 2" is null
2017-11-12 12:36:20.960 +00:00 [Error] Provider Id on movie "Molenbeek Part3 FLEMISH 720p HDTV x264-SPAROOD" is null
2017-11-12 12:36:23.680 +00:00 [Error] Provider Id on movie "Spongebob Squarepants - Terug In de tijd" is null
2017-11-12 12:36:23.857 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 3" is null
2017-11-12 12:36:25.395 +00:00 [Error] Provider Id on movie "Buurman en Buurman - deel 8" is null
2017-11-12 12:36:26.693 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 5" is null
2017-11-12 12:36:30.232 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 4" is null
2017-11-12 12:36:34.248 +00:00 [Error] Provider Id on movie "Molenbeek Part4 FLEMISH 720p HDTV x264-SPAROOD" is null
2017-11-12 12:36:34.730 +00:00 [Error] Provider Id on movie "F1-Life On The Limit" is null
2017-11-12 12:36:38.345 +00:00 [Error] Provider Id on movie "Optimized for Mobile" is null
2017-11-12 12:36:41.607 +00:00 [Error] Provider Id on movie "Theo Maassen: Van Kwaad Tot Erger" is null
2017-11-12 12:36:42.051 +00:00 [Error] Provider Id on movie "Molenbeek Part2 FLEMISH 720p HDTV x264-SPAROOD" is null
2017-11-12 12:36:45.210 +00:00 [Error] Provider Id on movie "Emma wil leven" is null
2017-11-12 12:36:51.195 +00:00 [Error] Provider Id on tv "Plex2csv" is null
2017-11-12 12:36:51.205 +00:00 [Error] Provider Id on tv "How Do They Do It? Met Thijs En Joep" is null
2017-11-12 12:36:51.208 +00:00 [Error] Provider Id on tv "Grab Networks" is null
2017-11-12 12:36:52.642 +00:00 [Error] Provider Id on tv "De Rijdende Rechter" is null
2017-11-12 12:36:52.715 +00:00 [Error] Provider Id on tv "Grab Networks" is null
2017-11-12 12:39:43.950 +00:00 [Error] Provider Id on movie "Buurman en Buurman - deel 9" is null
2017-11-12 12:39:45.565 +00:00 [Error] Provider Id on movie "Buurman en Buurman - deel 7" is null
2017-11-12 12:39:45.726 +00:00 [Error] Provider Id on movie "André Hazes: Bloed, Zweet en Tranen (Zijn Verhaal)" is null
2017-11-12 12:39:45.790 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 1" is null
2017-11-12 12:39:46.975 +00:00 [Error] Provider Id on movie "I’ll See You in My Dreams (2015)" is null
2017-11-12 12:39:48.352 +00:00 [Error] Provider Id on movie "Zembla Internationaal - Mishandeld in de jeugdgevangenis (VARA 26-10-2016) x264 HDTV 720p" is null
2017-11-12 12:39:48.868 +00:00 [Error] Provider Id on movie "2Doc- Google en het Wereldbrein" is null
2017-11-12 12:39:49.479 +00:00 [Error] Provider Id on movie "2Doc; Levenseindekliniek (2016) 720p HDTV DD5 1 x264" is null
2017-11-12 12:39:51.544 +00:00 [Error] Provider Id on movie "Spongebob Squarepants - Plaag van het wilde westen" is null
2017-11-12 12:39:54.871 +00:00 [Error] Provider Id on movie "Jerry Maquire (1996)" is null
2017-11-12 12:40:00.024 +00:00 [Error] Provider Id on movie "Optimized for TV" is null
2017-11-12 12:40:01.200 +00:00 [Error] Provider Id on movie "Blaze En De Monster Machines - Blaze Of Glory" is null
2017-11-12 12:40:02.785 +00:00 [Error] Provider Id on movie "Roué Verveer: In zeer goede staat" is null
2017-11-12 12:40:06.525 +00:00 [Error] Provider Id on movie "Katt Williams - Pimp Chronicles Part 1" is null
2017-11-12 12:40:08.713 +00:00 [Error] Provider Id on movie "Roué Verveer: Mans Genoeg" is null
2017-11-12 12:40:09.132 +00:00 [Error] Provider Id on movie "2Doc Going Clear Scientology and the Prison of Belief 2015 (1080i HDTV)" is null
2017-11-12 12:40:09.374 +00:00 [Error] Provider Id on movie "De nieuwe wereld met Bianca Krijgsman" is null
2017-11-12 12:40:11.391 +00:00 [Error] Provider Id on movie "7pDivX" is null
2017-11-12 12:40:12.464 +00:00 [Error] Provider Id on movie "9-11 The Greatest Lie Ever Sold (2005)" is null
2017-11-12 12:40:12.601 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 6" is null
2017-11-12 12:40:13.591 +00:00 [Error] Provider Id on movie "Molenbeek Part1 FLEMISH 720p HDTV x264-SPAROOD" is null
2017-11-12 12:40:14.983 +00:00 [Error] Provider Id on movie "Zdoc-Het Wiskundemysterie DUTCH 720p HDTV x264-iFH" is null
2017-11-12 12:40:15.833 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 2" is null
2017-11-12 12:40:17.322 +00:00 [Error] Provider Id on movie "Molenbeek Part3 FLEMISH 720p HDTV x264-SPAROOD" is null
2017-11-12 12:40:19.023 +00:00 [Error] Provider Id on movie "Spongebob Squarepants - Terug In de tijd" is null
2017-11-12 12:40:19.150 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 3" is null
2017-11-12 12:40:20.226 +00:00 [Error] Provider Id on movie "Buurman en Buurman - deel 8" is null
2017-11-12 12:40:21.192 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 5" is null
2017-11-12 12:40:22.295 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 4" is null
2017-11-12 12:40:25.955 +00:00 [Error] Provider Id on movie "Molenbeek Part4 FLEMISH 720p HDTV x264-SPAROOD" is null
2017-11-12 12:40:26.213 +00:00 [Error] Provider Id on movie "F1-Life On The Limit" is null
2017-11-12 12:40:29.126 +00:00 [Error] Provider Id on movie "Optimized for Mobile" is null
2017-11-12 12:40:31.619 +00:00 [Error] Provider Id on movie "Theo Maassen: Van Kwaad Tot Erger" is null
2017-11-12 12:40:31.981 +00:00 [Error] Provider Id on movie "Molenbeek Part2 FLEMISH 720p HDTV x264-SPAROOD" is null
2017-11-12 12:40:34.151 +00:00 [Error] Provider Id on movie "Emma wil leven" is null

@tidusjar
Copy link
Member

Looks like your metadata is not setup in emby correctly. Check the metadata under the externals section for a movie.

@filoor
Copy link
Author

filoor commented Nov 13, 2017

The most are setup correctly its just a little pat "49" that dont have metadata.
It did work before with the same emby server

@filoor
Copy link
Author

filoor commented Nov 13, 2017

after a new restart of the container Movies are now marked as available but still no mail i will send you later the log

@filoor
Copy link
Author

filoor commented Nov 13, 2017

This is the log of the last scan it did mark it as available but no mail

2017-11-13 06:18:23.636 +00:00 [Information] Start installing Hangfire SQL objects... 2017-11-13 06:18:23.693 +00:00 [Information] Hangfire SQL objects installed. 2017-11-13 06:18:23.722 +00:00 [Information] Starting Hangfire Server 2017-11-13 06:18:23.727 +00:00 [Information] Using job storage: 'SQLite Server: /config/Ombi.db' 2017-11-13 06:18:23.728 +00:00 [Information] Using the following options for Hangfire Server: 2017-11-13 06:18:23.729 +00:00 [Information] Worker count: 1 2017-11-13 06:18:23.729 +00:00 [Information] Listening queues: 'default' 2017-11-13 06:18:23.730 +00:00 [Information] Shutdown timeout: 1.00:00:00 2017-11-13 06:18:23.730 +00:00 [Information] Schedule polling interval: 00:00:15 2017-11-13 06:20:12.595 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 9" is null 2017-11-13 06:20:14.401 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 7" is null 2017-11-13 06:20:14.621 +00:00 [Error] Provider Id on movie "André Hazes: Bloed, Zweet en Tranen (Zijn Verhaal)" is null 2017-11-13 06:20:17.751 +00:00 [Error] Provider Id on movie "2Doc- Google en het Wereldbrein" is null 2017-11-13 06:20:18.393 +00:00 [Error] Provider Id on movie "2Doc; Levenseindekliniek (2016) 720p HDTV DD5 1 x264" is null 2017-11-13 06:20:30.250 +00:00 [Error] Provider Id on movie "Blaze En De Monster Machines - Blaze Of Glory" is null 2017-11-13 06:20:38.027 +00:00 [Error] Provider Id on movie "Roué Verveer: Mans Genoeg" is null 2017-11-13 06:20:38.475 +00:00 [Error] Provider Id on movie "2Doc Going Clear Scientology and the Prison of Belief 2015 (1080i HDTV)" is null 2017-11-13 06:20:38.752 +00:00 [Error] Provider Id on movie "De nieuwe wereld met Bianca Krijgsman" is null 2017-11-13 06:20:42.306 +00:00 [Error] Provider Id on movie "9-11 The Greatest Lie Ever Sold (2005)" is null 2017-11-13 06:20:42.501 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 6" is null 2017-11-13 06:20:43.175 +00:00 [Error] Provider Id on movie "Molenbeek Part1 FLEMISH 720p HDTV x264-SPAROOD" is null 2017-11-13 06:20:44.777 +00:00 [Error] Provider Id on movie "Zdoc-Het Wiskundemysterie DUTCH 720p HDTV x264-iFH" is null 2017-11-13 06:20:45.753 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 2" is null 2017-11-13 06:20:47.433 +00:00 [Error] Provider Id on movie "Molenbeek Part3 FLEMISH 720p HDTV x264-SPAROOD" is null 2017-11-13 06:20:49.417 +00:00 [Error] Provider Id on movie "Spongebob Squarepants - Terug In de tijd" is null 2017-11-13 06:20:49.601 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 3" is null 2017-11-13 06:20:50.888 +00:00 [Error] Provider Id on movie "Buurman & Buurman - Deel 8" is null 2017-11-13 06:20:52.015 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 5" is null 2017-11-13 06:20:53.311 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 4" is null 2017-11-13 06:20:57.547 +00:00 [Error] Provider Id on movie "Molenbeek Part4 FLEMISH 720p HDTV x264-SPAROOD" is null 2017-11-13 06:20:57.907 +00:00 [Error] Provider Id on movie "F1-Life On The Limit" is null 2017-11-13 06:21:05.373 +00:00 [Error] Provider Id on movie "Theo Maassen: Van Kwaad Tot Erger" is null 2017-11-13 06:21:05.764 +00:00 [Error] Provider Id on movie "Molenbeek Part2 FLEMISH 720p HDTV x264-SPAROOD" is null 2017-11-13 06:21:08.166 +00:00 [Error] Provider Id on movie "Emma wil leven" is null 2017-11-13 07:05:08.603 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 9" is null 2017-11-13 07:05:10.092 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 7" is null 2017-11-13 07:05:10.268 +00:00 [Error] Provider Id on movie "André Hazes: Bloed, Zweet en Tranen (Zijn Verhaal)" is null 2017-11-13 07:05:13.382 +00:00 [Error] Provider Id on movie "2Doc- Google en het Wereldbrein" is null 2017-11-13 07:05:14.071 +00:00 [Error] Provider Id on movie "2Doc; Levenseindekliniek (2016) 720p HDTV DD5 1 x264" is null 2017-11-13 07:05:24.959 +00:00 [Error] Provider Id on movie "Blaze En De Monster Machines - Blaze Of Glory" is null 2017-11-13 07:05:33.714 +00:00 [Error] Provider Id on movie "Roué Verveer: Mans Genoeg" is null 2017-11-13 07:05:34.133 +00:00 [Error] Provider Id on movie "2Doc Going Clear Scientology and the Prison of Belief 2015 (1080i HDTV)" is null 2017-11-13 07:05:34.377 +00:00 [Error] Provider Id on movie "De nieuwe wereld met Bianca Krijgsman" is null 2017-11-13 07:05:37.274 +00:00 [Error] Provider Id on movie "9-11 The Greatest Lie Ever Sold (2005)" is null 2017-11-13 07:05:37.405 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 6" is null 2017-11-13 07:05:37.985 +00:00 [Error] Provider Id on movie "Molenbeek Part1 FLEMISH 720p HDTV x264-SPAROOD" is null 2017-11-13 07:05:39.319 +00:00 [Error] Provider Id on movie "Zdoc-Het Wiskundemysterie DUTCH 720p HDTV x264-iFH" is null 2017-11-13 07:05:40.134 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 2" is null 2017-11-13 07:05:41.623 +00:00 [Error] Provider Id on movie "Molenbeek Part3 FLEMISH 720p HDTV x264-SPAROOD" is null 2017-11-13 07:05:43.327 +00:00 [Error] Provider Id on movie "Spongebob Squarepants - Terug In de tijd" is null 2017-11-13 07:05:43.483 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 3" is null 2017-11-13 07:05:44.550 +00:00 [Error] Provider Id on movie "Buurman & Buurman - Deel 8" is null 2017-11-13 07:05:45.494 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 5" is null 2017-11-13 07:05:46.512 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 4" is null 2017-11-13 07:05:49.225 +00:00 [Error] Provider Id on movie "Molenbeek Part4 FLEMISH 720p HDTV x264-SPAROOD" is null 2017-11-13 07:05:49.513 +00:00 [Error] Provider Id on movie "F1-Life On The Limit" is null 2017-11-13 07:05:53.747 +00:00 [Error] Provider Id on movie "Theo Maassen: Van Kwaad Tot Erger" is null 2017-11-13 07:05:54.090 +00:00 [Error] Provider Id on movie "Molenbeek Part2 FLEMISH 720p HDTV x264-SPAROOD" is null 2017-11-13 07:05:56.158 +00:00 [Error] Provider Id on movie "Emma wil leven" is null 2017-11-13 08:03:09.301 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 9" is null 2017-11-13 08:03:10.659 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 7" is null 2017-11-13 08:03:10.817 +00:00 [Error] Provider Id on movie "André Hazes: Bloed, Zweet en Tranen (Zijn Verhaal)" is null 2017-11-13 08:03:15.071 +00:00 [Error] Provider Id on movie "2Doc- Google en het Wereldbrein" is null 2017-11-13 08:03:15.570 +00:00 [Error] Provider Id on movie "2Doc; Levenseindekliniek (2016) 720p HDTV DD5 1 x264" is null 2017-11-13 08:03:25.449 +00:00 [Error] Provider Id on movie "Blaze En De Monster Machines - Blaze Of Glory" is null 2017-11-13 08:03:33.950 +00:00 [Error] Provider Id on movie "Roué Verveer: Mans Genoeg" is null 2017-11-13 08:03:34.360 +00:00 [Error] Provider Id on movie "2Doc Going Clear Scientology and the Prison of Belief 2015 (1080i HDTV)" is null 2017-11-13 08:03:34.582 +00:00 [Error] Provider Id on movie "De nieuwe wereld met Bianca Krijgsman" is null 2017-11-13 08:03:39.585 +00:00 [Error] Provider Id on movie "9-11 The Greatest Lie Ever Sold (2005)" is null 2017-11-13 08:03:39.741 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 6" is null 2017-11-13 08:03:40.335 +00:00 [Error] Provider Id on movie "Molenbeek Part1 FLEMISH 720p HDTV x264-SPAROOD" is null 2017-11-13 08:03:41.723 +00:00 [Error] Provider Id on movie "Zdoc-Het Wiskundemysterie DUTCH 720p HDTV x264-iFH" is null 2017-11-13 08:03:43.592 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 2" is null 2017-11-13 08:03:45.088 +00:00 [Error] Provider Id on movie "Molenbeek Part3 FLEMISH 720p HDTV x264-SPAROOD" is null 2017-11-13 08:03:46.816 +00:00 [Error] Provider Id on movie "Spongebob Squarepants - Terug In de tijd" is null 2017-11-13 08:03:46.972 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 3" is null 2017-11-13 08:03:48.019 +00:00 [Error] Provider Id on movie "Buurman & Buurman - Deel 8" is null 2017-11-13 08:03:48.902 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 5" is null 2017-11-13 08:03:49.960 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 4" is null 2017-11-13 08:03:53.615 +00:00 [Error] Provider Id on movie "Molenbeek Part4 FLEMISH 720p HDTV x264-SPAROOD" is null 2017-11-13 08:03:53.858 +00:00 [Error] Provider Id on movie "F1-Life On The Limit" is null 2017-11-13 08:03:58.280 +00:00 [Error] Provider Id on movie "Theo Maassen: Van Kwaad Tot Erger" is null 2017-11-13 08:03:58.685 +00:00 [Error] Provider Id on movie "Molenbeek Part2 FLEMISH 720p HDTV x264-SPAROOD" is null 2017-11-13 08:04:01.888 +00:00 [Error] Provider Id on movie "Emma wil leven" is null 2017-11-13 08:07:23.989 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 9" is null 2017-11-13 08:07:25.129 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 7" is null 2017-11-13 08:07:25.270 +00:00 [Error] Provider Id on movie "André Hazes: Bloed, Zweet en Tranen (Zijn Verhaal)" is null 2017-11-13 08:07:27.556 +00:00 [Error] Provider Id on movie "2Doc- Google en het Wereldbrein" is null 2017-11-13 08:07:28.082 +00:00 [Error] Provider Id on movie "2Doc; Levenseindekliniek (2016) 720p HDTV DD5 1 x264" is null 2017-11-13 08:07:40.045 +00:00 [Error] Provider Id on movie "Blaze En De Monster Machines - Blaze Of Glory" is null 2017-11-13 08:07:48.366 +00:00 [Error] Provider Id on movie "Roué Verveer: Mans Genoeg" is null 2017-11-13 08:07:48.784 +00:00 [Error] Provider Id on movie "2Doc Going Clear Scientology and the Prison of Belief 2015 (1080i HDTV)" is null 2017-11-13 08:07:49.038 +00:00 [Error] Provider Id on movie "De nieuwe wereld met Bianca Krijgsman" is null 2017-11-13 08:07:53.028 +00:00 [Error] Provider Id on movie "9-11 The Greatest Lie Ever Sold (2005)" is null 2017-11-13 08:07:53.193 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 6" is null 2017-11-13 08:07:53.764 +00:00 [Error] Provider Id on movie "Molenbeek Part1 FLEMISH 720p HDTV x264-SPAROOD" is null 2017-11-13 08:07:55.082 +00:00 [Error] Provider Id on movie "Zdoc-Het Wiskundemysterie DUTCH 720p HDTV x264-iFH" is null 2017-11-13 08:07:55.881 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 2" is null 2017-11-13 08:07:57.283 +00:00 [Error] Provider Id on movie "Molenbeek Part3 FLEMISH 720p HDTV x264-SPAROOD" is null 2017-11-13 08:07:58.904 +00:00 [Error] Provider Id on movie "Spongebob Squarepants - Terug In de tijd" is null 2017-11-13 08:07:59.033 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 3" is null 2017-11-13 08:08:00.073 +00:00 [Error] Provider Id on movie "Buurman & Buurman - Deel 8" is null 2017-11-13 08:08:02.965 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 5" is null 2017-11-13 08:08:03.998 +00:00 [Error] Provider Id on movie "Buurman & Buurman Deel 4" is null 2017-11-13 08:08:06.710 +00:00 [Error] Provider Id on movie "Molenbeek Part4 FLEMISH 720p HDTV x264-SPAROOD" is null 2017-11-13 08:08:06.976 +00:00 [Error] Provider Id on movie "F1-Life On The Limit" is null 2017-11-13 08:08:11.192 +00:00 [Error] Provider Id on movie "Theo Maassen: Van Kwaad Tot Erger" is null 2017-11-13 08:08:11.524 +00:00 [Error] Provider Id on movie "Molenbeek Part2 FLEMISH 720p HDTV x264-SPAROOD" is null 2017-11-13 08:08:14.619 +00:00 [Error] Provider Id on movie "Emma wil leven" is null 2017-11-13 08:08:17.654 +00:00 [Warning] Failed to process the job '1903': an exception occurred. Retry attempt 1 of 3 will be performed in 00:00:19. System.NullReferenceException: Object reference not set to an instance of an object. at lambda_method(Closure , Object ) at System.Linq.Enumerable.SelectIListIterator2.ToArray()
at System.Linq.Enumerable.ToArray[TSource](IEnumerable1 source) at Hangfire.Common.Job.FromExpression(LambdaExpression methodCall, Type explicitType) at Hangfire.BackgroundJobClientExtensions.Create(IBackgroundJobClient client, Expression1 methodCall, IState state)
at Ombi.Schedule.Jobs.Emby.EmbyAvaliabilityChecker.d__6.MoveNext() in C:\projects\requestplex\src\Ombi.Schedule\Jobs\Emby\EmbyAvaliabilityChecker.cs:line 80
--- End of stack trace from previous location where exception was thrown ---
at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw()
at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)
at Ombi.Schedule.Jobs.Emby.EmbyAvaliabilityChecker.d__5.MoveNext() in C:\projects\requestplex\src\Ombi.Schedule\Jobs\Emby\EmbyAvaliabilityChecker.cs:line 60
2017-11-13 08:08:39.605 +00:00 [Information] 1 scheduled job(s) enqueued.
`

@dmike3
Copy link

dmike3 commented Nov 16, 2017

I've noticed this problem as well. Movies are being picked up but no email is being generated for available movies. If I manually select "Mark as Available" it kicks off an email.

I'm on the latest version of Ombi as of Nov 16, 2017

tidusjar pushed a commit that referenced this issue Nov 17, 2017
@tidusjar
Copy link
Member

Can you please try the latest build.

@filoor
Copy link
Author

filoor commented Nov 18, 2017

Hi @tidusjar

Ombi Is now reaciting very slow and also loading pages takes 4ever

2017-11-18 06:48:06.377 +00:00 [Information] Error occurred during execution of 'DelayedJobScheduler' process. Execution will be retried (attempt #2) in 00:00:04 seconds.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked'.
   at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteScalar()
   at Dapper.SqlMapper.ExecuteScalarImpl[T](IDbConnection cnn, CommandDefinition& command)
   at Dapper.SqlMapper.ExecuteScalar[T](IDbConnection cnn, String sql, Object param, IDbTransaction transaction, Nullable`1 commandTimeout, Nullable`1 commandType)
   at Hangfire.SQLite.SQLiteStorageConnection.<>c__DisplayClass11_0.<GetFirstByLowestScoreFromSet>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func`2 func, Boolean isWriteLock)
   at Hangfire.Server.DelayedJobScheduler.<>c__DisplayClass10_0.<EnqueueNextScheduledJob>b__0(IStorageConnection connection)
   at Hangfire.Server.DelayedJobScheduler.UseConnectionDistributedLock[T](JobStorage storage, Func`2 action)
   at Hangfire.Server.DelayedJobScheduler.Execute(BackgroundProcessContext context)
   at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)
2017-11-18 06:48:21.601 +00:00 [Information] Error occurred during execution of 'ServerHeartbeat' process. Execution will be retried (attempt #2) in 00:00:03 seconds.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked'.
   at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteNonQuery()
   at Dapper.SqlMapper.ExecuteCommand(IDbConnection cnn, CommandDefinition& command, Action`2 paramReader)
   at Dapper.SqlMapper.ExecuteImpl(IDbConnection cnn, CommandDefinition& command)
   at Dapper.SqlMapper.Execute(IDbConnection cnn, String sql, Object param, IDbTransaction transaction, Nullable`1 commandTimeout, Nullable`1 commandType)
   at Hangfire.SQLite.SQLiteStorageConnection.<>c__DisplayClass16_0.<Heartbeat>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.<>c__DisplayClass19_0.<UseConnection>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func`2 func, Boolean isWriteLock)
   at Hangfire.SQLite.SQLiteStorage.UseConnection(Action`1 action, Boolean isWriteLock)
   at Hangfire.Server.ServerHeartbeat.Execute(BackgroundProcessContext context)
   at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)
2017-11-18 06:48:31.230 +00:00 [Information] Error occurred during execution of 'RecurringJobScheduler' process. Execution will be retried (attempt #2) in 00:00:01 seconds.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked'.
   at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
   at System.Data.Common.DbCommand.System.Data.IDbCommand.ExecuteReader(CommandBehavior behavior)
   at Dapper.SqlMapper.ExecuteReaderWithFlagsFallback(IDbCommand cmd, Boolean wasClosed, CommandBehavior behavior)
   at Dapper.SqlMapper.<QueryImpl>d__124`1.MoveNext()
   at System.Collections.Generic.List`1.AddEnumerable(IEnumerable`1 enumerable)
   at System.Linq.Enumerable.ToList[TSource](IEnumerable`1 source)
   at Dapper.SqlMapper.Query[T](IDbConnection cnn, String sql, Object param, IDbTransaction transaction, Boolean buffered, Nullable`1 commandTimeout, Nullable`1 commandType)
   at Hangfire.SQLite.SQLiteStorageConnection.<>c__DisplayClass10_0.<GetAllItemsFromSet>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func`2 func, Boolean isWriteLock)
   at Hangfire.Server.RecurringJobScheduler.<>c__DisplayClass8_0.<Execute>b__0(IStorageConnection connection)
   at Hangfire.Server.RecurringJobScheduler.UseConnectionDistributedLock(JobStorage storage, Action`1 action)
   at Hangfire.Server.RecurringJobScheduler.Execute(BackgroundProcessContext context)
   at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)
2017-11-18 06:48:40.668 +00:00 [Warning] Error occurred during execution of 'DelayedJobScheduler' process. Execution will be retried (attempt #3) in 00:00:06 seconds.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked'.
   at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteScalar()
   at Dapper.SqlMapper.ExecuteScalarImpl[T](IDbConnection cnn, CommandDefinition& command)
   at Dapper.SqlMapper.ExecuteScalar[T](IDbConnection cnn, String sql, Object param, IDbTransaction transaction, Nullable`1 commandTimeout, Nullable`1 commandType)
   at Hangfire.SQLite.SQLiteStorageConnection.<>c__DisplayClass11_0.<GetFirstByLowestScoreFromSet>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func`2 func, Boolean isWriteLock)
   at Hangfire.Server.DelayedJobScheduler.<>c__DisplayClass10_0.<EnqueueNextScheduledJob>b__0(IStorageConnection connection)
   at Hangfire.Server.DelayedJobScheduler.UseConnectionDistributedLock[T](JobStorage storage, Func`2 action)
   at Hangfire.Server.DelayedJobScheduler.Execute(BackgroundProcessContext context)
   at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)
2017-11-18 06:49:16.929 +00:00 [Error] Error occurred during execution of 'DelayedJobScheduler' process. Execution will be retried (attempt #4) in 00:00:12 seconds.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked'.
   at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteScalar()
   at Dapper.SqlMapper.ExecuteScalarImpl[T](IDbConnection cnn, CommandDefinition& command)
   at Dapper.SqlMapper.ExecuteScalar[T](IDbConnection cnn, String sql, Object param, IDbTransaction transaction, Nullable`1 commandTimeout, Nullable`1 commandType)
   at Hangfire.SQLite.SQLiteStorageConnection.<>c__DisplayClass11_0.<GetFirstByLowestScoreFromSet>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func`2 func, Boolean isWriteLock)
   at Hangfire.Server.DelayedJobScheduler.<>c__DisplayClass10_0.<EnqueueNextScheduledJob>b__0(IStorageConnection connection)
   at Hangfire.Server.DelayedJobScheduler.UseConnectionDistributedLock[T](JobStorage storage, Func`2 action)
   at Hangfire.Server.DelayedJobScheduler.Execute(BackgroundProcessContext context)
   at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)
2017-11-18 06:49:21.894 +00:00 [Warning] Error occurred during execution of 'ServerHeartbeat' process. Execution will be retried (attempt #3) in 00:00:09 seconds.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked'.
   at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteNonQuery()
   at Dapper.SqlMapper.ExecuteCommand(IDbConnection cnn, CommandDefinition& command, Action`2 paramReader)
   at Dapper.SqlMapper.ExecuteImpl(IDbConnection cnn, CommandDefinition& command)
   at Dapper.SqlMapper.Execute(IDbConnection cnn, String sql, Object param, IDbTransaction transaction, Nullable`1 commandTimeout, Nullable`1 commandType)
   at Hangfire.SQLite.SQLiteStorageConnection.<>c__DisplayClass16_0.<Heartbeat>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.<>c__DisplayClass19_0.<UseConnection>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func`2 func, Boolean isWriteLock)
   at Hangfire.SQLite.SQLiteStorage.UseConnection(Action`1 action, Boolean isWriteLock)
   at Hangfire.Server.ServerHeartbeat.Execute(BackgroundProcessContext context)
   at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)
2017-11-18 06:49:53.032 +00:00 [Information] Error occurred during execution of 'ServerWatchdog' process. Execution will be retried (attempt #2) in 00:00:02 seconds.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked'.
   at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteNonQuery()
   at Dapper.SqlMapper.ExecuteCommand(IDbConnection cnn, CommandDefinition& command, Action`2 paramReader)
   at Dapper.SqlMapper.ExecuteImpl(IDbConnection cnn, CommandDefinition& command)
   at Dapper.SqlMapper.Execute(IDbConnection cnn, String sql, Object param, IDbTransaction transaction, Nullable`1 commandTimeout, Nullable`1 commandType)
   at Hangfire.SQLite.SQLiteStorageConnection.<>c__DisplayClass17_0.<RemoveTimedOutServers>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func`2 func, Boolean isWriteLock)
   at Hangfire.SQLite.SQLiteStorageConnection.RemoveTimedOutServers(TimeSpan timeOut)
   at Hangfire.Server.ServerWatchdog.Execute(BackgroundProcessContext context)
   at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)
2017-11-18 06:49:59.105 +00:00 [Error] Error occurred during execution of 'DelayedJobScheduler' process. Execution will be retried (attempt #5) in 00:00:20 seconds.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked'.
   at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteScalar()
   at Dapper.SqlMapper.ExecuteScalarImpl[T](IDbConnection cnn, CommandDefinition& command)
   at Dapper.SqlMapper.ExecuteScalar[T](IDbConnection cnn, String sql, Object param, IDbTransaction transaction, Nullable`1 commandTimeout, Nullable`1 commandType)
   at Hangfire.SQLite.SQLiteStorageConnection.<>c__DisplayClass11_0.<GetFirstByLowestScoreFromSet>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func`2 func, Boolean isWriteLock)
   at Hangfire.Server.DelayedJobScheduler.<>c__DisplayClass10_0.<EnqueueNextScheduledJob>b__0(IStorageConnection connection)
   at Hangfire.Server.DelayedJobScheduler.UseConnectionDistributedLock[T](JobStorage storage, Func`2 action)
   at Hangfire.Server.DelayedJobScheduler.Execute(BackgroundProcessContext context)
   at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)
2017-11-18 06:50:23.158 +00:00 [Error] Error occurred during execution of 'ServerHeartbeat' process. Execution will be retried (attempt #4) in 00:00:11 seconds.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked'.
   at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteNonQuery()
   at Dapper.SqlMapper.ExecuteCommand(IDbConnection cnn, CommandDefinition& command, Action`2 paramReader)
   at Dapper.SqlMapper.ExecuteImpl(IDbConnection cnn, CommandDefinition& command)
   at Dapper.SqlMapper.Execute(IDbConnection cnn, String sql, Object param, IDbTransaction transaction, Nullable`1 commandTimeout, Nullable`1 commandType)
   at Hangfire.SQLite.SQLiteStorageConnection.<>c__DisplayClass16_0.<Heartbeat>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.<>c__DisplayClass19_0.<UseConnection>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func`2 func, Boolean isWriteLock)
   at Hangfire.SQLite.SQLiteStorage.UseConnection(Action`1 action, Boolean isWriteLock)
   at Hangfire.Server.ServerHeartbeat.Execute(BackgroundProcessContext context)
   at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)
2017-11-18 06:50:49.361 +00:00 [Error] Error occurred during execution of 'DelayedJobScheduler' process. Execution will be retried (attempt #6) in 00:00:35 seconds.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked'.
   at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteScalar()
   at Dapper.SqlMapper.ExecuteScalarImpl[T](IDbConnection cnn, CommandDefinition& command)
   at Dapper.SqlMapper.ExecuteScalar[T](IDbConnection cnn, String sql, Object param, IDbTransaction transaction, Nullable`1 commandTimeout, Nullable`1 commandType)
   at Hangfire.SQLite.SQLiteStorageConnection.<>c__DisplayClass11_0.<GetFirstByLowestScoreFromSet>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func`2 func, Boolean isWriteLock)
   at Hangfire.Server.DelayedJobScheduler.<>c__DisplayClass10_0.<EnqueueNextScheduledJob>b__0(IStorageConnection connection)
   at Hangfire.Server.DelayedJobScheduler.UseConnectionDistributedLock[T](JobStorage storage, Func`2 action)
   at Hangfire.Server.DelayedJobScheduler.Execute(BackgroundProcessContext context)
   at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)
2017-11-18 06:50:54.818 +00:00 [Warning] Error occurred during execution of 'ServerWatchdog' process. Execution will be retried (attempt #3) in 00:00:08 seconds.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked'.
   at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteNonQuery()
   at Dapper.SqlMapper.ExecuteCommand(IDbConnection cnn, CommandDefinition& command, Action`2 paramReader)
   at Dapper.SqlMapper.ExecuteImpl(IDbConnection cnn, CommandDefinition& command)
   at Dapper.SqlMapper.Execute(IDbConnection cnn, String sql, Object param, IDbTransaction transaction, Nullable`1 commandTimeout, Nullable`1 commandType)
   at Hangfire.SQLite.SQLiteStorageConnection.<>c__DisplayClass17_0.<RemoveTimedOutServers>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func`2 func, Boolean isWriteLock)
   at Hangfire.SQLite.SQLiteStorageConnection.RemoveTimedOutServers(TimeSpan timeOut)
   at Hangfire.Server.ServerWatchdog.Execute(BackgroundProcessContext context)
   at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)
2017-11-18 06:51:49.278 +00:00 [Information] Start installing Hangfire SQL objects...
2017-11-18 06:51:49.368 +00:00 [Information] Hangfire SQL objects installed.
2017-11-18 06:51:49.398 +00:00 [Information] Starting Hangfire Server
2017-11-18 06:51:49.403 +00:00 [Information] Using job storage: 'SQLite Server: /config/Ombi.db'
2017-11-18 06:51:49.403 +00:00 [Information] Using the following options for Hangfire Server:
2017-11-18 06:51:49.403 +00:00 [Information]     Worker count: 1
2017-11-18 06:51:49.404 +00:00 [Information]     Listening queues: 'default'
2017-11-18 06:51:49.404 +00:00 [Information]     Shutdown timeout: 1.00:00:00
2017-11-18 06:51:49.404 +00:00 [Information]     Schedule polling interval: 00:00:15
2017-11-18 06:52:25.168 +00:00 [Information] Start installing Hangfire SQL objects...
2017-11-18 06:52:25.247 +00:00 [Information] Hangfire SQL objects installed.
2017-11-18 06:52:25.287 +00:00 [Information] Starting Hangfire Server
2017-11-18 06:52:25.292 +00:00 [Information] Using job storage: 'SQLite Server: /config/Ombi.db'
2017-11-18 06:52:25.293 +00:00 [Information] Using the following options for Hangfire Server:
2017-11-18 06:52:25.293 +00:00 [Information]     Worker count: 1
2017-11-18 06:52:25.293 +00:00 [Information]     Listening queues: 'default'
2017-11-18 06:52:25.294 +00:00 [Information]     Shutdown timeout: 1.00:00:00
2017-11-18 06:52:25.294 +00:00 [Information]     Schedule polling interval: 00:00:15
2017-11-18 06:53:42.376 +00:00 [Information] Error occurred during execution of 'DelayedJobScheduler' process. Execution will be retried (attempt #2) in 00:00:01 seconds.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked'.
   at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteScalar()
   at Dapper.SqlMapper.ExecuteScalarImpl[T](IDbConnection cnn, CommandDefinition& command)
   at Dapper.SqlMapper.ExecuteScalar[T](IDbConnection cnn, String sql, Object param, IDbTransaction transaction, Nullable`1 commandTimeout, Nullable`1 commandType)
   at Hangfire.SQLite.SQLiteStorageConnection.<>c__DisplayClass11_0.<GetFirstByLowestScoreFromSet>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func`2 func, Boolean isWriteLock)
   at Hangfire.Server.DelayedJobScheduler.<>c__DisplayClass10_0.<EnqueueNextScheduledJob>b__0(IStorageConnection connection)
   at Hangfire.Server.DelayedJobScheduler.UseConnectionDistributedLock[T](JobStorage storage, Func`2 action)
   at Hangfire.Server.DelayedJobScheduler.Execute(BackgroundProcessContext context)
   at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)
2017-11-18 06:54:04.516 +00:00 [Information] Error occurred during execution of 'ServerHeartbeat' process. Execution will be retried (attempt #2) in 00:00:04 seconds.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked'.
   at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteNonQuery()
   at Dapper.SqlMapper.ExecuteCommand(IDbConnection cnn, CommandDefinition& command, Action`2 paramReader)
   at Dapper.SqlMapper.ExecuteImpl(IDbConnection cnn, CommandDefinition& command)
   at Dapper.SqlMapper.Execute(IDbConnection cnn, String sql, Object param, IDbTransaction transaction, Nullable`1 commandTimeout, Nullable`1 commandType)
   at Hangfire.SQLite.SQLiteStorageConnection.<>c__DisplayClass16_0.<Heartbeat>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.<>c__DisplayClass19_0.<UseConnection>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func`2 func, Boolean isWriteLock)
   at Hangfire.SQLite.SQLiteStorage.UseConnection(Action`1 action, Boolean isWriteLock)
   at Hangfire.Server.ServerHeartbeat.Execute(BackgroundProcessContext context)
   at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)
2017-11-18 06:54:13.415 +00:00 [Warning] Error occurred during execution of 'DelayedJobScheduler' process. Execution will be retried (attempt #3) in 00:00:05 seconds.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked'.
   at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteScalar()
   at Dapper.SqlMapper.ExecuteScalarImpl[T](IDbConnection cnn, CommandDefinition& command)
   at Dapper.SqlMapper.ExecuteScalar[T](IDbConnection cnn, String sql, Object param, IDbTransaction transaction, Nullable`1 commandTimeout, Nullable`1 commandType)
   at Hangfire.SQLite.SQLiteStorageConnection.<>c__DisplayClass11_0.<GetFirstByLowestScoreFromSet>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func`2 func, Boolean isWriteLock)
   at Hangfire.Server.DelayedJobScheduler.<>c__DisplayClass10_0.<EnqueueNextScheduledJob>b__0(IStorageConnection connection)
   at Hangfire.Server.DelayedJobScheduler.UseConnectionDistributedLock[T](JobStorage storage, Func`2 action)
   at Hangfire.Server.DelayedJobScheduler.Execute(BackgroundProcessContext context)
   at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)
2017-11-18 06:54:30.898 +00:00 [Information] Error occurred during execution of 'RecurringJobScheduler' process. Execution will be retried (attempt #2) in 00:00:01 seconds.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked'.
   at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
   at System.Data.Common.DbCommand.System.Data.IDbCommand.ExecuteReader(CommandBehavior behavior)
   at Dapper.SqlMapper.ExecuteReaderWithFlagsFallback(IDbCommand cmd, Boolean wasClosed, CommandBehavior behavior)
   at Dapper.SqlMapper.<QueryImpl>d__124`1.MoveNext()
   at System.Collections.Generic.List`1.AddEnumerable(IEnumerable`1 enumerable)
   at System.Linq.Enumerable.ToList[TSource](IEnumerable`1 source)
   at Dapper.SqlMapper.Query[T](IDbConnection cnn, String sql, Object param, IDbTransaction transaction, Boolean buffered, Nullable`1 commandTimeout, Nullable`1 commandType)
   at Hangfire.SQLite.SQLiteStorageConnection.<>c__DisplayClass10_0.<GetAllItemsFromSet>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func`2 func, Boolean isWriteLock)
   at Hangfire.Server.RecurringJobScheduler.<>c__DisplayClass8_0.<Execute>b__0(IStorageConnection connection)
   at Hangfire.Server.RecurringJobScheduler.UseConnectionDistributedLock(JobStorage storage, Action`1 action)
   at Hangfire.Server.RecurringJobScheduler.Execute(BackgroundProcessContext context)
   at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)
2017-11-18 06:54:38.561 +00:00 [Warning] Error occurred during execution of 'ServerHeartbeat' process. Execution will be retried (attempt #3) in 00:00:05 seconds.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked'.
   at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteNonQuery()
   at Dapper.SqlMapper.ExecuteCommand(IDbConnection cnn, CommandDefinition& command, Action`2 paramReader)
   at Dapper.SqlMapper.ExecuteImpl(IDbConnection cnn, CommandDefinition& command)
   at Dapper.SqlMapper.Execute(IDbConnection cnn, String sql, Object param, IDbTransaction transaction, Nullable`1 commandTimeout, Nullable`1 commandType)
   at Hangfire.SQLite.SQLiteStorageConnection.<>c__DisplayClass16_0.<Heartbeat>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.<>c__DisplayClass19_0.<UseConnection>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func`2 func, Boolean isWriteLock)
   at Hangfire.SQLite.SQLiteStorage.UseConnection(Action`1 action, Boolean isWriteLock)
   at Hangfire.Server.ServerHeartbeat.Execute(BackgroundProcessContext context)
   at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)
2017-11-18 06:54:48.575 +00:00 [Error] Error occurred during execution of 'DelayedJobScheduler' process. Execution will be retried (attempt #4) in 00:00:11 seconds.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked'.
   at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteScalar()
   at Dapper.SqlMapper.ExecuteScalarImpl[T](IDbConnection cnn, CommandDefinition& command)
   at Dapper.SqlMapper.ExecuteScalar[T](IDbConnection cnn, String sql, Object param, IDbTransaction transaction, Nullable`1 commandTimeout, Nullable`1 commandType)
   at Hangfire.SQLite.SQLiteStorageConnection.<>c__DisplayClass11_0.<GetFirstByLowestScoreFromSet>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func`2 func, Boolean isWriteLock)
   at Hangfire.Server.DelayedJobScheduler.<>c__DisplayClass10_0.<EnqueueNextScheduledJob>b__0(IStorageConnection connection)
   at Hangfire.Server.DelayedJobScheduler.UseConnectionDistributedLock[T](JobStorage storage, Func`2 action)
   at Hangfire.Server.DelayedJobScheduler.Execute(BackgroundProcessContext context)
   at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)
2017-11-18 06:55:49.264 +00:00 [Information] Start installing Hangfire SQL objects...
2017-11-18 06:55:49.348 +00:00 [Information] Hangfire SQL objects installed.
2017-11-18 06:55:49.377 +00:00 [Information] Starting Hangfire Server
2017-11-18 06:55:49.381 +00:00 [Information] Using job storage: 'SQLite Server: /config/Ombi.db'
2017-11-18 06:55:49.382 +00:00 [Information] Using the following options for Hangfire Server:
2017-11-18 06:55:49.382 +00:00 [Information]     Worker count: 1
2017-11-18 06:55:49.383 +00:00 [Information]     Listening queues: 'default'
2017-11-18 06:55:49.383 +00:00 [Information]     Shutdown timeout: 1.00:00:00
2017-11-18 06:55:49.383 +00:00 [Information]     Schedule polling interval: 00:00:15
2017-11-18 06:57:29.010 +00:00 [Information] Error occurred during execution of 'ServerHeartbeat' process. Execution will be retried (attempt #2) in 00:00:03 seconds.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked'.
   at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteNonQuery()
   at Dapper.SqlMapper.ExecuteCommand(IDbConnection cnn, CommandDefinition& command, Action`2 paramReader)
   at Dapper.SqlMapper.ExecuteImpl(IDbConnection cnn, CommandDefinition& command)
   at Dapper.SqlMapper.Execute(IDbConnection cnn, String sql, Object param, IDbTransaction transaction, Nullable`1 commandTimeout, Nullable`1 commandType)
   at Hangfire.SQLite.SQLiteStorageConnection.<>c__DisplayClass16_0.<Heartbeat>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.<>c__DisplayClass19_0.<UseConnection>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func`2 func, Boolean isWriteLock)
   at Hangfire.SQLite.SQLiteStorage.UseConnection(Action`1 action, Boolean isWriteLock)
   at Hangfire.Server.ServerHeartbeat.Execute(BackgroundProcessContext context)
   at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)
2017-11-18 06:57:59.176 +00:00 [Information] Error occurred during execution of 'RecurringJobScheduler' process. Execution will be retried (attempt #2) in 00:00:01 seconds.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked'.
   at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteNonQuery()
   at Microsoft.Data.Sqlite.SqliteTransaction.Commit()
   at Hangfire.SQLite.SQLiteStorage.<>c__DisplayClass22_0`1.<UseTransaction>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func`2 func, Boolean isWriteLock)
   at Hangfire.SQLite.SQLiteStorage.UseTransaction[T](Func`3 func, Nullable`1 isolationLevel)
   at Hangfire.SQLite.SQLiteStorage.UseTransaction(Action`2 action)
   at Hangfire.Server.RecurringJobScheduler.TryScheduleJob(JobStorage storage, IStorageConnection connection, String recurringJobId, IReadOnlyDictionary`2 recurringJob)
   at Hangfire.Server.RecurringJobScheduler.<>c__DisplayClass8_0.<Execute>b__0(IStorageConnection connection)
   at Hangfire.Server.RecurringJobScheduler.UseConnectionDistributedLock(JobStorage storage, Action`1 action)
   at Hangfire.Server.RecurringJobScheduler.Execute(BackgroundProcessContext context)
   at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)
2017-11-18 06:58:32.164 +00:00 [Warning] Error occurred during execution of 'ServerHeartbeat' process. Execution will be retried (attempt #3) in 00:00:07 seconds.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked'.
   at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteNonQuery()
   at Dapper.SqlMapper.ExecuteCommand(IDbConnection cnn, CommandDefinition& command, Action`2 paramReader)
   at Dapper.SqlMapper.ExecuteImpl(IDbConnection cnn, CommandDefinition& command)
   at Dapper.SqlMapper.Execute(IDbConnection cnn, String sql, Object param, IDbTransaction transaction, Nullable`1 commandTimeout, Nullable`1 commandType)
   at Hangfire.SQLite.SQLiteStorageConnection.<>c__DisplayClass16_0.<Heartbeat>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.<>c__DisplayClass19_0.<UseConnection>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func`2 func, Boolean isWriteLock)
   at Hangfire.SQLite.SQLiteStorage.UseConnection(Action`1 action, Boolean isWriteLock)
   at Hangfire.Server.ServerHeartbeat.Execute(BackgroundProcessContext context)
   at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)
2017-11-18 06:59:02.476 +00:00 [Warning] Error occurred during execution of 'RecurringJobScheduler' process. Execution will be retried (attempt #3) in 00:00:09 seconds.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked'.
   at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
   at System.Data.Common.DbCommand.System.Data.IDbCommand.ExecuteReader(CommandBehavior behavior)
   at Dapper.SqlMapper.ExecuteReaderWithFlagsFallback(IDbCommand cmd, Boolean wasClosed, CommandBehavior behavior)
   at Dapper.SqlMapper.<QueryImpl>d__124`1.MoveNext()
   at System.Collections.Generic.List`1.AddEnumerable(IEnumerable`1 enumerable)
   at System.Linq.Enumerable.ToList[TSource](IEnumerable`1 source)
   at Dapper.SqlMapper.Query[T](IDbConnection cnn, String sql, Object param, IDbTransaction transaction, Boolean buffered, Nullable`1 commandTimeout, Nullable`1 commandType)
   at Hangfire.SQLite.SQLiteStorageConnection.<>c__DisplayClass13_0.<GetAllEntriesFromHash>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func`2 func, Boolean isWriteLock)
   at Hangfire.Server.RecurringJobScheduler.<>c__DisplayClass8_0.<Execute>b__0(IStorageConnection connection)
   at Hangfire.Server.RecurringJobScheduler.UseConnectionDistributedLock(JobStorage storage, Action`1 action)
   at Hangfire.Server.RecurringJobScheduler.Execute(BackgroundProcessContext context)
   at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)
2017-11-18 06:59:10.008 +00:00 [Error] Error occurred during execution of 'ServerHeartbeat' process. Execution will be retried (attempt #4) in 00:00:16 seconds.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked'.
   at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteNonQuery()
   at Dapper.SqlMapper.ExecuteCommand(IDbConnection cnn, CommandDefinition& command, Action`2 paramReader)
   at Dapper.SqlMapper.ExecuteImpl(IDbConnection cnn, CommandDefinition& command)
   at Dapper.SqlMapper.Execute(IDbConnection cnn, String sql, Object param, IDbTransaction transaction, Nullable`1 commandTimeout, Nullable`1 commandType)
   at Hangfire.SQLite.SQLiteStorageConnection.<>c__DisplayClass16_0.<Heartbeat>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.<>c__DisplayClass19_0.<UseConnection>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func`2 func, Boolean isWriteLock)
   at Hangfire.SQLite.SQLiteStorage.UseConnection(Action`1 action, Boolean isWriteLock)
   at Hangfire.Server.ServerHeartbeat.Execute(BackgroundProcessContext context)
   at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)
2017-11-18 07:00:04.361 +00:00 [Error] Error occurred during execution of 'ServerHeartbeat' process. Execution will be retried (attempt #5) in 00:00:22 seconds.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked'.
   at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteNonQuery()
   at Dapper.SqlMapper.ExecuteCommand(IDbConnection cnn, CommandDefinition& command, Action`2 paramReader)
   at Dapper.SqlMapper.ExecuteImpl(IDbConnection cnn, CommandDefinition& command)
   at Dapper.SqlMapper.Execute(IDbConnection cnn, String sql, Object param, IDbTransaction transaction, Nullable`1 commandTimeout, Nullable`1 commandType)
   at Hangfire.SQLite.SQLiteStorageConnection.<>c__DisplayClass16_0.<Heartbeat>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.<>c__DisplayClass19_0.<UseConnection>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func`2 func, Boolean isWriteLock)
   at Hangfire.SQLite.SQLiteStorage.UseConnection(Action`1 action, Boolean isWriteLock)
   at Hangfire.Server.ServerHeartbeat.Execute(BackgroundProcessContext context)
   at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)
2017-11-18 07:00:19.626 +00:00 [Information] Error occurred during execution of 'DelayedJobScheduler' process. Execution will be retried (attempt #2) in 00:00:01 seconds.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked'.
   at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteScalar()
   at Dapper.SqlMapper.ExecuteScalarImpl[T](IDbConnection cnn, CommandDefinition& command)
   at Dapper.SqlMapper.ExecuteScalar[T](IDbConnection cnn, String sql, Object param, IDbTransaction transaction, Nullable`1 commandTimeout, Nullable`1 commandType)
   at Hangfire.SQLite.SQLiteStorageConnection.<>c__DisplayClass11_0.<GetFirstByLowestScoreFromSet>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func`2 func, Boolean isWriteLock)
   at Hangfire.Server.DelayedJobScheduler.<>c__DisplayClass10_0.<EnqueueNextScheduledJob>b__0(IStorageConnection connection)
   at Hangfire.Server.DelayedJobScheduler.UseConnectionDistributedLock[T](JobStorage storage, Func`2 action)
   at Hangfire.Server.DelayedJobScheduler.Execute(BackgroundProcessContext context)
   at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)
2017-11-18 07:00:31.398 +00:00 [Error] Error occurred during execution of 'RecurringJobScheduler' process. Execution will be retried (attempt #4) in 00:00:16 seconds.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked'.
   at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
   at System.Data.Common.DbCommand.System.Data.IDbCommand.ExecuteReader(CommandBehavior behavior)
   at Dapper.SqlMapper.ExecuteReaderWithFlagsFallback(IDbCommand cmd, Boolean wasClosed, CommandBehavior behavior)
   at Dapper.SqlMapper.<QueryImpl>d__124`1.MoveNext()
   at System.Collections.Generic.List`1.AddEnumerable(IEnumerable`1 enumerable)
   at System.Linq.Enumerable.ToList[TSource](IEnumerable`1 source)
   at Dapper.SqlMapper.Query[T](IDbConnection cnn, String sql, Object param, IDbTransaction transaction, Boolean buffered, Nullable`1 commandTimeout, Nullable`1 commandType)
   at Hangfire.SQLite.SQLiteStorageConnection.<>c__DisplayClass10_0.<GetAllItemsFromSet>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func`2 func, Boolean isWriteLock)
   at Hangfire.Server.RecurringJobScheduler.<>c__DisplayClass8_0.<Execute>b__0(IStorageConnection connection)
   at Hangfire.Server.RecurringJobScheduler.UseConnectionDistributedLock(JobStorage storage, Action`1 action)
   at Hangfire.Server.RecurringJobScheduler.Execute(BackgroundProcessContext context)
   at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)
2017-11-18 07:00:50.790 +00:00 [Warning] Error occurred during execution of 'DelayedJobScheduler' process. Execution will be retried (attempt #3) in 00:00:08 seconds.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked'.
   at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteScalar()
   at Dapper.SqlMapper.ExecuteScalarImpl[T](IDbConnection cnn, CommandDefinition& command)
   at Dapper.SqlMapper.ExecuteScalar[T](IDbConnection cnn, String sql, Object param, IDbTransaction transaction, Nullable`1 commandTimeout, Nullable`1 commandType)
   at Hangfire.SQLite.SQLiteStorageConnection.<>c__DisplayClass11_0.<GetFirstByLowestScoreFromSet>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func`2 func, Boolean isWriteLock)
   at Hangfire.Server.DelayedJobScheduler.<>c__DisplayClass10_0.<EnqueueNextScheduledJob>b__0(IStorageConnection connection)
   at Hangfire.Server.DelayedJobScheduler.UseConnectionDistributedLock[T](JobStorage storage, Func`2 action)
   at Hangfire.Server.DelayedJobScheduler.Execute(BackgroundProcessContext context)
   at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)
2017-11-18 07:01:04.737 +00:00 [Error] Error occurred during execution of 'ServerHeartbeat' process. Execution will be retried (attempt #6) in 00:00:31 seconds.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked'.
   at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteNonQuery()
   at Dapper.SqlMapper.ExecuteCommand(IDbConnection cnn, CommandDefinition& command, Action`2 paramReader)
   at Dapper.SqlMapper.ExecuteImpl(IDbConnection cnn, CommandDefinition& command)
   at Dapper.SqlMapper.Execute(IDbConnection cnn, String sql, Object param, IDbTransaction transaction, Nullable`1 commandTimeout, Nullable`1 commandType)
   at Hangfire.SQLite.SQLiteStorageConnection.<>c__DisplayClass16_0.<Heartbeat>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.<>c__DisplayClass19_0.<UseConnection>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func`2 func, Boolean isWriteLock)
   at Hangfire.SQLite.SQLiteStorage.UseConnection(Action`1 action, Boolean isWriteLock)
   at Hangfire.Server.ServerHeartbeat.Execute(BackgroundProcessContext context)
   at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)
2017-11-18 07:01:29.146 +00:00 [Error] Error occurred during execution of 'DelayedJobScheduler' process. Execution will be retried (attempt #4) in 00:00:12 seconds.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked'.
   at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteScalar()
   at Dapper.SqlMapper.ExecuteScalarImpl[T](IDbConnection cnn, CommandDefinition& command)
   at Dapper.SqlMapper.ExecuteScalar[T](IDbConnection cnn, String sql, Object param, IDbTransaction transaction, Nullable`1 commandTimeout, Nullable`1 commandType)
   at Hangfire.SQLite.SQLiteStorageConnection.<>c__DisplayClass11_0.<GetFirstByLowestScoreFromSet>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func`2 func, Boolean isWriteLock)
   at Hangfire.Server.DelayedJobScheduler.<>c__DisplayClass10_0.<EnqueueNextScheduledJob>b__0(IStorageConnection connection)
   at Hangfire.Server.DelayedJobScheduler.UseConnectionDistributedLock[T](JobStorage storage, Func`2 action)
   at Hangfire.Server.DelayedJobScheduler.Execute(BackgroundProcessContext context)
   at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)
2017-11-18 07:02:05.125 +00:00 [Error] Error occurred during execution of 'RecurringJobScheduler' process. Execution will be retried (attempt #5) in 00:00:22 seconds.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked'.
   at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteNonQuery()
   at Microsoft.Data.Sqlite.SqliteTransaction.Commit()
   at Hangfire.SQLite.SQLiteStorage.<>c__DisplayClass22_0`1.<UseTransaction>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func`2 func, Boolean isWriteLock)
   at Hangfire.SQLite.SQLiteStorage.UseTransaction[T](Func`3 func, Nullable`1 isolationLevel)
   at Hangfire.SQLite.SQLiteStorage.UseTransaction(Action`2 action)
   at Hangfire.Server.RecurringJobScheduler.TryScheduleJob(JobStorage storage, IStorageConnection connection, String recurringJobId, IReadOnlyDictionary`2 recurringJob)
   at Hangfire.Server.RecurringJobScheduler.<>c__DisplayClass8_0.<Execute>b__0(IStorageConnection connection)
   at Hangfire.Server.RecurringJobScheduler.UseConnectionDistributedLock(JobStorage storage, Action`1 action)
   at Hangfire.Server.RecurringJobScheduler.Execute(BackgroundProcessContext context)
   at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)
2017-11-18 07:02:36.099 +00:00 [Error] Error occurred during execution of 'ServerHeartbeat' process. Execution will be retried (attempt #7) in 00:00:36 seconds.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked'.
   at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteNonQuery()
   at Dapper.SqlMapper.ExecuteCommand(IDbConnection cnn, CommandDefinition& command, Action`2 paramReader)
   at Dapper.SqlMapper.ExecuteImpl(IDbConnection cnn, CommandDefinition& command)
   at Dapper.SqlMapper.Execute(IDbConnection cnn, String sql, Object param, IDbTransaction transaction, Nullable`1 commandTimeout, Nullable`1 commandType)
   at Hangfire.SQLite.SQLiteStorageConnection.<>c__DisplayClass16_0.<Heartbeat>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.<>c__DisplayClass19_0.<UseConnection>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func`2 func, Boolean isWriteLock)
   at Hangfire.SQLite.SQLiteStorage.UseConnection(Action`1 action, Boolean isWriteLock)
   at Hangfire.Server.ServerHeartbeat.Execute(BackgroundProcessContext context)
   at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)
2017-11-18 07:02:36.104 +00:00 [Information] Error occurred during execution of 'ServerWatchdog' process. Execution will be retried (attempt #2) in 00:00:01 seconds.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked'.
   at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteNonQuery()
   at Dapper.SqlMapper.ExecuteCommand(IDbConnection cnn, CommandDefinition& command, Action`2 paramReader)
   at Dapper.SqlMapper.ExecuteImpl(IDbConnection cnn, CommandDefinition& command)
   at Dapper.SqlMapper.Execute(IDbConnection cnn, String sql, Object param, IDbTransaction transaction, Nullable`1 commandTimeout, Nullable`1 commandType)
   at Hangfire.SQLite.SQLiteStorageConnection.<>c__DisplayClass17_0.<RemoveTimedOutServers>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func`2 func, Boolean isWriteLock)
   at Hangfire.SQLite.SQLiteStorageConnection.RemoveTimedOutServers(TimeSpan timeOut)
   at Hangfire.Server.ServerWatchdog.Execute(BackgroundProcessContext context)
   at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)
2017-11-18 07:03:20.524 +00:00 [Information] Error occurred during execution of 'DelayedJobScheduler' process. Execution will be retried (attempt #2) in 00:00:03 seconds.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked'.
   at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteScalar()
   at Dapper.SqlMapper.ExecuteScalarImpl[T](IDbConnection cnn, CommandDefinition& command)
   at Dapper.SqlMapper.ExecuteScalar[T](IDbConnection cnn, String sql, Object param, IDbTransaction transaction, Nullable`1 commandTimeout, Nullable`1 commandType)
   at Hangfire.SQLite.SQLiteStorageConnection.<>c__DisplayClass11_0.<GetFirstByLowestScoreFromSet>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func`2 func, Boolean isWriteLock)
   at Hangfire.Server.DelayedJobScheduler.<>c__DisplayClass10_0.<EnqueueNextScheduledJob>b__0(IStorageConnection connection)
   at Hangfire.Server.DelayedJobScheduler.UseConnectionDistributedLock[T](JobStorage storage, Func`2 action)
   at Hangfire.Server.DelayedJobScheduler.Execute(BackgroundProcessContext context)
   at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)
2017-11-18 07:03:30.552 +00:00 [Error] Error occurred during execution of 'RecurringJobScheduler' process. Execution will be retried (attempt #6) in 00:00:35 seconds.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked'.
   at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
   at System.Data.Common.DbCommand.System.Data.IDbCommand.ExecuteReader(CommandBehavior behavior)
   at Dapper.SqlMapper.ExecuteReaderWithFlagsFallback(IDbCommand cmd, Boolean wasClosed, CommandBehavior behavior)
   at Dapper.SqlMapper.<QueryImpl>d__124`1.MoveNext()
   at System.Collections.Generic.List`1.AddEnumerable(IEnumerable`1 enumerable)
   at System.Linq.Enumerable.ToList[TSource](IEnumerable`1 source)
   at Dapper.SqlMapper.Query[T](IDbConnection cnn, String sql, Object param, IDbTransaction transaction, Boolean buffered, Nullable`1 commandTimeout, Nullable`1 commandType)
   at Hangfire.SQLite.SQLiteStorageConnection.<>c__DisplayClass10_0.<GetAllItemsFromSet>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func`2 func, Boolean isWriteLock)
   at Hangfire.Server.RecurringJobScheduler.<>c__DisplayClass8_0.<Execute>b__0(IStorageConnection connection)
   at Hangfire.Server.RecurringJobScheduler.UseConnectionDistributedLock(JobStorage storage, Action`1 action)
   at Hangfire.Server.RecurringJobScheduler.Execute(BackgroundProcessContext context)
   at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)
2017-11-18 07:03:36.469 +00:00 [Warning] Error occurred during execution of 'ServerWatchdog' process. Execution will be retried (attempt #3) in 00:00:04 seconds.
Microsoft.Data.Sqlite.SqliteException (0x80004005): SQLite Error 5: 'database is locked'.
   at Microsoft.Data.Sqlite.SqliteException.ThrowExceptionForRC(Int32 rc, sqlite3 db)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteReader(CommandBehavior behavior)
   at Microsoft.Data.Sqlite.SqliteCommand.ExecuteNonQuery()
   at Dapper.SqlMapper.ExecuteCommand(IDbConnection cnn, CommandDefinition& command, Action`2 paramReader)
   at Dapper.SqlMapper.ExecuteImpl(IDbConnection cnn, CommandDefinition& command)
   at Dapper.SqlMapper.Execute(IDbConnection cnn, String sql, Object param, IDbTransaction transaction, Nullable`1 commandTimeout, Nullable`1 commandType)
   at Hangfire.SQLite.SQLiteStorageConnection.<>c__DisplayClass17_0.<RemoveTimedOutServers>b__0(DbConnection connection)
   at Hangfire.SQLite.SQLiteStorage.UseConnection[T](Func`2 func, Boolean isWriteLock)
   at Hangfire.SQLite.SQLiteStorageConnection.RemoveTimedOutServers(TimeSpan timeOut)
   at Hangfire.Server.ServerWatchdog.Execute(BackgroundProcessContext context)
   at Hangfire.Server.AutomaticRetryProcess.Execute(BackgroundProcessContext context)

@Magikarplvl4
Copy link
Contributor

Database lock issue #1720

@tidusjar
Copy link
Member

This should be resolved. Please confirm

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Projects
None yet
Development

No branches or pull requests

4 participants