Subtitles Serviio 1.3

Hi all,

Been using serviio for a really long time. In 1.2 subtitles were working great, but after 1.3 update there are issues.

Subtitles work in the mediabrowser and serviigo. Subtitles won't work on all other devices (xbox360, sony bravia 2010). In fact, when I have subtitles burned in none of the videos will play and I get a can't connect to server. I have the path to ffmpeg in the serviio.sh java opts section. I have tested with file that i know work with subtitles and get the same problem.

My system:
AMD quad
25 GB ram
UBUNTU 12.10
custom ffmpeg build from latest source

In trying to get to the root cause and looking at the debug log I noticed something.

Serviio is running this command fo ffmpeg:

/usr/local/bin/ffmpeg -threads auto -i /media/Media/Anime/So, I Can't Play H! (2012)/Season 01/So, I Can't Play H! - 1x01 - Red String of Fate.mkv -y -threads auto -c:v mpeg2video -b:v 17000k -maxrate:v 17000k -bufsize:v 17000k -vf subtitles=filename="/media/Media/Anime/So\, I Can\\\\\'t Play H! (2012)/Season 01/So\, I Can\\\\\'t Play H! - 1x01 - Red String of Fate.ass":original_size=1280x720:charenc=UTF-8 -r 24000/1001 -g 15 -c:a ac3 -b:a 384k -ac 2 -map 0:0 -map 0:1 -sn -f mpegts /tmp/Serviio/transcoding-temp-3273-sony2010-ORIGINAL-81c7e2389b8d110fb1be126020d1a33b.stf

when I try to run this command, it doesn't work because the sourcce movie file isn't in quotes. If I run this command:

/usr/local/bin/ffmpeg -threads auto -i "/media/Media/Anime/So, I Can't Play H! (2012)/Season 01/So, I Can't Play H! - 1x01 - Red String of Fate.mkv" -y -threads auto -c:v mpeg2video -b:v 17000k -maxrate:v 17000k -bufsize:v 17000k -vf subtitles=filename="/media/Media/Anime/So\, I Can\\\\\'t Play H! (2012)/Season 01/So\, I Can\\\\\'t Play H! - 1x01 - Red String of Fate.ass":original_size=1280x720:charenc=UTF-8 -r 24000/1001 -g 15 -c:a ac3 -b:a 384k -ac 2 -map 0:0 -map 0:1 -sn -f mpegts /tmp/Serviio/transcoding-temp-3273-sony2010-ORIGINAL-81c7e2389b8d110fb1be126020d1a33b.stf

it does work. Can any one verify?

Thanks,

Karnith

** Update ** I turned subtitles off and used the above ffmpeg command to create a new mkv. Subtitles are burned into the movie and when watched on the devices works. There must be a problem with how Serviio is giving the ffmpeg commands.

here is the full debug log:

  Code:

