Conversion not working anymore

[GnaXi 2]

Hi,

I have sooo many things queued up for conversion because it simply doesn't work anymore.
I've tried to start the task manually several times, but it just stops after a little while.

In the log I've been able to find this:

2022-01-16 18:54:18.512 Error App: Error in DummySeasonProvider
	*** Error Report ***
	Version: 4.7.0.20
	Command line: /system/EmbyServer.dll -programdata /config -ffdetect /bin/ffdetect -ffmpeg /bin/ffmpeg -ffprobe /bin/ffprobe -restartexitcode 3
	Operating system: Linux version 3.10.108 (root@build15) (gcc version 7.5.0 (GCC) ) #42218 SMP Fri Sep 24 02:39:43 CST 2021
	Framework: .NET 6.0.0-rtm.21522.10
	OS/Process: x64/x64
	Runtime: system/System.Private.CoreLib.dll
	Processor count: 4
	Data path: /config
	Application path: /system
	MediaBrowser.Model.Net.HttpException: MediaBrowser.Model.Net.HttpException: BadGateway
	   at Emby.Server.Implementations.HttpClientManager.CoreHttpClientManager.SendAsyncInternal(HttpRequestOptions options, String httpMethod)
	   at Emby.Server.Implementations.HttpClientManager.CoreHttpClientManager.SendAsync(HttpRequestOptions options, String httpMethod)
	   at Tvdb.EntryPoint.GetResponse(HttpRequestOptions request, String method)
	   at Tvdb.TvdbEpisodeProvider.FetchMainResult(String seriesId, String seasonType, CancellationToken cancellationToken)
	   at Tvdb.TvdbEpisodeProvider.DownloadEpisodesInfo(String id, String seasonType, CancellationToken cancellationToken)
	   at Tvdb.TvdbSeriesProvider.GetAllEpisodes(SeriesInfo seriesInfo, CancellationToken cancellationToken)
	   at MediaBrowser.Providers.TV.MissingEpisodeProvider.Run(Series series, LibraryOptions libraryOptions, Boolean addNewItems, IDirectoryService directoryService, CancellationToken cancellationToken)
	   at MediaBrowser.Providers.TV.SeriesMetadataService.AfterMetadataRefresh(Series item, LibraryOptions libraryOptions, MetadataRefreshOptions refreshOptions, CancellationToken cancellationToken)
	Source: Emby.Server.Implementations
	TargetSite: Void MoveNext()

This seems to happen every time the conversion task is run. Is this what is ending it? And anyone have any idea what I can do to fix it?

[Luke 37029]

HI there, please go over an example and attach the complete emby server log. thanks.

[GnaXi 2]

12 minutes ago, Luke said:

HI there, please go over an example and attach the complete emby server log. thanks.

Hi Luke,
Absolutely!

So I have these two permanent conversion roles set up:

As you can see, there is a bunch of stuff waiting in there.
They both have the following settings:

And previously when adding new content, they would be working great. Sometimes I would go over to Scheduled Tasks to run "Convert media" and Transfer media" manually, if I didn't want to wait for them to trigger automatically.
However, even when running them manually now, they do not run for very long and do not clear the queue:

Find the full embyserver log attached as requested.

EDIT: I also removed the conversions and set them up from scratch, but issue remains the same.

embyserver.txt

Edited January 16, 2022 by GnaXi

[Luke 37029]

Did you try running the convert media scheduled task? The default schedule for this task is every three hours, so based on this, it looks like you may have configured a specific schedule for it:

2022-01-16 12:53:33.027 Info TaskManager: Daily trigger for Convert media set to fire at 01/17/2022 00:00:00, which is 666.44954255 minutes from now.

And you may have forgotten hat you did that, and that's why it's not running.

[GnaXi 2]

6 hours ago, Luke said:

Did you try running the convert media scheduled task? The default schedule for this task is every three hours, so based on this, it looks like you may have configured a specific schedule for it:

2022-01-16 12:53:33.027 Info TaskManager: Daily trigger for Convert media set to fire at 01/17/2022 00:00:00, which is 666.44954255 minutes from now.

And you may have forgotten hat you did that, and that's why it's not running.

10 hours ago, GnaXi said:

However, even when running them manually now, they do not run for very long and do not clear the queue

I hate to quote myself, but this is one thing that I already answered

 

Edited January 17, 2022 by GnaXi

[Luke 37029]

8 hours ago, GnaXi said:

I hate to quote myself, but this is one thing that I already answered

 

Server log from that?

[GnaXi 2]

49 minutes ago, Luke said:

