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

Sonarr - Ombi send wrong ID for TV Shows -Bad Request: 0 is not a valid ID #3194

Closed
Dabu-dot opened this issue Oct 9, 2019 · 26 comments
Closed

Comments

@Dabu-dot
Copy link

Dabu-dot commented Oct 9, 2019

Describe the bug
When trying to add a new TV Show OR missing episodes of existing series, Sonarr report an invalid ID from Ombi and logs in failed requests. The main error reporting here is an Invalid Root Path.

With a bit of searching, I think Sonarr is "partially" detected in Ombi. (More explanation on that through the report). Finally, this issue can be reproduce either on an admin account or a standard user account with no "Auto-Approve" role.

To Reproduce
Sonarr settings in Ombi:

  • Enable
  • No V3
  • Sonarr Local IP
  • Port
  • Sonarr API Key
  • No SSL and no BaseURL

Load Qualities (SUCCESS and CORRECT)
Load Folders (SUCCESS and CORRECT)
Test Connectivity (SUCCESS)

Steps to reproduce the behavior:

  1. Search a TV Show in search bar.
  2. Request any Season or Episode.
  3. Sonarr report 3 error logs and can't proceed.

Expected behavior
Ombi should send a correct TV Show ID to Sonarr.

Screenshots
Here's why I say Sonarr is "partially" detected by Ombi. I've notice that I'm unable to go on PLEX through Ombi on the TV Show section. On the movies, I have this layout:

movies

As you can see, summary of the movies are translated in my language and the button "Regarder sur Plex" (See on Plex) is here ect.. Link of each movie works and redirect on Plex correct movie. However in the TV Show tab, I have this:

TV Shows

No translation, no similar series, no link to Plex. And many TV shows are missing and they are not registred as "Available". I can try to requests the missing shows but Ombi respond "TV Show already existing on drive, cannot add it to the requests list. Ombi detects the TV Show existing but don't update it through the UI.

Logs (Logs directory where Ombi is located)
Major list of request failing.

2019-10-10 23:29:52.434 [Error] StatusCode: BadRequest, Reason: Bad Request, RequestUri: http://localhost:8989/sonarr/api/series/
2019-10-10 23:29:55.178 [Error] StatusCode: BadRequest, Reason: Bad Request, RequestUri: http://localhost:8989/sonarr/api/series/
2019-10-10 23:29:59.813 [Error] StatusCode: BadRequest, Reason: Bad Request, RequestUri: http://localhost:8989/sonarr/api/series/0

Report log of Ombi on 10/10/2019:
Debug Log Ombi 10-10-2019 .txt

Exception grabbed by Sonnar concerning the Invalid ID and Path:

19-10-9 23:27:18.4|Info|OwinHostController|Listening on the following URLs:
19-10-9 23:27:18.4|Info|OwinHostController|  http://*:8989/
19-10-9 23:27:18.7|Info|NancyBootstrapper|Starting Web Server
19-10-9 23:29:04.3|Warn|MediaCoverMapper|File /config/MediaCover/20/poster.jpg not found
19-10-9 23:29:05.4|Warn|NzbDroneErrorPipeline|Invalid request Validation failed: 
 -- Invalid Path
 -- Invalid Path
19-10-9 23:29:05.6|Warn|MediaCoverMapper|File /config/MediaCover/20/poster.jpg not found
19-10-9 23:29:05.9|Warn|NzbDroneErrorPipeline|Invalid request Validation failed: 
 -- Invalid Path
 -- Invalid Path
19-10-9 23:29:06.0|Warn|NzbDroneErrorPipeline|API Error

[v2.0.0.5338] NzbDrone.Api.REST.BadRequestException: BadRequest :0 is not a valid ID
  at NzbDrone.Api.REST.RestModule`1[TResource].ValidateId (System.Int32 id) [0x0001a] in M:\BuildAgent\work\5d7581516c0ee5b3\src\NzbDrone.Api\REST\RestModule.cs:35 
  at (wrapper dynamic-method) System.Object.CallSite.Target(System.Runtime.CompilerServices.Closure,System.Runtime.CompilerServices.CallSite,NzbDrone.Api.REST.RestModule`1<NzbDrone.Api.Series.SeriesResource>,object)
  at System.Dynamic.UpdateDelegates.UpdateAndExecuteVoid2[T0,T1] (System.Runtime.CompilerServices.CallSite site, T0 arg0, T1 arg1) [0x00113] in <798dd06330af4ca3886d7d2be5573af7>:0 
  at NzbDrone.Api.REST.RestModule`1[TResource].<set_GetResourceById>b__29_0 (System.Object options) [0x00000] in M:\BuildAgent\work\5d7581516c0ee5b3\src\NzbDrone.Api\REST\RestModule.cs:82 
  at (wrapper dynamic-method) System.Object.CallSite.Target(System.Runtime.CompilerServices.Closure,System.Runtime.CompilerServices.CallSite,System.Func`2<object, object>,object)
  at Nancy.Routing.Route+<>c__DisplayClass4.<Wrap>b__3 (System.Object parameters, System.Threading.CancellationToken context) [0x00049] in <63c44d6f8d7e4f339a987bf9eb94d931>:0

Full Debug log can be found linked to this message.
Debug Log.txt

Desktop:

  • OS: NAS Synology DSM 6.2.2-24922 Update 3

Ombi Version:

  • Version: Ombi 3.0.4809-ls65
  • Media Server: PLEX standalone application Ver.1.17.0.1841

This is important (additional setup related to the issue and specific configuration of Environement):

  • Docker Ver.18.09-0-0506 with 3 Containers related to this issue
  • Docker Container Ombi 3.0.4809-ls65
  • Docker Container Sonarr 3.0.3.644-ls142
  • Docker Container Radarr 2.0.0.2090-ls29

Additional context
So before everything, yes I did search and found many open/closed issues about this and precisely this one which is very close to mine: #2466
But I have tried everything found on this one and below (Reddit, Sonarr support - they told me to go here, GitHub...) but nothing seems to work for now.

Sonarr was working from the beginning of my adventure with Ombi but have broke this week without any changes on the settings.

I have checked, double checked and triple checked my settings and everything is correct. I change my password on Sonarr to something less strong (without symbols) before completely disable authentification on Sonarr. I have regenerate API Key twice and nothing too. I've also checked any settings I have on Sonarr but everything is OK to me.

