Serviio

Using Mac OS 10.8.5, WDTV Live. List of available video streams show up no problem but when attempting to play one there is a pause while it attempts to load then reverts back to list of available streams. Reverting back to Serviio 1.2.1 fixes the problem. WDTV has been updated recently, not sure if that is related to the problem. Log file shows an "Unsupported range request, sending back 416" error for every stream it attempts to play.

Log file:
2013-09-18 17:13:02,751 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: video/mpeg,Content-Length: 50000000000,Date: Wed, 18 Sep 2013 21:13:02 GMT,Server: Mac OS X, UPnP/1.0 DLNADOC/1.50, Serviio/1.3.1,Cache-control: no-cache,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]]
2013-09-18 17:13:06,495 DEBUG [WebServer] I/O error: Broken pipe
2013-09-18 17:13:06,642 DEBUG [ServiioHttpService] Incoming request from /10.0.1.2:58950: GET /resource/1000000150001599/MEDIA_ITEM/MPEG_PS_PAL-0/ORIGINAL HTTP/1.0, headers = [Host: 10.0.1.3:8895,Content-Length: 0,Range: bytes=0-,User-Agent: INTEL_NMPR/2.1 DLNADOC/1.50 dma/3.0 alphanetworks]]
2013-09-18 17:13:06,642 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.2
2013-09-18 17:13:06,643 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.2
2013-09-18 17:13:06,643 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'Identifier=10.0.1.2, Profile=WDTV Live'
2013-09-18 17:13:06,643 DEBUG [ResourceDeliveryProcessor] Request for resource 1000000150001599 and type 'MEDIA_ITEM' received
2013-09-18 17:13:06,643 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000150001599 (online)
2013-09-18 17:13:06,643 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 15)
2013-09-18 17:13:06,643 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 15)
2013-09-18 17:13:06,644 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 1000000150001599, format MPEG_PS_PAL and profile WDTV Live
2013-09-18 17:13:06,644 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file http://r4---sn-gvbxgn-tt16.c.youtube.co ... 8FE5E85A82
2013-09-18 17:13:06,644 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file http://r4---sn-gvbxgn-tt16.c.youtube.co ... 8FE5E85A82: MPEG_PS_PAL
2013-09-18 17:13:06,644 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file http://r4---sn-gvbxgn-tt16.c.youtube.co ... 8FE5E85A82: MPEG_PS_NTSC
2013-09-18 17:13:06,644 DEBUG [DLNAProtocolHandler] Unsupported range request, sending back 416
2013-09-18 17:13:06,712 DEBUG [ServiioHttpService] Incoming request from /10.0.1.2:58951: GET /resource/1000000150001599/MEDIA_ITEM/MPEG_PS_PAL-0/ORIGINAL HTTP/1.0, headers = [Host: 10.0.1.3:8895,Content-Length: 0,Range: bytes=0-,User-Agent: INTEL_NMPR/2.1 DLNADOC/1.50 dma/3.0 alphanetworks]]
2013-09-18 17:13:06,713 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.2
2013-09-18 17:13:06,713 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.2
2013-09-18 17:13:06,713 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'Identifier=10.0.1.2, Profile=WDTV Live'
2013-09-18 17:13:06,713 DEBUG [ResourceDeliveryProcessor] Request for resource 1000000150001599 and type 'MEDIA_ITEM' received
2013-09-18 17:13:06,713 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000150001599 (online)
2013-09-18 17:13:06,713 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 15)
2013-09-18 17:13:06,713 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 15)
2013-09-18 17:13:06,714 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 1000000150001599, format MPEG_PS_PAL and profile WDTV Live
2013-09-18 17:13:06,714 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file http://r4---sn-gvbxgn-tt16.c.youtube.co ... 8FE5E85A82
2013-09-18 17:13:06,714 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file http://r4---sn-gvbxgn-tt16.c.youtube.co ... 8FE5E85A82: MPEG_PS_PAL
2013-09-18 17:13:06,714 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file http://r4---sn-gvbxgn-tt16.c.youtube.co ... 8FE5E85A82: MPEG_PS_NTSC
2013-09-18 17:13:06,714 DEBUG [DLNAProtocolHandler] Unsupported range request, sending back 416
2013-09-18 17:13:06,773 DEBUG [ServiioHttpService] Incoming request from /10.0.1.2:58952: GET /resource/1000000150001599/MEDIA_ITEM/MPEG_PS_PAL-0/ORIGINAL HTTP/1.0, headers = [Host: 10.0.1.3:8895,Content-Length: 0,Range: bytes=0-,User-Agent: INTEL_NMPR/2.1 DLNADOC/1.50 dma/3.0 alphanetworks]]
2013-09-18 17:13:06,773 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.2
2013-09-18 17:13:06,773 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.2
2013-09-18 17:13:06,774 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'Identifier=10.0.1.2, Profile=WDTV Live'
2013-09-18 17:13:06,774 DEBUG [ResourceDeliveryProcessor] Request for resource 1000000150001599 and type 'MEDIA_ITEM' received
2013-09-18 17:13:06,774 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000150001599 (online)
2013-09-18 17:13:06,774 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 15)
2013-09-18 17:13:06,774 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 15)
2013-09-18 17:13:06,774 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 1000000150001599, format MPEG_PS_PAL and profile WDTV Live
2013-09-18 17:13:06,774 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file http://r4---sn-gvbxgn-tt16.c.youtube.co ... 8FE5E85A82
2013-09-18 17:13:06,774 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file http://r4---sn-gvbxgn-tt16.c.youtube.co ... 8FE5E85A82: MPEG_PS_PAL
2013-09-18 17:13:06,774 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file http://r4---sn-gvbxgn-tt16.c.youtube.co ... 8FE5E85A82: MPEG_PS_NTSC
2013-09-18 17:13:06,774 DEBUG [DLNAProtocolHandler] Unsupported range request, sending back 416
2013-09-18 17:13:21,857 DEBUG [SearchManager] Committing search index
2013-09-18 17:13:46,242 DEBUG [FeedUpdaterThread] Checking for new and expired online resources
2013-09-18 17:13:46,242 DEBUG [OnlineRepositoryDAOImpl] Reading all OnlineRepositories
2013-09-18 17:13:46,243 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 15)
2013-09-18 17:13:46,249 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 91)
2013-09-18 17:13:51,858 DEBUG [SearchManager] Committing search index
2013-09-18 17:14:21,859 DEBUG [SearchManager] Committing search index
2013-09-18 17:14:46,249 DEBUG [FeedUpdaterThread] Checking for new and expired online resources
2013-09-18 17:14:46,249 DEBUG [OnlineRepositoryDAOImpl] Reading all OnlineRepositories
2013-09-18 17:14:46,249 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 15)
2013-09-18 17:14:46,255 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 91)
2013-09-18 17:14:51,860 DEBUG [SearchManager] Committing search index
2013-09-18 17:15:20,261 DEBUG [DiscoverySSDPMessageListener] Received a valid NOTIFY (ssdp:alive) message from Renderer ad36e2ff-0090-a9c8-d8c2-a31ebf0bdb26 from address /10.0.1.2:1900
2013-09-18 17:15:21,861 DEBUG [SearchManager] Committing search index