Server log from that?

I had just performed a manual task run before I downloaded the first server log.

[Luke 37029]

It looks like it did convert a video:

2022-01-16 17:08:07.961 Info MediaProbeManager: ProcessRun 'ffprobe' Execute: /bin/ffprobe -i file:"/config/sync/49/2378187/fceb2e67-f0e1-4575-8e6d-beb4336e2ffb.mp4" -threads 0 -v info -print_format json -show_streams -show_format -show_data
2022-01-16 17:08:08.203 Info MediaProbeManager: ProcessRun 'ffprobe' Process exited with code 0
2022-01-16 17:08:08.458 Info SubtitleEncoder: ProcessRun 'ffmpeg-subtitle_convert' Execute: /bin/ffmpeg  -sub_charenc windows-1252 -i file:"/video/movies/The Avengers [2012]/The.Avengers.2012.720p.BluRay.DTS.x264-LEGi0N (original).subscene.378334252385b72dd45c4c88155948a8.Danish.srt" "/config/cache/temp/57f9293dbd5a409bbaa695350cd4e6f0.vtt"
2022-01-16 17:08:08.667 Info SubtitleEncoder: ProcessRun 'ffmpeg-subtitle_convert' Process exited with code 0
2022-01-16 17:08:08.714 Info SubtitleEncoder: ffmpeg subtitle conversion took {0:n0}ms for /video/movies/The Avengers [2012]/The.Avengers.2012.720p.BluRay.DTS.x264-LEGi0N (original).subscene.378334252385b72dd45c4c88155948a8.Danish.srt
2022-01-16 17:08:09.027 Info VideoEncoder: ProcessRun 'Encoding edd43c' Execute: /bin/ffmpeg -loglevel +timing -y -print_graphs_file "/config/logs/ffmpeg-directstream-edd43ca4-c312-4d28-9eaf-2a10df522db8_1graph.txt" -copyts -start_at_zero -f mp4 -c:v:0 h264 -i "/video/movies/Harry Potter - Goblet Of Fire [2005]/Harry Potter - Goblet Of Fire [2005] (high).mp4" -map 0:0 -map 0:1 -sn -c:v:0 copy -c:a:0 copy -disposition:a:0 default -avoid_negative_ts disabled -f mp4 -map_metadata -1 -map_chapters -1 "/config/sync/49/2378190/edd43ca4-c312-4d28-9eaf-2a10df522db8.mp4"
2022-01-16 17:08:24.091 Info VideoEncoder: AppendExtraLogData - Read graph file: /config/logs/ffmpeg-directstream-edd43ca4-c312-4d28-9eaf-2a10df522db8_1graph.txt
2022-01-16 17:08:24.091 Info VideoEncoder: AppendExtraLogData - Deserialized GraphData fileStream: {0:n} bytes Graph Count: 0
2022-01-16 17:08:24.091 Info VideoEncoder: AppendExtraLogData - File Deleted
2022-01-16 17:08:24.094 Info VideoEncoder: ProcessRun 'Encoding edd43c' Process exited with code 0
2022-01-16 17:08:24.094 Info MediaProbeManager: ProcessRun 'ffprobe' Execute: /bin/ffprobe -i file:"/config/sync/49/2378190/edd43ca4-c312-4d28-9eaf-2a10df522db8.mp4" -threads 0 -v info -print_format json -show_streams -show_format -show_data
2022-01-16 17:08:24.344 Info MediaProbeManager: ProcessRun 'ffprobe' Process exited with code 0
2022-01-16 17:08:24.399 Info SubtitleEncoder: ProcessRun 'ffmpeg-subtitle_convert' Execute: /bin/ffmpeg  -sub_charenc utf-8 -i file:"/video/movies/Harry Potter - Goblet Of Fire [2005]/Harry Potter - Goblet Of Fire [2005] (high).subscene.0bd4ff53ab4367c876b3368190cc94c1.English.srt" "/config/cache/temp/daff6ef51abf4ea1afcc9aa95562ba10.vtt"
2022-01-16 17:08:24.547 Info SubtitleEncoder: ProcessRun 'ffmpeg-subtitle_convert' Process exited with code 0
2022-01-16 17:08:24.569 Info SubtitleEncoder: ffmpeg subtitle conversion took {0:n0}ms for /video/movies/Harry Potter - Goblet Of Fire [2005]/Harry Potter - Goblet Of Fire [2005] (high).subscene.0bd4ff53ab4367c876b3368190cc94c1.English.srt
2022-01-16 17:10:45.119 Info SessionManager: Session 0c59b1dc17fef7ccee42aa41af264f12 has gone idle while playing
2022-01-16 17:10:45.119 Info SessionManager: Playback stopped reported by app Emby for Android 3.2.34 playing The Flaming Spittoon Acquisition. Stopped at 591473 ms
2022-01-16 17:10:45.120 Info PlaybackReporting - EventMonitorEntryPoint: _sessionManager_PlaybackStop : Entered
2022-01-16 17:10:45.120 Info PlaybackReporting - EventMonitorEntryPoint: Saving final duration for Item : 6c9600f53b1a0eba-4cf43da0d93647ca85272a71a0e0ae2a-165494
2022-01-16 17:10:45.483 Info PlaybackReporting - EventMonitorEntryPoint: Removing Old Key from playback_trackers : 6c9600f53b1a0eba-4cf43da0d93647ca85272a71a0e0ae2a-165494
2022-01-16 17:18:35.942 Info HttpClient: GET https://api.github.com/repos/MediaBrowser/Emby.Releases/releases
2022-01-16 17:32:01.631 Info App: Emby Media Converter copying file from /config/sync/49/2378187/fceb2e67-f0e1-4575-8e6d-beb4336e2ffb.mp4 to /video/movies/The Avengers [2012]/The.Avengers.2012.720p.BluRay.DTS.x264-LEGi0N (original).mp4
2022-01-16 17:33:24.717 Info App: Emby Media Converter copying file from /config/sync/49/2378187/8bbbc2ae5f8d40f689ccdd0ed2296136.vtt to /video/movies/The Avengers [2012]/The.Avengers.2012.720p.BluRay.DTS.x264-LEGi0N (original).dan.vtt
2022-01-16 17:33:24.881 Info App: ReportSyncJobItemTransferred 2378187
2022-01-16 17:33:24.883 Info App: Deleting temporary sync directory /config/sync/49/2378187
2022-01-16 17:33:26.374 Info App: Emby Media Converter copying file from /config/sync/49/2378190/edd43ca4-c312-4d28-9eaf-2a10df522db8.mp4 to /video/movies/Harry Potter - Goblet Of Fire [2005]/Harry Potter - Goblet Of Fire [2005] (high).mp4
2022-01-16 17:33:54.752 Info App: Emby Media Converter copying file from /config/sync/49/2378190/124f9f5deb5a40299b67a96798b8066b.vtt to /video/movies/Harry Potter - Goblet Of Fire [2005]/Harry Potter - Goblet Of Fire [2005] (high).eng.vtt
2022-01-16 17:33:54.831 Info App: ReportSyncJobItemTransferred 2378190
2022-01-16 17:33:54.833 Info App: Deleting temporary sync directory /config/sync/49/2378190
2022-01-16 17:35:09.764 Info LibraryMonitor: The Avengers (/video/movies/The Avengers [2012]/The.Avengers.2012.720p.BluRay.DTS.x264-LEGi0N (original).mp4) will be refreshed.

 