Radarr works as expected on Ombi, and have the EXACTS same settings (besides Port and API Key) as Sonarr in Ombi page and in the settings of themselves. Same Indexers, same profiles, almost same Root Path Folders (obviously not the exact same path as they contains different content), same remote mapping ect..

And from what I am seeing, Ombi load the corrects profiles contained in Sonarr and show the correct path for TV Shows and Anime.

@ombi-bot
Copy link
Contributor

ombi-bot commented Oct 9, 2019

Hi!
Thanks for the issue report. Before a real human comes by, please make sure you used our bug report format.
Have you looked at the wiki yet? https://github.com/tidusjar/ombi/wiki/
Before posting make sure you also read our FAQ.
Make the title describe your issue. Having 'not working' or 'I get this bug' for 100 issues, isn't really helpful.
If we need more information or there is some progress we tag the issue or update the tag and keep you updated.
Thanks!
Ombi Bot.

@Dabu-dot
Copy link
Author

Dabu-dot commented Oct 10, 2019

I'll note here the new things I've tried to fix it and the results of it:

  • Delete OmbiExternal.db, reboot Ombi and run ManualSync. (Nothing happened and OmbiExternal.db is not regenarated)
  • Retry to request on date 10/10/2019, new report logs from Ombi can be found in original post.

@gandalf764
Copy link

where i find: OmbiExternal.db ??

@Dabu-dot
Copy link
Author

where i find: OmbiExternal.db ??

It depends of your environement. It should be located at the root of your Ombi folder however. Please specify your setup so developers can help you to resolve this issue.

By the way, this issue is still unresolved. Deleting OmbiExternal.db will not resolve this problem.

@gandalf764
Copy link

gandalf764 commented Nov 19, 2019 via email

@Dabu-dot
Copy link
Author

Yeah.. I've said that it wouldn't work and there is no temporary fix for now. I'm out of idea of what would be causing this error so we are at a dead-end for now.

Wait for someone to help or contact @tidusjar if he's available.

@gandalf764
Copy link

gandalf764 commented Nov 19, 2019 via email

@Dabu-dot
Copy link
Author

True, this only happens with Sonarr, Radarr isn't touched by this error.
Glad to hear that it works now (You did all by yourself) , however I also hope that somebody find the origin of this issue.
We need to understand what is causing this behavior in order to prevent it.

Have a nice day.

@gandalf764
Copy link

gandalf764 commented Nov 19, 2019 via email

@tidusjar
Copy link
Member

Hi guys,

I cannot produce this and I cannot seem to figure out where this is going wrong in Ombi.

Can someone please do the following, edit the appsettings.json file (located where Ombi is installed) and modify the Logging section to something like the below:

  "Logging": {
    "IncludeScopes": false,
    "LogLevel": {
      "Default": "Trace",
      "System": "Trace",
      "Microsoft": "Warning"
    }
  }

Then repeat your steps to get the error and report back with the log file?

@gandalf764
Copy link

gandalf764 commented Nov 20, 2019 via email

@ombi-bot
Copy link
Contributor

ombi-bot commented Nov 20, 2019 via email

@Dabu-dot
Copy link
Author

Hi guys,

I cannot produce this and I cannot seem to figure out where this is going wrong in Ombi.

Can someone please do the following, edit the appsettings.json file (located where Ombi is installed) and modify the Logging section to something like the below:

  "Logging": {
    "IncludeScopes": false,
    "LogLevel": {
      "Default": "Trace",
      "System": "Trace",
      "Microsoft": "Warning"
    }
  }

Then repeat your steps to get the error and report back with the log file?

I would like to try this, but unfortunately the setup I have on my NAS with Docker doesn't contain any file named appsettings.json neither at the root of my installation folder nor at any others folders contained in it. I suppose Docker might have spliced the files of my installation. I'll reinstall it from fresh and see where this is getting me.

@ombi-bot
Copy link
Contributor

ombi-bot commented Nov 26, 2019 via email

@Dabu-dot
Copy link
Author

Dabu-dot commented Nov 26, 2019

Ombi.zip
Okay so for some reasons, I'm really struggling to reinstall Ombi as a container for now (that was my fault, but I'll recover it soon..)

I might have a backup of the ancient installation of Ombi. This archive contains all the files that were in my folder container. There were nothing more. If you guys want to take a look, you'll see that I don't have any file corresponding to your description. My installation maybe was incomplete, I don't know..


EDIT: So I managed to reinstall Ombi, fresh start and all. I've reconnected Plex, Sonarr and Radarr in the Settings Page, sync all that up and waited for a bit. After checking, it seems to have the same issue. All movies availables in Plex are correctly identified and displaying "Available" status in Ombi.

But availables TV Shows on Plex don't update their status and you can still click the request button. Also, if you click the "Request" Button for an available tv show, Ombi don't return any info on the web-ui. Same result if you try to request a NEW TV Show to Sonarr, nothing appears and nothing is send. So I might have a problem with sending requests now and I don't understand why...

As I said, my folder container don't have the file appsettings.json even after a fresh reinstall :/

I've also noticed something interesting in the log file. Here's the full file:
log-20191126.txt

Ombi return this into LogFile:

2019-11-26 20:20:38.584 +01:00 [Debug] Batch acquisition of 0 triggers
2019-11-26 20:20:38.584 +01:00 [Debug] Calling Execute on job Plex.IPlexEpisodeSync
2019-11-26 20:20:38.778 +01:00 [Information] Total Epsiodes found for Séries d'Animation = 1944
2019-11-26 20:20:38.806 +01:00 [Warning] The episode title "Episode 1" we cannot find the parent series. The episode grandparentKey = 297, grandparentTitle = "Aggretsuko"
2019-11-26 20:20:38.822 +01:00 [Warning] The episode title "Episode 2" we cannot find the parent series. The episode grandparentKey = 297, grandparentTitle = "Aggretsuko"
2019-11-26 20:20:38.829 +01:00 [Warning] The episode title "Episode 3" we cannot find the parent series. The episode grandparentKey = 297, grandparentTitle = "Aggretsuko"

[...]