2013-08-17 07:08:43,738 DEBUG [ServiioHttpService] Incoming request from /192.168.1.1:59464: GET /resource/3273/MEDIA_ITEM/MPEG_TS_SD_NA_ISO-0/ORIGINAL HTTP/1.1, headers = [TimeSeekRange.dlna.org: npt=0.000-,getcontentFeatures.dlna.org: 1,Pragma: getIfoFileURI.dlna.org,transferMode.dlna.org: Streaming,X-AV-Physical-Unit-Info: pa="BRAVIA KDL-52NX800";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-52NX800"; mv="1.7";,Host: 192.168.1.14:8895]]
2013-08-17 07:08:43,738 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.1
2013-08-17 07:08:43,740 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.1
2013-08-17 07:08:43,744 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'Identifier=192.168.1.1, Profile=Sony Bravia TV (2010)'
2013-08-17 07:08:43,744 DEBUG [ResourceDeliveryProcessor] Request for resource 3273 and type 'MEDIA_ITEM' received
2013-08-17 07:08:43,744 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 3273 (local)
2013-08-17 07:08:43,744 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 3273)
2013-08-17 07:08:43,745 DEBUG [VideoDAOImpl] Reading a Video (id = 3273)
2013-08-17 07:08:43,746 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 3273, format MPEG_TS_SD_NA_ISO and profile Sony Bravia TV (2010)
2013-08-17 07:08:43,747 DEBUG [MediaItemDAOImpl] Getting file of media item 3273
2013-08-17 07:08:43,749 DEBUG [SubtitlesService] Found external subtitle file: /media/Media/Anime/So, I Can't Play H! (2012)/Season 01/So, I Can't Play H! - 1x01 - Red String of Fate.ass
2013-08-17 07:08:43,749 DEBUG [MediaItemDAOImpl] Getting file of media item 3273
2013-08-17 07:08:43,752 DEBUG [SubtitlesService] Found external subtitle file: /media/Media/Anime/So, I Can't Play H! (2012)/Season 01/So, I Can't Play H! - 1x01 - Red String of Fate.ass
2013-08-17 07:08:43,752 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file So, I Can't Play H! - 1x01 - Red String of Fate.mkv
2013-08-17 07:08:43,752 DEBUG [MediaItemDAOImpl] Getting file of media item 3273
2013-08-17 07:08:43,755 DEBUG [SubtitlesService] Found external subtitle file: /media/Media/Anime/So, I Can't Play H! (2012)/Season 01/So, I Can't Play H! - 1x01 - Red String of Fate.ass
2013-08-17 07:08:43,755 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file So, I Can't Play H! - 1x01 - Red String of Fate.mkv: MPEG_TS_SD_EU_ISO
2013-08-17 07:08:43,756 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file So, I Can't Play H! - 1x01 - Red String of Fate.mkv: MPEG_TS_SD_NA_ISO
2013-08-17 07:08:43,756 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file So, I Can't Play H! - 1x01 - Red String of Fate.mkv: MPEG_TS_SD_KO_ISO
2013-08-17 07:08:43,756 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 3273 (local)
2013-08-17 07:08:43,756 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 3273)
2013-08-17 07:08:43,757 DEBUG [VideoDAOImpl] Reading a Video (id = 3273)
2013-08-17 07:08:43,759 DEBUG [VideoDeliveryEngine] Delivering item '3273' for client 'Identifier=192.168.1.1, Profile=Sony Bravia TV (2010)'
2013-08-17 07:08:43,759 DEBUG [MediaItemDAOImpl] Getting file of media item 3273
2013-08-17 07:08:43,761 DEBUG [SubtitlesService] Found external subtitle file: /media/Media/Anime/So, I Can't Play H! (2012)/Season 01/So, I Can't Play H! - 1x01 - Red String of Fate.ass
2013-08-17 07:08:43,762 DEBUG [MediaItemDAOImpl] Getting file of media item 3273
2013-08-17 07:08:43,764 DEBUG [SubtitlesService] Found external subtitle file: /media/Media/Anime/So, I Can't Play H! (2012)/Season 01/So, I Can't Play H! - 1x01 - Red String of Fate.ass
2013-08-17 07:08:43,764 DEBUG [VideoDeliveryEngine] Delivering file 'So, I Can't Play H! - 1x01 - Red String of Fate.mkv' using transcoding
2013-08-17 07:08:43,765 DEBUG [MediaItemDAOImpl] Getting file of media item 3273
2013-08-17 07:08:43,767 DEBUG [SubtitlesService] Found external subtitle file: /media/Media/Anime/So, I Can't Play H! (2012)/Season 01/So, I Can't Play H! - 1x01 - Red String of Fate.ass
2013-08-17 07:08:43,784 DEBUG [AbstractTranscodingDeliveryEngine] No suitable transcoding job exists yet, start one for client 'Identifier=192.168.1.1, Profile=Sony Bravia TV (2010)'
2013-08-17 07:08:43,784 DEBUG [MediaItemDAOImpl] Getting file of media item 3273
2013-08-17 07:08:43,787 DEBUG [FFMPEGWrapper] Invoking FFmpeg to transcode video file: /media/Media/Anime/So, I Can't Play H! (2012)/Season 01/So, I Can't Play H! - 1x01 - Red String of Fate.mkv
2013-08-17 07:08:43,789 DEBUG [ProcessExecutor] Starting /usr/local/bin/ffmpeg -threads auto -i /media/Media/Anime/So, I Can't Play H! (2012)/Season 01/So, I Can't Play H! - 1x01 - Red String of Fate.mkv -y -threads auto -c:v mpeg2video -b:v 17000k -maxrate:v 17000k -bufsize:v 17000k -vf subtitles=filename="/media/Media/Anime/So\, I Can\\\\\'t Play H! (2012)/Season 01/So\, I Can\\\\\'t Play H! - 1x01 - Red String of Fate.ass":original_size=1280x720:charenc=UTF-8 -r 24000/1001 -g 15 -c:a ac3 -b:a 384k -ac 2 -map 0:0 -map 0:1 -sn -f mpegts /tmp/Serviio/transcoding-temp-3273-sony2010-ORIGINAL-81c7e2389b8d110fb1be126020d1a33b.stf
2013-08-17 07:08:44,160 WARN  [ProcessExecutor] Process /usr/local/bin/ffmpeg has a return code of 1! This is a possible error. Detailed output follows.
filename        : KGShadowOfTheDay.ttf
mimetype        : application/x-truetype-font
[Parsed_subtitles_0 @ 0x325d280] Unable to open "/media/Media/Anime/So, I Can\t Play H! (2012)/Season 01/So, I Can\\t Play H! - 1x01 - Red String of Fate.ass"
[AVFilterGraph @ 0x32ee6a0] Error initializing filter 'subtitles' with args 'filename="/media/Media/Anime/So, I Can\\'t Play H! (2012)/Season 01/So, I Can\\'t Play H! - 1x01 - Red String of Fate.ass":original_size=1280x720:charenc=UTF-8'
Error opening filters!
2013-08-17 07:08:44,160 DEBUG [TranscodingJobListener] Transcoding finished; successful: false
2013-08-17 07:08:52,852 DEBUG [DiscoverySSDPMessageListener] Received a valid M-SEARCH message for search target urn:schemas-upnp-org:device:MediaServer:1 from address /192.168.1.11:49152s
2013-08-17 07:08:52,854 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s) to /192.168.1.11:49152
2013-08-17 07:08:52,856 DEBUG [DiscoverySSDPMessageListener] Received a valid M-SEARCH message for search target urn:schemas-upnp-org:device:MediaServer:1 from address /169.254.8.99:49152s
2013-08-17 07:08:52,857 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s) to /169.254.8.99:49152
2013-08-17 07:08:53,818 DEBUG [TranscodingJobListener] Deleted temp file '/tmp/Serviio/transcoding-temp-3273-sony2010-ORIGINAL-81c7e2389b8d110fb1be126020d1a33b.stf': true
2013-08-17 07:08:53,818 DEBUG [AbstractTranscodingDeliveryEngine] Removing transcoding listener with id transcoding-temp-3273-sony2010-ORIGINAL-81c7e2389b8d110fb1be126020d1a33b.stf
2013-08-17 07:08:53,818 ERROR [ResourceTransportRequestHandler] Error while processing resource, sending back 500 error. Message: FFmpeg execution failed
java.io.IOException: FFmpeg execution failed
   at org.serviio.delivery.resource.transcode.FileBasedTranscodingDeliveryStrategy.createInputStream(FileBasedTranscodingDeliveryStrategy.java:49)
   at org.serviio.delivery.resource.transcode.AbstractTranscodingDeliveryEngine.retrieveTranscodedResource(AbstractTranscodingDeliveryEngine.java:134)
   at org.serviio.delivery.resource.AbstractDeliveryEngine.deliver(AbstractDeliveryEngine.java:110)
   at org.serviio.delivery.MediaResourceRetrievalStrategy.retrieveResource(MediaResourceRetrievalStrategy.java:153)
   at org.serviio.delivery.GETMethodProcessor.retrieveResource(GETMethodProcessor.java:121)
   at org.serviio.delivery.GETMethodProcessor.buildDeliveryContainer(GETMethodProcessor.java:48)
   at org.serviio.delivery.AbstractMethodProcessor.handleRequest(AbstractMethodProcessor.java:100)
   at org.serviio.delivery.ResourceDeliveryProcessor.deliverContent(ResourceDeliveryProcessor.java:81)
   at org.serviio.upnp.webserver.ResourceTransportRequestHandler.handleRequest(ResourceTransportRequestHandler.java:86)
   at org.serviio.upnp.webserver.AbstractRequestHandler.handle(AbstractRequestHandler.java:61)
   at org.apache.http.protocol.HttpService.doService(HttpService.java:293)
   at org.serviio.upnp.webserver.ServiioHttpService.doService(ServiioHttpService.java:77)
   at org.apache.http.protocol.HttpService.handleRequest(HttpService.java:212)
   at org.serviio.upnp.webserver.WebServer$WorkerThread.run(WebServer.java:192)



[zip]

It will be fixed in 1.3.1