[GnaXi 2]

Interesting. It is still stuck in there though:

I have tried to run the "Transfer media" task, but it stays there.

[Luke 37029]

Stuck in where?

[GnaXi 2]

2 hours ago, Luke said:

Stuck in where?

In conversions:

Not to be rude or anything, but how well do you know your own software? It seems like I keep repeating myself here about some very basic features of your software O_o'

[ebr 14905]

Hi.  It looks to me like those items are in their completed state...

[GnaXi 2]

3 hours ago, ebr said:

Hi.  It looks to me like those items are in their completed state...

But then I wonder why they are not removed from the list? That is how it used to work at least.
I've been using Emby for years and never had any issues with the automatic conversion feature until now.

[Luke 37029]

It's never been like that, unless you remove them manually. That screen is meant to be an activity log.

[GnaXi 2]

6 hours ago, Luke said:

It's never been like that, unless you remove them manually. That screen is meant to be an activity log.

That is a surprise to me to be completely honest with you.
I've used this feature for several years now in more than one instance of Emby and they have all worked the same up until now.
When a title has been converted and both the conversion and transfer media tasks was run, they would disappear from the list.

And I can say for certain that not everything has been handled, as I have over 200 things waiting to be converted and nothing is happening.

[GnaXi 2]

Also, I'd like to mention that if I remove the conversion setup and re-add it, the same movies end up on the list, confirming that they are not actually being converted.

[GnaXi 2]

My media is still not being converted. Any ideas?

[Luke 37029]

3 hours ago, GnaXi said:

My media is still not being converted. Any ideas?

What exactly are you expecting to be converted?