2019-11-26 20:20:38.953 +01:00 [Warning] The episode title "Frères de la côte, 1re partie" we cannot find the parent series. The episode grandparentKey = 2054, grandparentTitle = "Archer"
2019-11-26 20:20:38.960 +01:00 [Warning] The episode title "Frères de la côte, 2e partie" we cannot find the parent series. The episode grandparentKey = 2054, grandparentTitle = "Archer"
2019-11-26 20:20:38.967 +01:00 [Warning] The episode title "Frères de la côte, 3e partie" we cannot find the parent series. The episode grandparentKey = 2054, grandparentTitle = "Archer"

This continues on for all the episodes of TV Shows that I have. I suppose that's why he can't find them as the name of my episodes aren't in English but in my native language. Sonarr and Radarr renames them into French after grabbing them. Now, the problem is that I need to keep the names of my episodes in French for Plex display and other purposes.. If that a part of the problem, is there a way to make Ombi detect my files in another language than English ?

@tidusjar
Copy link
Member

Very interesting that we are picking up the episodes but cannot find the main tv show to match it.

Can you include your OmbiExternal.db? you can email it to me tidusjar@gmail.com

@Dabu-dot
Copy link
Author

Sure thing, you should receive it really soon :)

@benwallacestock
Copy link

Has any progress been made with this?

I am getting exactly the same behaviour. I installed and set all fo this up (I use Jellyfin, Sonarr, Radarr, and Ombi) yesterday and as of today, any TV requests fail to be added to Ombi, and it is also not showing that I have some shows in Ombi that are in Jellyfin. Radarr and all movie requests work and link up fine.

When I do a request for part of a series, Sonarr gives the below error, but it works fine with a whole series.

20-1-10 14:54:09.9|Error|AddSeriesService|tvdbid {1} was not found, it may have been removed from TheTVDB.
20-1-10 14:54:10.0|Warn|NzbDroneErrorPipeline|Invalid request Validation failed:
-- A series with this ID was not found
20-1-10 14:54:10.0|Error|AddSeriesService|tvdbid {1} was not found, it may have been removed from TheTVDB.
20-1-10 14:54:10.1|Warn|NzbDroneErrorPipeline|Invalid request Validation failed:
-- A series with this ID was not found
20-1-10 14:54:10.1|Warn|NzbDroneErrorPipeline|API Error

[v2.0.0.5338] NzbDrone.Api.REST.BadRequestException: BadRequest :0 is not a valid ID
at NzbDrone.Api.REST.RestModule1.ValidateId(Int32 id) in M:\BuildAgent\work\5d7581516c0ee5b3\src\NzbDrone.Api\REST\RestModule.cs:line 33 at CallSite.Target(Closure , CallSite , RestModule1 , Object )
at NzbDrone.Api.REST.RestModule1.<set_GetResourceById>b__29_0(Object options) in M:\BuildAgent\work\5d7581516c0ee5b3\src\NzbDrone.Api\REST\RestModule.cs:line 82 at CallSite.Target(Closure , CallSite , Func2 , Object )
at Nancy.Routing.Route.<>c__DisplayClass4.b__3(Object parameters, CancellationToken context)

@freender
Copy link

Hi All,
I have exactly same issue.
As per Sonarr trace logs Ombi sends 0 as series ID
/api/Episode?seriesId=0

Let me now if I can provide any info that can assist in issue assessment

