MKV subtitles not playing

Thu Oct 31, 2013 7:45 am by kitjai

Hi All,
thankyou for creating such a good piece of software. I have a minor issue which doesn't allow me to play embedded subtitles from my MKV file on PC running Serviio to my Sony Bravia KDLHX850.
The file plays well, however the subtitles dont show

The file is located on the same HDD that serviio runs on.

Could someone please help me?

Regards
Kitjai

here is the ffmpeg.exe -i on the file:

Code:: c:\Program Files\Serviio\lib>ffmpeg.exe -i "E:\Naruto\Shippuuden\[HorribleSubs] Naruto Shippuuden - 100 [480p].mkv" ffmpeg version N-57650-gcb52d6d Copyright (c) 2000-2013 the FFmpeg developers built on Oct 30 2013 20:29:47 with gcc 4.8.2 (GCC) configuration: --enable-gpl --enable-version3 --disable-w32threads --enable-av isynth --enable-bzlib --enable-fontconfig --enable-frei0r --enable-gnutls --enab le-iconv --enable-libass --enable-libbluray --enable-libcaca --enable-libfreetyp e --enable-libgsm --enable-libilbc --enable-libmodplug --enable-libmp3lame --ena ble-libopencore-amrnb --enable-libopencore-amrwb --enable-libopenjpeg --enable-l ibopus --enable-librtmp --enable-libschroedinger --enable-libsoxr --enable-libsp eex --enable-libtheora --enable-libtwolame --enable-libvidstab --enable-libvo-aa cenc --enable-libvo-amrwbenc --enable-libvorbis --enable-libvpx --enable-libwavp ack --enable-libx264 --enable-libxavs --enable-libxvid --enable-zlib libavutil 52. 48.100 / 52. 48.100 libavcodec 55. 39.100 / 55. 39.100 libavformat 55. 19.104 / 55. 19.104 libavdevice 55. 5.100 / 55. 5.100 libavfilter 3. 90.100 / 3. 90.100 libswscale 2. 5.101 / 2. 5.101 libswresample 0. 17.104 / 0. 17.104 libpostproc 52. 3.100 / 52. 3.100 Input #0, matroska,webm, from 'E:\Naruto\Shippuuden\[HorribleSubs] Naruto Shippu uden - 100 [480p].mkv': Metadata: creation_time : 2009-03-12 11:04:42 Duration: 00:23:11.08, start: 0.000000, bitrate: 729 kb/s Stream #0:0: Video: h264 (High), yuv420p, 848x480, SAR 171:170 DAR 3021:1700 , 23.98 fps, 23.98 tbr, 1k tbn, 47.95 tbc (default) Stream #0:1: Audio: aac, 44100 Hz, stereo, fltp (default) Stream #0:2: Subtitle: ssa (default) Codec 0x18000 is not in the full list. Stream #0:3: Attachment: unknown_codec Metadata: filename : BAARS___.TTF mimetype : application/x-truetype-font At least one output file must be specified c:\Program Files\Serviio\lib>

Here is a pic for the console:

Media info:

