[SOLVED] problem with burned-in subtitles
Now I'm facing a problem with subtitles.
As far as I understand now with v.1.2 they should be supported for all devices, but I can't get them working on my Philips HTS5563/12 Home theatre.
Here you find my DEBUG log and my settings, con you help me please?
Please note that I'm using "Philips (2010-)" profile, while the log says Resource request accepted. Using client 'Identifier=192.168.1.50, Profile=Generic DLNA profile'
When recording the log I was using "G:\TEMP" as Transcoded file location. I had changed it few minutes earlier, restarting service and server.
Still, the log reports serviio looking for a file in 'C:\Windows\TEMP\Serviio\'
Thanks
Edit: forgot to say that HTS returns me the error "file not supported" while without burning subs it plays perfectly.
I'm on Windows 7, serviio 1.2, ffmpeg updated with yesterday's download (same result with the one bundled with serviio anyway)
- Code:
2013-03-14 09:39:32,111 DEBUG [WebServer] Incoming connection from /192.168.1.50:40579
2013-03-14 09:39:32,111 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.50
2013-03-14 09:39:32,112 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#Browse"' from 192.168.1.50
2013-03-14 09:39:32,112 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.50
2013-03-14 09:39:32,115 DEBUG [ContentDirectory] Browse() called for renderer Unrecognized device (profile 1) with parameters: objectID = V_F^FOL_R2$F5027$MI49842, browseFlag = BrowseMetadata, filter = res,res@resolution,res@protocolInfo,res@size,res@duration,res@bitrate,res@sampleFrequency,res@bitsPerSample,res@nrAudioChannels,res@protection,dc:creator,dc:date,upnp:genre,upnp:album,upnp:originalTrackNumber,upnp:channelNr,upnp:scheduledStartTime,upnp:scheduledEndTime,upnp:icon,upnp:albumArtURI,upnp:artist,container@childCount, startIndex = 0, count = 1, sortCriteria =
2013-03-14 09:39:32,115 DEBUG [AccessGroupDAOImpl] Reading a AccessGroup (id = 1)
2013-03-14 09:39:32,115 DEBUG [LocalContentCacheDecorator] Found entry in the cache (local_default), returning it
2013-03-14 09:39:32,118 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message
2013-03-14 09:39:32,124 DEBUG [WebServer] Incoming connection from /192.168.1.50:40580
2013-03-14 09:39:32,124 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.50
2013-03-14 09:39:32,124 DEBUG [ResourceTransportRequestHandler] GET /resource/49842/MEDIA_ITEM/MPEG_PS_PAL-0/ORIGINAL HTTP/1.1, headers = [HOST: 192.168.1.2:8895,DATE: Thu, 14 Mar 2013 09:40:03 GMT,CONNECTION: Keep-Alive,USER-AGENT: IPI/1.0 UPnP/1.0 DLNADOC/1.50,friendlyName.dlna.org: BD-Player,transferMode.dlna.org: Streaming,TimeSeekRange.dlna.org: npt=0-]]
2013-03-14 09:39:32,124 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.50
2013-03-14 09:39:32,124 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'Identifier=192.168.1.50, Profile=Generic DLNA profile'
2013-03-14 09:39:32,125 DEBUG [ResourceDeliveryProcessor] Request for resource 49842 and type 'MEDIA_ITEM' received
2013-03-14 09:39:32,125 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 49842 (local)
2013-03-14 09:39:32,125 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 49842)
2013-03-14 09:39:32,125 DEBUG [VideoDAOImpl] Reading a Video (id = 49842)
2013-03-14 09:39:32,125 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 49842, format MPEG_PS_PAL and profile Generic DLNA profile
2013-03-14 09:39:32,125 DEBUG [MediaItemDAOImpl] Getting file of media item 49842
2013-03-14 09:39:32,125 DEBUG [SubtitlesService] Found external subtitle file: F:\utorrent\Incoming\Looper (2012) [1080p]\Looper.2012.1080p.BluRay.x264.YIFY.srt
2013-03-14 09:39:32,125 DEBUG [MediaItemDAOImpl] Getting file of media item 49842
2013-03-14 09:39:32,125 DEBUG [SubtitlesService] Found external subtitle file: F:\utorrent\Incoming\Looper (2012) [1080p]\Looper.2012.1080p.BluRay.x264.YIFY.srt
2013-03-14 09:39:32,125 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file Looper.2012.1080p.BluRay.x264.YIFY.mp4
2013-03-14 09:39:32,125 DEBUG [MediaItemDAOImpl] Getting file of media item 49842
2013-03-14 09:39:32,125 DEBUG [SubtitlesService] Found external subtitle file: F:\utorrent\Incoming\Looper (2012) [1080p]\Looper.2012.1080p.BluRay.x264.YIFY.srt
2013-03-14 09:39:32,125 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file Looper.2012.1080p.BluRay.x264.YIFY.mp4: MPEG_PS_PAL
2013-03-14 09:39:32,125 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file Looper.2012.1080p.BluRay.x264.YIFY.mp4: MPEG_PS_NTSC
2013-03-14 09:39:32,125 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 49842 (local)
2013-03-14 09:39:32,125 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 49842)
2013-03-14 09:39:32,125 DEBUG [VideoDAOImpl] Reading a Video (id = 49842)
2013-03-14 09:39:32,126 DEBUG [VideoDeliveryEngine] Delivering item '49842' for client 'Identifier=192.168.1.50, Profile=Generic DLNA profile'
2013-03-14 09:39:32,126 DEBUG [MediaItemDAOImpl] Getting file of media item 49842
2013-03-14 09:39:32,126 DEBUG [SubtitlesService] Found external subtitle file: F:\utorrent\Incoming\Looper (2012) [1080p]\Looper.2012.1080p.BluRay.x264.YIFY.srt
2013-03-14 09:39:32,126 DEBUG [MediaItemDAOImpl] Getting file of media item 49842
2013-03-14 09:39:32,126 DEBUG [SubtitlesService] Found external subtitle file: F:\utorrent\Incoming\Looper (2012) [1080p]\Looper.2012.1080p.BluRay.x264.YIFY.srt
2013-03-14 09:39:32,126 DEBUG [VideoDeliveryEngine] Delivering file 'Looper.2012.1080p.BluRay.x264.YIFY.mp4' using transcoding
2013-03-14 09:39:32,126 DEBUG [MediaItemDAOImpl] Getting file of media item 49842
2013-03-14 09:39:32,127 DEBUG [SubtitlesService] Found external subtitle file: F:\utorrent\Incoming\Looper (2012) [1080p]\Looper.2012.1080p.BluRay.x264.YIFY.srt
2013-03-14 09:39:32,127 DEBUG [AbstractTranscodingDeliveryEngine] A suitable transcoding job already exists, re-use it for client 'Identifier=192.168.1.50, Profile=Generic DLNA profile'
2013-03-14 09:39:32,127 ERROR [ResourceTransportRequestHandler] Error while processing resource, sending back 500 error. Message: Transcoded file 'C:\Windows\TEMP\Serviio\transcoding-temp-49842-1-ORIGINAL-ff942a9a37341bd39749a8c17157c619.stf' cannot be found, FFmpeg execution probably failed
java.io.IOException: Transcoded file 'C:\Windows\TEMP\Serviio\transcoding-temp-49842-1-ORIGINAL-ff942a9a37341bd39749a8c17157c619.stf' cannot be found, FFmpeg execution probably failed
at org.serviio.delivery.resource.transcode.FileBasedTranscodingDeliveryStrategy.createInputStream(FileBasedTranscodingDeliveryStrategy.java:45)
at org.serviio.delivery.resource.transcode.AbstractTranscodingDeliveryEngine.retrieveTranscodedResource(AbstractTranscodingDeliveryEngine.java:131)
at org.serviio.delivery.resource.AbstractDeliveryEngine.deliver(AbstractDeliveryEngine.java:100)
at org.serviio.delivery.MediaResourceRetrievalStrategy.retrieveResource(MediaResourceRetrievalStrategy.java:120)
at org.serviio.delivery.GETMethodProcessor.retrieveResource(GETMethodProcessor.java:120)
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:80)
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:58)
at org.apache.http.protocol.HttpService.handleRequest(HttpService.java:212)
at org.serviio.upnp.webserver.WebServer$WorkerThread.run(WebServer.java:192)
2013-03-14 09:39:32,232 DEBUG [WebServer] Incoming connection from /192.168.1.50:40581
2013-03-14 09:39:32,232 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.50
2013-03-14 09:39:32,233 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#Browse"' from 192.168.1.50
2013-03-14 09:39:32,233 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.50
2013-03-14 09:39:32,236 DEBUG [ContentDirectory] Browse() called for renderer Unrecognized device (profile 1) with parameters: objectID = V_F^FOL_R2$F5027$MI49842, browseFlag = BrowseMetadata, filter = res,res@resolution,res@protocolInfo,res@size,res@duration,res@bitrate,res@sampleFrequency,res@bitsPerSample,res@nrAudioChannels,res@protection,dc:creator,dc:date,upnp:genre,upnp:album,upnp:originalTrackNumber,upnp:channelNr,upnp:scheduledStartTime,upnp:scheduledEndTime,upnp:icon,upnp:albumArtURI,upnp:artist,container@childCount, startIndex = 0, count = 1, sortCriteria =
2013-03-14 09:39:32,236 DEBUG [AccessGroupDAOImpl] Reading a AccessGroup (id = 1)
2013-03-14 09:39:32,236 DEBUG [LocalContentCacheDecorator] Found entry in the cache (local_default), returning it
2013-03-14 09:39:32,239 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message
2013-03-14 09:39:39,537 DEBUG [ActionsServerResource] Action with name 'stopServer' was requested
2013-03-14 09:39:39,537 DEBUG [DiscoveryManager] UPNP device 83403509-60a4-3ac0-bae1-94340baf2344 (192.168.1.2) is unavailable
2013-03-14 09:39:39,537 DEBUG [WebServer] Socket closed
2013-03-14 09:39:39,538 INFO [WebServer] WebServer shutting down
2013-03-14 09:39:39,537 INFO [EventDispatcher] Leaving EventDispatcher
2013-03-14 09:39:39,537 INFO [DiscoveryAdvertisementNotifier] Leaving DiscoveryAdvertisementNotifier
2013-03-14 09:39:39,537 DEBUG [DiscoverySSDPMessageListener] Socket closed: socket closed
2013-03-14 09:39:39,538 INFO [DiscoverySSDPMessageListener] Leaving DiscoverySSDPMessageListener
2013-03-14 09:39:39,538 INFO [EventSubscriptionExpirationChecker] Leaving EventSubscriptionExpirationChecker, removing all event subscriptions
2013-03-14 09:39:39,538 DEBUG [EventSubscriptionExpirationChecker] Removed subscription 17717107-382b-4263-bb88-dd07da0d7383 from service urn:upnp-org:serviceId:ConnectionManager
2013-03-14 09:39:39,538 DEBUG [EventSubscriptionExpirationChecker] Removed subscription 5e7a20e8-f358-49eb-a13f-5dbb2b697d5f from service urn:upnp-org:serviceId:ContentDirectory
2013-03-14 09:39:39,538 DEBUG [EventSubscriptionExpirationChecker] Removed subscription 306c4a2a-b31d-4f38-8fb6-76dc38940ecb from service urn:microsoft.com:serviceId:X_MS_MediaReceiverRegistrar
2013-03-14 09:39:39,720 DEBUG [DiscoveryAdvertisementNotifier] Multicasting SSDP byebye using interface eth9 (D-Link DGE-528T Gigabit Ethernet Adapter) and address PC-FISSO, timeout = 0