20-2-17 22:14:34.6|Trace|Http|Req: 6902 [GET] /api/v3/health
20-2-17 22:14:34.6|Trace|Http|Res: 6902 [GET] /api/v3/health: 200.OK (0 ms)
20-2-17 22:14:34.6|Trace|Http|Res: 6900 [PUT] /api/v3/config/host: 202.Accepted (167 ms)
20-2-17 22:14:34.6|Debug|Api|[GET] /api/v3/health: 200.OK (0 ms)
20-2-17 22:14:34.6|Debug|Api|[PUT] /api/v3/config/host: 202.Accepted (167 ms)
20-2-17 22:14:34.6|Trace|EventAggregator|ConfigSavedEvent <~ TaskManager
20-2-17 22:14:34.7|Trace|Http|Req: 6903 [GET] /api/Episode?seriesId=0
20-2-17 22:14:34.7|Trace|Http|Res: 6903 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:34.7|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:34.9|Trace|Http|Req: 6904 [GET] /api/Episode?seriesId=0
20-2-17 22:14:34.9|Trace|Http|Res: 6904 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:34.9|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:35.2|Trace|Http|Req: 6905 [GET] /api/Episode?seriesId=0
20-2-17 22:14:35.2|Trace|Http|Res: 6905 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:35.2|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:35.4|Trace|Http|Req: 6906 [GET] /api/Episode?seriesId=0
20-2-17 22:14:35.4|Trace|Http|Res: 6906 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:35.4|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:35.7|Trace|Http|Req: 6907 [GET] /api/Episode?seriesId=0
20-2-17 22:14:35.7|Trace|Http|Res: 6907 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:35.7|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:35.9|Trace|Http|Req: 6908 [GET] /api/v3/health
20-2-17 22:14:35.9|Trace|Http|Req: 6909 [GET] /api/v3/diskspace
20-2-17 22:14:35.9|Trace|Http|Res: 6908 [GET] /api/v3/health: 200.OK (1 ms)
20-2-17 22:14:35.9|Trace|Http|Req: 6910 [GET] /api/Episode?seriesId=0
20-2-17 22:14:35.9|Trace|Http|Req: 6911 [GET] /api/v3/system/status
20-2-17 22:14:35.9|Debug|Api|[GET] /api/v3/health: 200.OK (1 ms)
20-2-17 22:14:35.9|Trace|Http|Res: 6910 [GET] /api/Episode?seriesId=0: 200.OK (2 ms)
20-2-17 22:14:35.9|Trace|Http|Res: 6911 [GET] /api/v3/system/status: 200.OK (1 ms)
20-2-17 22:14:35.9|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (2 ms)
20-2-17 22:14:35.9|Debug|Api|[GET] /api/v3/system/status: 200.OK (1 ms)
20-2-17 22:14:35.9|Trace|Http|Res: 6909 [GET] /api/v3/diskspace: 200.OK (25 ms)
20-2-17 22:14:35.9|Debug|Api|[GET] /api/v3/diskspace: 200.OK (25 ms)
20-2-17 22:14:36.2|Trace|Http|Req: 6912 [GET] /api/Episode?seriesId=0
20-2-17 22:14:36.2|Trace|Http|Res: 6912 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:36.2|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:36.4|Trace|Http|Req: 6913 [GET] /api/Episode?seriesId=0
20-2-17 22:14:36.4|Trace|Http|Res: 6913 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:36.4|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:36.7|Trace|Http|Req: 6914 [GET] /api/Episode?seriesId=0
20-2-17 22:14:36.7|Trace|Http|Res: 6914 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:36.7|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:36.9|Trace|Http|Req: 6915 [GET] /api/Episode?seriesId=0
20-2-17 22:14:36.9|Trace|Http|Res: 6915 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:36.9|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:37.2|Trace|Http|Req: 6916 [GET] /api/Episode?seriesId=0
20-2-17 22:14:37.2|Trace|Http|Res: 6916 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:37.2|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:37.4|Trace|Http|Req: 6917 [GET] /api/Episode?seriesId=0
20-2-17 22:14:37.4|Trace|Http|Res: 6917 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:37.4|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:37.7|Trace|Http|Req: 6918 [GET] /api/Episode?seriesId=0
20-2-17 22:14:37.7|Trace|Http|Res: 6918 [GET] /api/Episode?seriesId=0: 200.OK (2 ms)
20-2-17 22:14:37.7|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (2 ms)
20-2-17 22:14:37.9|Trace|Http|Req: 6919 [GET] /api/Episode?seriesId=0
20-2-17 22:14:37.9|Trace|Http|Res: 6919 [GET] /api/Episode?seriesId=0: 200.OK (2 ms)
20-2-17 22:14:37.9|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (2 ms)
20-2-17 22:14:38.2|Trace|Http|Req: 6920 [GET] /api/Episode?seriesId=0
20-2-17 22:14:38.2|Trace|Http|Res: 6920 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:38.2|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:38.4|Trace|Http|Req: 6921 [GET] /api/Episode?seriesId=0
20-2-17 22:14:38.4|Trace|Http|Res: 6921 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:38.4|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:38.5|Trace|Http|Req: 6922 [GET] /api/v3/log/file
20-2-17 22:14:38.5|Trace|Http|Res: 6922 [GET] /api/v3/log/file: 200.OK (10 ms)
20-2-17 22:14:38.5|Debug|Api|[GET] /api/v3/log/file: 200.OK (10 ms)
20-2-17 22:14:38.7|Trace|Http|Req: 6923 [GET] /api/Episode?seriesId=0
20-2-17 22:14:38.7|Trace|Http|Res: 6923 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:38.7|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:38.9|Trace|Http|Req: 6924 [GET] /api/Episode?seriesId=0
20-2-17 22:14:38.9|Trace|Http|Res: 6924 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:38.9|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:39.2|Trace|Http|Req: 6925 [GET] /api/Episode?seriesId=0
20-2-17 22:14:39.2|Trace|Http|Res: 6925 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:39.2|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:39.4|Trace|Http|Req: 6926 [GET] /api/Episode?seriesId=0
20-2-17 22:14:39.4|Trace|Http|Res: 6926 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:39.4|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:39.7|Trace|Http|Req: 6927 [GET] /api/Episode?seriesId=0
20-2-17 22:14:39.7|Trace|Http|Res: 6927 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:39.7|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:39.9|Trace|Http|Req: 6928 [GET] /api/Episode?seriesId=0
20-2-17 22:14:39.9|Trace|Http|Res: 6928 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:39.9|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:40.2|Trace|Http|Req: 6929 [GET] /api/Episode?seriesId=0
20-2-17 22:14:40.3|Trace|Http|Res: 6929 [GET] /api/Episode?seriesId=0: 200.OK (2 ms)
20-2-17 22:14:40.3|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (2 ms)
20-2-17 22:14:40.5|Trace|Http|Req: 6930 [GET] /api/Episode?seriesId=0
20-2-17 22:14:40.5|Trace|Http|Res: 6930 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:40.5|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:40.7|Trace|Scheduler|Pending Tasks: 1
20-2-17 22:14:40.7|Trace|CommandQueueManager|Publishing MessagingCleanup
20-2-17 22:14:40.7|Trace|CommandQueueManager|Checking if command is queued or started: MessagingCleanup
20-2-17 22:14:40.7|Trace|CommandQueueManager|Inserting new command: MessagingCleanup
20-2-17 22:14:40.7|Trace|CommandExecutor|MessagingCleanupCommand -> CleanupCommandMessagingService
20-2-17 22:14:40.7|Trace|CommandQueueManager|Marking command as started: MessagingCleanup
20-2-17 22:14:40.7|Trace|CommandQueueManager|Cleaning up old commands
20-2-17 22:14:40.7|Trace|CommandQueueManager|Updating command status
20-2-17 22:14:40.7|Trace|EventAggregator|Publishing CommandExecutedEvent
20-2-17 22:14:40.7|Trace|EventAggregator|CommandExecutedEvent -> TaskManager
20-2-17 22:14:40.7|Trace|TaskManager|Updating last run time for: NzbDrone.Core.Messaging.Commands.MessagingCleanupCommand
20-2-17 22:14:40.7|Trace|EventAggregator|CommandExecutedEvent <- TaskManager
20-2-17 22:14:40.7|Trace|EventAggregator|CommandExecutedEvent -> TaskModule
20-2-17 22:14:40.7|Trace|EventAggregator|CommandExecutedEvent <- TaskModule
20-2-17 22:14:40.7|Trace|EventAggregator|CommandExecutedEvent -> TaskModule
20-2-17 22:14:40.7|Trace|EventAggregator|CommandExecutedEvent <- TaskModule
20-2-17 22:14:40.7|Trace|CommandExecutor|MessagingCleanupCommand <- CleanupCommandMessagingService [00:00:00.0137670]
20-2-17 22:14:40.8|Trace|Http|Req: 6931 [GET] /api/v3/command
20-2-17 22:14:40.8|Trace|CommandQueueManager|Getting all commands
20-2-17 22:14:40.8|Trace|Http|Res: 6931 [GET] /api/v3/command: 200.OK (1 ms)
20-2-17 22:14:40.8|Debug|Api|[GET] /api/v3/command: 200.OK (1 ms)
20-2-17 22:14:40.8|Trace|Http|Req: 6932 [GET] /api/Episode?seriesId=0
20-2-17 22:14:40.8|Trace|Http|Res: 6932 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:40.8|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:41.0|Trace|Http|Req: 6933 [GET] /api/Episode?seriesId=0
20-2-17 22:14:41.0|Trace|Http|Res: 6933 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:41.0|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:41.3|Trace|Http|Req: 6934 [GET] /api/Episode?seriesId=0
20-2-17 22:14:41.3|Trace|Http|Res: 6934 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:41.3|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:41.5|Trace|Http|Req: 6935 [GET] /api/Episode?seriesId=0
20-2-17 22:14:41.5|Trace|Http|Res: 6935 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:41.5|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:41.8|Trace|Http|Req: 6936 [GET] /api/Episode?seriesId=0
20-2-17 22:14:41.8|Trace|Http|Res: 6936 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:41.8|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:42.0|Trace|Http|Req: 6937 [GET] /api/Episode?seriesId=0
20-2-17 22:14:42.0|Trace|Http|Res: 6937 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:42.0|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:42.3|Trace|Http|Req: 6938 [GET] /api/Episode?seriesId=0
20-2-17 22:14:42.3|Trace|Http|Res: 6938 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:42.3|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:42.5|Trace|Http|Req: 6939 [GET] /api/Episode?seriesId=0
20-2-17 22:14:42.5|Trace|Http|Res: 6939 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:42.5|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:42.8|Trace|Http|Req: 6940 [GET] /api/Episode?seriesId=0
20-2-17 22:14:42.8|Trace|Http|Res: 6940 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:42.8|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:43.0|Trace|Http|Req: 6941 [GET] /api/Episode?seriesId=0
20-2-17 22:14:43.0|Trace|Http|Res: 6941 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:43.0|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:43.3|Trace|Http|Req: 6942 [GET] /api/Episode?seriesId=0
20-2-17 22:14:43.3|Trace|Http|Res: 6942 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:43.3|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:43.4|Trace|Http|Req: 6943 [GET] /api/profile
20-2-17 22:14:43.4|Trace|Http|Res: 6943 [GET] /api/profile: 200.OK (2 ms)
20-2-17 22:14:43.4|Debug|Api|[GET] /api/profile: 200.OK (2 ms)
20-2-17 22:14:43.4|Trace|Http|Req: 6944 [GET] /api/rootfolder
20-2-17 22:14:43.4|Debug|RootFolderService|Generating list of unmapped folders
20-2-17 22:14:43.5|Debug|RootFolderService|0 unmapped folders detected.
20-2-17 22:14:43.5|Debug|RootFolderService|Generating list of unmapped folders
20-2-17 22:14:43.5|Debug|RootFolderService|0 unmapped folders detected.
20-2-17 22:14:43.5|Trace|Http|Res: 6944 [GET] /api/rootfolder: 200.OK (49 ms)
20-2-17 22:14:43.5|Debug|Api|[GET] /api/rootfolder: 200.OK (49 ms)
20-2-17 22:14:43.5|Trace|Http|Req: 6945 [GET] /api/Episode?seriesId=0
20-2-17 22:14:43.5|Trace|Http|Res: 6945 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:43.5|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:43.8|Trace|Http|Req: 6946 [GET] /api/Episode?seriesId=0
20-2-17 22:14:43.8|Trace|Http|Res: 6946 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:43.8|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:44.0|Trace|Http|Req: 6947 [GET] /api/Episode?seriesId=0
20-2-17 22:14:44.0|Trace|Http|Res: 6947 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:44.0|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:44.3|Trace|Http|Req: 6948 [GET] /api/Episode?seriesId=0
20-2-17 22:14:44.3|Trace|Http|Res: 6948 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:44.3|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:44.5|Trace|Http|Req: 6949 [GET] /api/Episode?seriesId=0
20-2-17 22:14:44.5|Trace|Http|Res: 6949 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:44.5|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:44.8|Trace|Http|Req: 6950 [GET] /api/Episode?seriesId=0
20-2-17 22:14:44.8|Trace|Http|Res: 6950 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:44.8|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:45.0|Trace|Http|Req: 6951 [GET] /api/Episode?seriesId=0
20-2-17 22:14:45.0|Trace|Http|Res: 6951 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:45.0|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:45.3|Trace|Http|Req: 6952 [GET] /api/Episode?seriesId=0
20-2-17 22:14:45.3|Trace|Http|Res: 6952 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:45.3|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:45.5|Trace|Http|Req: 6953 [GET] /api/Episode?seriesId=0
20-2-17 22:14:45.5|Trace|Http|Res: 6953 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:45.5|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:45.8|Trace|Http|Req: 6954 [GET] /api/Episode?seriesId=0
20-2-17 22:14:45.8|Trace|Http|Res: 6954 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:45.8|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:46.0|Trace|Http|Req: 6955 [GET] /api/Episode?seriesId=0
20-2-17 22:14:46.0|Trace|Http|Res: 6955 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:46.1|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:46.3|Trace|Http|Req: 6956 [GET] /api/Episode?seriesId=0
20-2-17 22:14:46.3|Trace|Http|Res: 6956 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:46.3|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:46.6|Trace|Http|Req: 6957 [GET] /api/Episode?seriesId=0
20-2-17 22:14:46.6|Trace|Http|Res: 6957 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:46.6|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:46.8|Trace|Http|Req: 6958 [GET] /api/Episode?seriesId=0
20-2-17 22:14:46.8|Trace|Http|Res: 6958 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:46.8|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:47.1|Trace|Http|Req: 6959 [GET] /api/Episode?seriesId=0
20-2-17 22:14:47.1|Trace|Http|Res: 6959 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:47.1|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:47.3|Trace|Http|Req: 6960 [GET] /api/Episode?seriesId=0
20-2-17 22:14:47.3|Trace|Http|Res: 6960 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:47.3|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:47.6|Trace|Http|Req: 6961 [GET] /api/Episode?seriesId=0
20-2-17 22:14:47.6|Trace|Http|Res: 6961 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:47.6|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:47.8|Trace|Http|Req: 6962 [GET] /api/Episode?seriesId=0
20-2-17 22:14:47.8|Trace|Http|Res: 6962 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:47.8|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:48.1|Trace|Http|Req: 6963 [GET] /api/Episode?seriesId=0
20-2-17 22:14:48.1|Trace|Http|Res: 6963 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:48.1|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:48.3|Trace|Http|Req: 6964 [GET] /api/Episode?seriesId=0
20-2-17 22:14:48.3|Trace|Http|Res: 6964 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:48.3|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:48.6|Trace|Http|Req: 6965 [GET] /api/Episode?seriesId=0
20-2-17 22:14:48.6|Trace|Http|Res: 6965 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:48.6|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:48.8|Trace|Http|Req: 6966 [GET] /api/Episode?seriesId=0
20-2-17 22:14:48.8|Trace|Http|Res: 6966 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:48.8|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:49.1|Trace|Http|Req: 6967 [GET] /api/Episode?seriesId=0
20-2-17 22:14:49.1|Trace|Http|Res: 6967 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:49.1|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:49.3|Trace|Http|Req: 6968 [GET] /api/Episode?seriesId=0
20-2-17 22:14:49.3|Trace|Http|Res: 6968 [GET] /api/Episode?seriesId=0: 200.OK (2 ms)
20-2-17 22:14:49.3|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (2 ms)
20-2-17 22:14:49.6|Trace|Http|Req: 6969 [GET] /api/Episode?seriesId=0
20-2-17 22:14:49.6|Trace|Http|Res: 6969 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:49.6|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:49.8|Trace|Http|Req: 6970 [GET] /api/Episode?seriesId=0
20-2-17 22:14:49.8|Trace|Http|Res: 6970 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:49.8|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:50.1|Trace|Http|Req: 6971 [GET] /api/Episode?seriesId=0
20-2-17 22:14:50.1|Trace|Http|Res: 6971 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:50.1|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:50.3|Trace|Http|Req: 6972 [GET] /api/Episode?seriesId=0
20-2-17 22:14:50.3|Trace|Http|Res: 6972 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:50.3|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:50.6|Trace|Http|Req: 6973 [GET] /api/Episode?seriesId=0
20-2-17 22:14:50.6|Trace|Http|Res: 6973 [GET] /api/Episode?seriesId=0: 200.OK (2 ms)
20-2-17 22:14:50.6|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (2 ms)
20-2-17 22:14:50.9|Trace|Http|Req: 6974 [GET] /api/Episode?seriesId=0
20-2-17 22:14:50.9|Trace|Http|Res: 6974 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:50.9|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:51.1|Trace|Http|Req: 6975 [GET] /api/Episode?seriesId=0
20-2-17 22:14:51.1|Trace|Http|Res: 6975 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:51.1|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:51.4|Trace|Http|Req: 6976 [GET] /api/Episode?seriesId=0
20-2-17 22:14:51.4|Trace|Http|Res: 6976 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:51.4|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:51.6|Trace|Http|Req: 6977 [GET] /api/Episode?seriesId=0
20-2-17 22:14:51.6|Trace|Http|Res: 6977 [GET] /api/Episode?seriesId=0: 200.OK (2 ms)
20-2-17 22:14:51.6|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (2 ms)
20-2-17 22:14:51.9|Trace|Http|Req: 6978 [GET] /api/Episode?seriesId=0
20-2-17 22:14:51.9|Trace|Http|Res: 6978 [GET] /api/Episode?seriesId=0: 200.OK (2 ms)
20-2-17 22:14:51.9|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (2 ms)
20-2-17 22:14:52.1|Trace|Http|Req: 6979 [GET] /api/Episode?seriesId=0
20-2-17 22:14:52.1|Trace|Http|Res: 6979 [GET] /api/Episode?seriesId=0: 200.OK (2 ms)
20-2-17 22:14:52.1|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (2 ms)
20-2-17 22:14:52.4|Trace|Http|Req: 6980 [GET] /api/Episode?seriesId=0
20-2-17 22:14:52.4|Trace|Http|Res: 6980 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:52.4|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:52.6|Trace|Http|Req: 6981 [GET] /api/Episode?seriesId=0
20-2-17 22:14:52.6|Trace|Http|Res: 6981 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:52.6|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:52.9|Trace|Http|Req: 6982 [GET] /api/Episode?seriesId=0
20-2-17 22:14:52.9|Trace|Http|Res: 6982 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:52.9|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:53.1|Trace|Http|Req: 6983 [GET] /api/Episode?seriesId=0
20-2-17 22:14:53.1|Trace|Http|Res: 6983 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:53.1|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:53.4|Trace|Http|Req: 6984 [GET] /api/Episode?seriesId=0
20-2-17 22:14:53.4|Trace|Http|Res: 6984 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:53.4|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:53.6|Trace|Http|Req: 6985 [GET] /api/Episode?seriesId=0
20-2-17 22:14:53.6|Trace|Http|Res: 6985 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:53.6|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:53.9|Trace|Http|Req: 6986 [GET] /api/Episode?seriesId=0
20-2-17 22:14:53.9|Trace|Http|Res: 6986 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:53.9|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:54.1|Trace|Http|Req: 6987 [GET] /api/Episode?seriesId=0
20-2-17 22:14:54.1|Trace|Http|Res: 6987 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:54.1|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:54.4|Trace|Http|Req: 6988 [GET] /api/Episode?seriesId=0
20-2-17 22:14:54.4|Trace|Http|Res: 6988 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:54.4|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:54.6|Trace|Http|Req: 6989 [GET] /api/Episode?seriesId=0
20-2-17 22:14:54.6|Trace|Http|Res: 6989 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:54.6|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:54.9|Trace|Http|Req: 6990 [GET] /api/Episode?seriesId=0
20-2-17 22:14:54.9|Trace|Http|Res: 6990 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:54.9|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:55.1|Trace|Http|Req: 6991 [GET] /api/Episode?seriesId=0
20-2-17 22:14:55.1|Trace|Http|Res: 6991 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:55.1|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:55.4|Trace|Http|Req: 6992 [GET] /api/Episode?seriesId=0
20-2-17 22:14:55.4|Trace|Http|Res: 6992 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:55.4|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:55.6|Trace|Http|Req: 6993 [GET] /api/Episode?seriesId=0
20-2-17 22:14:55.6|Trace|Http|Res: 6993 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:55.6|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:55.9|Trace|Http|Req: 6994 [GET] /api/Episode?seriesId=0
20-2-17 22:14:55.9|Trace|Http|Res: 6994 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:55.9|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:56.1|Trace|Http|Req: 6995 [GET] /api/Episode?seriesId=0
20-2-17 22:14:56.1|Trace|Http|Res: 6995 [GET] /api/Episode?seriesId=0: 200.OK (2 ms)
20-2-17 22:14:56.1|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (2 ms)
20-2-17 22:14:56.4|Trace|Http|Req: 6996 [GET] /api/Episode?seriesId=0
20-2-17 22:14:56.4|Trace|Http|Res: 6996 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:56.4|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:56.7|Trace|Http|Req: 6997 [GET] /api/Episode?seriesId=0
20-2-17 22:14:56.7|Trace|Http|Res: 6997 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:56.7|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:56.9|Trace|Http|Req: 6998 [GET] /api/Episode?seriesId=0
20-2-17 22:14:56.9|Trace|Http|Res: 6998 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:56.9|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:57.2|Trace|Http|Req: 6999 [GET] /api/Episode?seriesId=0
20-2-17 22:14:57.2|Trace|Http|Res: 6999 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:57.2|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:57.4|Trace|Http|Req: 7000 [GET] /api/Episode?seriesId=0
20-2-17 22:14:57.4|Trace|Http|Res: 7000 [GET] /api/Episode?seriesId=0: 200.OK (2 ms)
20-2-17 22:14:57.4|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (2 ms)
20-2-17 22:14:57.7|Trace|Http|Req: 7001 [GET] /api/Episode?seriesId=0
20-2-17 22:14:57.7|Trace|Http|Res: 7001 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:57.7|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:57.9|Trace|Http|Req: 7002 [GET] /api/Episode?seriesId=0
20-2-17 22:14:57.9|Trace|Http|Res: 7002 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:57.9|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:58.2|Trace|Http|Req: 7003 [GET] /api/Episode?seriesId=0
20-2-17 22:14:58.2|Trace|Http|Res: 7003 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:58.2|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:58.4|Trace|Http|Req: 7004 [GET] /api/Episode?seriesId=0
20-2-17 22:14:58.4|Trace|Http|Res: 7004 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:58.4|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:58.7|Trace|Http|Req: 7005 [GET] /api/Episode?seriesId=0
20-2-17 22:14:58.7|Trace|Http|Res: 7005 [GET] /api/Episode?seriesId=0: 200.OK (2 ms)
20-2-17 22:14:58.7|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (2 ms)
20-2-17 22:14:58.9|Trace|Http|Req: 7006 [GET] /api/Episode?seriesId=0
20-2-17 22:14:58.9|Trace|Http|Res: 7006 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:58.9|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:59.2|Trace|Http|Req: 7007 [GET] /api/Episode?seriesId=0
20-2-17 22:14:59.2|Trace|Http|Res: 7007 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:59.2|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:59.4|Trace|Http|Req: 7008 [GET] /api/Episode?seriesId=0
20-2-17 22:14:59.4|Trace|Http|Res: 7008 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:59.4|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:59.7|Trace|Http|Req: 7009 [GET] /api/Episode?seriesId=0
20-2-17 22:14:59.7|Trace|Http|Res: 7009 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:59.7|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:59.9|Trace|Http|Req: 7010 [GET] /api/Episode?seriesId=0
20-2-17 22:14:59.9|Trace|Http|Res: 7010 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:14:59.9|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:15:00.2|Trace|Http|Req: 7011 [GET] /api/Episode?seriesId=0
20-2-17 22:15:00.2|Trace|Http|Res: 7011 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:15:00.2|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:15:00.4|Trace|Http|Req: 7012 [GET] /api/Episode?seriesId=0
20-2-17 22:15:00.4|Trace|Http|Res: 7012 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:15:00.4|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:15:00.7|Trace|Http|Req: 7013 [GET] /api/rootfolder
20-2-17 22:15:00.7|Trace|Http|Req: 7014 [GET] /api/Episode?seriesId=0
20-2-17 22:15:00.7|Trace|Http|Res: 7014 [GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:15:00.7|Debug|RootFolderService|Generating list of unmapped folders
20-2-17 22:15:00.7|Debug|Api|[GET] /api/Episode?seriesId=0: 200.OK (1 ms)
20-2-17 22:15:00.7|Debug|RootFolderService|0 unmapped folders detected.
20-2-17 22:15:00.7|Debug|RootFolderService|Generating list of unmapped folders
20-2-17 22:15:00.7|Debug|RootFolderService|0 unmapped folders detected.
20-2-17 22:15:00.7|Trace|Http|Res: 7013 [GET] /api/rootfolder: 200.OK (44 ms)
20-2-17 22:15:00.7|Debug|Api|[GET] /api/rootfolder: 200.OK (44 ms)
20-2-17 22:15:00.7|Trace|Http|Req: 7015 [GET] /api/rootfolder
20-2-17 22:15:00.7|Debug|RootFolderService|Generating list of unmapped folders
20-2-17 22:15:00.7|Debug|RootFolderService|0 unmapped folders detected.
20-2-17 22:15:00.8|Debug|RootFolderService|Generating list of unmapped folders
20-2-17 22:15:00.8|Debug|RootFolderService|0 unmapped folders detected.
20-2-17 22:15:00.8|Trace|Http|Res: 7015 [GET] /api/rootfolder: 200.OK (40 ms)
20-2-17 22:15:00.8|Debug|Api|[GET] /api/rootfolder: 200.OK (40 ms)
20-2-17 22:15:00.8|Trace|Http|Req: 7016 [GET] /api/series
20-2-17 22:15:00.9|Trace|Http|Res: 7016 [GET] /api/series: 200.OK (39 ms)
20-2-17 22:15:00.9|Debug|Api|[GET] /api/series: 200.OK (39 ms)
20-2-17 22:15:00.9|Trace|Http|Req: 7017 [POST] /api/series/
20-2-17 22:15:00.9|Trace|SonarrErrorPipeline|Handling Exception
20-2-17 22:15:00.9|Warn|SonarrErrorPipeline|Invalid request Validation failed: 
 -- Path: Invalid Path
 -- RootFolderPath: Invalid Path
20-2-17 22:15:00.9|Trace|Http|Res: 7017 [POST] /api/series/: 400.BadRequest (10 ms)
20-2-17 22:15:00.9|Debug|Api|[POST] /api/series/: 400.BadRequest (10 ms)
20-2-17 22:15:00.9|Trace|Http|Req: 7018 [POST] /api/series/
20-2-17 22:15:00.9|Trace|SonarrErrorPipeline|Handling Exception
20-2-17 22:15:00.9|Warn|SonarrErrorPipeline|Invalid request Validation failed: 
 -- Path: Invalid Path
 -- RootFolderPath: Invalid Path
20-2-17 22:15:00.9|Trace|Http|Res: 7018 [POST] /api/series/: 400.BadRequest (9 ms)
20-2-17 22:15:00.9|Debug|Api|[POST] /api/series/: 400.BadRequest (9 ms)
20-2-17 22:15:00.9|Trace|Http|Req: 7019 [GET] /api/series/0
20-2-17 22:15:00.9|Trace|SonarrErrorPipeline|Handling Exception
20-2-17 22:15:00.9|Warn|SonarrErrorPipeline|API Error

[v3.0.3.698] Sonarr.Http.REST.BadRequestException: BadRequest: 0 is not a valid ID
  at Sonarr.Http.REST.RestModule`1[TResource].ValidateId (System.Int32 id) [0x0001a] in M:\BuildAgent\work\63739567f01dbcc2\src\Sonarr.Http\REST\RestModule.cs:47 
  at (wrapper dynamic-method) System.Object.CallSite.Target(System.Runtime.CompilerServices.Closure,System.Runtime.CompilerServices.CallSite,Sonarr.Http.REST.RestModule`1<NzbDrone.Api.Series.SeriesResource>,object)
  at Sonarr.Http.REST.RestModule`1[TResource].<set_GetResourceById>b__30_0 (System.Object options) [0x00000] in M:\BuildAgent\work\63739567f01dbcc2\src\Sonarr.Http\REST\RestModule.cs:94 
  at Nancy.NancyModule+<>c__DisplayClass14_0`1[T].<Get>b__0 (System.Object args) [0x00047] in <e31b230dbd29407fadcc55713e0bbd0f>:0 
  at Nancy.NancyModule+<>c__DisplayClass16_0`1[T].<Get>b__0 (System.Object args, System.Threading.CancellationToken ct) [0x00047] in <e31b230dbd29407fadcc55713e0bbd0f>:0 
  at Nancy.Routing.Route`1[T].Invoke (Nancy.DynamicDictionary parameters, System.Threading.CancellationToken cancellationToken) [0x00017] in <e31b230dbd29407fadcc55713e0bbd0f>:0 
  at Nancy.Routing.DefaultRouteInvoker.Invoke (Nancy.Routing.Route route, System.Threading.CancellationToken cancellationToken, Nancy.DynamicDictionary parameters, Nancy.NancyContext context) [0x00086] in <e31b230dbd29407fadcc55713e0bbd0f>:0 
  at Nancy.Routing.DefaultRequestDispatcher.Dispatch (Nancy.NancyContext context, System.Threading.CancellationToken cancellationToken) [0x002b7] in <e31b230dbd29407fadcc55713e0bbd0f>:0 
  at Nancy.NancyEngine.InvokeRequestLifeCycle (Nancy.NancyContext context, System.Threading.CancellationToken cancellationToken, Nancy.Bootstrapper.IPipelines pipelines) [0x0011d] in <e31b230dbd29407fadcc55713e0bbd0f>:0 