Code:: General Unique ID : 238328314325565291156943066798099079816 (0xB34C5D1C75679E49BCD9BC7109F92288) Complete name : E:\Naruto.mkv Format : Matroska Format version : Version 2 File size : 143 MiB Duration : 23mn 9s Overall bit rate : 866 Kbps Encoded date : UTC 2013-10-24 11:02:39 Writing application : mkvmerge v5.2.0 ('I can't explain') built on Dec 18 2011 18:12:03 Writing library : libebml v1.2.3 + libmatroska v1.3.0 Attachment : Yes Video ID : 1 Format : AVC Format/Info : Advanced Video Codec Format profile : Main@L3.1 Format settings, CABAC : Yes Format settings, ReFrames : 6 frames Codec ID : V_MPEG4/ISO/AVC Duration : 23mn 9s Nominal bit rate : 768 Kbps Width : 848 pixels Height : 480 pixels Display aspect ratio : 16:9 Frame rate mode : Constant Frame rate : 23.976 fps Color space : YUV Chroma subsampling : 4:2:0 Bit depth : 8 bits Scan type : Progressive Bits/(Pixel*Frame) : 0.079 Writing library : x264 core 120 r2120 0c7dab9 Encoding settings : cabac=1 / ref=6 / deblock=1:1:1 / analyse=0x1:0x111 / me=umh / subme=8 / psy=1 / psy_rd=0.40:0.00 / mixed_ref=1 / me_range=16 / chroma_me=1 / trellis=1 / 8x8dct=0 / cqm=0 / deadzone=21,11 / fast_pskip=1 / chroma_qp_offset=-2 / threads=4 / sliced_threads=0 / nr=0 / decimate=1 / interlaced=0 / bluray_compat=0 / constrained_intra=0 / bframes=3 / b_pyramid=2 / b_adapt=2 / b_bias=0 / direct=3 / weightb=1 / open_gop=0 / weightp=2 / keyint=250 / keyint_min=23 / scenecut=40 / intra_refresh=0 / rc_lookahead=50 / rc=2pass / mbtree=1 / bitrate=768 / ratetol=1.0 / qcomp=0.60 / qpmin=0 / qpmax=69 / qpstep=4 / cplxblur=20.0 / qblur=0.5 / vbv_maxrate=1536 / vbv_bufsize=3840 / nal_hrd=none / ip_ratio=1.40 / aq=1:0.60 Default : Yes Forced : Yes Audio ID : 2 Format : AAC Format/Info : Advanced Audio Codec Format profile : LC Codec ID : A_AAC Duration : 23mn 9s Channel(s) : 2 channels Channel positions : Front: L R Sampling rate : 44.1 KHz Compression mode : Lossy Default : Yes Forced : Yes Text ID : 3 Format : ASS Codec ID : S_TEXT/ASS Codec ID/Info : Advanced Sub Station Alpha Compression mode : Lossless Default : Yes Forced : Yes

Thanks Again

kitjai

Thu Oct 31, 2013 7:47 am by kitjai

detailed log:

Code:: 2013-10-31 18:38:39,917 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv 2013-10-31 18:38:39,917 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:39,919 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv: AVC_TS_MP_HD_AC3_ISO 2013-10-31 18:38:39,920 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: video/mpeg,Date: Thu, 31 Oct 2013 07:38:39 GMT,Server: Windows 7, UPnP/1.0 DLNADOC/1.50, Serviio/1.3.1,Cache-control: no-cache,contentFeatures.dlna.org: DLNA.ORG_PN=AVC_TS_HD_24_AC3_ISO;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]] 2013-10-31 18:38:39,926 DEBUG [ServiioHttpService] Incoming request from /192.168.1.4:49027: GET /resource/2388/MEDIA_ITEM/AVC_TS_MP_HD_AC3_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-55HX850";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-55HX850"; mv="1.7";,Host: 192.168.1.10:8895]] 2013-10-31 18:38:39,926 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 18:38:39,926 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 18:38:39,927 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:39,927 DEBUG [ResourceDeliveryProcessor] Request for resource 2388 and type 'MEDIA_ITEM' received 2013-10-31 18:38:39,927 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 2388 (local) 2013-10-31 18:38:39,927 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 2388) 2013-10-31 18:38:39,928 DEBUG [VideoDAOImpl] Reading a Video (id = 2388) 2013-10-31 18:38:39,928 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 2388, format AVC_TS_MP_HD_AC3_ISO and profile Sony Bravia TV (2012) 2013-10-31 18:38:39,928 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:39,930 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:39,931 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv 2013-10-31 18:38:39,931 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:39,933 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv: AVC_TS_MP_HD_AC3_ISO 2013-10-31 18:38:39,933 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 2388 (local) 2013-10-31 18:38:39,933 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 2388) 2013-10-31 18:38:39,933 DEBUG [VideoDAOImpl] Reading a Video (id = 2388) 2013-10-31 18:38:39,934 DEBUG [VideoDeliveryEngine] Delivering item '2388' for client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:39,934 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:39,935 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:39,937 DEBUG [VideoDeliveryEngine] Delivering file '[HorribleSubs] Naruto Shippuuden - 100 [480p].mkv' using transcoding 2013-10-31 18:38:39,937 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:39,938 DEBUG [AbstractTranscodingDeliveryEngine] No suitable transcoding job exists yet, start one for client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:39,939 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:39,940 DEBUG [FFMPEGWrapper] Invoking FFmpeg to transcode video file: E:\Naruto\Shippuuden\[HorribleSubs] Naruto Shippuuden - 100 [480p].mkv 2013-10-31 18:38:39,940 DEBUG [ProcessExecutor] Starting C:\Program Files\Serviio\bin\\..\lib/ffmpeg.exe -fflags +genpts -threads auto -i E:\Naruto\Shippuuden\[HorribleSubs] Naruto Shippuuden - 100 [480p].mkv -y -threads auto -c:v copy -bsf:v h264_mp4toannexb -c:a ac3 -b:a 384k -ac 2 -map 0:0 -map 0:1 -sn -f mpegts C:\Windows\TEMP\Serviio\transcoding-temp-2388-sony2012-ORIGINAL.stf 2013-10-31 18:38:40,440 DEBUG [FileBasedTranscodingDeliveryStrategy] Sending transcoding stream 2013-10-31 18:38:40,441 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:40,443 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv: AVC_TS_MP_HD_AC3_ISO 2013-10-31 18:38:40,443 DEBUG [MediaItemDAOImpl] Marking MediaItem (id = 2388) as read 2013-10-31 18:38:40,451 DEBUG [LocalContentCacheDecorator] Cleared cache (local_resetafterplay) 2013-10-31 18:38:40,451 DEBUG [GETMethodProcessor] Stream entity has length: 50000000000 2013-10-31 18:38:40,451 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer 2013-10-31 18:38:40,451 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: video/mpeg,Date: Thu, 31 Oct 2013 07:38:40 GMT,Server: Windows 7, UPnP/1.0 DLNADOC/1.50, Serviio/1.3.1,Cache-control: no-cache,TimeSeekRange.dlna.org: npt=0-1391/1391,contentFeatures.dlna.org: DLNA.ORG_PN=AVC_TS_HD_24_AC3_ISO;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]] 2013-10-31 18:38:42,651 DEBUG [WebServer] I/O error: Connection reset by peer: socket write error 2013-10-31 18:38:42,668 DEBUG [ServiioHttpService] Incoming request from /192.168.1.4:49028: GET /resource/2388/MEDIA_ITEM/AVC_TS_MP_HD_AC3_ISO-0/ORIGINAL HTTP/1.1, headers = [TimeSeekRange.dlna.org: npt=73.620-,getcontentFeatures.dlna.org: 1,Pragma: getIfoFileURI.dlna.org,transferMode.dlna.org: Streaming,X-AV-Physical-Unit-Info: pa="BRAVIA KDL-55HX850";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-55HX850"; mv="1.7";,Host: 192.168.1.10:8895]] 2013-10-31 18:38:42,669 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 18:38:42,669 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 18:38:42,669 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:42,669 DEBUG [ResourceDeliveryProcessor] Request for resource 2388 and type 'MEDIA_ITEM' received 2013-10-31 18:38:42,669 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 2388 (local) 2013-10-31 18:38:42,669 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 2388) 2013-10-31 18:38:42,669 DEBUG [VideoDAOImpl] Reading a Video (id = 2388) 2013-10-31 18:38:42,670 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 2388, format AVC_TS_MP_HD_AC3_ISO and profile Sony Bravia TV (2012) 2013-10-31 18:38:42,670 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:42,671 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:42,673 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv 2013-10-31 18:38:42,673 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:42,674 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv: AVC_TS_MP_HD_AC3_ISO 2013-10-31 18:38:42,674 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 2388 (local) 2013-10-31 18:38:42,674 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 2388) 2013-10-31 18:38:42,675 DEBUG [VideoDAOImpl] Reading a Video (id = 2388) 2013-10-31 18:38:42,675 DEBUG [VideoDeliveryEngine] Delivering item '2388' for client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:42,675 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:42,676 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:42,678 DEBUG [VideoDeliveryEngine] Delivering file '[HorribleSubs] Naruto Shippuuden - 100 [480p].mkv' using transcoding 2013-10-31 18:38:42,678 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:42,679 DEBUG [AbstractTranscodingDeliveryEngine] A suitable transcoding job already exists, re-use it for client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:42,679 DEBUG [FileBasedTranscodingDeliveryStrategy] Sending transcoding stream 2013-10-31 18:38:42,680 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:42,681 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv: AVC_TS_MP_HD_AC3_ISO 2013-10-31 18:38:42,682 DEBUG [GETMethodProcessor] Delivering bytes 11693056 - 50000000000 from transcoded file, based on time range 73.62 - 1391.0 2013-10-31 18:38:42,682 DEBUG [GETMethodProcessor] Stream entity has length: 50000000000 2013-10-31 18:38:42,682 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer 2013-10-31 18:38:42,682 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 206 Partial Content, headers = [[Content-Type: video/mpeg,Date: Thu, 31 Oct 2013 07:38:42 GMT,Server: Windows 7, UPnP/1.0 DLNADOC/1.50, Serviio/1.3.1,Cache-control: no-cache,TimeSeekRange.dlna.org: npt=73.62-1391/1391,contentFeatures.dlna.org: DLNA.ORG_PN=AVC_TS_HD_24_AC3_ISO;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]] 2013-10-31 18:38:50,782 DEBUG [WebServer] I/O error: Connection reset by peer: socket write error 2013-10-31 18:38:50,790 DEBUG [ServiioHttpService] Incoming request from /192.168.1.4:49029: GET /resource/2388/MEDIA_ITEM/AVC_TS_MP_HD_AC3_ISO-0/ORIGINAL HTTP/1.1, headers = [TimeSeekRange.dlna.org: npt=86.087-87.087,getcontentFeatures.dlna.org: 1,Pragma: getIfoFileURI.dlna.org,transferMode.dlna.org: Streaming,X-AV-Physical-Unit-Info: pa="BRAVIA KDL-55HX850";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-55HX850"; mv="1.7";,Host: 192.168.1.10:8895]] 2013-10-31 18:38:50,790 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 18:38:50,791 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 18:38:50,791 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:50,791 DEBUG [ResourceDeliveryProcessor] Request for resource 2388 and type 'MEDIA_ITEM' received 2013-10-31 18:38:50,791 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 2388 (local) 2013-10-31 18:38:50,791 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 2388) 2013-10-31 18:38:50,791 DEBUG [VideoDAOImpl] Reading a Video (id = 2388) 2013-10-31 18:38:50,791 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 2388, format AVC_TS_MP_HD_AC3_ISO and profile Sony Bravia TV (2012) 2013-10-31 18:38:50,791 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:50,793 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:50,794 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv 2013-10-31 18:38:50,794 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:50,796 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv: AVC_TS_MP_HD_AC3_ISO 2013-10-31 18:38:50,796 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 2388 (local) 2013-10-31 18:38:50,796 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 2388) 2013-10-31 18:38:50,796 DEBUG [VideoDAOImpl] Reading a Video (id = 2388) 2013-10-31 18:38:50,796 DEBUG [VideoDeliveryEngine] Delivering item '2388' for client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:50,796 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:50,798 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:50,799 DEBUG [VideoDeliveryEngine] Delivering file '[HorribleSubs] Naruto Shippuuden - 100 [480p].mkv' using transcoding 2013-10-31 18:38:50,799 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:50,801 DEBUG [AbstractTranscodingDeliveryEngine] A suitable transcoding job already exists, re-use it for client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:50,801 DEBUG [FileBasedTranscodingDeliveryStrategy] Sending transcoding stream 2013-10-31 18:38:50,801 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:50,802 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv: AVC_TS_MP_HD_AC3_ISO 2013-10-31 18:38:50,802 DEBUG [GETMethodProcessor] Delivering bytes 14597120 - 50000000000 from transcoded file, based on time range 86.087 - 87.087 2013-10-31 18:38:50,802 DEBUG [GETMethodProcessor] Stream entity has length: 50000000000 2013-10-31 18:38:50,803 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer 2013-10-31 18:38:50,803 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 206 Partial Content, headers = [[Content-Type: video/mpeg,Date: Thu, 31 Oct 2013 07:38:50 GMT,Server: Windows 7, UPnP/1.0 DLNADOC/1.50, Serviio/1.3.1,Cache-control: no-cache,TimeSeekRange.dlna.org: npt=86.087-87.087/1391,contentFeatures.dlna.org: DLNA.ORG_PN=AVC_TS_HD_24_AC3_ISO;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]] 2013-10-31 18:38:51,284 DEBUG [WebServer] I/O error: Connection reset by peer: socket write error 2013-10-31 18:38:51,285 DEBUG [ServiioHttpService] Incoming request from /192.168.1.4:49030: GET /resource/2388/MEDIA_ITEM/AVC_TS_MP_HD_AC3_ISO-0/ORIGINAL HTTP/1.1, headers = [TimeSeekRange.dlna.org: npt=91.087-92.087,getcontentFeatures.dlna.org: 1,Pragma: getIfoFileURI.dlna.org,transferMode.dlna.org: Streaming,X-AV-Physical-Unit-Info: pa="BRAVIA KDL-55HX850";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-55HX850"; mv="1.7";,Host: 192.168.1.10:8895]] 2013-10-31 18:38:51,285 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 18:38:51,285 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 18:38:51,285 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:51,285 DEBUG [ResourceDeliveryProcessor] Request for resource 2388 and type 'MEDIA_ITEM' received 2013-10-31 18:38:51,285 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 2388 (local) 2013-10-31 18:38:51,286 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 2388) 2013-10-31 18:38:51,286 DEBUG [VideoDAOImpl] Reading a Video (id = 2388) 2013-10-31 18:38:51,286 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 2388, format AVC_TS_MP_HD_AC3_ISO and profile Sony Bravia TV (2012) 2013-10-31 18:38:51,286 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:51,288 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:51,289 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv 2013-10-31 18:38:51,289 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:51,291 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv: AVC_TS_MP_HD_AC3_ISO 2013-10-31 18:38:51,291 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 2388 (local) 2013-10-31 18:38:51,291 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 2388) 2013-10-31 18:38:51,291 DEBUG [VideoDAOImpl] Reading a Video (id = 2388) 2013-10-31 18:38:51,292 DEBUG [VideoDeliveryEngine] Delivering item '2388' for client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:51,292 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:51,295 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:51,297 DEBUG [VideoDeliveryEngine] Delivering file '[HorribleSubs] Naruto Shippuuden - 100 [480p].mkv' using transcoding 2013-10-31 18:38:51,297 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:51,298 DEBUG [AbstractTranscodingDeliveryEngine] A suitable transcoding job already exists, re-use it for client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:51,346 DEBUG [FileBasedTranscodingDeliveryStrategy] Sending transcoding stream 2013-10-31 18:38:51,346 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:51,348 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv: AVC_TS_MP_HD_AC3_ISO 2013-10-31 18:38:51,348 DEBUG [GETMethodProcessor] Delivering bytes 15762432 - 50000000000 from transcoded file, based on time range 91.087 - 92.087 2013-10-31 18:38:51,348 DEBUG [GETMethodProcessor] Stream entity has length: 50000000000 2013-10-31 18:38:51,348 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer 2013-10-31 18:38:51,348 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 206 Partial Content, headers = [[Content-Type: video/mpeg,Date: Thu, 31 Oct 2013 07:38:51 GMT,Server: Windows 7, UPnP/1.0 DLNADOC/1.50, Serviio/1.3.1,Cache-control: no-cache,TimeSeekRange.dlna.org: npt=91.087-92.087/1391,contentFeatures.dlna.org: DLNA.ORG_PN=AVC_TS_HD_24_AC3_ISO;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]] 2013-10-31 18:38:51,781 DEBUG [WebServer] I/O error: Connection reset by peer: socket write error 2013-10-31 18:38:51,783 DEBUG [ServiioHttpService] Incoming request from /192.168.1.4:49031: GET /resource/2388/MEDIA_ITEM/AVC_TS_MP_HD_AC3_ISO-0/ORIGINAL HTTP/1.1, headers = [TimeSeekRange.dlna.org: npt=96.087-97.087,getcontentFeatures.dlna.org: 1,Pragma: getIfoFileURI.dlna.org,transferMode.dlna.org: Streaming,X-AV-Physical-Unit-Info: pa="BRAVIA KDL-55HX850";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-55HX850"; mv="1.7";,Host: 192.168.1.10:8895]] 2013-10-31 18:38:51,783 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 18:38:51,783 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 18:38:51,784 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:51,784 DEBUG [ResourceDeliveryProcessor] Request for resource 2388 and type 'MEDIA_ITEM' received 2013-10-31 18:38:51,784 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 2388 (local) 2013-10-31 18:38:51,784 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 2388) 2013-10-31 18:38:51,784 DEBUG [VideoDAOImpl] Reading a Video (id = 2388) 2013-10-31 18:38:51,784 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 2388, format AVC_TS_MP_HD_AC3_ISO and profile Sony Bravia TV (2012) 2013-10-31 18:38:51,784 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:51,786 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:51,787 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv 2013-10-31 18:38:51,787 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:51,789 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv: AVC_TS_MP_HD_AC3_ISO 2013-10-31 18:38:51,789 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 2388 (local) 2013-10-31 18:38:51,789 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 2388) 2013-10-31 18:38:51,789 DEBUG [VideoDAOImpl] Reading a Video (id = 2388) 2013-10-31 18:38:51,790 DEBUG [VideoDeliveryEngine] Delivering item '2388' for client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:51,790 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:51,791 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:51,793 DEBUG [VideoDeliveryEngine] Delivering file '[HorribleSubs] Naruto Shippuuden - 100 [480p].mkv' using transcoding 2013-10-31 18:38:51,793 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:51,794 DEBUG [AbstractTranscodingDeliveryEngine] A suitable transcoding job already exists, re-use it for client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:51,795 DEBUG [FileBasedTranscodingDeliveryStrategy] Sending transcoding stream 2013-10-31 18:38:51,795 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:51,796 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv: AVC_TS_MP_HD_AC3_ISO 2013-10-31 18:38:51,796 DEBUG [GETMethodProcessor] Delivering bytes 16927744 - 50000000000 from transcoded file, based on time range 96.087 - 97.087 2013-10-31 18:38:51,797 DEBUG [GETMethodProcessor] Stream entity has length: 50000000000 2013-10-31 18:38:51,797 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer 2013-10-31 18:38:51,797 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 206 Partial Content, headers = [[Content-Type: video/mpeg,Date: Thu, 31 Oct 2013 07:38:51 GMT,Server: Windows 7, UPnP/1.0 DLNADOC/1.50, Serviio/1.3.1,Cache-control: no-cache,TimeSeekRange.dlna.org: npt=96.087-97.087/1391,contentFeatures.dlna.org: DLNA.ORG_PN=AVC_TS_HD_24_AC3_ISO;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]] 2013-10-31 18:38:52,284 DEBUG [WebServer] I/O error: Connection reset by peer: socket write error 2013-10-31 18:38:52,285 DEBUG [ServiioHttpService] Incoming request from /192.168.1.4:49032: GET /resource/2388/MEDIA_ITEM/AVC_TS_MP_HD_AC3_ISO-0/ORIGINAL HTTP/1.1, headers = [TimeSeekRange.dlna.org: npt=101.087-102.087,getcontentFeatures.dlna.org: 1,Pragma: getIfoFileURI.dlna.org,transferMode.dlna.org: Streaming,X-AV-Physical-Unit-Info: pa="BRAVIA KDL-55HX850";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-55HX850"; mv="1.7";,Host: 192.168.1.10:8895]] 2013-10-31 18:38:52,285 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 18:38:52,285 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 18:38:52,285 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:52,285 DEBUG [ResourceDeliveryProcessor] Request for resource 2388 and type 'MEDIA_ITEM' received 2013-10-31 18:38:52,285 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 2388 (local) 2013-10-31 18:38:52,285 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 2388) 2013-10-31 18:38:52,286 DEBUG [VideoDAOImpl] Reading a Video (id = 2388) 2013-10-31 18:38:52,286 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 2388, format AVC_TS_MP_HD_AC3_ISO and profile Sony Bravia TV (2012) 2013-10-31 18:38:52,286 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:52,287 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:52,288 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv 2013-10-31 18:38:52,289 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:52,290 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv: AVC_TS_MP_HD_AC3_ISO 2013-10-31 18:38:52,290 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 2388 (local) 2013-10-31 18:38:52,290 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 2388) 2013-10-31 18:38:52,290 DEBUG [VideoDAOImpl] Reading a Video (id = 2388) 2013-10-31 18:38:52,291 DEBUG [VideoDeliveryEngine] Delivering item '2388' for client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:52,291 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:52,292 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:52,294 DEBUG [VideoDeliveryEngine] Delivering file '[HorribleSubs] Naruto Shippuuden - 100 [480p].mkv' using transcoding 2013-10-31 18:38:52,294 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:52,296 DEBUG [AbstractTranscodingDeliveryEngine] A suitable transcoding job already exists, re-use it for client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:52,296 DEBUG [FileBasedTranscodingDeliveryStrategy] Sending transcoding stream 2013-10-31 18:38:52,296 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:52,298 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv: AVC_TS_MP_HD_AC3_ISO 2013-10-31 18:38:52,298 DEBUG [GETMethodProcessor] Delivering bytes 18093056 - 50000000000 from transcoded file, based on time range 101.087 - 102.087 2013-10-31 18:38:52,298 DEBUG [GETMethodProcessor] Stream entity has length: 50000000000 2013-10-31 18:38:52,298 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer 2013-10-31 18:38:52,298 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 206 Partial Content, headers = [[Content-Type: video/mpeg,Date: Thu, 31 Oct 2013 07:38:52 GMT,Server: Windows 7, UPnP/1.0 DLNADOC/1.50, Serviio/1.3.1,Cache-control: no-cache,TimeSeekRange.dlna.org: npt=101.087-102.087/1391,contentFeatures.dlna.org: DLNA.ORG_PN=AVC_TS_HD_24_AC3_ISO;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]] 2013-10-31 18:38:52,783 DEBUG [WebServer] I/O error: Connection reset by peer: socket write error 2013-10-31 18:38:52,787 DEBUG [ServiioHttpService] Incoming request from /192.168.1.4:49033: GET /resource/2388/MEDIA_ITEM/AVC_TS_MP_HD_AC3_ISO-0/ORIGINAL HTTP/1.1, headers = [TimeSeekRange.dlna.org: npt=106.087-107.087,getcontentFeatures.dlna.org: 1,Pragma: getIfoFileURI.dlna.org,transferMode.dlna.org: Streaming,X-AV-Physical-Unit-Info: pa="BRAVIA KDL-55HX850";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-55HX850"; mv="1.7";,Host: 192.168.1.10:8895]] 2013-10-31 18:38:52,787 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 18:38:52,787 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 18:38:52,787 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:52,787 DEBUG [ResourceDeliveryProcessor] Request for resource 2388 and type 'MEDIA_ITEM' received 2013-10-31 18:38:52,787 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 2388 (local) 2013-10-31 18:38:52,787 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 2388) 2013-10-31 18:38:52,787 DEBUG [VideoDAOImpl] Reading a Video (id = 2388) 2013-10-31 18:38:52,788 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 2388, format AVC_TS_MP_HD_AC3_ISO and profile Sony Bravia TV (2012) 2013-10-31 18:38:52,788 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:52,789 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:52,791 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv 2013-10-31 18:38:52,791 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:52,792 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv: AVC_TS_MP_HD_AC3_ISO 2013-10-31 18:38:52,792 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 2388 (local) 2013-10-31 18:38:52,792 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 2388) 2013-10-31 18:38:52,792 DEBUG [VideoDAOImpl] Reading a Video (id = 2388) 2013-10-31 18:38:52,793 DEBUG [VideoDeliveryEngine] Delivering item '2388' for client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:52,793 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:52,794 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:52,796 DEBUG [VideoDeliveryEngine] Delivering file '[HorribleSubs] Naruto Shippuuden - 100 [480p].mkv' using transcoding 2013-10-31 18:38:52,796 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:52,797 DEBUG [AbstractTranscodingDeliveryEngine] A suitable transcoding job already exists, re-use it for client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:52,797 DEBUG [FileBasedTranscodingDeliveryStrategy] Sending transcoding stream 2013-10-31 18:38:52,797 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:52,799 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv: AVC_TS_MP_HD_AC3_ISO 2013-10-31 18:38:52,799 DEBUG [GETMethodProcessor] Delivering bytes 19257344 - 50000000000 from transcoded file, based on time range 106.087 - 107.087 2013-10-31 18:38:52,799 DEBUG [GETMethodProcessor] Stream entity has length: 50000000000 2013-10-31 18:38:52,799 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer 2013-10-31 18:38:52,799 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 206 Partial Content, headers = [[Content-Type: video/mpeg,Date: Thu, 31 Oct 2013 07:38:52 GMT,Server: Windows 7, UPnP/1.0 DLNADOC/1.50, Serviio/1.3.1,Cache-control: no-cache,TimeSeekRange.dlna.org: npt=106.087-107.087/1391,contentFeatures.dlna.org: DLNA.ORG_PN=AVC_TS_HD_24_AC3_ISO;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]] 2013-10-31 18:38:52,946 DEBUG [TranscodingJobListener] Transcoding finished; successful: true 2013-10-31 18:38:53,285 DEBUG [WebServer] I/O error: Connection reset by peer: socket write error 2013-10-31 18:38:53,286 DEBUG [ServiioHttpService] Incoming request from /192.168.1.4:49034: GET /resource/2388/MEDIA_ITEM/AVC_TS_MP_HD_AC3_ISO-0/ORIGINAL HTTP/1.1, headers = [TimeSeekRange.dlna.org: npt=111.087-112.087,getcontentFeatures.dlna.org: 1,Pragma: getIfoFileURI.dlna.org,transferMode.dlna.org: Streaming,X-AV-Physical-Unit-Info: pa="BRAVIA KDL-55HX850";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-55HX850"; mv="1.7";,Host: 192.168.1.10:8895]] 2013-10-31 18:38:53,287 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 18:38:53,287 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 18:38:53,287 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:53,287 DEBUG [ResourceDeliveryProcessor] Request for resource 2388 and type 'MEDIA_ITEM' received 2013-10-31 18:38:53,287 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 2388 (local) 2013-10-31 18:38:53,287 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 2388) 2013-10-31 18:38:53,288 DEBUG [VideoDAOImpl] Reading a Video (id = 2388) 2013-10-31 18:38:53,288 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 2388, format AVC_TS_MP_HD_AC3_ISO and profile Sony Bravia TV (2012) 2013-10-31 18:38:53,288 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:53,290 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:53,292 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv 2013-10-31 18:38:53,292 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:53,293 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv: AVC_TS_MP_HD_AC3_ISO 2013-10-31 18:38:53,293 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 2388 (local) 2013-10-31 18:38:53,293 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 2388) 2013-10-31 18:38:53,294 DEBUG [VideoDAOImpl] Reading a Video (id = 2388) 2013-10-31 18:38:53,294 DEBUG [VideoDeliveryEngine] Delivering item '2388' for client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:53,294 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:53,295 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:53,297 DEBUG [VideoDeliveryEngine] Delivering file '[HorribleSubs] Naruto Shippuuden - 100 [480p].mkv' using transcoding 2013-10-31 18:38:53,297 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:53,299 DEBUG [AbstractTranscodingDeliveryEngine] A suitable transcoding job already exists, re-use it for client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:53,349 DEBUG [FileBasedTranscodingDeliveryStrategy] Transcoded file 'C:\Windows\TEMP\Serviio\transcoding-temp-2388-sony2012-ORIGINAL.stf' is complete, sending simple stream 2013-10-31 18:38:53,416 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:53,417 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv: AVC_TS_MP_HD_AC3_ISO 2013-10-31 18:38:53,417 DEBUG [GETMethodProcessor] Delivering bytes 20516864 - 50000000000 from transcoded file, based on time range 111.087 - 112.087 2013-10-31 18:38:53,418 DEBUG [GETMethodProcessor] Stream entity has length: 50000000000 2013-10-31 18:38:53,418 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer 2013-10-31 18:38:53,418 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 206 Partial Content, headers = [[Content-Type: video/mpeg,Date: Thu, 31 Oct 2013 07:38:53 GMT,Server: Windows 7, UPnP/1.0 DLNADOC/1.50, Serviio/1.3.1,Cache-control: no-cache,TimeSeekRange.dlna.org: npt=111.087-112.087/1391,contentFeatures.dlna.org: DLNA.ORG_PN=AVC_TS_HD_24_AC3_ISO;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]] 2013-10-31 18:38:54,009 DEBUG [WebServer] I/O error: Connection reset by peer: socket write error 2013-10-31 18:38:54,012 DEBUG [ServiioHttpService] Incoming request from /192.168.1.4:49035: GET /resource/2388/MEDIA_ITEM/AVC_TS_MP_HD_AC3_ISO-0/ORIGINAL HTTP/1.1, headers = [TimeSeekRange.dlna.org: npt=116.087-117.087,getcontentFeatures.dlna.org: 1,Pragma: getIfoFileURI.dlna.org,transferMode.dlna.org: Streaming,X-AV-Physical-Unit-Info: pa="BRAVIA KDL-55HX850";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-55HX850"; mv="1.7";,Host: 192.168.1.10:8895]] 2013-10-31 18:38:54,012 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 18:38:54,012 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 18:38:54,013 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:54,013 DEBUG [ResourceDeliveryProcessor] Request for resource 2388 and type 'MEDIA_ITEM' received 2013-10-31 18:38:54,013 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 2388 (local) 2013-10-31 18:38:54,013 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 2388) 2013-10-31 18:38:54,013 DEBUG [VideoDAOImpl] Reading a Video (id = 2388) 2013-10-31 18:38:54,013 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 2388, format AVC_TS_MP_HD_AC3_ISO and profile Sony Bravia TV (2012) 2013-10-31 18:38:54,013 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:54,015 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:54,016 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv 2013-10-31 18:38:54,016 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:54,018 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv: AVC_TS_MP_HD_AC3_ISO 2013-10-31 18:38:54,018 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 2388 (local) 2013-10-31 18:38:54,018 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 2388) 2013-10-31 18:38:54,018 DEBUG [VideoDAOImpl] Reading a Video (id = 2388) 2013-10-31 18:38:54,018 DEBUG [VideoDeliveryEngine] Delivering item '2388' for client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:54,019 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:54,020 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:54,022 DEBUG [VideoDeliveryEngine] Delivering file '[HorribleSubs] Naruto Shippuuden - 100 [480p].mkv' using transcoding 2013-10-31 18:38:54,022 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:54,023 DEBUG [AbstractTranscodingDeliveryEngine] A suitable transcoding job already exists, re-use it for client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:54,023 DEBUG [FileBasedTranscodingDeliveryStrategy] Transcoded file 'C:\Windows\TEMP\Serviio\transcoding-temp-2388-sony2012-ORIGINAL.stf' is complete, sending simple stream 2013-10-31 18:38:54,024 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:54,025 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv: AVC_TS_MP_HD_AC3_ISO 2013-10-31 18:38:54,025 DEBUG [GETMethodProcessor] Delivering bytes 21798912 - 50000000000 from transcoded file, based on time range 116.087 - 117.087 2013-10-31 18:38:54,025 DEBUG [GETMethodProcessor] Stream entity has length: 50000000000 2013-10-31 18:38:54,026 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer 2013-10-31 18:38:54,026 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 206 Partial Content, headers = [[Content-Type: video/mpeg,Date: Thu, 31 Oct 2013 07:38:54 GMT,Server: Windows 7, UPnP/1.0 DLNADOC/1.50, Serviio/1.3.1,Cache-control: no-cache,TimeSeekRange.dlna.org: npt=116.087-117.087/1391,contentFeatures.dlna.org: DLNA.ORG_PN=AVC_TS_HD_24_AC3_ISO;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]] 2013-10-31 18:38:54,509 DEBUG [WebServer] I/O error: Connection reset by peer: socket write error 2013-10-31 18:38:54,511 DEBUG [ServiioHttpService] Incoming request from /192.168.1.4:49036: GET /resource/2388/MEDIA_ITEM/AVC_TS_MP_HD_AC3_ISO-0/ORIGINAL HTTP/1.1, headers = [TimeSeekRange.dlna.org: npt=121.087-122.087,getcontentFeatures.dlna.org: 1,Pragma: getIfoFileURI.dlna.org,transferMode.dlna.org: Streaming,X-AV-Physical-Unit-Info: pa="BRAVIA KDL-55HX850";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-55HX850"; mv="1.7";,Host: 192.168.1.10:8895]] 2013-10-31 18:38:54,512 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 18:38:54,512 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 18:38:54,512 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:54,512 DEBUG [ResourceDeliveryProcessor] Request for resource 2388 and type 'MEDIA_ITEM' received 2013-10-31 18:38:54,512 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 2388 (local) 2013-10-31 18:38:54,512 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 2388) 2013-10-31 18:38:54,512 DEBUG [VideoDAOImpl] Reading a Video (id = 2388) 2013-10-31 18:38:54,513 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 2388, format AVC_TS_MP_HD_AC3_ISO and profile Sony Bravia TV (2012) 2013-10-31 18:38:54,513 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:54,514 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:54,516 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv 2013-10-31 18:38:54,516 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:54,517 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv: AVC_TS_MP_HD_AC3_ISO 2013-10-31 18:38:54,517 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 2388 (local) 2013-10-31 18:38:54,517 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 2388) 2013-10-31 18:38:54,518 DEBUG [VideoDAOImpl] Reading a Video (id = 2388) 2013-10-31 18:38:54,518 DEBUG [VideoDeliveryEngine] Delivering item '2388' for client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:54,518 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:54,519 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:54,521 DEBUG [VideoDeliveryEngine] Delivering file '[HorribleSubs] Naruto Shippuuden - 100 [480p].mkv' using transcoding 2013-10-31 18:38:54,521 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:54,523 DEBUG [AbstractTranscodingDeliveryEngine] A suitable transcoding job already exists, re-use it for client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:54,523 DEBUG [FileBasedTranscodingDeliveryStrategy] Transcoded file 'C:\Windows\TEMP\Serviio\transcoding-temp-2388-sony2012-ORIGINAL.stf' is complete, sending simple stream 2013-10-31 18:38:54,523 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:54,525 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv: AVC_TS_MP_HD_AC3_ISO 2013-10-31 18:38:54,525 DEBUG [GETMethodProcessor] Delivering bytes 23081984 - 50000000000 from transcoded file, based on time range 121.087 - 122.087 2013-10-31 18:38:54,525 DEBUG [GETMethodProcessor] Stream entity has length: 50000000000 2013-10-31 18:38:54,525 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer 2013-10-31 18:38:54,525 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 206 Partial Content, headers = [[Content-Type: video/mpeg,Date: Thu, 31 Oct 2013 07:38:54 GMT,Server: Windows 7, UPnP/1.0 DLNADOC/1.50, Serviio/1.3.1,Cache-control: no-cache,TimeSeekRange.dlna.org: npt=121.087-122.087/1391,contentFeatures.dlna.org: DLNA.ORG_PN=AVC_TS_HD_24_AC3_ISO;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]] 2013-10-31 18:38:55,010 DEBUG [WebServer] I/O error: Connection reset by peer: socket write error 2013-10-31 18:38:55,012 DEBUG [ServiioHttpService] Incoming request from /192.168.1.4:49037: GET /resource/2388/MEDIA_ITEM/AVC_TS_MP_HD_AC3_ISO-0/ORIGINAL HTTP/1.1, headers = [TimeSeekRange.dlna.org: npt=126.087-127.087,getcontentFeatures.dlna.org: 1,Pragma: getIfoFileURI.dlna.org,transferMode.dlna.org: Streaming,X-AV-Physical-Unit-Info: pa="BRAVIA KDL-55HX850";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-55HX850"; mv="1.7";,Host: 192.168.1.10:8895]] 2013-10-31 18:38:55,012 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 18:38:55,013 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 18:38:55,013 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:55,013 DEBUG [ResourceDeliveryProcessor] Request for resource 2388 and type 'MEDIA_ITEM' received 2013-10-31 18:38:55,013 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 2388 (local) 2013-10-31 18:38:55,013 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 2388) 2013-10-31 18:38:55,013 DEBUG [VideoDAOImpl] Reading a Video (id = 2388) 2013-10-31 18:38:55,013 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 2388, format AVC_TS_MP_HD_AC3_ISO and profile Sony Bravia TV (2012) 2013-10-31 18:38:55,014 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:55,015 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:55,017 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv 2013-10-31 18:38:55,017 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:55,018 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv: AVC_TS_MP_HD_AC3_ISO 2013-10-31 18:38:55,018 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 2388 (local) 2013-10-31 18:38:55,018 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 2388) 2013-10-31 18:38:55,019 DEBUG [VideoDAOImpl] Reading a Video (id = 2388) 2013-10-31 18:38:55,019 DEBUG [VideoDeliveryEngine] Delivering item '2388' for client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:55,019 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:55,020 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:55,022 DEBUG [VideoDeliveryEngine] Delivering file '[HorribleSubs] Naruto Shippuuden - 100 [480p].mkv' using transcoding 2013-10-31 18:38:55,022 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:55,023 DEBUG [AbstractTranscodingDeliveryEngine] A suitable transcoding job already exists, re-use it for client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:55,024 DEBUG [FileBasedTranscodingDeliveryStrategy] Transcoded file 'C:\Windows\TEMP\Serviio\transcoding-temp-2388-sony2012-ORIGINAL.stf' is complete, sending simple stream 2013-10-31 18:38:55,024 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:55,025 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv: AVC_TS_MP_HD_AC3_ISO 2013-10-31 18:38:55,025 DEBUG [GETMethodProcessor] Delivering bytes 24364032 - 50000000000 from transcoded file, based on time range 126.087 - 127.087 2013-10-31 18:38:55,026 DEBUG [GETMethodProcessor] Stream entity has length: 50000000000 2013-10-31 18:38:55,026 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer 2013-10-31 18:38:55,026 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 206 Partial Content, headers = [[Content-Type: video/mpeg,Date: Thu, 31 Oct 2013 07:38:55 GMT,Server: Windows 7, UPnP/1.0 DLNADOC/1.50, Serviio/1.3.1,Cache-control: no-cache,TimeSeekRange.dlna.org: npt=126.087-127.087/1391,contentFeatures.dlna.org: DLNA.ORG_PN=AVC_TS_HD_24_AC3_ISO;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]] 2013-10-31 18:38:55,512 DEBUG [WebServer] I/O error: Connection reset by peer: socket write error 2013-10-31 18:38:55,514 DEBUG [ServiioHttpService] Incoming request from /192.168.1.4:49038: GET /resource/2388/MEDIA_ITEM/AVC_TS_MP_HD_AC3_ISO-0/ORIGINAL HTTP/1.1, headers = [TimeSeekRange.dlna.org: npt=131.087-132.087,getcontentFeatures.dlna.org: 1,Pragma: getIfoFileURI.dlna.org,transferMode.dlna.org: Streaming,X-AV-Physical-Unit-Info: pa="BRAVIA KDL-55HX850";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-55HX850"; mv="1.7";,Host: 192.168.1.10:8895]] 2013-10-31 18:38:55,514 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 18:38:55,514 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 18:38:55,514 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:55,514 DEBUG [ResourceDeliveryProcessor] Request for resource 2388 and type 'MEDIA_ITEM' received 2013-10-31 18:38:55,514 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 2388 (local) 2013-10-31 18:38:55,514 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 2388) 2013-10-31 18:38:55,514 DEBUG [VideoDAOImpl] Reading a Video (id = 2388) 2013-10-31 18:38:55,515 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 2388, format AVC_TS_MP_HD_AC3_ISO and profile Sony Bravia TV (2012) 2013-10-31 18:38:55,515 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:55,516 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:55,518 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv 2013-10-31 18:38:55,518 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:55,519 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv: AVC_TS_MP_HD_AC3_ISO 2013-10-31 18:38:55,519 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 2388 (local) 2013-10-31 18:38:55,520 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 2388) 2013-10-31 18:38:55,520 DEBUG [VideoDAOImpl] Reading a Video (id = 2388) 2013-10-31 18:38:55,520 DEBUG [VideoDeliveryEngine] Delivering item '2388' for client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:55,520 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:55,522 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:55,523 DEBUG [VideoDeliveryEngine] Delivering file '[HorribleSubs] Naruto Shippuuden - 100 [480p].mkv' using transcoding 2013-10-31 18:38:55,523 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:55,525 DEBUG [AbstractTranscodingDeliveryEngine] A suitable transcoding job already exists, re-use it for client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:55,525 DEBUG [FileBasedTranscodingDeliveryStrategy] Transcoded file 'C:\Windows\TEMP\Serviio\transcoding-temp-2388-sony2012-ORIGINAL.stf' is complete, sending simple stream 2013-10-31 18:38:55,525 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:55,527 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv: AVC_TS_MP_HD_AC3_ISO 2013-10-31 18:38:55,527 DEBUG [GETMethodProcessor] Delivering bytes 25647104 - 50000000000 from transcoded file, based on time range 131.087 - 132.087 2013-10-31 18:38:55,527 DEBUG [GETMethodProcessor] Stream entity has length: 50000000000 2013-10-31 18:38:55,527 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer 2013-10-31 18:38:55,527 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 206 Partial Content, headers = [[Content-Type: video/mpeg,Date: Thu, 31 Oct 2013 07:38:55 GMT,Server: Windows 7, UPnP/1.0 DLNADOC/1.50, Serviio/1.3.1,Cache-control: no-cache,TimeSeekRange.dlna.org: npt=131.087-132.087/1391,contentFeatures.dlna.org: DLNA.ORG_PN=AVC_TS_HD_24_AC3_ISO;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]] 2013-10-31 18:38:56,013 DEBUG [WebServer] I/O error: Connection reset by peer: socket write error 2013-10-31 18:38:56,016 DEBUG [ServiioHttpService] Incoming request from /192.168.1.4:49039: GET /resource/2388/MEDIA_ITEM/AVC_TS_MP_HD_AC3_ISO-0/ORIGINAL HTTP/1.1, headers = [TimeSeekRange.dlna.org: npt=136.087-137.087,getcontentFeatures.dlna.org: 1,Pragma: getIfoFileURI.dlna.org,transferMode.dlna.org: Streaming,X-AV-Physical-Unit-Info: pa="BRAVIA KDL-55HX850";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-55HX850"; mv="1.7";,Host: 192.168.1.10:8895]] 2013-10-31 18:38:56,016 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 18:38:56,016 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 18:38:56,016 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:56,017 DEBUG [ResourceDeliveryProcessor] Request for resource 2388 and type 'MEDIA_ITEM' received 2013-10-31 18:38:56,017 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 2388 (local) 2013-10-31 18:38:56,017 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 2388) 2013-10-31 18:38:56,017 DEBUG [VideoDAOImpl] Reading a Video (id = 2388) 2013-10-31 18:38:56,017 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 2388, format AVC_TS_MP_HD_AC3_ISO and profile Sony Bravia TV (2012) 2013-10-31 18:38:56,017 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:56,019 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:56,020 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv 2013-10-31 18:38:56,021 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:56,022 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv: AVC_TS_MP_HD_AC3_ISO 2013-10-31 18:38:56,022 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 2388 (local) 2013-10-31 18:38:56,022 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 2388) 2013-10-31 18:38:56,022 DEBUG [VideoDAOImpl] Reading a Video (id = 2388) 2013-10-31 18:38:56,023 DEBUG [VideoDeliveryEngine] Delivering item '2388' for client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:56,023 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:56,024 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:56,026 DEBUG [VideoDeliveryEngine] Delivering file '[HorribleSubs] Naruto Shippuuden - 100 [480p].mkv' using transcoding 2013-10-31 18:38:56,026 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:56,027 DEBUG [AbstractTranscodingDeliveryEngine] A suitable transcoding job already exists, re-use it for client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 18:38:56,027 DEBUG [FileBasedTranscodingDeliveryStrategy] Transcoded file 'C:\Windows\TEMP\Serviio\transcoding-temp-2388-sony2012-ORIGINAL.stf' is complete, sending simple stream 2013-10-31 18:38:56,028 DEBUG [MediaItemDAOImpl] Getting file of media item 2388 2013-10-31 18:38:56,029 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file [HorribleSubs] Naruto Shippuuden - 100 [480p].mkv: AVC_TS_MP_HD_AC3_ISO 2013-10-31 18:38:56,029 DEBUG [GETMethodProcessor] Delivering bytes 26930176 - 50000000000 from transcoded file, based on time range 136.087 - 137.087 2013-10-31 18:38:56,029 DEBUG [GETMethodProcessor] Stream entity has length: 50000000000 2013-10-31 18:38:56,030 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer 2013-10-31 18:38:56,030 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 206 Partial Content, headers = [[Content-Type: video/mpeg,Date: Thu, 31 Oct 2013 07:38:56 GMT,Server: Windows 7, UPnP/1.0 DLNADOC/1.50, Serviio/1.3.1,Cache-control: no-cache,TimeSeekRange.dlna.org: npt=136.087-137.087/1391,contentFeatures.dlna.org: DLNA.ORG_PN=AVC_TS_HD_24_AC3_ISO;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]] 2013-10-31 18:38:56,513 DEBUG [WebServer] I/O error: Connection reset by peer: socket write error 2013-10-31 18:38:56,515 DEBUG [ServiioHttpService] Incoming request from /192.168.1.4:49040: GET /resource/2388/MEDIA_ITEM/AVC_TS_MP_HD_AC3_ISO-0/ORIGINAL HTTP/1.1, headers = [TimeSeekRange.dlna.org: npt=141.087-142.087,getcontentFeatures.dlna.org: 1,Pragma: getIfoFileURI.dlna.org,transferMode.dlna.org: Streaming,X-AV-Physical-Unit-Info: pa="BRAVIA KDL-55HX850";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-55HX850"; mv="1.7";,Host: 192.168.1.10:8895]]

Thu Oct 31, 2013 8:05 am by Illico

Nothing on detailed log about the embedded subtitle...
Could you rename the mkv file, force the library refresh and check detailed log file to see if serviio/ffmpeg well detects the embedded subtitle track ?

Thu Oct 31, 2013 9:30 am by kitjai

Thanks for the reply,

I renamed the file - naruto.mkv

Hope this helps

Code:: 2013-10-31 20:24:37,258 DEBUG [ServiioHttpService] Incoming request from /192.168.1.4:46871: POST /serviceControl HTTP/1.1, headers = [X-AV-Physical-Unit-Info: pa="BRAVIA KDL-55HX850";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-55HX850"; mv="1.7";,Host: 192.168.1.10:8895,User-Agent: UPnP/1.0 DLNADOC/1.50,Content-Length: 686,Content-Type: text/xml; charset="utf-8",SOAPACTION: "urn:schemas-upnp-org:service:ContentDirectory:1#Browse"]] 2013-10-31 20:24:37,258 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:24:37,259 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#Browse"' from 192.168.1.4 2013-10-31 20:24:37,259 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:24:37,464 DEBUG [ContentDirectory] Browse() called for renderer KDL-55HX850 (profile sony2012) with parameters: objectID = 2, browseFlag = BrowseDirectChildren, filter = dc:title,av:mediaClass,dc:date,@childCount,res,upnp:rating,upnp:rating@type,upnp:class,res@resolution,res@av:mpfEntries,upnp:album,upnp:genre,upnp:albumArtURI,upnp:albumArtURI@dlna:profileID,dc:creator,res@size,res@duration,res@bitrate,res@protocolInfo, startIndex = 0, count = 10, sortCriteria = 2013-10-31 20:24:37,486 DEBUG [VideoDAOImpl] Retrieving number of video initials [Any] 2013-10-31 20:24:37,606 DEBUG [VideoDAOImpl] Retrieving number of videos of type 2 [Any] 2013-10-31 20:24:37,640 DEBUG [SeriesDAOImpl] Retrieving number of series 2013-10-31 20:24:37,649 DEBUG [RepositoryDAOImpl] Retrieving number of repositories for VIDEO [Any] 2013-10-31 20:24:37,654 DEBUG [VideoDAOImpl] Retrieving number of 10 last viewed videos [Any] 2013-10-31 20:24:37,679 DEBUG [VideoDAOImpl] Retrieving number of 10 last added videos 2013-10-31 20:24:37,679 DEBUG [VideoDAOImpl] Retrieving number of videos of type 0 [Any] 2013-10-31 20:24:37,705 DEBUG [GenreDAOImpl] Retrieving number of genres for VIDEO 2013-10-31 20:24:37,758 DEBUG [PersonDAOImpl] Retrieving number of person initials for role ACTOR 2013-10-31 20:24:37,833 DEBUG [FeedUpdaterThread] Checking for new and expired online resources 2013-10-31 20:24:37,833 DEBUG [OnlineRepositoryDAOImpl] Reading all OnlineRepositories 2013-10-31 20:24:37,862 DEBUG [PersonDAOImpl] Retrieving number of person initials for role DIRECTOR 2013-10-31 20:24:37,956 DEBUG [PersonDAOImpl] Retrieving number of person initials for role PRODUCER 2013-10-31 20:24:37,976 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message 2013-10-31 20:24:38,029 DEBUG [ServiioHttpService] Incoming request from /192.168.1.4:46872: POST /serviceControl HTTP/1.1, headers = [X-AV-Physical-Unit-Info: pa="BRAVIA KDL-55HX850";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-55HX850"; mv="1.7";,Host: 192.168.1.10:8895,User-Agent: UPnP/1.0 DLNADOC/1.50,Content-Length: 687,Content-Type: text/xml; charset="utf-8",SOAPACTION: "urn:schemas-upnp-org:service:ContentDirectory:1#Browse"]] 2013-10-31 20:24:38,029 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:24:38,030 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#Browse"' from 192.168.1.4 2013-10-31 20:24:38,030 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:24:38,232 DEBUG [ContentDirectory] Browse() called for renderer KDL-55HX850 (profile sony2012) with parameters: objectID = 2, browseFlag = BrowseDirectChildren, filter = dc:title,av:mediaClass,dc:date,@childCount,res,upnp:rating,upnp:rating@type,upnp:class,res@resolution,res@av:mpfEntries,upnp:album,upnp:genre,upnp:albumArtURI,upnp:albumArtURI@dlna:profileID,dc:creator,res@size,res@duration,res@bitrate,res@protocolInfo, startIndex = 10, count = 10, sortCriteria = 2013-10-31 20:24:38,233 DEBUG [VideoDAOImpl] Retrieving number of video release years [Any] 2013-10-31 20:24:38,264 DEBUG [PlaylistDAOImpl] Retrieving number of playlists for VIDEO [Any] 2013-10-31 20:24:38,270 DEBUG [OnlineRepositoryDAOImpl] Retrieving list of [FEED, WEB_RESOURCE] OnlineRepositories for VIDEO [Any] 2013-10-31 20:24:38,279 DEBUG [OnlineRepositoryDAOImpl] Retrieving list of [LIVE_STREAM] OnlineRepositories for VIDEO [Any] 2013-10-31 20:24:38,286 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message 2013-10-31 20:24:38,336 DEBUG [ServiioHttpService] Incoming request from /192.168.1.4:46873: POST /serviceControl HTTP/1.1, headers = [X-AV-Physical-Unit-Info: pa="BRAVIA KDL-55HX850";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-55HX850"; mv="1.7";,Host: 192.168.1.10:8895,User-Agent: UPnP/1.0 DLNADOC/1.50,Content-Length: 686,Content-Type: text/xml; charset="utf-8",SOAPACTION: "urn:schemas-upnp-org:service:ContentDirectory:1#Browse"]] 2013-10-31 20:24:38,336 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:24:38,336 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#Browse"' from 192.168.1.4 2013-10-31 20:24:38,336 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:24:38,539 DEBUG [ContentDirectory] Browse() called for renderer KDL-55HX850 (profile sony2012) with parameters: objectID = 2, browseFlag = BrowseDirectChildren, filter = dc:title,av:mediaClass,dc:date,@childCount,res,upnp:rating,upnp:rating@type,upnp:class,res@resolution,res@av:mpfEntries,upnp:album,upnp:genre,upnp:albumArtURI,upnp:albumArtURI@dlna:profileID,dc:creator,res@size,res@duration,res@bitrate,res@protocolInfo, startIndex = 0, count = 10, sortCriteria = 2013-10-31 20:24:38,539 DEBUG [VideoDAOImpl] Retrieving number of video initials [Any] 2013-10-31 20:24:38,572 DEBUG [VideoDAOImpl] Retrieving number of videos of type 2 [Any] 2013-10-31 20:24:38,590 DEBUG [SeriesDAOImpl] Retrieving number of series 2013-10-31 20:24:38,590 DEBUG [RepositoryDAOImpl] Retrieving number of repositories for VIDEO [Any] 2013-10-31 20:24:38,591 DEBUG [VideoDAOImpl] Retrieving number of 10 last viewed videos [Any] 2013-10-31 20:24:38,604 DEBUG [VideoDAOImpl] Retrieving number of 10 last added videos 2013-10-31 20:24:38,604 DEBUG [VideoDAOImpl] Retrieving number of videos of type 0 [Any] 2013-10-31 20:24:38,620 DEBUG [GenreDAOImpl] Retrieving number of genres for VIDEO 2013-10-31 20:24:38,641 DEBUG [PersonDAOImpl] Retrieving number of person initials for role ACTOR 2013-10-31 20:24:38,700 DEBUG [PersonDAOImpl] Retrieving number of person initials for role DIRECTOR 2013-10-31 20:24:38,711 DEBUG [PersonDAOImpl] Retrieving number of person initials for role PRODUCER 2013-10-31 20:24:38,804 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message 2013-10-31 20:24:38,820 DEBUG [ServiioHttpService] Incoming request from /192.168.1.4:46874: POST /serviceControl HTTP/1.1, headers = [X-AV-Physical-Unit-Info: pa="BRAVIA KDL-55HX850";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-55HX850"; mv="1.7";,Host: 192.168.1.10:8895,User-Agent: UPnP/1.0 DLNADOC/1.50,Content-Length: 687,Content-Type: text/xml; charset="utf-8",SOAPACTION: "urn:schemas-upnp-org:service:ContentDirectory:1#Browse"]] 2013-10-31 20:24:38,820 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:24:38,821 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#Browse"' from 192.168.1.4 2013-10-31 20:24:38,821 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:24:39,031 DEBUG [ContentDirectory] Browse() called for renderer KDL-55HX850 (profile sony2012) with parameters: objectID = 2, browseFlag = BrowseDirectChildren, filter = dc:title,av:mediaClass,dc:date,@childCount,res,upnp:rating,upnp:rating@type,upnp:class,res@resolution,res@av:mpfEntries,upnp:album,upnp:genre,upnp:albumArtURI,upnp:albumArtURI@dlna:profileID,dc:creator,res@size,res@duration,res@bitrate,res@protocolInfo, startIndex = 10, count = 10, sortCriteria = 2013-10-31 20:24:39,031 DEBUG [VideoDAOImpl] Retrieving number of video release years [Any] 2013-10-31 20:24:39,050 DEBUG [PlaylistDAOImpl] Retrieving number of playlists for VIDEO [Any] 2013-10-31 20:24:39,050 DEBUG [OnlineRepositoryDAOImpl] Retrieving list of [FEED, WEB_RESOURCE] OnlineRepositories for VIDEO [Any] 2013-10-31 20:24:39,051 DEBUG [OnlineRepositoryDAOImpl] Retrieving list of [LIVE_STREAM] OnlineRepositories for VIDEO [Any] 2013-10-31 20:24:39,055 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message 2013-10-31 20:24:40,061 DEBUG [ServiioHttpService] Incoming request from /192.168.1.4:46875: POST /serviceControl HTTP/1.1, headers = [X-AV-Physical-Unit-Info: pa="BRAVIA KDL-55HX850";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-55HX850"; mv="1.7";,Host: 192.168.1.10:8895,User-Agent: UPnP/1.0 DLNADOC/1.50,Content-Length: 688,Content-Type: text/xml; charset="utf-8",SOAPACTION: "urn:schemas-upnp-org:service:ContentDirectory:1#Browse"]] 2013-10-31 20:24:40,061 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:24:40,061 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#Browse"' from 192.168.1.4 2013-10-31 20:24:40,061 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:24:40,263 DEBUG [ContentDirectory] Browse() called for renderer KDL-55HX850 (profile sony2012) with parameters: objectID = V_F, browseFlag = BrowseDirectChildren, filter = dc:title,av:mediaClass,dc:date,@childCount,res,upnp:rating,upnp:rating@type,upnp:class,res@resolution,res@av:mpfEntries,upnp:album,upnp:genre,upnp:albumArtURI,upnp:albumArtURI@dlna:profileID,dc:creator,res@size,res@duration,res@bitrate,res@protocolInfo, startIndex = 0, count = 10, sortCriteria = 2013-10-31 20:24:40,264 DEBUG [RepositoryDAOImpl] Retrieving list of Repositories for VIDEO (from=0, count=10) [Any] 2013-10-31 20:24:40,274 DEBUG [CoverImageDAOImpl] Reading a CoverImage for repository (id = 1) 2013-10-31 20:24:40,302 DEBUG [FolderDAOImpl] Getting number of VIDEO sub-folders and media items in folder 'root' (filter: ALL) [Any] 2013-10-31 20:24:40,324 DEBUG [CoverImageDAOImpl] Reading a CoverImage (id = 1092) 2013-10-31 20:24:40,343 DEBUG [CoverImageDAOImpl] Reading a CoverImage for repository (id = 2) 2013-10-31 20:24:40,345 DEBUG [FolderDAOImpl] Getting number of VIDEO sub-folders and media items in folder 'root' (filter: ALL) [Any] 2013-10-31 20:24:40,359 DEBUG [CoverImageDAOImpl] Reading a CoverImage (id = 2761) 2013-10-31 20:24:40,360 DEBUG [CoverImageDAOImpl] Reading a CoverImage for repository (id = 3) 2013-10-31 20:24:40,362 DEBUG [FolderDAOImpl] Getting number of VIDEO sub-folders and media items in folder 'root' (filter: ALL) [Any] 2013-10-31 20:24:40,378 DEBUG [CoverImageDAOImpl] Reading a CoverImage (id = 2764) 2013-10-31 20:24:40,379 DEBUG [RepositoryDAOImpl] Retrieving number of repositories for VIDEO [Any] 2013-10-31 20:24:40,381 DEBUG [LocalContentCacheDecorator] Stored entry in the cache (local_default), returning it 2013-10-31 20:24:40,385 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message 2013-10-31 20:24:40,445 DEBUG [ServiioHttpService] Incoming request from /192.168.1.4:46876: POST /serviceControl HTTP/1.1, headers = [X-AV-Physical-Unit-Info: pa="BRAVIA KDL-55HX850";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-55HX850"; mv="1.7";,Host: 192.168.1.10:8895,User-Agent: UPnP/1.0 DLNADOC/1.50,Content-Length: 688,Content-Type: text/xml; charset="utf-8",SOAPACTION: "urn:schemas-upnp-org:service:ContentDirectory:1#Browse"]] 2013-10-31 20:24:40,446 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:24:40,446 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#Browse"' from 192.168.1.4 2013-10-31 20:24:40,446 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:24:40,659 DEBUG [ContentDirectory] Browse() called for renderer KDL-55HX850 (profile sony2012) with parameters: objectID = V_F, browseFlag = BrowseDirectChildren, filter = dc:title,av:mediaClass,dc:date,@childCount,res,upnp:rating,upnp:rating@type,upnp:class,res@resolution,res@av:mpfEntries,upnp:album,upnp:genre,upnp:albumArtURI,upnp:albumArtURI@dlna:profileID,dc:creator,res@size,res@duration,res@bitrate,res@protocolInfo, startIndex = 0, count = 10, sortCriteria = 2013-10-31 20:24:40,659 DEBUG [LocalContentCacheDecorator] Found entry in the cache (local_default), returning it 2013-10-31 20:24:40,666 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message 2013-10-31 20:24:41,858 DEBUG [ServiioHttpService] Incoming request from /192.168.1.4:46877: POST /serviceControl HTTP/1.1, headers = [X-AV-Physical-Unit-Info: pa="BRAVIA KDL-55HX850";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-55HX850"; mv="1.7";,Host: 192.168.1.10:8895,User-Agent: UPnP/1.0 DLNADOC/1.50,Content-Length: 695,Content-Type: text/xml; charset="utf-8",SOAPACTION: "urn:schemas-upnp-org:service:ContentDirectory:1#Browse"]] 2013-10-31 20:24:41,858 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:24:41,859 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#Browse"' from 192.168.1.4 2013-10-31 20:24:41,859 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:24:42,060 DEBUG [ContentDirectory] Browse() called for renderer KDL-55HX850 (profile sony2012) with parameters: objectID = V_F^FOL_R2, browseFlag = BrowseDirectChildren, filter = dc:title,av:mediaClass,dc:date,@childCount,res,upnp:rating,upnp:rating@type,upnp:class,res@resolution,res@av:mpfEntries,upnp:album,upnp:genre,upnp:albumArtURI,upnp:albumArtURI@dlna:profileID,dc:creator,res@size,res@duration,res@bitrate,res@protocolInfo, startIndex = 0, count = 10, sortCriteria = 2013-10-31 20:24:42,061 DEBUG [FolderDAOImpl] Getting number of sub-Folders in folder null [Any] 2013-10-31 20:24:42,069 DEBUG [FolderDAOImpl] Getting list of sub-Folders in folder null (from=0, count=10) [Any] 2013-10-31 20:24:42,075 DEBUG [CoverImageDAOImpl] Reading a CoverImage for folder (id = 156) 2013-10-31 20:24:42,082 DEBUG [FolderDAOImpl] Getting number of VIDEO sub-folders and media items in folder 156 (filter: ALL) [Any] 2013-10-31 20:24:42,092 DEBUG [CoverImageDAOImpl] Reading a CoverImage (id = 1558) 2013-10-31 20:24:42,093 DEBUG [CoverImageDAOImpl] Reading a CoverImage for folder (id = 157) 2013-10-31 20:24:42,094 DEBUG [FolderDAOImpl] Getting number of VIDEO sub-folders and media items in folder 157 (filter: ALL) [Any] 2013-10-31 20:24:42,105 DEBUG [CoverImageDAOImpl] Reading a CoverImage (id = 1559) 2013-10-31 20:24:42,106 DEBUG [CoverImageDAOImpl] Reading a CoverImage for folder (id = 158) 2013-10-31 20:24:42,106 DEBUG [FolderDAOImpl] Getting number of VIDEO sub-folders and media items in folder 158 (filter: ALL) [Any] 2013-10-31 20:24:42,115 DEBUG [CoverImageDAOImpl] Reading a CoverImage (id = 1560) 2013-10-31 20:24:42,116 DEBUG [CoverImageDAOImpl] Reading a CoverImage for folder (id = 159) 2013-10-31 20:24:42,117 DEBUG [FolderDAOImpl] Getting number of VIDEO sub-folders and media items in folder 159 (filter: ALL) [Any] 2013-10-31 20:24:42,125 DEBUG [CoverImageDAOImpl] Reading a CoverImage (id = 1561) 2013-10-31 20:24:42,126 DEBUG [CoverImageDAOImpl] Reading a CoverImage for folder (id = 160) 2013-10-31 20:24:42,130 DEBUG [FolderDAOImpl] Getting number of VIDEO sub-folders and media items in folder 160 (filter: ALL) [Any] 2013-10-31 20:24:42,141 DEBUG [CoverImageDAOImpl] Reading a CoverImage (id = 1585) 2013-10-31 20:24:42,142 DEBUG [CoverImageDAOImpl] Reading a CoverImage for folder (id = 161) 2013-10-31 20:24:42,145 DEBUG [FolderDAOImpl] Getting number of VIDEO sub-folders and media items in folder 161 (filter: ALL) [Any] 2013-10-31 20:24:42,156 DEBUG [CoverImageDAOImpl] Reading a CoverImage (id = 1899) 2013-10-31 20:24:42,156 DEBUG [CoverImageDAOImpl] Reading a CoverImage for folder (id = 162) 2013-10-31 20:24:42,157 DEBUG [FolderDAOImpl] Getting number of VIDEO sub-folders and media items in folder 162 (filter: ALL) [Any] 2013-10-31 20:24:42,165 DEBUG [CoverImageDAOImpl] Reading a CoverImage (id = 2195) 2013-10-31 20:24:42,166 DEBUG [CoverImageDAOImpl] Reading a CoverImage for folder (id = 163) 2013-10-31 20:24:42,166 DEBUG [FolderDAOImpl] Getting number of VIDEO sub-folders and media items in folder 163 (filter: ALL) [Any] 2013-10-31 20:24:42,175 DEBUG [CoverImageDAOImpl] Reading a CoverImage (id = 2220) 2013-10-31 20:24:42,175 DEBUG [CoverImageDAOImpl] Reading a CoverImage for folder (id = 164) 2013-10-31 20:24:42,178 DEBUG [FolderDAOImpl] Getting number of VIDEO sub-folders and media items in folder 164 (filter: ALL) [Any] 2013-10-31 20:24:42,187 DEBUG [CoverImageDAOImpl] Reading a CoverImage (id = 2226) 2013-10-31 20:24:42,187 DEBUG [CoverImageDAOImpl] Reading a CoverImage for folder (id = 166) 2013-10-31 20:24:42,188 DEBUG [FolderDAOImpl] Getting number of VIDEO sub-folders and media items in folder 166 (filter: ALL) [Any] 2013-10-31 20:24:42,195 DEBUG [CoverImageDAOImpl] Reading a CoverImage (id = 2630) 2013-10-31 20:24:42,196 DEBUG [FolderDAOImpl] Getting number of VIDEO sub-folders and media items in folder 'root' (filter: ALL) [Any] 2013-10-31 20:24:42,197 DEBUG [LocalContentCacheDecorator] Stored entry in the cache (local_default), returning it 2013-10-31 20:24:42,205 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message 2013-10-31 20:24:42,236 DEBUG [ServiioHttpService] Incoming request from /192.168.1.4:46878: POST /serviceControl HTTP/1.1, headers = [X-AV-Physical-Unit-Info: pa="BRAVIA KDL-55HX850";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-55HX850"; mv="1.7";,Host: 192.168.1.10:8895,User-Agent: UPnP/1.0 DLNADOC/1.50,Content-Length: 696,Content-Type: text/xml; charset="utf-8",SOAPACTION: "urn:schemas-upnp-org:service:ContentDirectory:1#Browse"]] 2013-10-31 20:24:42,236 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:24:42,237 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#Browse"' from 192.168.1.4 2013-10-31 20:24:42,237 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:24:42,448 DEBUG [ContentDirectory] Browse() called for renderer KDL-55HX850 (profile sony2012) with parameters: objectID = V_F^FOL_R2, browseFlag = BrowseDirectChildren, filter = dc:title,av:mediaClass,dc:date,@childCount,res,upnp:rating,upnp:rating@type,upnp:class,res@resolution,res@av:mpfEntries,upnp:album,upnp:genre,upnp:albumArtURI,upnp:albumArtURI@dlna:profileID,dc:creator,res@size,res@duration,res@bitrate,res@protocolInfo, startIndex = 10, count = 10, sortCriteria = 2013-10-31 20:24:42,448 DEBUG [FolderDAOImpl] Getting number of sub-Folders in folder null [Any] 2013-10-31 20:24:42,449 DEBUG [FolderDAOImpl] Getting list of sub-Folders in folder null (from=10, count=10) [Any] 2013-10-31 20:24:42,455 DEBUG [CoverImageDAOImpl] Reading a CoverImage for folder (id = 167) 2013-10-31 20:24:42,456 DEBUG [FolderDAOImpl] Getting number of VIDEO sub-folders and media items in folder 167 (filter: ALL) [Any] 2013-10-31 20:24:42,465 DEBUG [CoverImageDAOImpl] Reading a CoverImage (id = 2631) 2013-10-31 20:24:42,466 DEBUG [CoverImageDAOImpl] Reading a CoverImage for folder (id = 168) 2013-10-31 20:24:42,469 DEBUG [FolderDAOImpl] Getting number of VIDEO sub-folders and media items in folder 168 (filter: ALL) [Any] 2013-10-31 20:24:42,477 DEBUG [CoverImageDAOImpl] Reading a CoverImage (id = 2675) 2013-10-31 20:24:42,478 DEBUG [CoverImageDAOImpl] Reading a CoverImage for folder (id = 169) 2013-10-31 20:24:42,479 DEBUG [FolderDAOImpl] Getting number of VIDEO sub-folders and media items in folder 169 (filter: ALL) [Any] 2013-10-31 20:24:42,489 DEBUG [CoverImageDAOImpl] Reading a CoverImage (id = 2687) 2013-10-31 20:24:42,490 DEBUG [CoverImageDAOImpl] Reading a CoverImage for folder (id = 170) 2013-10-31 20:24:42,491 DEBUG [FolderDAOImpl] Getting number of VIDEO sub-folders and media items in folder 170 (filter: ALL) [Any] 2013-10-31 20:24:42,499 DEBUG [CoverImageDAOImpl] Reading a CoverImage (id = 2711) 2013-10-31 20:24:42,503 DEBUG [VideoDAOImpl] Retrieving list of videos for folder 171 (from=0, count=6) [Any] 2013-10-31 20:24:42,515 DEBUG [MediaItemDAOImpl] Getting file of media item 2725 2013-10-31 20:24:42,519 DEBUG [MediaItemDAOImpl] Getting file of media item 2725 2013-10-31 20:24:42,520 DEBUG [GenreDAOImpl] Reading a Genre (id = 10) 2013-10-31 20:24:42,523 DEBUG [VideoDAOImpl] Reading a Video (id = 2725) 2013-10-31 20:24:42,529 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 2725 and profile Sony Bravia TV (2012) 2013-10-31 20:24:42,531 DEBUG [MediaItemDAOImpl] Getting file of media item 2725 2013-10-31 20:24:42,532 DEBUG [CoverImageDAOImpl] Reading a CoverImage (id = 2761) 2013-10-31 20:24:42,533 DEBUG [MediaItemDAOImpl] Getting file of media item 2725 2013-10-31 20:24:42,533 DEBUG [MediaItemDAOImpl] Getting file of media item 2725 2013-10-31 20:24:42,534 DEBUG [MediaItemDAOImpl] Getting file of media item 3141 2013-10-31 20:24:42,534 DEBUG [MediaItemDAOImpl] Getting file of media item 3141 2013-10-31 20:24:42,535 DEBUG [GenreDAOImpl] Reading a Genre (id = 11) 2013-10-31 20:24:42,535 DEBUG [VideoDAOImpl] Reading a Video (id = 3141) 2013-10-31 20:24:42,535 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 3141 and profile Sony Bravia TV (2012) 2013-10-31 20:24:42,535 DEBUG [MediaItemDAOImpl] Getting file of media item 3141 2013-10-31 20:24:42,536 DEBUG [MediaItemDAOImpl] Getting file of media item 3141 2013-10-31 20:24:42,537 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file Naruto.mkv: AVC_TS_MP_HD_AC3_ISO 2013-10-31 20:24:42,537 DEBUG [CoverImageDAOImpl] Reading a CoverImage (id = 3240) 2013-10-31 20:24:42,538 DEBUG [MediaItemDAOImpl] Getting file of media item 3141 2013-10-31 20:24:42,538 DEBUG [MediaItemDAOImpl] Getting file of media item 3141 2013-10-31 20:24:42,539 DEBUG [FolderDAOImpl] Getting number of VIDEO sub-folders and media items in folder 'root' (filter: ALL) [Any] 2013-10-31 20:24:42,539 DEBUG [LocalContentCacheDecorator] Stored entry in the cache (local_default), returning it 2013-10-31 20:24:42,546 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message 2013-10-31 20:24:42,606 DEBUG [ServiioHttpService] Incoming request from /192.168.1.4:46879: POST /serviceControl HTTP/1.1, headers = [X-AV-Physical-Unit-Info: pa="BRAVIA KDL-55HX850";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-55HX850"; mv="1.7";,Host: 192.168.1.10:8895,User-Agent: UPnP/1.0 DLNADOC/1.50,Content-Length: 695,Content-Type: text/xml; charset="utf-8",SOAPACTION: "urn:schemas-upnp-org:service:ContentDirectory:1#Browse"]] 2013-10-31 20:24:42,606 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:24:42,606 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#Browse"' from 192.168.1.4 2013-10-31 20:24:42,606 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:24:42,676 DEBUG [ServiioHttpService] Incoming request from /192.168.1.4:46880: GET /resource/2761/COVER_IMAGE HTTP/1.1, headers = [transferMode.dlna.org: Interactive,X-AV-Physical-Unit-Info: pa="BRAVIA KDL-55HX850";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-55HX850"; mv="1.7";,Host: 192.168.1.10:8895]] 2013-10-31 20:24:42,677 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:24:42,677 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:24:42,683 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 20:24:42,683 DEBUG [ResourceDeliveryProcessor] Request for resource 2761 and type 'COVER_IMAGE' received 2013-10-31 20:24:42,684 DEBUG [CoverImageDAOImpl] Reading a CoverImage (id = 2761) 2013-10-31 20:24:42,685 DEBUG [CoverImageRetrievalStrategy] Retrieving info of Cover image with id 2761 2013-10-31 20:24:42,686 DEBUG [CoverImageDAOImpl] Reading a CoverImage (id = 2761) 2013-10-31 20:24:42,687 DEBUG [CoverImageRetrievalStrategy] Retrieving Cover image with id 2761 2013-10-31 20:24:42,687 DEBUG [GETMethodProcessor] Stream entity has length: 6486 2013-10-31 20:24:42,688 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: image/jpeg,Content-Length: 6486,Date: Thu, 31 Oct 2013 09:24:42 GMT,Server: Windows 7, UPnP/1.0 DLNADOC/1.50, Serviio/1.3.1,Cache-control: no-cache,transferMode.dlna.org: Interactive,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]] 2013-10-31 20:24:42,699 DEBUG [ServiioHttpService] Incoming request from /192.168.1.4:46881: GET /resource/3240/COVER_IMAGE HTTP/1.1, headers = [transferMode.dlna.org: Interactive,X-AV-Physical-Unit-Info: pa="BRAVIA KDL-55HX850";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-55HX850"; mv="1.7";,Host: 192.168.1.10:8895]] 2013-10-31 20:24:42,699 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:24:42,700 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:24:42,700 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 20:24:42,700 DEBUG [ResourceDeliveryProcessor] Request for resource 3240 and type 'COVER_IMAGE' received 2013-10-31 20:24:42,700 DEBUG [CoverImageDAOImpl] Reading a CoverImage (id = 3240) 2013-10-31 20:24:42,700 DEBUG [CoverImageRetrievalStrategy] Retrieving info of Cover image with id 3240 2013-10-31 20:24:42,700 DEBUG [CoverImageDAOImpl] Reading a CoverImage (id = 3240) 2013-10-31 20:24:42,700 DEBUG [CoverImageRetrievalStrategy] Retrieving Cover image with id 3240 2013-10-31 20:24:42,701 DEBUG [GETMethodProcessor] Stream entity has length: 5391 2013-10-31 20:24:42,701 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: image/jpeg,Content-Length: 5391,Date: Thu, 31 Oct 2013 09:24:42 GMT,Server: Windows 7, UPnP/1.0 DLNADOC/1.50, Serviio/1.3.1,Cache-control: no-cache,transferMode.dlna.org: Interactive,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]] 2013-10-31 20:24:42,808 DEBUG [ContentDirectory] Browse() called for renderer KDL-55HX850 (profile sony2012) with parameters: objectID = V_F^FOL_R2, browseFlag = BrowseDirectChildren, filter = dc:title,av:mediaClass,dc:date,@childCount,res,upnp:rating,upnp:rating@type,upnp:class,res@resolution,res@av:mpfEntries,upnp:album,upnp:genre,upnp:albumArtURI,upnp:albumArtURI@dlna:profileID,dc:creator,res@size,res@duration,res@bitrate,res@protocolInfo, startIndex = 0, count = 10, sortCriteria = 2013-10-31 20:24:42,808 DEBUG [LocalContentCacheDecorator] Found entry in the cache (local_default), returning it 2013-10-31 20:24:42,815 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message 2013-10-31 20:24:42,874 DEBUG [ServiioHttpService] Incoming request from /192.168.1.4:46882: POST /serviceControl HTTP/1.1, headers = [X-AV-Physical-Unit-Info: pa="BRAVIA KDL-55HX850";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-55HX850"; mv="1.7";,Host: 192.168.1.10:8895,User-Agent: UPnP/1.0 DLNADOC/1.50,Content-Length: 696,Content-Type: text/xml; charset="utf-8",SOAPACTION: "urn:schemas-upnp-org:service:ContentDirectory:1#Browse"]] 2013-10-31 20:24:42,874 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:24:42,874 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#Browse"' from 192.168.1.4 2013-10-31 20:24:42,874 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:24:43,085 DEBUG [ContentDirectory] Browse() called for renderer KDL-55HX850 (profile sony2012) with parameters: objectID = V_F^FOL_R2, browseFlag = BrowseDirectChildren, filter = dc:title,av:mediaClass,dc:date,@childCount,res,upnp:rating,upnp:rating@type,upnp:class,res@resolution,res@av:mpfEntries,upnp:album,upnp:genre,upnp:albumArtURI,upnp:albumArtURI@dlna:profileID,dc:creator,res@size,res@duration,res@bitrate,res@protocolInfo, startIndex = 10, count = 10, sortCriteria = 2013-10-31 20:24:43,085 DEBUG [LocalContentCacheDecorator] Found entry in the cache (local_default), returning it 2013-10-31 20:24:43,095 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message 2013-10-31 20:24:45,826 DEBUG [ServiioHttpService] Incoming request from /192.168.1.4:46883: POST /serviceControl HTTP/1.1, headers = [X-AV-Physical-Unit-Info: pa="BRAVIA KDL-55HX850";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-55HX850"; mv="1.7";,Host: 192.168.1.10:8895,User-Agent: UPnP/1.0 DLNADOC/1.50,Content-Length: 695,Content-Type: text/xml; charset="utf-8",SOAPACTION: "urn:schemas-upnp-org:service:ContentDirectory:1#Browse"]] 2013-10-31 20:24:45,826 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:24:45,827 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#Browse"' from 192.168.1.4 2013-10-31 20:24:45,827 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:24:46,028 DEBUG [ContentDirectory] Browse() called for renderer KDL-55HX850 (profile sony2012) with parameters: objectID = V_F^FOL_R2, browseFlag = BrowseDirectChildren, filter = dc:title,av:mediaClass,dc:date,@childCount,res,upnp:rating,upnp:rating@type,upnp:class,res@resolution,res@av:mpfEntries,upnp:album,upnp:genre,upnp:albumArtURI,upnp:albumArtURI@dlna:profileID,dc:creator,res@size,res@duration,res@bitrate,res@protocolInfo, startIndex = 0, count = 10, sortCriteria = 2013-10-31 20:24:46,028 DEBUG [LocalContentCacheDecorator] Found entry in the cache (local_default), returning it 2013-10-31 20:24:46,035 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message 2013-10-31 20:24:46,064 DEBUG [ServiioHttpService] Incoming request from /192.168.1.4:46884: POST /serviceControl HTTP/1.1, headers = [X-AV-Physical-Unit-Info: pa="BRAVIA KDL-55HX850";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-55HX850"; mv="1.7";,Host: 192.168.1.10:8895,User-Agent: UPnP/1.0 DLNADOC/1.50,Content-Length: 696,Content-Type: text/xml; charset="utf-8",SOAPACTION: "urn:schemas-upnp-org:service:ContentDirectory:1#Browse"]] 2013-10-31 20:24:46,064 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:24:46,064 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#Browse"' from 192.168.1.4 2013-10-31 20:24:46,064 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:24:46,276 DEBUG [ContentDirectory] Browse() called for renderer KDL-55HX850 (profile sony2012) with parameters: objectID = V_F^FOL_R2, browseFlag = BrowseDirectChildren, filter = dc:title,av:mediaClass,dc:date,@childCount,res,upnp:rating,upnp:rating@type,upnp:class,res@resolution,res@av:mpfEntries,upnp:album,upnp:genre,upnp:albumArtURI,upnp:albumArtURI@dlna:profileID,dc:creator,res@size,res@duration,res@bitrate,res@protocolInfo, startIndex = 10, count = 10, sortCriteria = 2013-10-31 20:24:46,276 DEBUG [LocalContentCacheDecorator] Found entry in the cache (local_default), returning it 2013-10-31 20:24:46,283 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message 2013-10-31 20:24:48,380 DEBUG [ServiioHttpService] Incoming request from /192.168.1.4:46885: HEAD /resource/3141/MEDIA_ITEM/AVC_TS_MP_HD_AC3_ISO-0/ORIGINAL HTTP/1.1, headers = [getcontentFeatures.dlna.org: 1,Pragma: getIfoFileURI.dlna.org,transferMode.dlna.org: Streaming,X-AV-Physical-Unit-Info: pa="BRAVIA KDL-55HX850";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-55HX850"; mv="1.7";,Host: 192.168.1.10:8895]] 2013-10-31 20:24:48,381 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:24:48,381 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:24:48,381 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 20:24:48,381 DEBUG [ResourceDeliveryProcessor] Request for resource 3141 and type 'MEDIA_ITEM' received 2013-10-31 20:24:48,381 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 3141 (local) 2013-10-31 20:24:48,381 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 3141) 2013-10-31 20:24:48,386 DEBUG [VideoDAOImpl] Reading a Video (id = 3141) 2013-10-31 20:24:48,387 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 3141, format AVC_TS_MP_HD_AC3_ISO and profile Sony Bravia TV (2012) 2013-10-31 20:24:48,387 DEBUG [MediaItemDAOImpl] Getting file of media item 3141 2013-10-31 20:24:48,387 DEBUG [MediaItemDAOImpl] Getting file of media item 3141 2013-10-31 20:24:48,388 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file Naruto.mkv 2013-10-31 20:24:48,388 DEBUG [MediaItemDAOImpl] Getting file of media item 3141 2013-10-31 20:24:48,388 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file Naruto.mkv: AVC_TS_MP_HD_AC3_ISO 2013-10-31 20:24:48,389 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: video/mpeg,Date: Thu, 31 Oct 2013 09:24:48 GMT,Server: Windows 7, UPnP/1.0 DLNADOC/1.50, Serviio/1.3.1,Cache-control: no-cache,contentFeatures.dlna.org: DLNA.ORG_PN=AVC_TS_HD_24_AC3_ISO;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]] 2013-10-31 20:24:48,394 DEBUG [ServiioHttpService] Incoming request from /192.168.1.4:46886: GET /resource/3141/MEDIA_ITEM/AVC_TS_MP_HD_AC3_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-55HX850";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-55HX850"; mv="1.7";,Host: 192.168.1.10:8895]] 2013-10-31 20:24:48,394 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:24:48,394 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:24:48,395 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 20:24:48,395 DEBUG [ResourceDeliveryProcessor] Request for resource 3141 and type 'MEDIA_ITEM' received 2013-10-31 20:24:48,395 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 3141 (local) 2013-10-31 20:24:48,395 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 3141) 2013-10-31 20:24:48,396 DEBUG [VideoDAOImpl] Reading a Video (id = 3141) 2013-10-31 20:24:48,396 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 3141, format AVC_TS_MP_HD_AC3_ISO and profile Sony Bravia TV (2012) 2013-10-31 20:24:48,396 DEBUG [MediaItemDAOImpl] Getting file of media item 3141 2013-10-31 20:24:48,397 DEBUG [MediaItemDAOImpl] Getting file of media item 3141 2013-10-31 20:24:48,397 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file Naruto.mkv 2013-10-31 20:24:48,397 DEBUG [MediaItemDAOImpl] Getting file of media item 3141 2013-10-31 20:24:48,398 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file Naruto.mkv: AVC_TS_MP_HD_AC3_ISO 2013-10-31 20:24:48,398 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 3141 (local) 2013-10-31 20:24:48,398 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 3141) 2013-10-31 20:24:48,398 DEBUG [VideoDAOImpl] Reading a Video (id = 3141) 2013-10-31 20:24:48,398 DEBUG [VideoDeliveryEngine] Delivering item '3141' for client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 20:24:48,398 DEBUG [MediaItemDAOImpl] Getting file of media item 3141 2013-10-31 20:24:48,399 DEBUG [MediaItemDAOImpl] Getting file of media item 3141 2013-10-31 20:24:48,399 DEBUG [VideoDeliveryEngine] Delivering file 'Naruto.mkv' using transcoding 2013-10-31 20:24:48,399 DEBUG [MediaItemDAOImpl] Getting file of media item 3141 2013-10-31 20:24:48,400 DEBUG [AbstractTranscodingDeliveryEngine] No suitable transcoding job exists yet, start one for client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 20:24:48,401 DEBUG [MediaItemDAOImpl] Getting file of media item 3141 2013-10-31 20:24:48,401 DEBUG [FFMPEGWrapper] Invoking FFmpeg to transcode video file: E:\Naruto.mkv 2013-10-31 20:24:48,401 DEBUG [ProcessExecutor] Starting C:\Program Files\Serviio\bin\\..\lib/ffmpeg.exe -fflags +genpts -threads auto -i E:\Naruto.mkv -y -threads auto -c:v copy -bsf:v h264_mp4toannexb -c:a ac3 -b:a 384k -ac 2 -map 0:0 -map 0:1 -sn -f mpegts C:\Windows\TEMP\Serviio\transcoding-temp-3141-sony2012-ORIGINAL.stf 2013-10-31 20:24:48,901 DEBUG [FileBasedTranscodingDeliveryStrategy] Sending transcoding stream 2013-10-31 20:24:48,902 DEBUG [MediaItemDAOImpl] Getting file of media item 3141 2013-10-31 20:24:48,903 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file Naruto.mkv: AVC_TS_MP_HD_AC3_ISO 2013-10-31 20:24:48,903 DEBUG [MediaItemDAOImpl] Marking MediaItem (id = 3141) as read 2013-10-31 20:24:48,911 DEBUG [LocalContentCacheDecorator] Cleared cache (local_resetafterplay) 2013-10-31 20:24:48,911 DEBUG [GETMethodProcessor] Stream entity has length: 50000000000 2013-10-31 20:24:48,911 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer 2013-10-31 20:24:48,911 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: video/mpeg,Date: Thu, 31 Oct 2013 09:24:48 GMT,Server: Windows 7, UPnP/1.0 DLNADOC/1.50, Serviio/1.3.1,Cache-control: no-cache,TimeSeekRange.dlna.org: npt=0-1389/1389,contentFeatures.dlna.org: DLNA.ORG_PN=AVC_TS_HD_24_AC3_ISO;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]] 2013-10-31 20:24:50,945 DEBUG [WebServer] I/O error: Connection reset by peer: socket write error 2013-10-31 20:24:50,957 DEBUG [ServiioHttpService] Incoming request from /192.168.1.4:46887: GET /resource/3141/MEDIA_ITEM/AVC_TS_MP_HD_AC3_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-55HX850";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-55HX850"; mv="1.7";,Host: 192.168.1.10:8895]] 2013-10-31 20:24:50,957 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:24:50,958 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:24:50,958 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 20:24:50,958 DEBUG [ResourceDeliveryProcessor] Request for resource 3141 and type 'MEDIA_ITEM' received 2013-10-31 20:24:50,958 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 3141 (local) 2013-10-31 20:24:50,958 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 3141) 2013-10-31 20:24:50,958 DEBUG [VideoDAOImpl] Reading a Video (id = 3141) 2013-10-31 20:24:50,959 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 3141, format AVC_TS_MP_HD_AC3_ISO and profile Sony Bravia TV (2012) 2013-10-31 20:24:50,959 DEBUG [MediaItemDAOImpl] Getting file of media item 3141 2013-10-31 20:24:50,959 DEBUG [MediaItemDAOImpl] Getting file of media item 3141 2013-10-31 20:24:50,960 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file Naruto.mkv 2013-10-31 20:24:50,960 DEBUG [MediaItemDAOImpl] Getting file of media item 3141 2013-10-31 20:24:50,960 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file Naruto.mkv: AVC_TS_MP_HD_AC3_ISO 2013-10-31 20:24:50,960 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 3141 (local) 2013-10-31 20:24:50,960 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 3141) 2013-10-31 20:24:50,961 DEBUG [VideoDAOImpl] Reading a Video (id = 3141) 2013-10-31 20:24:50,961 DEBUG [VideoDeliveryEngine] Delivering item '3141' for client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 20:24:50,961 DEBUG [MediaItemDAOImpl] Getting file of media item 3141 2013-10-31 20:24:50,961 DEBUG [MediaItemDAOImpl] Getting file of media item 3141 2013-10-31 20:24:50,962 DEBUG [VideoDeliveryEngine] Delivering file 'Naruto.mkv' using transcoding 2013-10-31 20:24:50,962 DEBUG [MediaItemDAOImpl] Getting file of media item 3141 2013-10-31 20:24:50,962 DEBUG [AbstractTranscodingDeliveryEngine] A suitable transcoding job already exists, re-use it for client 'Identifier=192.168.1.4, Profile=Sony Bravia TV (2012)' 2013-10-31 20:24:50,963 DEBUG [FileBasedTranscodingDeliveryStrategy] Sending transcoding stream 2013-10-31 20:24:50,963 DEBUG [MediaItemDAOImpl] Getting file of media item 3141 2013-10-31 20:24:50,963 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file Naruto.mkv: AVC_TS_MP_HD_AC3_ISO 2013-10-31 20:24:50,963 DEBUG [MediaItemDAOImpl] Marking MediaItem (id = 3141) as read 2013-10-31 20:24:50,966 DEBUG [LocalContentCacheDecorator] Cleared cache (local_resetafterplay) 2013-10-31 20:24:50,966 DEBUG [GETMethodProcessor] Stream entity has length: 50000000000 2013-10-31 20:24:50,966 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer 2013-10-31 20:24:50,966 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: video/mpeg,Date: Thu, 31 Oct 2013 09:24:50 GMT,Server: Windows 7, UPnP/1.0 DLNADOC/1.50, Serviio/1.3.1,Cache-control: no-cache,TimeSeekRange.dlna.org: npt=0-1389/1389,contentFeatures.dlna.org: DLNA.ORG_PN=AVC_TS_HD_24_AC3_ISO;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]] 2013-10-31 20:25:02,823 DEBUG [TranscodingJobListener] Transcoding finished; successful: true 2013-10-31 20:25:12,808 DEBUG [WebServer] I/O error: Connection reset by peer: socket write error 2013-10-31 20:25:13,685 DEBUG [ServiioHttpService] Incoming request from /192.168.1.4:46888: POST /serviceControl HTTP/1.1, headers = [X-AV-Physical-Unit-Info: pa="BRAVIA KDL-55HX850";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-55HX850"; mv="1.7";,Host: 192.168.1.10:8895,User-Agent: UPnP/1.0 DLNADOC/1.50,Content-Length: 695,Content-Type: text/xml; charset="utf-8",SOAPACTION: "urn:schemas-upnp-org:service:ContentDirectory:1#Browse"]] 2013-10-31 20:25:13,685 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:25:13,686 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#Browse"' from 192.168.1.4 2013-10-31 20:25:13,686 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:25:13,887 DEBUG [ContentDirectory] Browse() called for renderer KDL-55HX850 (profile sony2012) with parameters: objectID = V_F^FOL_R2, browseFlag = BrowseDirectChildren, filter = dc:title,av:mediaClass,dc:date,@childCount,res,upnp:rating,upnp:rating@type,upnp:class,res@resolution,res@av:mpfEntries,upnp:album,upnp:genre,upnp:albumArtURI,upnp:albumArtURI@dlna:profileID,dc:creator,res@size,res@duration,res@bitrate,res@protocolInfo, startIndex = 0, count = 10, sortCriteria = 2013-10-31 20:25:13,887 DEBUG [LocalContentCacheDecorator] Found entry in the cache (local_default), returning it 2013-10-31 20:25:13,893 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message 2013-10-31 20:25:13,920 DEBUG [ServiioHttpService] Incoming request from /192.168.1.4:46889: POST /serviceControl HTTP/1.1, headers = [X-AV-Physical-Unit-Info: pa="BRAVIA KDL-55HX850";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="BRAVIA KDL-55HX850"; mv="1.7";,Host: 192.168.1.10:8895,User-Agent: UPnP/1.0 DLNADOC/1.50,Content-Length: 696,Content-Type: text/xml; charset="utf-8",SOAPACTION: "urn:schemas-upnp-org:service:ContentDirectory:1#Browse"]] 2013-10-31 20:25:13,920 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:25:13,920 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#Browse"' from 192.168.1.4 2013-10-31 20:25:13,920 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.1.4 2013-10-31 20:25:14,122 DEBUG [ContentDirectory] Browse() called for renderer KDL-55HX850 (profile sony2012) with parameters: objectID = V_F^FOL_R2, browseFlag = BrowseDirectChildren, filter = dc:title,av:mediaClass,dc:date,@childCount,res,upnp:rating,upnp:rating@type,upnp:class,res@resolution,res@av:mpfEntries,upnp:album,upnp:genre,upnp:albumArtURI,upnp:albumArtURI@dlna:profileID,dc:creator,res@size,res@duration,res@bitrate,res@protocolInfo, startIndex = 10, count = 10, sortCriteria = 2013-10-31 20:25:14,122 DEBUG [LocalContentCacheDecorator] Found entry in the cache (local_default), returning it 2013-10-31 20:25:14,127 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message 2013-10-31 20:25:37,286 WARN [IndexedDiskCache] Region [thumbnails] Disk cache not shutdown properly, shutting down now. 2013-10-31 20:25:37,286 WARN [IndexedDiskCache] Region [online_technical_metadata] Disk cache not shutdown properly, shutting down now. 2013-10-31 20:25:37,286 INFO [LibraryAdditionsCheckerThread] Finished looking for newly added files 2013-10-31 20:25:37,386 INFO [LibraryUpdatesCheckerThread] Finished looking for updates to currently shared files 2013-10-31 20:25:37,486 INFO [FeedUpdaterThread] Finished looking for online resources information 2013-10-31 20:25:37,586 INFO [PluginCompilerThread] Finished looking for plugins 2013-10-31 20:25:37,688 INFO [SearchManager] Starting up search engine 2013-10-31 20:25:37,867 INFO [SearchIndexer] Closing search index writer 2013-10-31 20:25:37,868 INFO [SearchIndexer] Closing search index writer 2013-10-31 20:25:37,868 DEBUG [DiscoveryManager] UPNP device 8dee68fe-0370-3fc8-a5f5-ae4a1fb10a65 (192.168.1.10) is unavailable 2013-10-31 20:25:37,868 DEBUG [WebServer] Socket closed 2013-10-31 20:25:37,868 INFO [WebServer] WebServer shutting down 2013-10-31 20:25:37,869 INFO [DiscoveryAdvertisementNotifier] Leaving DiscoveryAdvertisementNotifier 2013-10-31 20:25:37,869 INFO [EventSubscriptionExpirationChecker] Leaving EventSubscriptionExpirationChecker, removing all event subscriptions 2013-10-31 20:25:37,869 DEBUG [DiscoverySSDPMessageListener] Socket closed: socket closed 2013-10-31 20:25:37,869 INFO [DiscoverySSDPMessageListener] Leaving DiscoverySSDPMessageListener 2013-10-31 20:25:37,869 INFO [EventDispatcher] Leaving EventDispatcher 2013-10-31 20:25:37,917 DEBUG [DiscoveryAdvertisementNotifier] Multicasting SSDP byebye using interface eth3 (Realtek RTL8168C(P)/8111C(P) Family PCI-E Gigabit Ethernet NIC (NDIS 6.20)) and address 192.168.1.10, timeout = 0 2013-10-31 20:25:37,917 INFO [DatabaseManager] Shutting down database 2013-10-31 20:25:37,917 DEBUG [DBConnectionPool] Closed connection for pool Serviio DB Pool 2013-10-31 20:25:37,917 DEBUG [DBConnectionPool] Closed connection for pool Serviio DB Pool 2013-10-31 20:25:37,917 DEBUG [DBConnectionPool] Closed connection for pool Serviio DB Pool 2013-10-31 20:25:38,120 DEBUG [DatabaseManager] DB shutdown returned: Derby system shutdown. 2013-10-31 20:25:38,120 INFO [AbstractTranscodingDeliveryEngine] Cleaning transcode engine and its data 2013-10-31 20:25:38,167 DEBUG [TranscodingJobListener] Deleted temp file 'C:\Windows\TEMP\Serviio\transcoding-temp-3141-sony2012-ORIGINAL.stf': true 2013-10-31 20:25:38,167 DEBUG [AbstractTranscodingDeliveryEngine] Deleting temporary transcoded files from: C:\Windows\TEMP\Serviio 2013-10-31 20:25:44,235 INFO [ServiioConsole] Exitting Serviio Console 2013-10-31 20:25:44,235 DEBUG [RepositoryView] Instructing LibraryCheckingThread to stop 2013-10-31 20:25:44,235 INFO [ServiioConsole] Serviio Console completely closed

Thu Oct 31, 2013 5:14 pm by Illico

kitjai wrote:Hope this helps

No, you send log section during file playback... I would like when file is added to the serviio library (just after force refresh).
It seems that serviio/ffmpeg does not detect the subtitle track.

Fri Nov 01, 2013 2:52 am by kitjai

Here is a link to the log

http://www.filedropper.com/serviiodetailedlog

Thanks
kitjai

Fri Nov 01, 2013 11:54 am by Darkfalz

Bravia 2012 series don't support MKV playback, so your file is being remuxed to mpeg2ts which is why you're losing the subtitle.

Edit: NM, you are trying to hard-encode them.

Fri Nov 01, 2013 1:41 pm by kitjai

I'm not sure, because I installed ums and it play the subtitles.
I don't like ums though

MKV subtitles not playing

MKV subtitles not playing

Re: MKV subtitles not playing

Re: MKV subtitles not playing

Re: MKV subtitles not playing

Re: MKV subtitles not playing

Re: MKV subtitles not playing

Re: MKV subtitles not playing

Re: MKV subtitles not playing

Who is online