Serviio not transcoding stream "on the fly"? large! tmp file

Hi I'm just getting started with Serviio.

My video collection is in ffmpeg-converted h264.mkvformat.

I want to on-the-fly transcode & stream the collection to a Panasonic DMP-BDT220 BD player.

I've installed Serviio, selected the Panasonic BD profile, pointed it at my store, and launched it.

The Panasonic's renderer client sees the store, and I can select a movie to play.

Here's where I'm (already) stuck :-/

With both MediaTomb & UMS, the start of playback of the transcode (vcodec == h264, acodec == copy) was almost immediate, and both Video & Audio, converted to mpegts on the fly, were perfect. Lots of OTHER stuff was broken, which is why I found my way to Serviio finally.

With Serviio, however, it takes ~ 30-45 seconds for the movie to start playing.

On the screen I see the first few seconds of Video, then it just gets stuck there ... Video doesn't progress any further. Audio, otoh, keeps playing -- and SOUNDS ok.

While setting up for debug logging, I noticed that Serviio appeared to be creating a LARGE transcoding tmp file

  Code:

   ls -al /tmp/Serviio/
      total 944M
      drwxrwxrwt 62 root    root    4.0K Aug 22 20:00 ../
      drwxr-xr-x  2 serviio serviio 4.0K Aug 22 20:04 ./
      -rw-r--r--  1 serviio serviio 944M Aug 22 20:06 transcoding-temp-35-panasonicBDT220-ORIGINAL.stf


Since my goal is to do this on-the-fly, I was surprised to see the file created and populated.

I suspect this may be behind the problem I'm having with stuck-video, etc. Not really sure this soon in the game, though.

So, 1st question -- how do I make sure that Serviio is ONLY transcoding on the fly -- and not writing/storing any tmp files. Or at least NOTHING this large.

[DenyAll]

So, 1st question -- how do I make sure that Serviio is ONLY transcoding on the fly -- and not writing/storing any tmp files. Or at least NOTHING this large.

Serviio is transcoding on-the-fly. "On-the-fly" means it will transcode in real time, or near real time, when required - it doesn't mean that it won't create a temporary file.

Any on-the-fly transcoding system will store the transcoded video, either as a temporary file as Serviio has done, or temporarily to a RAM file or buffer (ie. in memory). There are advantages and disadvantages to either approach, but speed isn't normally an issue either way. The temporary files are just that - they are wiped when Serviio is restarted, or when you start a new transcode job from the same device.

Putting the large file to one side you have an issue with it being delayed on startup and then not playing. When my video's transcode, they generally start on my TV near instantaneously. The Panasonic BDT220 profile is quite a simple one - it remuxes anything with h264 or mpeg2 video (converting audio to AC3 if not already) and transcodes all other video types. Your h264 mkvformat should simply be re-muxed to a m2ts container, which should be quick, and should result in a temporary file about the same size as the original. Note that play should start on your TV as soon as the file starts transcoding (ie. it doesn't wait until the transcode job is finished)... this is not what you are experiencing though....

Can you please post some MediaInfo details for your file. Have you also tried playing the file without transcoding (either turn transcoding off, or select the Generic profile), probably wont work, but always worth a try.

Serviio is transcoding on-the-fly. "On-the-fly" means it will transcode in real time, or near real time, when required - it doesn't mean that it won't create a temporary file.

Any on-the-fly transcoding system will store the transcoded video, either as a temporary file as Serviio has done, or temporarily to a RAM file or buffer (ie. in memory). There are advantages and disadvantages to either approach, but speed isn't normally an issue either way. The temporary files are just that - they are wiped when Serviio is restarted, or when you start a new transcode job from the same device.

Ok, then no worries about that. I guess I was just never aware of MediaTomb or UMS doing it.

you have an issue with it being delayed on startup and then not playing. When my video's transcode, they generally start on my TV near instantaneously.

So likely a problem here.

The Panasonic BDT220 profile is quite a simple one

At the moment, I'm using the newer version from [url]http://forum.serviio.org/viewtopic.php?f=13&t=5983&start=20#p69986
[/url]