20-2-17 22:15:00.9|Trace|Http|Res: 7019 [GET] /api/series/0: 400.BadRequest (9 ms)

@tidusjar
Copy link
Member

You have slightly different errors where the root path is incorrect, check your path settings in sonarr

@freender
Copy link

freender commented Feb 18, 2020

Interesting..
In Sonarr UI root folder seems fine:
image

If i go to ../api/rootfolder
I see following response from Sonarr:

[
  {
    "path": "/plex/tv/",
    "freeSpace": 18661237784576,
    "totalSpace": 22509897654272,
    "unmappedFolders": [],
    "id": 6
  }
]

In Ombi it also looks good:
image

However series request still doesn't work (
Shall I create separate issue?

@tidusjar
Copy link
Member

tidusjar commented Feb 18, 2020 via email

@freender
Copy link

Nope It's not. At some point of troubleshooting it changed to empty:) I populated it with same value as default root folder - no change.

Today I deleted all series end root folders from Sonarr and Imported them from scratch.
If I request some season of series that that already exist in Sonarr - no issue.
All Ombi requests for new series fails.

Next step - I am gonna backup old Ombi docker config and spin up fresh ombi instance to isolate the issue. If it doesn't help - sonarr will be recreated from scratch

@freender
Copy link

The issue is not reproducing on fresh Ombi docker config. I think we can close the ticket for now.