Any help would be appreciated.

Could you send the same part of the log when played in 1.2.1?

Hope this helps:


2013-09-19 16:52:10,187 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: video/mpeg,Content-Length: 50000000000,Date: Thu, 19 Sep 2013 20:52:10 GMT,Server: Mac OS X, UPnP/1.0 DLNADOC/1.50, Serviio/1.2.1,Cache-control: no-cache,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]]
2013-09-19 16:52:10,314 DEBUG [WebServer] I/O error: Broken pipe
2013-09-19 16:52:10,317 DEBUG [ServiioHttpService] Incoming request from /10.0.1.2:37797: GET /resource/1000000150001817/MEDIA_ITEM/MPEG_PS_PAL-0/ORIGINAL HTTP/1.0, headers = [Host: 10.0.1.3:8895,Content-Length: 0,User-Agent: INTEL_NMPR/2.1 DLNADOC/1.50 dma/3.0 alphanetworks]]
2013-09-19 16:52:10,317 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.2
2013-09-19 16:52:10,318 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.2
2013-09-19 16:52:10,318 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'Identifier=10.0.1.2, Profile=WDTV Live'
2013-09-19 16:52:10,318 DEBUG [ResourceDeliveryProcessor] Request for resource 1000000150001817 and type 'MEDIA_ITEM' received
2013-09-19 16:52:10,318 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000150001817 (online)
2013-09-19 16:52:10,318 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 15)
2013-09-19 16:52:10,319 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 15)
2013-09-19 16:52:10,319 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 1000000150001817, format MPEG_PS_PAL and profile WDTV Live
2013-09-19 16:52:10,319 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file http://r4---sn-gvbxgn-tt16.c.youtube.co ... 6923AAC0A2
2013-09-19 16:52:10,319 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file http://r4---sn-gvbxgn-tt16.c.youtube.co ... 6923AAC0A2: MPEG_PS_PAL
2013-09-19 16:52:10,319 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file http://r4---sn-gvbxgn-tt16.c.youtube.co ... 6923AAC0A2: MPEG_PS_NTSC
2013-09-19 16:52:10,320 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000150001817 (online)
2013-09-19 16:52:10,320 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 15)
2013-09-19 16:52:10,320 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 15)
2013-09-19 16:52:10,320 DEBUG [VideoDeliveryEngine] Delivering item '1000000150001817' for client 'Identifier=10.0.1.2, Profile=WDTV Live'
2013-09-19 16:52:10,320 DEBUG [VideoDeliveryEngine] Delivering file 'http://r4---sn-gvbxgn-tt16.c.youtube.com/videoplayback?fexp=912307%2C922218%2C913564%2C914060%2C916624%2C901453%2C902544%2C924606%2C929117%2C929121%2C929906%2C929907%2C929922%2C929923%2C929127%2C929129%2C929131%2C929930%2C936403%2C925724%2C925726%2C936310%2C925720%2C925722%2C925718%2C925714%2C929917%2C906945%2C929933%2C929935%2C920302%2C906842%2C927704%2C913428%2C920605%2C919811%2C935020%2C935021%2C932309%2C913563%2C919373%2C930803%2C908536%2C932211%2C938701%2C931924%2C934005%2C940501%2C936308%2C909549%2C935006%2C901608%2C900816%2C912711%2C934507%2C907231%2C936312%2C906001&mv=m&itag=35&sparams=algorithm%2Cburst%2Ccp%2Cfactor%2Cid%2Cip%2Cipbits%2Citag%2Csource%2Cupn%2Cexpire&upn=2x8LCrvDYZs&cp=U0hWTlZPVF9JUENONl9OSVhBOnNaRUdVaC1DbVFp&key=yt1&ip=99.241.113.74&algorithm=throttle-factor&burst=40&sver=3&expire=1379646046&source=youtube&ipbits=8&id=abbedcef9efb44d6&ms=au&factor=1.25&mt=1379623240&signature=1426C2EE3DFF0F06ACD19487F111BB95ECCC0EEE.7A4800A27491787913E4FA3AC32ACA6923AAC0A2' using transcoding
2013-09-19 16:52:10,321 DEBUG [AbstractTranscodingDeliveryEngine] A suitable transcoding job already exists, re-use it for client 'Identifier=10.0.1.2, Profile=WDTV Live'
2013-09-19 16:52:10,321 DEBUG [FileBasedTranscodingDeliveryStrategy] Sending transcoding stream
2013-09-19 16:52:10,321 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file http://r4---sn-gvbxgn-tt16.c.youtube.co ... 6923AAC0A2: MPEG_PS_PAL
2013-09-19 16:52:10,321 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file http://r4---sn-gvbxgn-tt16.c.youtube.co ... 6923AAC0A2: MPEG_PS_NTSC
2013-09-19 16:52:10,321 DEBUG [GETMethodProcessor] Stream entity has length: 50000000000
2013-09-19 16:52:10,321 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: video/mpeg,Content-Length: 50000000000,Date: Thu, 19 Sep 2013 20:52:10 GMT,Server: Mac OS X, UPnP/1.0 DLNADOC/1.50, Serviio/1.2.1,Cache-control: no-cache,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]]
2013-09-19 16:52:10,527 DEBUG [WebServer] I/O error: Broken pipe
2013-09-19 16:52:10,529 DEBUG [ServiioHttpService] Incoming request from /10.0.1.2:37798: GET /resource/1000000150001817/MEDIA_ITEM/MPEG_PS_PAL-0/ORIGINAL HTTP/1.0, headers = [Host: 10.0.1.3:8895,Content-Length: 0,User-Agent: INTEL_NMPR/2.1 DLNADOC/1.50 dma/3.0 alphanetworks]]
2013-09-19 16:52:10,530 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.2
2013-09-19 16:52:10,530 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 10.0.1.2
2013-09-19 16:52:10,530 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'Identifier=10.0.1.2, Profile=WDTV Live'
2013-09-19 16:52:10,531 DEBUG [ResourceDeliveryProcessor] Request for resource 1000000150001817 and type 'MEDIA_ITEM' received
2013-09-19 16:52:10,531 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000150001817 (online)
2013-09-19 16:52:10,531 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 15)
2013-09-19 16:52:10,531 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 15)
2013-09-19 16:52:10,532 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 1000000150001817, format MPEG_PS_PAL and profile WDTV Live
2013-09-19 16:52:10,532 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file http://r4---sn-gvbxgn-tt16.c.youtube.co ... 6923AAC0A2
2013-09-19 16:52:10,532 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file http://r4---sn-gvbxgn-tt16.c.youtube.co ... 6923AAC0A2: MPEG_PS_PAL
2013-09-19 16:52:10,532 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file http://r4---sn-gvbxgn-tt16.c.youtube.co ... 6923AAC0A2: MPEG_PS_NTSC
2013-09-19 16:52:10,532 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000150001817 (online)
2013-09-19 16:52:10,532 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 15)
2013-09-19 16:52:10,532 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 15)
2013-09-19 16:52:10,533 DEBUG [VideoDeliveryEngine] Delivering item '1000000150001817' for client 'Identifier=10.0.1.2, Profile=WDTV Live'
2013-09-19 16:52:10,533 DEBUG [VideoDeliveryEngine] Delivering file 'http://r4---sn-gvbxgn-tt16.c.youtube.com/videoplayback?fexp=912307%2C922218%2C913564%2C914060%2C916624%2C901453%2C902544%2C924606%2C929117%2C929121%2C929906%2C929907%2C929922%2C929923%2C929127%2C929129%2C929131%2C929930%2C936403%2C925724%2C925726%2C936310%2C925720%2C925722%2C925718%2C925714%2C929917%2C906945%2C929933%2C929935%2C920302%2C906842%2C927704%2C913428%2C920605%2C919811%2C935020%2C935021%2C932309%2C913563%2C919373%2C930803%2C908536%2C932211%2C938701%2C931924%2C934005%2C940501%2C936308%2C909549%2C935006%2C901608%2C900816%2C912711%2C934507%2C907231%2C936312%2C906001&mv=m&itag=35&sparams=algorithm%2Cburst%2Ccp%2Cfactor%2Cid%2Cip%2Cipbits%2Citag%2Csource%2Cupn%2Cexpire&upn=2x8LCrvDYZs&cp=U0hWTlZPVF9JUENONl9OSVhBOnNaRUdVaC1DbVFp&key=yt1&ip=99.241.113.74&algorithm=throttle-factor&burst=40&sver=3&expire=1379646046&source=youtube&ipbits=8&id=abbedcef9efb44d6&ms=au&factor=1.25&mt=1379623240&signature=1426C2EE3DFF0F06ACD19487F111BB95ECCC0EEE.7A4800A27491787913E4FA3AC32ACA6923AAC0A2' using transcoding
2013-09-19 16:52:10,533 DEBUG [AbstractTranscodingDeliveryEngine] A suitable transcoding job already exists, re-use it for client 'Identifier=10.0.1.2, Profile=WDTV Live'

Try to remove this from the wdtv profile

SUCCESS!!

Thanks for the effort in making such a great product and keeping it going.

Thank you! I had exactly the same problem, and this has solved it for me too. I guess this entry in the profile is a mistake, as the WDTV Live is a DLNA-compliant device.

So for those of you with working WDTV profiles, have you changed anything from the default profile other than this line? I tried removing this line from the default WDTV profile, but am still unable to stream live web feeds. If anyone is using an otherwise modified WDTV profile, would you mind posting it? Thanks in advance!

No, that's the only thing I changed.

Did you restart the server / PC after the change?