No difference to the original one. I.e., same issues.

Have you also tried playing the file without transcoding (either turn transcoding off, or select the Generic profile), probably wont work, but always worth a try.

Yes, and it doesn't work. I get the "Cannot Play" error @ the player.

MediaInfo details for your file

Here's the info for one file. Just to be clear, it's the same for ALL my videos.

  Code:

General
Unique ID                                : 438381584701175352318445440968847485673 (0x8FFA4297E6B5B7858322F290275A0791)
Complete name                            : movie.mkv
Format                                   : Matroska
Format version                           : Version 2
File size                                : 1.09 GiB
Duration                                 : 1h 24mn
Overall bit rate                         : 1 850 Kbps
Writing application                      : HandBrake rev5474
Writing library                          : libmkv 0.6.5

Video
ID                                       : 1
Format                                   : AVC
Format/Info                              : Advanced Video Codec
Format profile                           : High@L4.0
Format settings, CABAC                   : Yes
Format settings, ReFrames                : 16 frames
Codec ID                                 : V_MPEG4/ISO/AVC
Duration                                 : 1h 24mn
Width                                    : 720 pixels
Height                                   : 480 pixels
Display aspect ratio                     : 4:3
Frame rate mode                          : Constant
Frame rate                               : 23.976 fps
Standard                                 : NTSC
Color space                              : YUV
Chroma subsampling                       : 4:2:0
Bit depth                                : 8 bits
Scan type                                : Progressive
Writing library                          : x264 core 130 r2273 b3065e6
Encoding settings                        : cabac=1 / ref=16 / deblock=1:-2:-1 / analyse=0x3:0x133 / me=umh / subme=10 / psy=1 / psy_rd=1.00:0.00 / mixed_ref=1 / me_range=24 / chroma_me=1 / trellis=2 / 8x8dct=1 / cqm=0 / deadzone=21,11 / fast_pskip=0 / chroma_qp_offset=-2 / threads=6 / lookahead_threads=1 / sliced_threads=0 / nr=0 / decimate=0 / interlaced=0 / bluray_compat=0 / constrained_intra=0 / bframes=8 / b_pyramid=2 / b_adapt=2 / b_bias=0 / direct=3 / weightb=1 / open_gop=0 / weightp=2 / keyint=240 / keyint_min=24 / scenecut=40 / intra_refresh=0 / rc_lookahead=60 / rc=crf / mbtree=1 / crf=19.0 / qcomp=0.60 / qpmin=0 / qpmax=69 / qpstep=4 / ip_ratio=1.40 / aq=1:1.00
Language                                 : English
Default                                  : Yes
Forced                                   : No
Color primaries                          : BT.601 NTSC
Transfer characteristics                 : BT.709
Matrix coefficients                      : BT.601

Audio #1
ID                                       : 2
Format                                   : AAC
Format/Info                              : Advanced Audio Codec
Format profile                           : LC
Codec ID                                 : A_AAC
Duration                                 : 1h 24mn
Channel(s)                               : 2 channels
Channel positions                        : Front: L R
Sampling rate                            : 48.0 KHz
Compression mode                         : Lossy
Language                                 : English
Default                                  : Yes
Forced                                   : No

Audio #2
ID                                       : 3
Format                                   : AC-3
Format/Info                              : Audio Coding 3
Mode extension                           : CM (complete main)
Format settings, Endianness              : Big
Codec ID                                 : A_AC3
Duration                                 : 1h 24mn
Bit rate mode                            : Constant
Bit rate                                 : 448 Kbps
Channel(s)                               : 6 channels
Channel positions                        : Front: L C R, Side: L R, LFE
Sampling rate                            : 48.0 KHz
Bit depth                                : 16 bits
Compression mode                         : Lossy
Stream size                              : 269 MiB (24%)
Language                                 : English
Default                                  : No
Forced                                   : No