@dasb00ter
Copy link

Version 3.0.5164
Branch develop

`info: Ombi.Schedule.Jobs.Plex.PlexContentSync[0]

  Finished Plex Content Cacher, with processed content: 0, episodes: 0. Recently Added Scan: True

fail: Ombi.Api.Api[1000]

  StatusCode: BadRequest, Reason: Bad Request, RequestUri: http://192.168.1.redacted:8989/api/series/

fail: Ombi.Api.Api[1000]

  StatusCode: BadRequest, Reason: Bad Request, RequestUri: http://192.168.1.redacted:8989/api/series/

fail: Ombi.Api.Api[1000]

  StatusCode: BadRequest, Reason: Bad Request, RequestUri: http://192.168.1.redacted:8989/api/series/0`

Reading through this I checked connectivity between ombi an sonarr all seems to be working and correct. I tried changing the root folder under the ombi list request page (the correct folders from sonarr are correctly listed in ombi). Let me know if you need something more. Incidentally any requests always hang in processing(even though they are downloaded and made available in plex) and never are automatically marked as available in the request list page). My newsletter never lists movies only tv shows. I mention the last 2 issues only bc I dont know if they might be related in your mind. Ombi is primarily ,at least for me, a way for requests to happen and I'm happy to have it. I'm just not sure how people corrected this problem since it seems now it cant handle requests?

@henkisdabro
Copy link

I experience the problem too as of today, with the Ombi.Api.Api[1000] error messages. I'm using Sonarr v3 nightly, latest version as of today and I managed to resolve the errors by simply unchecking the "V3" box in the Ombi Settings>TV>Sonarr settings page and settings the Base URL to / (from previously empty). After doing this, requests started working and shows pop up inside Sonarr accordingly – I was then even able to go back to Ombi settings and change the settings back again to enable "V3" and clearing the Base URL box, and it still works!

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

No branches or pull requests

8 participants