Menu
00:00:00.000                             : Chapter 1
00:06:50.410                             : Chapter 2
00:10:59.158                             : Chapter 3
00:13:24.637                             : Chapter 4
00:17:52.404                             : Chapter 5
00:21:02.761                             : Chapter 6
00:23:21.400                             : Chapter 7
00:29:49.287                             : Chapter 8
00:35:11.109                             : Chapter 9
00:44:04.266                             : Chapter 10
00:47:34.434                             : Chapter 11
00:52:24.516                             : Chapter 12
00:58:14.199                             : Chapter 13
01:02:41.048                             : Chapter 14
01:09:14.525                             : Chapter 15
01:13:54.596                             : Chapter 16
01:19:39.524                             : Chapter 17


For reference, this exact file starts good A&V playback almost instantaneously in MT & UMS. So probly PEBKAC!

I captured the debug log while launching a video.

Again, here, the video launches, plays a couple of frames, stops, repeats this 4-5 times -- kind of a stutter -- then just halts and stick there. The audio keeps playing.

  Code:

==> /usr/local/serviio/log/serviio.log <==
2013-08-23 00:15:35,396 DEBUG [DiscoverySSDPMessageListener] Received a valid M-SEARCH message for search target urn:schemas-upnp-org:device:MediaServer:1 from address /10.1.1.109:1089s
2013-08-23 00:15:35,397 DEBUG [DiscoverySSDPMessageListener] Received a valid M-SEARCH message for search target urn:schemas-upnp-org:device:MediaServer:1 from address /10.1.1.109:1089s
2013-08-23 00:15:35,400 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s) to /10.1.1.109:1089
2013-08-23 00:15:35,401 DEBUG [DiscoverySearchResponder] Sending 1 M-SEARCH response message(s) to /10.1.1.109:1089
2013-08-23 00:15:36,921 DEBUG [ServiioHttpService] Incoming request from /10.1.1.109:2064: GET /deviceDescription/ea8d1d61-973a-3902-8d09-8a517a3fce53 HTTP/1.1, headers = [HOST: 10.1.1.202:8895,ACCEPT-LANGUAGE: ja,CONNECTION: close]]
2013-08-23 00:15:36,921 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.1.1.109
2013-08-23 00:15:36,925 DEBUG [DeviceDescriptionRequestHandler] DeviceDescription request received for device ea8d1d61-973a-3902-8d09-8a517a3fce53 from 10.1.1.109 (headers = [HOST: 10.1.1.202:8895,ACCEPT-LANGUAGE: ja,CONNECTION: close])
2013-08-23 00:15:36,925 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.1.1.109
2013-08-23 00:15:36,927 DEBUG [RendererManager] Looking for a renderer profile for Http headers: [HOST: 10.1.1.202:8895,ACCEPT-LANGUAGE: ja,CONNECTION: close]
2013-08-23 00:15:36,928 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.1.1.109
2013-08-23 00:15:37,269 DEBUG [DeviceDescriptionRequestHandler] Sending DeviceDescription XML back using profile 'Panasonic - BDT220 V1.1'
2013-08-23 00:15:37,377 DEBUG [ServiioHttpService] Incoming request from /10.1.1.109:2065: GET /icon/smallJPG HTTP/1.1, headers = [Host: 10.1.1.202:8895,Accept: */*,Accept-Language: en-us,Accept-Charset: utf-8,X-PANASONIC-VLI-Auth: UwjQSR203G8YZfqhx7xFB+sauqldOv6hOyfPcxA7nh/V/3OpbCwcbMM4Z2g/0Xwa]]
2013-08-23 00:15:37,377 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.1.1.109
2013-08-23 00:15:37,379 DEBUG [UPnPIconRequestHandler] UPnP icon request received for icon smallJPG
2013-08-23 00:15:38,413 DEBUG [ServiioHttpService] Incoming request from /10.1.1.109:2066: SUBSCRIBE /serviceEventing/ContentDirectory HTTP/1.1, headers = [HOST: 10.1.1.202:8895,CALLBACK: <http://10.1.1.109:60605/event_0>,NT: upnp:event,TIMEOUT: Second-1800,CONNECTION: close]]
2013-08-23 00:15:38,414 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.1.1.109
2013-08-23 00:15:38,416 DEBUG [ServiceEventSubscriptionRequestHandler] ServiceEvent subscription request received for service ContentDirectory
2013-08-23 00:15:38,417 DEBUG [ServiceEventSubscriptionRequestHandler] Event subscription registered (uuid=a1a8e966-6b9f-4116-9ed2-489bff5d0a36) for service urn:upnp-org:serviceId:ContentDirectory with duration 1800 reporting to http://10.1.1.109:60605/event_0
2013-08-23 00:15:38,555 DEBUG [ServiioHttpService] Incoming request from /10.1.1.109:2067: POST /serviceControl HTTP/1.1, headers = [HOST: 10.1.1.202:8895,CONTENT-LENGTH: 905,CONTENT-TYPE: text/xml; charset="utf-8",USER-AGENT: Panasonic-UPnPSDK/1.00 DLNADOC/1.50,SOAPACTION: "urn:schemas-upnp-org:service:ContentDirectory:1#Browse",CONNECTION: close]]
2013-08-23 00:15:38,556 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.1.1.109
2013-08-23 00:15:38,558 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#Browse"' from 10.1.1.109
2013-08-23 00:15:38,558 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.1.1.109
2013-08-23 00:15:38,582 DEBUG [ContentDirectory] Browse() called for renderer Blu-ray Disc Player (profile BDT220V1.1) with parameters: objectID = 0, browseFlag = BrowseDirectChildren, filter = @childCount,@refID,dc:date,dc:creator,upnp:channelNr,upnp:channelName,upnp:genre,upnp:album,upnp:albumArtURI,upnp:albumArtURI@dlna:profileID,upnp:rating,upnp:playbackCount,res,res@duration,res@size,res@bitrate,res@dlna:ifoFileURI,res@protocolInfo,res@pxn:Version,res@pxn:NaviList,res@pxn:StreamPort,res@pxn:ResumePoint,res@pxn:ChapterList,arib:objectType,pxn:groupTopFlag,pxn:groupID,pxn:groupMemberNum,pxn:groupTitle, startIndex = 0, count = 5, sortCriteria =
2013-08-23 00:15:38,582 DEBUG [AccessGroupDAOImpl] Reading a AccessGroup (id = 1)
2013-08-23 00:15:38,593 INFO  [BrowsingCategoriesMessages] Loaded browsing categories message bundle for locale: en
2013-08-23 00:15:38,603 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message
2013-08-23 00:15:38,735 DEBUG [EventDispatcher] Sending event notification #0 for subscription a1a8e966-6b9f-4116-9ed2-489bff5d0a36 to endpoint http://10.1.1.109:60605/event_0
2013-08-23 00:15:38,760 DEBUG [RequestExecutor] Sending HTTP request to 10.1.1.109:60605
2013-08-23 00:15:38,856 DEBUG [EventDispatcher] Event notification sent and received successfully
2013-08-23 00:15:39,543 DEBUG [ServiioHttpService] Incoming request from /10.1.1.109:2068: POST /serviceControl HTTP/1.1, headers = [HOST: 10.1.1.202:8895,CONTENT-LENGTH: 905,CONTENT-TYPE: text/xml; charset="utf-8",USER-AGENT: Panasonic-UPnPSDK/1.00 DLNADOC/1.50,SOAPACTION: "urn:schemas-upnp-org:service:ContentDirectory:1#Browse",CONNECTION: close]]
2013-08-23 00:15:39,544 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.1.1.109
2013-08-23 00:15:39,546 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#Browse"' from 10.1.1.109
2013-08-23 00:15:39,546 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.1.1.109
2013-08-23 00:15:39,563 DEBUG [ContentDirectory] Browse() called for renderer Blu-ray Disc Player (profile BDT220V1.1) with parameters: objectID = V, browseFlag = BrowseDirectChildren, filter = @childCount,@refID,dc:date,dc:creator,upnp:channelNr,upnp:channelName,upnp:genre,upnp:album,upnp:albumArtURI,upnp:albumArtURI@dlna:profileID,upnp:rating,upnp:playbackCount,res,res@duration,res@size,res@bitrate,res@dlna:ifoFileURI,res@protocolInfo,res@pxn:Version,res@pxn:NaviList,res@pxn:StreamPort,res@pxn:ResumePoint,res@pxn:ChapterList,arib:objectType,pxn:groupTopFlag,pxn:groupID,pxn:groupMemberNum,pxn:groupTitle, startIndex = 0, count = 5, sortCriteria =
2013-08-23 00:15:39,563 DEBUG [AccessGroupDAOImpl] Reading a AccessGroup (id = 1)
2013-08-23 00:15:39,567 DEBUG [VideoDAOImpl] Retrieving number of videos of type 2 [No_Restriction]
2013-08-23 00:15:39,595 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message
2013-08-23 00:15:40,629 DEBUG [ServiioHttpService] Incoming request from /10.1.1.109:2069: POST /serviceControl HTTP/1.1, headers = [HOST: 10.1.1.202:8895,CONTENT-LENGTH: 907,CONTENT-TYPE: text/xml; charset="utf-8",USER-AGENT: Panasonic-UPnPSDK/1.00 DLNADOC/1.50,SOAPACTION: "urn:schemas-upnp-org:service:ContentDirectory:1#Browse",CONNECTION: close]]
2013-08-23 00:15:40,630 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.1.1.109
2013-08-23 00:15:40,699 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#Browse"' from 10.1.1.109
2013-08-23 00:15:40,700 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.1.1.109
2013-08-23 00:15:40,715 DEBUG [ContentDirectory] Browse() called for renderer Blu-ray Disc Player (profile BDT220V1.1) with parameters: objectID = V_M, browseFlag = BrowseDirectChildren, filter = @childCount,@refID,dc:date,dc:creator,upnp:channelNr,upnp:channelName,upnp:genre,upnp:album,upnp:albumArtURI,upnp:albumArtURI@dlna:profileID,upnp:rating,upnp:playbackCount,res,res@duration,res@size,res@bitrate,res@dlna:ifoFileURI,res@protocolInfo,res@pxn:Version,res@pxn:NaviList,res@pxn:StreamPort,res@pxn:ResumePoint,res@pxn:ChapterList,arib:objectType,pxn:groupTopFlag,pxn:groupID,pxn:groupMemberNum,pxn:groupTitle, startIndex = 0, count = 5, sortCriteria =
2013-08-23 00:15:40,715 DEBUG [AccessGroupDAOImpl] Reading a AccessGroup (id = 1)
2013-08-23 00:15:40,717 DEBUG [LocalContentCacheDecorator] Found entry in the cache (local_default), returning it
2013-08-23 00:15:40,736 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message
2013-08-23 00:15:48,182 DEBUG [ServiioHttpService] Incoming request from /10.1.1.109:2070: GET /resource/61/MEDIA_ITEM/AVC_TS_MP_SD_AC3_ISO-1/ORIGINAL HTTP/1.1, headers = [TimeSeekRange.dlna.org: npt=0.000-,HOST: 10.1.1.202:8895,transferMode.dlna.org: Streaming,getcontentFeatures.dlna.org: 1]]
2013-08-23 00:15:48,182 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.1.1.109
2013-08-23 00:15:48,184 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.1.1.109
2013-08-23 00:15:48,186 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'Identifier=10.1.1.109, Profile=Panasonic - BDT220 V1.1'
2013-08-23 00:15:48,186 DEBUG [ResourceDeliveryProcessor] Request for resource 61 and type 'MEDIA_ITEM' received
2013-08-23 00:15:48,187 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 61 (local)
2013-08-23 00:15:48,187 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 61)
2013-08-23 00:15:48,188 DEBUG [VideoDAOImpl] Reading a Video (id = 61)
2013-08-23 00:15:48,190 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 61, format AVC_TS_MP_SD_AC3_ISO and profile Panasonic - BDT220 V1.1
2013-08-23 00:15:48,191 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file movie.mkv
2013-08-23 00:15:48,192 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file movie.mkv: AVC_TS_MP_SD_AC3_ISO
2013-08-23 00:15:48,192 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 61 (local)
2013-08-23 00:15:48,192 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 61)
2013-08-23 00:15:48,194 DEBUG [VideoDAOImpl] Reading a Video (id = 61)
2013-08-23 00:15:48,196 DEBUG [VideoDeliveryEngine] Delivering item '61' for client 'Identifier=10.1.1.109, Profile=Panasonic - BDT220 V1.1'
2013-08-23 00:15:48,197 DEBUG [VideoDeliveryEngine] Delivering file 'movie.mkv' using transcoding
2013-08-23 00:15:48,197 DEBUG [AbstractTranscodingDeliveryEngine] A suitable transcoding job already exists, re-use it for client 'Identifier=10.1.1.109, Profile=Panasonic - BDT220 V1.1'
2013-08-23 00:15:48,198 DEBUG [FileBasedTranscodingDeliveryStrategy] Transcoded file '/tmp/Serviio/transcoding-temp-61-BDT220V1.1-ORIGINAL.stf' is complete, sending simple stream
2013-08-23 00:15:48,198 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file movie.mkv: AVC_TS_MP_SD_AC3_ISO
2013-08-23 00:15:48,198 DEBUG [MediaItemDAOImpl] Marking MediaItem (id = 61) as read
2013-08-23 00:15:48,251 DEBUG [LocalContentCacheDecorator] Cleared cache (local_resetafterplay)
2013-08-23 00:15:48,252 DEBUG [GETMethodProcessor] Stream entity has length: 1103382152
2013-08-23 00:15:48,252 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer
2013-08-23 00:15:48,253 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: video/vnd.dlna.mpeg-tts,Date: Fri, 23 Aug 2013 07:15:48 GMT,Server: Linux, UPnP/1.0 DLNADOC/1.50, Serviio/1.3.1,Cache-control: no-cache,TimeSeekRange.dlna.org: npt=0-6948/6948,contentFeatures.dlna.org: DLNA.ORG_PN=MPEG_TS_SD_NA;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]]
2013-08-23 00:15:51,027 DEBUG [FeedUpdaterThread] Checking for new and expired online resources
2013-08-23 00:15:51,027 DEBUG [OnlineRepositoryDAOImpl] Reading all OnlineRepositories
2013-08-23 00:15:53,020 DEBUG [WebServer] I/O error: Connection reset
2013-08-23 00:15:53,026 DEBUG [ServiioHttpService] Incoming request from /10.1.1.109:2071: GET /resource/61/MEDIA_ITEM/AVC_TS_MP_SD_AC3_ISO-1/ORIGINAL HTTP/1.1, headers = [TimeSeekRange.dlna.org: npt=0.000-,HOST: 10.1.1.202:8895,transferMode.dlna.org: Streaming,getcontentFeatures.dlna.org: 1]]
2013-08-23 00:15:53,026 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.1.1.109
2013-08-23 00:15:53,028 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.1.1.109
2013-08-23 00:15:53,030 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'Identifier=10.1.1.109, Profile=Panasonic - BDT220 V1.1'
2013-08-23 00:15:53,030 DEBUG [ResourceDeliveryProcessor] Request for resource 61 and type 'MEDIA_ITEM' received
2013-08-23 00:15:53,031 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 61 (local)
2013-08-23 00:15:53,031 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 61)
2013-08-23 00:15:53,032 DEBUG [VideoDAOImpl] Reading a Video (id = 61)
2013-08-23 00:15:53,034 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 61, format AVC_TS_MP_SD_AC3_ISO and profile Panasonic - BDT220 V1.1
2013-08-23 00:15:53,035 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file movie.mkv
2013-08-23 00:15:53,036 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file movie.mkv: AVC_TS_MP_SD_AC3_ISO
2013-08-23 00:15:53,036 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 61 (local)
2013-08-23 00:15:53,036 DEBUG [MediaItemDAOImpl] Reading a MediaItem (id = 61)
2013-08-23 00:15:53,039 DEBUG [VideoDAOImpl] Reading a Video (id = 61)
2013-08-23 00:15:53,041 DEBUG [VideoDeliveryEngine] Delivering item '61' for client 'Identifier=10.1.1.109, Profile=Panasonic - BDT220 V1.1'
2013-08-23 00:15:53,042 DEBUG [VideoDeliveryEngine] Delivering file 'movie.mkv' using transcoding
2013-08-23 00:15:53,042 DEBUG [AbstractTranscodingDeliveryEngine] A suitable transcoding job already exists, re-use it for client 'Identifier=10.1.1.109, Profile=Panasonic - BDT220 V1.1'
2013-08-23 00:15:53,043 DEBUG [FileBasedTranscodingDeliveryStrategy] Transcoded file '/tmp/Serviio/transcoding-temp-61-BDT220V1.1-ORIGINAL.stf' is complete, sending simple stream
2013-08-23 00:15:53,043 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file movie.mkv: AVC_TS_MP_SD_AC3_ISO
2013-08-23 00:15:53,044 DEBUG [MediaItemDAOImpl] Marking MediaItem (id = 61) as read
2013-08-23 00:15:53,103 DEBUG [LocalContentCacheDecorator] Cleared cache (local_resetafterplay)
2013-08-23 00:15:53,103 DEBUG [GETMethodProcessor] Stream entity has length: 1103382152
2013-08-23 00:15:53,104 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer
2013-08-23 00:15:53,104 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: video/vnd.dlna.mpeg-tts,Date: Fri, 23 Aug 2013 07:15:53 GMT,Server: Linux, UPnP/1.0 DLNADOC/1.50, Serviio/1.3.1,Cache-control: no-cache,TimeSeekRange.dlna.org: npt=0-6948/6948,contentFeatures.dlna.org: DLNA.ORG_PN=MPEG_TS_SD_NA;DLNA.ORG_OP=10;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=01500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]]
2013-08-23 00:16:17,495 DEBUG [DiscoveryAdvertisementNotifier] Multicasting SSDP alive using interface eth0 (eth0) and address 10.1.1.202, timeout = 0
2013-08-23 00:16:17,497 DEBUG [DiscoveryAdvertisementNotifier] Sending 6 'alive' messages describing device ea8d1d61-973a-3902-8d09-8a517a3fce53
2013-08-23 00:16:19,307 DEBUG [DiscoveryAdvertisementNotifier] Will advertise again in 00:04:04 (advertisement duration is 1800 sec.)
2013-08-23 00:16:29,982 DEBUG [WebServer] I/O error: Broken pipe
2013-08-23 00:16:30,763 DEBUG [ServiioHttpService] Incoming request from /10.1.1.109:2072: UNSUBSCRIBE /serviceEventing/ContentDirectory HTTP/1.1, headers = [HOST: 10.1.1.202:8895,SID: uuid:a1a8e966-6b9f-4116-9ed2-489bff5d0a36,CONNECTION: close]]
2013-08-23 00:16:30,763 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.1.1.109
2013-08-23 00:16:30,765 DEBUG [ServiceEventSubscriptionRequestHandler] ServiceEvent unsubscription request received for service ContentDirectory and subscription uuid:a1a8e966-6b9f-4116-9ed2-489bff5d0a36
2013-08-23 00:16:30,766 DEBUG [ServiceEventSubscriptionRequestHandler] Event subscription (uuid=a1a8e966-6b9f-4116-9ed2-489bff5d0a36) removed for service urn:upnp-org:serviceId:ContentDirectory
2013-08-23 00:16:51,030 DEBUG [FeedUpdaterThread] Checking for new and expired online resources
2013-08-23 00:16:51,030 DEBUG [OnlineRepositoryDAOImpl] Reading all OnlineRepositories


Finally got this straightened out -- I needed to limit bandwidth manually to stop the freezing on launch, 4000K does the trick here. My WiFi link should be able to handle much more than that, but oh well. It's good enough to get the video playing.

Now on to the other remaining issues ...