FAQ  •  Register  •  Login

malformed rtsp metadata in IP Cam

<<

mpi

Serviio lover

Posts: 66

Joined: Fri Nov 18, 2011 9:15 pm

Post Mon Mar 11, 2013 1:27 pm

malformed rtsp metadata in IP Cam

Hi,

I have an IP cam that provides H264 rtsp stream in the following form:
rtsp://user:pass@IP:PORT
I can view this live stream under VLC with no problem (although it takes a little-while to start).
It tried to get it under serviio but it fails.
Looking at ffmpeg -i it says:
  Code:
ffmpeg version 1.1.1 Copyright (c) 2000-2013 the FFmpeg developers
  built on Jan 29 2013 00:10:12 with gcc 4.0.1 (GCC) (Apple Inc. build 5493)
  configuration: --enable-static --disable-shared --disable-ffplay --disable-ffserver --enable-libmp3lame --enable-librtmp --enable-libfreetype --enable-fontconfig --enable-libass --enable-pthreads --disable-mmx --extra-ldflags=-L/Users/MacAdmin/Desktop/build/target/lib --extra-cflags=-I/Users/MacAdmin/Desktop/build/target/include --extra-libs='-lpolarssl -lfreetype -lexpat -liconv'
  libavutil      52. 13.100 / 52. 13.100
  libavcodec     54. 86.100 / 54. 86.100
  libavformat    54. 59.106 / 54. 59.106
  libavdevice    54.  3.102 / 54.  3.102
  libavfilter     3. 32.100 /  3. 32.100
  libswscale      2.  1.103 /  2.  1.103
  libswresample   0. 17.102 /  0. 17.102
[rtsp @ 0x12ada00] UDP timeout, retrying with TCP
[rtsp @ 0x12ada00] Could not find codec parameters for stream 0 (Video: h264): unspecified size
Consider increasing the value for the 'analyzeduration' and 'probesize' options
[rtsp @ 0x12ada00] Estimating duration from bitrate, this may be inaccurate
Guessed Channel Layout for  Input Stream #0.1 : mono
Input #0, rtsp, from 'rtsp://user:pass@IP:PORT':
  Metadata:
    title           : h264 stream by H.264/MJPEG RTSP stream(IPCamera_Logo)
  Duration: N/A, start: 0.000000, bitrate: 64 kb/s
    Stream #0:0: Video: h264, 90k tbr, 90k tbn, 180k tbc
    Stream #0:1: Audio: pcm_mulaw, 8000 Hz, mono, s16, 64 kb/s
At least one output file must be specified
So it seems the stream does not provide accurate metadata info to ffmpeg: it can eventually figure-them out (like VLC does I guess), but it's taking too long for Serviio.

So, I'm wondering if one could craft a .groovy plugin to provide Serviio/ffmpeg with proper info so that Serviio could work with that feed (until cam manufacturer eventually fixes firmware...).
Looking forward any help/suggestion.

Thanks!
<<

zip

User avatar

Serviio developer / Site Admin

Posts: 16507

Joined: Sat Oct 24, 2009 12:24 pm

Location: London, UK

Post Mon Mar 11, 2013 4:56 pm

Re: malformed rtsp metadata in IP Cam

how does it fail with Serviio? enable detailed log and try to execute the ffmpeg command manually
<<

mpi

Serviio lover

Posts: 66

Joined: Fri Nov 18, 2011 9:15 pm

Post Mon Mar 11, 2013 5:40 pm

Re: malformed rtsp metadata in IP Cam

Hi zip, thanks for looking into that.
Here is Serviio debug info (had same issue with Serviio 1.1):
  Code:
2013-03-11 18:34:34,752 WARN  [FeedUpdaterThread] Failed to retrieve online item information for rtsp://user:pass@IP:PORT. It might not play.
java.io.IOException: org.serviio.library.local.metadata.extractor.InvalidMediaFormatException: Unknown video width.
   at org.serviio.library.online.metadata.FeedUpdaterThread.retrieveMetadata(FeedUpdaterThread.java:292)
   at org.serviio.library.online.metadata.FeedUpdaterThread.retrieveTechnicalMetadata(FeedUpdaterThread.java:209)
   at org.serviio.library.online.metadata.FeedUpdaterThread.run(FeedUpdaterThread.java:102)
Caused by: org.serviio.library.local.metadata.extractor.InvalidMediaFormatException: Unknown video width.
   at org.serviio.library.metadata.FFmpegMetadataRetriever.validateMandatoryMetadata(FFmpegMetadataRetriever.java:459)
   at org.serviio.library.metadata.FFmpegMetadataRetriever.retrieveMetadata(FFmpegMetadataRetriever.java:94)
   at org.serviio.library.metadata.FFmpegMetadataRetriever.retrieveOnlineMetadata(FFmpegMetadataRetriever.java:132)
   at org.serviio.library.online.metadata.FeedUpdaterThread.retrieveMetadata(FeedUpdaterThread.java:269)
   ... 2 more

ffmpeg command is
  Code:
ffmpeg -rtsp_transport +tcp+udp -analyzeduration 10000000 -i rtsp://user:pass@IP:PORT
ffmpeg version 1.1.1 Copyright (c) 2000-2013 the FFmpeg developers
  built on Jan 29 2013 00:10:12 with gcc 4.0.1 (GCC) (Apple Inc. build 5493)
  configuration: --enable-static --disable-shared --disable-ffplay --disable-ffserver --enable-libmp3lame --enable-librtmp --enable-libfreetype --enable-fontconfig --enable-libass --enable-pthreads --disable-mmx --extra-ldflags=-L/Users/MacAdmin/Desktop/build/target/lib --extra-cflags=-I/Users/MacAdmin/Desktop/build/target/include --extra-libs='-lpolarssl -lfreetype -lexpat -liconv'
  libavutil      52. 13.100 / 52. 13.100
  libavcodec     54. 86.100 / 54. 86.100
  libavformat    54. 59.106 / 54. 59.106
  libavdevice    54.  3.102 / 54.  3.102
  libavfilter     3. 32.100 /  3. 32.100
  libswscale      2.  1.103 /  2.  1.103
  libswresample   0. 17.102 /  0. 17.102
[rtsp @ 0x116b400] UDP timeout, retrying with TCP
[rtsp @ 0x116b400] Could not find codec parameters for stream 0 (Video: h264): unspecified size
Consider increasing the value for the 'analyzeduration' and 'probesize' options
[rtsp @ 0x116b400] Estimating duration from bitrate, this may be inaccurate
Guessed Channel Layout for  Input Stream #0.1 : mono
Input #0, rtsp, from 'rtsp://user:pass@IP:PORT':
  Metadata:
    title           : h264 stream by H.264/MJPEG RTSP stream(IPCamera_Logo)
  Duration: N/A, start: 0.000000, bitrate: 64 kb/s
    Stream #0:0: Video: h264, 90k tbr, 90k tbn, 180k tbc
    Stream #0:1: Audio: pcm_mulaw, 8000 Hz, mono, s16, 64 kb/s
At least one output file must be specified
Thanks for any help!
<<

zip

User avatar

Serviio developer / Site Admin

Posts: 16507

Joined: Sat Oct 24, 2009 12:24 pm

Location: London, UK

Post Mon Mar 11, 2013 7:08 pm

Re: malformed rtsp metadata in IP Cam

ok, resolution is missing, which is mandatory information
<<

mpi

Serviio lover

Posts: 66

Joined: Fri Nov 18, 2011 9:15 pm

Post Mon Mar 11, 2013 7:13 pm

Re: malformed rtsp metadata in IP Cam

ok, thanks zip.
Now, if I know that information (and it seems VLC does figure it out), how could I feed it into Serviio so that it works?
Can a specific .groovy plugin do that?
(I can provide temporary access to the feed in PM if need be).
<<

zip

User avatar

Serviio developer / Site Admin

Posts: 16507

Joined: Sat Oct 24, 2009 12:24 pm

Location: London, UK

Post Mon Mar 11, 2013 7:17 pm

Re: malformed rtsp metadata in IP Cam

You can't provide it from the groovy file. Not sure there is much help here.
<<

mpi

Serviio lover

Posts: 66

Joined: Fri Nov 18, 2011 9:15 pm

Post Tue Mar 12, 2013 3:50 pm

Re: malformed rtsp metadata in IP Cam

hum, too bad...will need to find another avenue then, until cam manuf eventually update firmware.
Maybe having VLC (which can read that stream) re-stream it in the middle?...but I fear this might be too much for my ARM-based NAS.
Any creative suggestion welcome!
Thanks.
<<

Illico

User avatar

DLNA master

Posts: 4649

Joined: Fri Jul 23, 2010 8:08 am

Location: France

Post Tue Mar 12, 2013 3:55 pm

Re: malformed rtsp metadata in IP Cam

mpi wrote:Any creative suggestion welcome!

What about increase "analyzeduration" option?


[rtsp @ 0x12ada00] Could not find codec parameters for stream 0 (Video: h264): unspecified size
Consider increasing the value for the 'analyzeduration'
Illico
Sony 2010 KDL-46EX501 | BDP-S373 | SMP-N100 | Windows 8-i7 | Network DD HD-CE1.5TLU2 | Livebox2-UHD86 | ServiiDroid | ServiiGo | BubbleUPnP
Serviio beta tester - Moderator
<<

mpi

Serviio lover

Posts: 66

Joined: Fri Nov 18, 2011 9:15 pm

Post Tue Mar 12, 2013 10:53 pm

Re: malformed rtsp metadata in IP Cam

Thanks for the suggestion Illico.
However I increased it by 10x and same issue...
<<

mpi

Serviio lover

Posts: 66

Joined: Fri Nov 18, 2011 9:15 pm

Post Thu Mar 14, 2013 1:35 pm

Re: malformed rtsp metadata in IP Cam

Would an ONVIF protocol groovy plugin be possible as more and more IP cams seems to support that standard now?
http://www.onvif.org/specs/stream/ONVIF ... c-v221.pdf

Thanks.
<<

zip

User avatar

Serviio developer / Site Admin

Posts: 16507

Joined: Sat Oct 24, 2009 12:24 pm

Location: London, UK

Post Thu Mar 14, 2013 3:13 pm

Re: malformed rtsp metadata in IP Cam

does FFmpeg support it?
<<

mpi

Serviio lover

Posts: 66

Joined: Fri Nov 18, 2011 9:15 pm

Post Sun Mar 17, 2013 9:27 pm

Re: malformed rtsp metadata in IP Cam

Ok, some progress here.
It turns-out cam manuf passed me a newer pre-release version of the firmware which happened to fix the malformed metadata issues.
Now ffmpeg command gives:
  Code:
./ffmpeg -rtsp_transport +tcp+udp -analyzeduration 100000000 -i rtsp://user:pass@192.168.3.210:81
ffmpeg version 1.1.1 Copyright (c) 2000-2013 the FFmpeg developers
  built on Jan 29 2013 00:10:12 with gcc 4.0.1 (GCC) (Apple Inc. build 5493)
  configuration: --enable-static --disable-shared --disable-ffplay --disable-ffserver --enable-libmp3lame --enable-librtmp --enable-libfreetype --enable-fontconfig --enable-libass --enable-pthreads --disable-mmx --extra-ldflags=-L/Users/MacAdmin/Desktop/build/target/lib --extra-cflags=-I/Users/MacAdmin/Desktop/build/target/include --extra-libs='-lpolarssl -lfreetype -lexpat -liconv'
  libavutil      52. 13.100 / 52. 13.100
  libavcodec     54. 86.100 / 54. 86.100
  libavformat    54. 59.106 / 54. 59.106
  libavdevice    54.  3.102 / 54.  3.102
  libavfilter     3. 32.100 /  3. 32.100
  libswscale      2.  1.103 /  2.  1.103
  libswresample   0. 17.102 /  0. 17.102
[rtsp @ 0x11e9400] Estimating duration from bitrate, this may be inaccurate
Guessed Channel Layout for  Input Stream #0.1 : mono
Input #0, rtsp, from 'rtsp://user:pass@192.168.3.210:81':
  Metadata:
    title           : h264 stream by H.264/MJPEG RTSP stream(ipcamera)
  Duration: N/A, start: 0.000000, bitrate: 64 kb/s
    Stream #0:0: Video: h264 (Constrained Baseline), yuv420p, 640x480, 90k tbr, 90k tbn, 180k tbc
    Stream #0:1: Audio: pcm_mulaw, 8000 Hz, mono, s16, 64 kb/s
At least one output file must be specified
However, I'm not completely finished with the issue.
I can receive properly the stream on my Sony bdp-s470 or XMBC when I run Serviio out of my Mac (great!!).
But I have an issue when I run Serviio on my ARM NAS: probably a transcoding issue too demanding for my NAS...
I can understand there might be an issue for Sony bdp-s470 (though I thought h264 would not need transcoding, maybe it's the pcm_mulaw?). However there are also issues with XMBC client which should swallow all formats with no transcoding.
Any recommendation on profiles to make this work?

Log for Sony bdp-s470 transcoding:
  Code:
2013-03-17 22:00:08,380 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-17 22:00:11,653 DEBUG [WebServer] Incoming connection from /192.168.3.101:63225
2013-03-17 22:00:11,751 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:00:11,753 DEBUG [ResourceTransportRequestHandler] HEAD /resource/1000000210001993/MEDIA_ITEM/MPEG_PS_NTSC-0/ORIGINAL HTTP/1.1, headers = [Host: 192.168.3.200:8895,Accept: */*,getcontentFeatures.dlna.org: 1,X-AV-Physical-Unit-Info: pa="Blu-ray Disc Player",X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"]]
2013-03-17 22:00:11,753 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:00:11,754 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-17 22:00:11,755 DEBUG [ResourceDeliveryProcessor] Request for resource 1000000210001993 and type 'MEDIA_ITEM' received
2013-03-17 22:00:11,755 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001993 (online)
2013-03-17 22:00:11,755 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-17 22:00:11,757 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 1000000210001993, format MPEG_PS_NTSC and profile Sony BD Player / SMP
2013-03-17 22:00:11,757 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file rtsp://user:pass@192.168.3.210:81
2013-03-17 22:00:11,758 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_PAL
2013-03-17 22:00:11,758 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_NTSC
2013-03-17 22:00:11,758 DEBUG [ResourceDeliveryProcessor] Sending HEAD response back
2013-03-17 22:00:11,759 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: video/mpeg,Date: Sun, 17 Mar 2013 21:00:11 GMT,Server: Linux, UPnP/1.0 DLNADOC/1.50, Serviio/1.1,Cache-control: no-cache,contentFeatures.dlna.org: DLNA.ORG_PN=MPEG_PS_NTSC;DLNA.ORG_OP=00;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=8D500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]]
2013-03-17 22:00:11,763 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:00:11,765 DEBUG [ResourceTransportRequestHandler] GET /resource/1000000210001993/MEDIA_ITEM/MPEG_PS_NTSC-0/ORIGINAL HTTP/1.1, headers = [Host: 192.168.3.200:8895,Accept: */*,getcontentFeatures.dlna.org: 1,X-AV-Physical-Unit-Info: pa="Blu-ray Disc Player",X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"]]
2013-03-17 22:00:11,765 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:00:11,767 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-17 22:00:11,767 DEBUG [ResourceDeliveryProcessor] Request for resource 1000000210001993 and type 'MEDIA_ITEM' received
2013-03-17 22:00:11,768 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001993 (online)
2013-03-17 22:00:11,768 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-17 22:00:11,769 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 1000000210001993, format MPEG_PS_NTSC and profile Sony BD Player / SMP
2013-03-17 22:00:11,769 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file rtsp://user:pass@192.168.3.210:81
2013-03-17 22:00:11,770 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_PAL
2013-03-17 22:00:11,770 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_NTSC
2013-03-17 22:00:11,770 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001993 (online)
2013-03-17 22:00:11,770 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-17 22:00:11,772 DEBUG [VideoDeliveryEngine] Delivering item '1000000210001993' for client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-17 22:00:11,772 DEBUG [VideoDeliveryEngine] Delivering file 'rtsp://user:pass@192.168.3.210:81' using transcoding
2013-03-17 22:00:11,773 DEBUG [AbstractTranscodingDeliveryEngine] No suitable transcoding job exists yet, start one for client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-17 22:00:11,773 DEBUG [FFMPEGWrapper] Invoking FFmpeg to transcode video file: rtsp://user:pass@192.168.3.210:81
2013-03-17 22:00:11,774 DEBUG [ProcessExecutor] Starting /root/.serviio/opt/bin/ffmpeg -rtsp_transport +tcp+udp -analyzeduration 10000000 -threads 1 -i rtsp://user:pass@192.168.3.210:81 -y -copyts -c:v mpeg2video -qscale:v 3 -r 24000/1001 -g 15 -c:a ac3_fixed -b:a 384k -ar 48000 -ac 1 -map 0:0 -map 0:1 -sn -f vob pipe:
2013-03-17 22:00:13,330 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-17 22:00:13,808 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_PAL
2013-03-17 22:00:13,808 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_NTSC
2013-03-17 22:00:13,808 DEBUG [ResourceDeliveryProcessor] Stream entity has length: 50000000000
2013-03-17 22:00:13,809 DEBUG [ResourceDeliveryProcessor] Sending file back
2013-03-17 22:00:13,809 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer
2013-03-17 22:00:13,809 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: video/mpeg,Date: Sun, 17 Mar 2013 21:00:13 GMT,Server: Linux, UPnP/1.0 DLNADOC/1.50, Serviio/1.1,Cache-control: no-cache,contentFeatures.dlna.org: DLNA.ORG_PN=MPEG_PS_NTSC;DLNA.ORG_OP=00;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=8D500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]]
2013-03-17 22:00:13,825 DEBUG [WebServer] Incoming connection from /192.168.3.101:63226
2013-03-17 22:00:13,921 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:00:13,923 DEBUG [ResourceTransportRequestHandler] GET /resource/1000000210001993/MEDIA_ITEM/MPEG_PS_NTSC-0/ORIGINAL HTTP/1.1, headers = [Host: 192.168.3.200:8895,Accept: */*,getcontentFeatures.dlna.org: 1,X-AV-Physical-Unit-Info: pa="Blu-ray Disc Player",X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"]]
2013-03-17 22:00:13,923 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:00:13,924 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-17 22:00:13,925 DEBUG [ResourceDeliveryProcessor] Request for resource 1000000210001993 and type 'MEDIA_ITEM' received
2013-03-17 22:00:13,925 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001993 (online)
2013-03-17 22:00:13,925 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-17 22:00:13,927 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 1000000210001993, format MPEG_PS_NTSC and profile Sony BD Player / SMP
2013-03-17 22:00:13,927 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file rtsp://user:pass@192.168.3.210:81
2013-03-17 22:00:13,938 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_PAL
2013-03-17 22:00:13,938 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_NTSC
2013-03-17 22:00:13,938 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001993 (online)
2013-03-17 22:00:13,938 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-17 22:00:13,940 DEBUG [VideoDeliveryEngine] Delivering item '1000000210001993' for client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-17 22:00:13,940 DEBUG [VideoDeliveryEngine] Delivering file 'rtsp://user:pass@192.168.3.210:81' using transcoding
2013-03-17 22:00:13,941 DEBUG [AbstractTranscodingDeliveryEngine] A suitable transcoding job already exists, re-use it for client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-17 22:00:13,941 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_PAL
2013-03-17 22:00:13,941 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_NTSC
2013-03-17 22:00:13,941 DEBUG [ResourceDeliveryProcessor] Stream entity has length: 50000000000
2013-03-17 22:00:13,942 DEBUG [ResourceDeliveryProcessor] Sending file back
2013-03-17 22:00:13,942 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer
2013-03-17 22:00:13,942 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: video/mpeg,Date: Sun, 17 Mar 2013 21:00:13 GMT,Server: Linux, UPnP/1.0 DLNADOC/1.50, Serviio/1.1,Cache-control: no-cache,contentFeatures.dlna.org: DLNA.ORG_PN=MPEG_PS_NTSC;DLNA.ORG_OP=00;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=8D500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]]
2013-03-17 22:00:14,158 DEBUG [WebServer] Incoming connection from /192.168.3.101:63227
2013-03-17 22:00:14,252 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:00:14,254 DEBUG [ResourceTransportRequestHandler] HEAD /resource/1000000210001993/MEDIA_ITEM/MPEG_PS_NTSC-0/ORIGINAL HTTP/1.1, headers = [Host: 192.168.3.200:8895,Accept: */*,getcontentFeatures.dlna.org: 1,X-AV-Physical-Unit-Info: pa="Blu-ray Disc Player",X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"]]
2013-03-17 22:00:14,254 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:00:14,256 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-17 22:00:14,257 DEBUG [ResourceDeliveryProcessor] Request for resource 1000000210001993 and type 'MEDIA_ITEM' received
2013-03-17 22:00:14,257 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001993 (online)
2013-03-17 22:00:14,257 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-17 22:00:14,279 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 1000000210001993, format MPEG_PS_NTSC and profile Sony BD Player / SMP
2013-03-17 22:00:14,279 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file rtsp://user:pass@192.168.3.210:81
2013-03-17 22:00:14,279 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_PAL
2013-03-17 22:00:14,280 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_NTSC
2013-03-17 22:00:14,280 DEBUG [ResourceDeliveryProcessor] Sending HEAD response back
2013-03-17 22:00:14,280 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: video/mpeg,Date: Sun, 17 Mar 2013 21:00:14 GMT,Server: Linux, UPnP/1.0 DLNADOC/1.50, Serviio/1.1,Cache-control: no-cache,contentFeatures.dlna.org: DLNA.ORG_PN=MPEG_PS_NTSC;DLNA.ORG_OP=00;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=8D500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]]
2013-03-17 22:00:14,287 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:00:14,318 DEBUG [ResourceTransportRequestHandler] GET /resource/1000000210001993/MEDIA_ITEM/MPEG_PS_NTSC-0/ORIGINAL HTTP/1.1, headers = [Host: 192.168.3.200:8895,Accept: */*,getcontentFeatures.dlna.org: 1,X-AV-Physical-Unit-Info: pa="Blu-ray Disc Player",X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"]]
2013-03-17 22:00:14,319 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:00:14,320 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-17 22:00:14,321 DEBUG [ResourceDeliveryProcessor] Request for resource 1000000210001993 and type 'MEDIA_ITEM' received
2013-03-17 22:00:14,321 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001993 (online)
2013-03-17 22:00:14,321 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-17 22:00:14,323 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 1000000210001993, format MPEG_PS_NTSC and profile Sony BD Player / SMP
2013-03-17 22:00:14,323 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file rtsp://user:pass@192.168.3.210:81
2013-03-17 22:00:14,323 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_PAL
2013-03-17 22:00:14,324 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_NTSC
2013-03-17 22:00:14,324 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001993 (online)
2013-03-17 22:00:14,324 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-17 22:00:14,325 DEBUG [VideoDeliveryEngine] Delivering item '1000000210001993' for client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-17 22:00:14,326 DEBUG [VideoDeliveryEngine] Delivering file 'rtsp://user:pass@192.168.3.210:81' using transcoding
2013-03-17 22:00:14,326 DEBUG [AbstractTranscodingDeliveryEngine] A suitable transcoding job already exists, re-use it for client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-17 22:00:14,954 DEBUG [WebServer] I/O error: Broken pipe
2013-03-17 22:00:14,955 DEBUG [NonClosingPipedInputStream] Scheduling stream stop to happen in 20 seconds if there is no traffic
2013-03-17 22:00:15,328 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_PAL
2013-03-17 22:00:15,328 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_NTSC
2013-03-17 22:00:15,328 DEBUG [ResourceDeliveryProcessor] Stream entity has length: 50000000000
2013-03-17 22:00:15,329 DEBUG [ResourceDeliveryProcessor] Sending file back
2013-03-17 22:00:15,329 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer
2013-03-17 22:00:15,329 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: video/mpeg,Date: Sun, 17 Mar 2013 21:00:15 GMT,Server: Linux, UPnP/1.0 DLNADOC/1.50, Serviio/1.1,Cache-control: no-cache,contentFeatures.dlna.org: DLNA.ORG_PN=MPEG_PS_NTSC;DLNA.ORG_OP=00;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=8D500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]]
2013-03-17 22:00:15,348 DEBUG [WebServer] Incoming connection from /192.168.3.101:63228
2013-03-17 22:00:15,442 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:00:15,443 DEBUG [ResourceTransportRequestHandler] GET /resource/1000000210001993/MEDIA_ITEM/MPEG_PS_NTSC-0/ORIGINAL HTTP/1.1, headers = [Host: 192.168.3.200:8895,Accept: */*,getcontentFeatures.dlna.org: 1,X-AV-Physical-Unit-Info: pa="Blu-ray Disc Player",X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"]]
2013-03-17 22:00:15,443 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:00:15,445 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-17 22:00:15,445 DEBUG [ResourceDeliveryProcessor] Request for resource 1000000210001993 and type 'MEDIA_ITEM' received
2013-03-17 22:00:15,446 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001993 (online)
2013-03-17 22:00:15,446 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-17 22:00:15,468 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 1000000210001993, format MPEG_PS_NTSC and profile Sony BD Player / SMP
2013-03-17 22:00:15,468 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file rtsp://user:pass@192.168.3.210:81
2013-03-17 22:00:15,468 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_PAL
2013-03-17 22:00:15,468 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_NTSC
2013-03-17 22:00:15,469 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001993 (online)
2013-03-17 22:00:15,469 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-17 22:00:15,470 DEBUG [VideoDeliveryEngine] Delivering item '1000000210001993' for client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-17 22:00:15,471 DEBUG [VideoDeliveryEngine] Delivering file 'rtsp://user:pass@192.168.3.210:81' using transcoding
2013-03-17 22:00:15,471 DEBUG [AbstractTranscodingDeliveryEngine] A suitable transcoding job already exists, re-use it for client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-17 22:00:16,477 DEBUG [StreamBasedTranscodingDeliveryStrategy] Transcoded stream is empty, connection may have been lost
2013-03-17 22:00:16,478 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_PAL
2013-03-17 22:00:16,478 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_NTSC
2013-03-17 22:00:16,478 DEBUG [ResourceDeliveryProcessor] Stream entity has length: 50000000000
2013-03-17 22:00:16,479 DEBUG [ResourceDeliveryProcessor] Sending file back
2013-03-17 22:00:16,479 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer
2013-03-17 22:00:16,479 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: video/mpeg,Date: Sun, 17 Mar 2013 21:00:16 GMT,Server: Linux, UPnP/1.0 DLNADOC/1.50, Serviio/1.1,Cache-control: no-cache,contentFeatures.dlna.org: DLNA.ORG_PN=MPEG_PS_NTSC;DLNA.ORG_OP=00;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=8D500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]]
2013-03-17 22:00:17,907 DEBUG [FeedUpdaterThread] Checking for new and expired online resources
2013-03-17 22:00:17,907 DEBUG [OnlineRepositoryDAOImpl] Reading all OnlineRepositories
2013-03-17 22:00:17,912 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-17 22:00:18,390 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-17 22:00:23,340 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-17 22:00:28,290 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-17 22:00:32,128 DEBUG [DiscoveryAdvertisementNotifier] Found 1 network interfaces to advertise on
2013-03-17 22:00:32,129 DEBUG [DiscoveryAdvertisementNotifier] Multicasting SSDP alive using interface eth0 (eth0) and address 192.168.3.200, timeout = 0
2013-03-17 22:00:32,131 DEBUG [DiscoveryAdvertisementNotifier] Sending 6 'alive' messages describing device 6489fbb2-c75d-3879-9842-9162558132c2
2013-03-17 22:00:32,798 DEBUG [WebServer] Incoming connection from /192.168.3.101:63229
2013-03-17 22:00:32,892 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:00:32,894 DEBUG [DeviceDescriptionRequestHandler] DeviceDescription request received for device 6489fbb2-c75d-3879-9842-9162558132c2 from 192.168.3.101 (headers = [Host: 192.168.3.200:8895,Date: Sun, 17 Mar 2013 21:00:31 GMT,User-Agent: UPnP/1.0,X-AV-Physical-Unit-Info: pa="Blu-ray Disc Player";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0";])
2013-03-17 22:00:32,894 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:00:32,895 DEBUG [RendererManager] Looking for a renderer profile for Http headers: [Host: 192.168.3.200:8895,Date: Sun, 17 Mar 2013 21:00:31 GMT,User-Agent: UPnP/1.0,X-AV-Physical-Unit-Info: pa="Blu-ray Disc Player";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0";]
2013-03-17 22:00:32,896 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:00:32,923 DEBUG [DeviceDescriptionRequestHandler] Sending DeviceDescription XML back using profile 'Sony BD Player / SMP'
2013-03-17 22:00:33,000 DEBUG [WebServer] Incoming connection from /192.168.3.101:63230
2013-03-17 22:00:33,028 DEBUG [WebServer] Incoming connection from /192.168.3.200:41104
2013-03-17 22:00:33,028 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.200
2013-03-17 22:00:33,030 DEBUG [DeviceDescriptionRequestHandler] DeviceDescription request received for device 6489fbb2-c75d-3879-9842-9162558132c2 from 192.168.3.200 (headers = [Connection: close,Cache-Control: no-cache,Accept: */*,Accept-Encoding: deflate, gzip,Accept-Language: en,Host: 192.168.3.200:8895,User-Agent: iTunes/4.7.1 (Linux; N; Linux; armv5tel-linux; EN; utf8) SqueezeCenter, Squeezebox Server, Logitech Media Server/7.7.0/33614,Icy-Metadata: 1])
2013-03-17 22:00:33,030 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.200
2013-03-17 22:00:33,032 DEBUG [RendererManager] Looking for a renderer profile for Http headers: [Connection: close,Cache-Control: no-cache,Accept: */*,Accept-Encoding: deflate, gzip,Accept-Language: en,Host: 192.168.3.200:8895,User-Agent: iTunes/4.7.1 (Linux; N; Linux; armv5tel-linux; EN; utf8) SqueezeCenter, Squeezebox Server, Logitech Media Server/7.7.0/33614,Icy-Metadata: 1]
2013-03-17 22:00:33,032 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.200
2013-03-17 22:00:33,036 DEBUG [DeviceDescriptionRequestHandler] Sending DeviceDescription XML back using profile 'Generic DLNA profile'
2013-03-17 22:00:33,096 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:00:33,108 DEBUG [ServiceDescriptionRequestHandler] ServiceDescription request received for service ConnectionManager
2013-03-17 22:00:33,187 DEBUG [ServiceDescriptionRequestHandler] Sending ServiceDescription XML back
2013-03-17 22:00:33,324 DEBUG [WebServer] Incoming connection from /192.168.3.101:63231
2013-03-17 22:00:33,350 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-17 22:00:33,421 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:00:33,422 DEBUG [ServiceDescriptionRequestHandler] ServiceDescription request received for service ContentDirectory
2013-03-17 22:00:33,639 DEBUG [ServiceDescriptionRequestHandler] Sending ServiceDescription XML back
2013-03-17 22:00:33,867 DEBUG [WebServer] Incoming connection from /192.168.3.101:63232
2013-03-17 22:00:33,946 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:00:33,968 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#GetSortCapabilities"' from 192.168.3.101:
2013-03-17 22:00:33,968 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:00:34,031 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message
2013-03-17 22:00:34,042 DEBUG [WebServer] Incoming connection from /192.168.3.101:63233
2013-03-17 22:00:34,107 DEBUG [DiscoveryAdvertisementNotifier] Will advertise again in 00:03:14 (advertisement duration is 1800 sec.)
2013-03-17 22:00:34,136 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:00:34,148 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ConnectionManager:1#GetProtocolInfo"' from 192.168.3.101:
2013-03-17 22:00:34,148 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:00:34,191 DEBUG [ConnectionManager] Sending protocol info using profile 'Sony BD Player / SMP'
2013-03-17 22:00:34,357 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message
2013-03-17 22:00:35,058 DEBUG [WebServer] Incoming connection from /192.168.3.101:63234
2013-03-17 22:00:35,152 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:00:35,153 DEBUG [DeviceDescriptionRequestHandler] DeviceDescription request received for device 6489fbb2-c75d-3879-9842-9162558132c2 from 192.168.3.101 (headers = [Host: 192.168.3.200:8895,Date: Sun, 17 Mar 2013 21:00:33 GMT,User-Agent: UPnP/1.0,X-AV-Physical-Unit-Info: pa="Blu-ray Disc Player";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0";])
2013-03-17 22:00:35,154 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:00:35,155 DEBUG [RendererManager] Looking for a renderer profile for Http headers: [Host: 192.168.3.200:8895,Date: Sun, 17 Mar 2013 21:00:33 GMT,User-Agent: UPnP/1.0,X-AV-Physical-Unit-Info: pa="Blu-ray Disc Player";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0";]
2013-03-17 22:00:35,155 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:00:35,180 DEBUG [DeviceDescriptionRequestHandler] Sending DeviceDescription XML back using profile 'Sony BD Player / SMP'
2013-03-17 22:00:35,288 DEBUG [WebServer] Incoming connection from /192.168.3.101:63235
2013-03-17 22:00:35,340 DEBUG [WebServer] Incoming connection from /127.0.0.1:35192
2013-03-17 22:00:35,341 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 127.0.0.1
2013-03-17 22:00:35,342 DEBUG [ServiceEventSubscriptionRequestHandler] ServiceEvent renewal request received for service ContentDirectory and subscription uuid:732c2590-43c2-4365-baec-774fc3f770e7
2013-03-17 22:00:35,342 DEBUG [ServiceEventSubscriptionRequestHandler] Event subscription renewed for service urn:upnp-org:serviceId:ContentDirectory and subscription 732c2590-43c2-4365-baec-774fc3f770e7
2013-03-17 22:00:35,356 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:00:35,378 DEBUG [ServiceDescriptionRequestHandler] ServiceDescription request received for service ConnectionManager
2013-03-17 22:00:35,379 DEBUG [ServiceDescriptionRequestHandler] Sending ServiceDescription XML back
2013-03-17 22:00:35,498 DEBUG [WebServer] Incoming connection from /192.168.3.101:63236
2013-03-17 22:00:35,592 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:00:35,593 DEBUG [ServiceDescriptionRequestHandler] ServiceDescription request received for service ContentDirectory
2013-03-17 22:00:35,594 DEBUG [ServiceDescriptionRequestHandler] Sending ServiceDescription XML back
2013-03-17 22:00:35,808 DEBUG [WebServer] Incoming connection from /192.168.3.101:63237
2013-03-17 22:00:35,896 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:00:35,918 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#GetSortCapabilities"' from 192.168.3.101:
2013-03-17 22:00:35,918 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:00:35,989 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message
2013-03-17 22:00:36,018 DEBUG [WebServer] Incoming connection from /192.168.3.101:63238
2013-03-17 22:00:36,096 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:00:36,119 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ConnectionManager:1#GetProtocolInfo"' from 192.168.3.101:
2013-03-17 22:00:36,119 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:00:36,151 DEBUG [ConnectionManager] Sending protocol info using profile 'Sony BD Player / SMP'
2013-03-17 22:00:36,348 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message
2013-03-17 22:00:38,300 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-17 22:00:43,360 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-17 22:00:48,310 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-17 22:00:53,370 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-17 22:00:58,320 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-17 22:01:03,380 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-17 22:01:08,330 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-17 22:01:13,390 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-17 22:01:16,488 DEBUG [NonClosingPipedInputStream] Closing piped input stream and closing related feeder process
2013-03-17 22:01:16,488 DEBUG [NonClosingPipedInputStream] Scheduling stream stop to happen in 20 seconds if there is no traffic
2013-03-17 22:01:16,488 DEBUG [ProcessExecutor] Stopping external process: Thread[Thread-1202,5,main]
2013-03-17 22:01:16,489 DEBUG [ProcessUtils] Sending kill -9 to the Unix process: 15865
2013-03-17 22:01:16,489 DEBUG [ProcessExecutor] Starting kill -9 15865
2013-03-17 22:01:16,557 WARN  [ProcessExecutor] Process /root/.serviio/opt/bin/ffmpeg has a return code of 137! This is a possible error.
2013-03-17 22:01:16,557 DEBUG [TranscodingJobListener] Transcoding finished; successful: false
2013-03-17 22:01:16,560 DEBUG [TranscodingJobListener] Transcoding finished; successful: true
2013-03-17 22:01:16,561 DEBUG [WebServer] I/O error: Pipe broken
2013-03-17 22:01:16,562 DEBUG [WebServer] I/O error: Pipe broken
2013-03-17 22:01:16,568 DEBUG [WebServer] Incoming connection from /192.168.3.101:63244
2013-03-17 22:01:16,569 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:01:16,571 DEBUG [ResourceTransportRequestHandler] GET /resource/1000000210001993/MEDIA_ITEM/MPEG_PS_NTSC-0/ORIGINAL HTTP/1.1, headers = [Host: 192.168.3.200:8895,Accept: */*,getcontentFeatures.dlna.org: 1,X-AV-Physical-Unit-Info: pa="Blu-ray Disc Player",X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"]]
2013-03-17 22:01:16,571 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:01:16,572 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-17 22:01:16,573 DEBUG [ResourceDeliveryProcessor] Request for resource 1000000210001993 and type 'MEDIA_ITEM' received
2013-03-17 22:01:16,573 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001993 (online)
2013-03-17 22:01:16,573 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-17 22:01:16,575 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 1000000210001993, format MPEG_PS_NTSC and profile Sony BD Player / SMP
2013-03-17 22:01:16,575 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file rtsp://user:pass@192.168.3.210:81
2013-03-17 22:01:16,575 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_PAL
2013-03-17 22:01:16,576 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_NTSC
2013-03-17 22:01:16,576 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001993 (online)
2013-03-17 22:01:16,576 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-17 22:01:16,578 DEBUG [VideoDeliveryEngine] Delivering item '1000000210001993' for client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-17 22:01:16,578 DEBUG [VideoDeliveryEngine] Delivering file 'rtsp://user:pass@192.168.3.210:81' using transcoding
2013-03-17 22:01:16,579 DEBUG [AbstractTranscodingDeliveryEngine] No suitable transcoding job exists yet, start one for client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-17 22:01:16,579 DEBUG [FFMPEGWrapper] Invoking FFmpeg to transcode video file: rtsp://user:pass@192.168.3.210:81
2013-03-17 22:01:16,580 DEBUG [ProcessExecutor] Starting /root/.serviio/opt/bin/ffmpeg -rtsp_transport +tcp+udp -analyzeduration 10000000 -threads 1 -i rtsp://user:pass@192.168.3.210:81 -y -copyts -c:v mpeg2video -qscale:v 3 -r 24000/1001 -g 15 -c:a ac3_fixed -b:a 384k -ar 48000 -ac 1 -map 0:0 -map 0:1 -sn -f vob pipe:
2013-03-17 22:01:17,568 DEBUG [WebServer] I/O error: Pipe broken
2013-03-17 22:01:17,917 DEBUG [FeedUpdaterThread] Checking for new and expired online resources
2013-03-17 22:01:17,917 DEBUG [OnlineRepositoryDAOImpl] Reading all OnlineRepositories
2013-03-17 22:01:17,922 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-17 22:01:18,340 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-17 22:01:18,618 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_PAL
2013-03-17 22:01:18,618 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_NTSC
2013-03-17 22:01:18,618 DEBUG [ResourceDeliveryProcessor] Stream entity has length: 50000000000
2013-03-17 22:01:18,619 DEBUG [ResourceDeliveryProcessor] Sending file back
2013-03-17 22:01:18,619 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer
2013-03-17 22:01:18,619 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: video/mpeg,Date: Sun, 17 Mar 2013 21:01:18 GMT,Server: Linux, UPnP/1.0 DLNADOC/1.50, Serviio/1.1,Cache-control: no-cache,contentFeatures.dlna.org: DLNA.ORG_PN=MPEG_PS_NTSC;DLNA.ORG_OP=00;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=8D500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]]
2013-03-17 22:01:18,868 DEBUG [WebServer] Incoming connection from /192.168.3.101:63245
2013-03-17 22:01:18,914 DEBUG [WebServer] I/O error: Broken pipe
2013-03-17 22:01:18,914 DEBUG [NonClosingPipedInputStream] Scheduling stream stop to happen in 20 seconds if there is no traffic
2013-03-17 22:01:18,957 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:01:18,969 DEBUG [ResourceTransportRequestHandler] GET /resource/1000000210001993/MEDIA_ITEM/MPEG_PS_NTSC-0/ORIGINAL HTTP/1.1, headers = [Host: 192.168.3.200:8895,Accept: */*]]
2013-03-17 22:01:18,969 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:01:18,971 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-17 22:01:18,972 DEBUG [ResourceDeliveryProcessor] Request for resource 1000000210001993 and type 'MEDIA_ITEM' received
2013-03-17 22:01:18,972 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001993 (online)
2013-03-17 22:01:18,972 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-17 22:01:18,973 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 1000000210001993, format MPEG_PS_NTSC and profile Sony BD Player / SMP
2013-03-17 22:01:18,974 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file rtsp://user:pass@192.168.3.210:81
2013-03-17 22:01:18,974 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_PAL
2013-03-17 22:01:18,974 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_NTSC
2013-03-17 22:01:18,974 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001993 (online)
2013-03-17 22:01:18,974 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-17 22:01:18,976 DEBUG [VideoDeliveryEngine] Delivering item '1000000210001993' for client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-17 22:01:18,976 DEBUG [VideoDeliveryEngine] Delivering file 'rtsp://user:pass@192.168.3.210:81' using transcoding
2013-03-17 22:01:18,977 DEBUG [AbstractTranscodingDeliveryEngine] A suitable transcoding job already exists, re-use it for client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-17 22:01:19,978 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_PAL
2013-03-17 22:01:19,978 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_NTSC
2013-03-17 22:01:19,978 DEBUG [ResourceDeliveryProcessor] Stream entity has length: 50000000000
2013-03-17 22:01:19,979 DEBUG [ResourceDeliveryProcessor] Sending file back
2013-03-17 22:01:19,979 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer
2013-03-17 22:01:19,979 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: video/mpeg,Date: Sun, 17 Mar 2013 21:01:19 GMT,Server: Linux, UPnP/1.0 DLNADOC/1.50, Serviio/1.1,Cache-control: no-cache,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]]
2013-03-17 22:01:20,188 DEBUG [WebServer] Incoming connection from /192.168.3.101:63246
2013-03-17 22:01:20,283 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:01:20,284 DEBUG [ResourceTransportRequestHandler] HEAD /resource/1000000210001993/MEDIA_ITEM/MPEG_PS_NTSC-0/ORIGINAL HTTP/1.1, headers = [Host: 192.168.3.200:8895,Accept: */*,getcontentFeatures.dlna.org: 1,X-AV-Physical-Unit-Info: pa="Blu-ray Disc Player",X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"]]
2013-03-17 22:01:20,284 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:01:20,286 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-17 22:01:20,287 DEBUG [ResourceDeliveryProcessor] Request for resource 1000000210001993 and type 'MEDIA_ITEM' received
2013-03-17 22:01:20,287 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001993 (online)
2013-03-17 22:01:20,287 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-17 22:01:20,299 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 1000000210001993, format MPEG_PS_NTSC and profile Sony BD Player / SMP
2013-03-17 22:01:20,299 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file rtsp://user:pass@192.168.3.210:81
2013-03-17 22:01:20,299 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_PAL
2013-03-17 22:01:20,299 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_NTSC
2013-03-17 22:01:20,300 DEBUG [ResourceDeliveryProcessor] Sending HEAD response back
2013-03-17 22:01:20,300 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: video/mpeg,Date: Sun, 17 Mar 2013 21:01:20 GMT,Server: Linux, UPnP/1.0 DLNADOC/1.50, Serviio/1.1,Cache-control: no-cache,contentFeatures.dlna.org: DLNA.ORG_PN=MPEG_PS_NTSC;DLNA.ORG_OP=00;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=8D500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]]
2013-03-17 22:01:20,305 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:01:20,307 DEBUG [ResourceTransportRequestHandler] GET /resource/1000000210001993/MEDIA_ITEM/MPEG_PS_NTSC-0/ORIGINAL HTTP/1.1, headers = [Host: 192.168.3.200:8895,Accept: */*,getcontentFeatures.dlna.org: 1,X-AV-Physical-Unit-Info: pa="Blu-ray Disc Player",X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"]]
2013-03-17 22:01:20,307 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:01:20,319 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-17 22:01:20,320 DEBUG [ResourceDeliveryProcessor] Request for resource 1000000210001993 and type 'MEDIA_ITEM' received
2013-03-17 22:01:20,320 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001993 (online)
2013-03-17 22:01:20,320 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-17 22:01:20,322 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 1000000210001993, format MPEG_PS_NTSC and profile Sony BD Player / SMP
2013-03-17 22:01:20,322 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file rtsp://user:pass@192.168.3.210:81
2013-03-17 22:01:20,322 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_PAL
2013-03-17 22:01:20,322 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_NTSC
2013-03-17 22:01:20,323 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001993 (online)
2013-03-17 22:01:20,323 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-17 22:01:20,324 DEBUG [VideoDeliveryEngine] Delivering item '1000000210001993' for client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-17 22:01:20,325 DEBUG [VideoDeliveryEngine] Delivering file 'rtsp://user:pass@192.168.3.210:81' using transcoding
2013-03-17 22:01:20,325 DEBUG [AbstractTranscodingDeliveryEngine] A suitable transcoding job already exists, re-use it for client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-17 22:01:20,325 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_PAL
2013-03-17 22:01:20,326 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_NTSC
2013-03-17 22:01:20,326 DEBUG [ResourceDeliveryProcessor] Stream entity has length: 50000000000
2013-03-17 22:01:20,326 DEBUG [ResourceDeliveryProcessor] Sending file back
2013-03-17 22:01:20,327 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer
2013-03-17 22:01:20,327 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: video/mpeg,Date: Sun, 17 Mar 2013 21:01:20 GMT,Server: Linux, UPnP/1.0 DLNADOC/1.50, Serviio/1.1,Cache-control: no-cache,contentFeatures.dlna.org: DLNA.ORG_PN=MPEG_PS_NTSC;DLNA.ORG_OP=00;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=8D500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]]
2013-03-17 22:01:20,398 DEBUG [WebServer] Incoming connection from /192.168.3.101:63247
2013-03-17 22:01:20,493 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:01:20,494 DEBUG [ResourceTransportRequestHandler] GET /resource/1000000210001993/MEDIA_ITEM/MPEG_PS_NTSC-0/ORIGINAL HTTP/1.1, headers = [Host: 192.168.3.200:8895,Accept: */*,getcontentFeatures.dlna.org: 1,X-AV-Physical-Unit-Info: pa="Blu-ray Disc Player",X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"]]
2013-03-17 22:01:20,495 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:01:20,496 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-17 22:01:20,497 DEBUG [ResourceDeliveryProcessor] Request for resource 1000000210001993 and type 'MEDIA_ITEM' received
2013-03-17 22:01:20,497 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001993 (online)
2013-03-17 22:01:20,497 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-17 22:01:20,509 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 1000000210001993, format MPEG_PS_NTSC and profile Sony BD Player / SMP
2013-03-17 22:01:20,509 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file rtsp://user:pass@192.168.3.210:81
2013-03-17 22:01:20,510 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_PAL
2013-03-17 22:01:20,510 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_NTSC
2013-03-17 22:01:20,510 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001993 (online)
2013-03-17 22:01:20,510 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-17 22:01:20,512 DEBUG [VideoDeliveryEngine] Delivering item '1000000210001993' for client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-17 22:01:20,512 DEBUG [VideoDeliveryEngine] Delivering file 'rtsp://user:pass@192.168.3.210:81' using transcoding
2013-03-17 22:01:20,512 DEBUG [AbstractTranscodingDeliveryEngine] A suitable transcoding job already exists, re-use it for client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-17 22:01:21,517 DEBUG [StreamBasedTranscodingDeliveryStrategy] Transcoded stream is empty, connection may have been lost
2013-03-17 22:01:21,518 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_PAL
2013-03-17 22:01:21,518 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_NTSC
2013-03-17 22:01:21,519 DEBUG [ResourceDeliveryProcessor] Stream entity has length: 50000000000
2013-03-17 22:01:21,519 DEBUG [ResourceDeliveryProcessor] Sending file back
2013-03-17 22:01:21,519 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer
2013-03-17 22:01:21,519 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: video/mpeg,Date: Sun, 17 Mar 2013 21:01:21 GMT,Server: Linux, UPnP/1.0 DLNADOC/1.50, Serviio/1.1,Cache-control: no-cache,contentFeatures.dlna.org: DLNA.ORG_PN=MPEG_PS_NTSC;DLNA.ORG_OP=00;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=8D500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]]
2013-03-17 22:01:23,290 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-17 22:01:28,350 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-17 22:01:33,048 DEBUG [WebServer] Incoming connection from /192.168.3.200:41139
2013-03-17 22:01:33,049 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.200
2013-03-17 22:01:33,050 DEBUG [DeviceDescriptionRequestHandler] DeviceDescription request received for device 6489fbb2-c75d-3879-9842-9162558132c2 from 192.168.3.200 (headers = [Connection: close,Cache-Control: no-cache,Accept: */*,Accept-Encoding: deflate, gzip,Accept-Language: en,Host: 192.168.3.200:8895,User-Agent: iTunes/4.7.1 (Linux; N; Linux; armv5tel-linux; EN; utf8) SqueezeCenter, Squeezebox Server, Logitech Media Server/7.7.0/33614,Icy-Metadata: 1])
2013-03-17 22:01:33,050 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.200
2013-03-17 22:01:33,052 DEBUG [RendererManager] Looking for a renderer profile for Http headers: [Connection: close,Cache-Control: no-cache,Accept: */*,Accept-Encoding: deflate, gzip,Accept-Language: en,Host: 192.168.3.200:8895,User-Agent: iTunes/4.7.1 (Linux; N; Linux; armv5tel-linux; EN; utf8) SqueezeCenter, Squeezebox Server, Logitech Media Server/7.7.0/33614,Icy-Metadata: 1]
2013-03-17 22:01:33,053 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.200
2013-03-17 22:01:33,080 DEBUG [DeviceDescriptionRequestHandler] Sending DeviceDescription XML back using profile 'Generic DLNA profile'
2013-03-17 22:01:33,410 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-17 22:01:38,360 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-17 22:01:43,310 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-17 22:01:48,370 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-17 22:01:53,320 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-17 22:01:58,380 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-17 22:02:03,330 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-17 22:02:08,391 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-17 22:02:13,340 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-17 22:02:17,927 DEBUG [FeedUpdaterThread] Checking for new and expired online resources
2013-03-17 22:02:17,928 DEBUG [OnlineRepositoryDAOImpl] Reading all OnlineRepositories
2013-03-17 22:02:17,932 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-17 22:02:18,290 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-17 22:02:21,528 DEBUG [NonClosingPipedInputStream] Closing piped input stream and closing related feeder process
2013-03-17 22:02:21,528 DEBUG [NonClosingPipedInputStream] Scheduling stream stop to happen in 20 seconds if there is no traffic
2013-03-17 22:02:21,528 DEBUG [ProcessExecutor] Stopping external process: Thread[Thread-1224,5,main]
2013-03-17 22:02:21,528 DEBUG [ProcessUtils] Sending kill -9 to the Unix process: 15915
2013-03-17 22:02:21,528 DEBUG [ProcessExecutor] Starting kill -9 15915
2013-03-17 22:02:21,542 DEBUG [TranscodingJobListener] Transcoding finished; successful: true
2013-03-17 22:02:21,557 DEBUG [WebServer] I/O error: Pipe broken
2013-03-17 22:02:21,558 DEBUG [WebServer] I/O error: Pipe broken
2013-03-17 22:02:22,557 DEBUG [WebServer] I/O error: Pipe broken
2013-03-17 22:02:22,564 DEBUG [WebServer] Incoming connection from /192.168.3.101:63263
2013-03-17 22:02:22,565 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:02:22,566 DEBUG [ResourceTransportRequestHandler] GET /resource/1000000210001993/MEDIA_ITEM/MPEG_PS_NTSC-0/ORIGINAL HTTP/1.1, headers = [Host: 192.168.3.200:8895,Accept: */*,getcontentFeatures.dlna.org: 1,X-AV-Physical-Unit-Info: pa="Blu-ray Disc Player",X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"]]
2013-03-17 22:02:22,567 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-17 22:02:22,568 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-17 22:02:22,569 DEBUG [ResourceDeliveryProcessor] Request for resource 1000000210001993 and type 'MEDIA_ITEM' received
2013-03-17 22:02:22,569 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001993 (online)
2013-03-17 22:02:22,569 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-17 22:02:22,571 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 1000000210001993, format MPEG_PS_NTSC and profile Sony BD Player / SMP
2013-03-17 22:02:22,571 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file rtsp://user:pass@192.168.3.210:81
2013-03-17 22:02:22,571 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_PAL
2013-03-17 22:02:22,571 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_NTSC
2013-03-17 22:02:22,572 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001993 (online)
2013-03-17 22:02:22,572 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-17 22:02:22,573 DEBUG [VideoDeliveryEngine] Delivering item '1000000210001993' for client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-17 22:02:22,574 DEBUG [VideoDeliveryEngine] Delivering file 'rtsp://user:pass@192.168.3.210:81' using transcoding
2013-03-17 22:02:22,574 DEBUG [AbstractTranscodingDeliveryEngine] No suitable transcoding job exists yet, start one for client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-17 22:02:22,575 DEBUG [FFMPEGWrapper] Invoking FFmpeg to transcode video file: rtsp://user:pass@192.168.3.210:81
2013-03-17 22:02:22,575 DEBUG [ProcessExecutor] Starting /root/.serviio/opt/bin/ffmpeg -rtsp_transport +tcp+udp -analyzeduration 10000000 -threads 1 -i rtsp://user:pass@192.168.3.210:81 -y -copyts -c:v mpeg2video -qscale:v 3 -r 24000/1001 -g 15 -c:a ac3_fixed -b:a 384k -ar 48000 -ac 1 -map 0:0 -map 0:1 -sn -f vob pipe:
2013-03-17 22:02:23,350 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-17 22:02:25,118 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_PAL
2013-03-17 22:02:25,118 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: MPEG_PS_NTSC
2013-03-17 22:02:25,118 DEBUG [ResourceDeliveryProcessor] Stream entity has length: 50000000000
2013-03-17 22:02:25,119 DEBUG [ResourceDeliveryProcessor] Sending file back
2013-03-17 22:02:25,119 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer
2013-03-17 22:02:25,119 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: video/mpeg,Date: Sun, 17 Mar 2013 21:02:25 GMT,Server: Linux, UPnP/1.0 DLNADOC/1.50, Serviio/1.1,Cache-control: no-cache,contentFeatures.dlna.org: DLNA.ORG_PN=MPEG_PS_NTSC;DLNA.ORG_OP=00;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=8D500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]]
2013-03-17 22:02:28,410 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
Thanks!

Back to ONVIF: actually ONVIF is just XML web services to setup/control IP Cams: actual rendering is supposed to work with ffmpeg.
Opensource ONVIF Device Manager (http://sourceforge.net/projects/onvifdm/?source=navbar) provides a good exemple of a ref implementation, and actually uses ffmpeg for rendering.
I imagine getting a ONVIF groovy would probably be nice to handle many IP Cams.
Best,
<<

zip

User avatar

Serviio developer / Site Admin

Posts: 16507

Joined: Sat Oct 24, 2009 12:24 pm

Location: London, UK

Post Sun Mar 17, 2013 11:14 pm

Re: malformed rtsp metadata in IP Cam

all rtsp goes through FFmpeg because Serviio doesn't support the protocol natively - thus the transcoding.

Try to add this to Sonydbp 2012 OnlineTranscoding section:

  Code:
<Video targetContainer="mpegts" targetACodec="ac3">
  <Matches container="rtsp" vCodec="h264"/>
</Video>
<<

mpi

Serviio lover

Posts: 66

Joined: Fri Nov 18, 2011 9:15 pm

Post Mon Mar 18, 2013 9:21 am

Re: malformed rtsp metadata in IP Cam

Hi zip,

Thanks a lot, it works!...well, sometimes.
It takes quite a while to start, and fails frequently (back screen for long and then back to menu): it seems there are lots of "broken pipe" message in log.
CPU stays in the 15% boundaries, with peaks at 30%.
  Code:
2013-03-18 10:09:23,200 DEBUG [FeedUpdaterThread] Checking for new and expired online resources
2013-03-18 10:09:23,200 DEBUG [OnlineRepositoryDAOImpl] Reading all OnlineRepositories
2013-03-18 10:09:23,205 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-18 10:09:25,713 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-18 10:09:30,663 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-18 10:09:33,031 DEBUG [WebServer] Incoming connection from /192.168.3.101:59053
2013-03-18 10:09:33,125 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:09:33,127 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#Browse"' from 192.168.3.101:
2013-03-18 10:09:33,127 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:09:33,147 DEBUG [ContentDirectory] Browse() called for renderer Sony BD Player / SMP (profile 10) with parameters: objectID = 2, browseFlag = BrowseDirectChildren, filter = av:mediaClass,dc:title,dc:date,@childCount,upnp:class,res,res@resolution,res@protocolInfo,res@size,res@duration,res@bitrate,res@dlna:ifoFileURI, startIndex = 0, count = 10, sortCriteria =
2013-03-18 10:09:33,148 DEBUG [AccessGroupDAOImpl] Reading a AccessGroup (id = 1)
2013-03-18 10:09:33,151 DEBUG [VideoDAOImpl] Retrieving number of video initials [No_Restriction]
2013-03-18 10:09:33,284 DEBUG [VideoDAOImpl] Retrieving number of videos of type 2 [No_Restriction]
2013-03-18 10:09:33,288 DEBUG [SeriesDAOImpl] Retrieving number of series
2013-03-18 10:09:33,303 DEBUG [RepositoryDAOImpl] Retrieving number of repositories for VIDEO [No_Restriction]
2013-03-18 10:09:33,312 DEBUG [VideoDAOImpl] Retrieving number of 10 last viewed videos [No_Restriction]
2013-03-18 10:09:33,358 DEBUG [VideoDAOImpl] Retrieving number of 10 last added videos
2013-03-18 10:09:33,359 DEBUG [VideoDAOImpl] Retrieving number of videos of type 0 [No_Restriction]
2013-03-18 10:09:33,418 DEBUG [GenreDAOImpl] Retrieving number of genres for VIDEO
2013-03-18 10:09:33,476 DEBUG [PersonDAOImpl] Retrieving number of person initials for role ACTOR
2013-03-18 10:09:33,508 DEBUG [PersonDAOImpl] Retrieving number of person initials for role DIRECTOR
2013-03-18 10:09:33,538 DEBUG [PersonDAOImpl] Retrieving number of person initials for role PRODUCER
2013-03-18 10:09:33,604 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message
2013-03-18 10:09:33,687 DEBUG [WebServer] Incoming connection from /192.168.3.101:59054
2013-03-18 10:09:33,807 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:09:33,809 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#Browse"' from 192.168.3.101:
2013-03-18 10:09:33,809 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:09:33,847 DEBUG [ContentDirectory] Browse() called for renderer Sony BD Player / SMP (profile 10) with parameters: objectID = 2, browseFlag = BrowseDirectChildren, filter = av:mediaClass,dc:title,dc:date,@childCount,upnp:class,res,res@resolution,res@protocolInfo,res@size,res@duration,res@bitrate,res@dlna:ifoFileURI, startIndex = 10, count = 10, sortCriteria =
2013-03-18 10:09:33,847 DEBUG [AccessGroupDAOImpl] Reading a AccessGroup (id = 1)
2013-03-18 10:09:33,850 DEBUG [PlaylistDAOImpl] Retrieving number of playlists for VIDEO [No_Restriction]
2013-03-18 10:09:33,896 DEBUG [OnlineRepositoryDAOImpl] Retrieving list of [FEED, WEB_RESOURCE] OnlineRepositories for VIDEO [No_Restriction]
2013-03-18 10:09:33,899 DEBUG [OnlineRepositoryDAOImpl] Retrieving list of [LIVE_STREAM] OnlineRepositories for VIDEO [No_Restriction]
2013-03-18 10:09:33,953 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message
2013-03-18 10:09:35,723 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-18 10:09:38,491 DEBUG [WebServer] Incoming connection from /192.168.3.101:59055
2013-03-18 10:09:38,588 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:09:38,601 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#Browse"' from 192.168.3.101:
2013-03-18 10:09:38,601 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:09:38,634 DEBUG [ContentDirectory] Browse() called for renderer Sony BD Player / SMP (profile 10) with parameters: objectID = V_OF, browseFlag = BrowseDirectChildren, filter = av:mediaClass,dc:title,dc:date,@childCount,upnp:class,res,res@resolution,res@protocolInfo,res@size,res@duration,res@bitrate,res@dlna:ifoFileURI, startIndex = 0, count = 10, sortCriteria =
2013-03-18 10:09:38,634 DEBUG [AccessGroupDAOImpl] Reading a AccessGroup (id = 1)
2013-03-18 10:09:38,636 DEBUG [OnlineRepositoryDAOImpl] Retrieving list of [FEED, WEB_RESOURCE] OnlineRepositories for VIDEO [No_Restriction]
2013-03-18 10:09:38,639 DEBUG [OnlineRepositoryDAOImpl] Retrieving list of [LIVE_STREAM] OnlineRepositories for VIDEO [No_Restriction]
2013-03-18 10:09:38,645 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 1000000210001886 and profile Sony BD Player / SMP
2013-03-18 10:09:38,646 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: AVC_TS_MP_SD_AC3_ISO
2013-03-18 10:09:38,647 DEBUG [OnlineRepositoryDAOImpl] Retrieving list of [FEED, WEB_RESOURCE] OnlineRepositories for VIDEO [No_Restriction]
2013-03-18 10:09:38,660 DEBUG [OnlineRepositoryDAOImpl] Retrieving list of [LIVE_STREAM] OnlineRepositories for VIDEO [No_Restriction]
2013-03-18 10:09:38,684 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message
2013-03-18 10:09:40,673 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-18 10:09:40,895 DEBUG [WebServer] Incoming connection from /192.168.3.101:59056
2013-03-18 10:09:40,994 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:09:41,022 DEBUG [ResourceTransportRequestHandler] HEAD /resource/1000000210001886/MEDIA_ITEM/AVC_TS_MP_SD_AC3_ISO-1/ORIGINAL HTTP/1.1, headers = [Host: 192.168.3.200:8895,Accept: */*,getcontentFeatures.dlna.org: 1,X-AV-Physical-Unit-Info: pa="Blu-ray Disc Player",X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"]]
2013-03-18 10:09:41,023 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:09:41,024 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-18 10:09:41,025 DEBUG [ResourceDeliveryProcessor] Request for resource 1000000210001886 and type 'MEDIA_ITEM' received
2013-03-18 10:09:41,025 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001886 (online)
2013-03-18 10:09:41,026 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-18 10:09:41,027 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 1000000210001886, format AVC_TS_MP_SD_AC3_ISO and profile Sony BD Player / SMP
2013-03-18 10:09:41,028 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file rtsp://user:pass@192.168.3.210:81
2013-03-18 10:09:41,028 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: AVC_TS_MP_SD_AC3_ISO
2013-03-18 10:09:41,028 DEBUG [ResourceDeliveryProcessor] Sending HEAD response back
2013-03-18 10:09:41,029 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: video/vnd.dlna.mpeg-tts,Date: Mon, 18 Mar 2013 09:09:41 GMT,Server: Linux, UPnP/1.0 DLNADOC/1.50, Serviio/1.1,Cache-control: no-cache,contentFeatures.dlna.org: DLNA.ORG_PN=MPEG_TS_SD_NA;DLNA.ORG_OP=00;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=8D500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]]
2013-03-18 10:09:41,034 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:09:41,036 DEBUG [ResourceTransportRequestHandler] GET /resource/1000000210001886/MEDIA_ITEM/AVC_TS_MP_SD_AC3_ISO-1/ORIGINAL HTTP/1.1, headers = [Host: 192.168.3.200:8895,Accept: */*,getcontentFeatures.dlna.org: 1,X-AV-Physical-Unit-Info: pa="Blu-ray Disc Player",X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"]]
2013-03-18 10:09:41,036 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:09:41,038 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-18 10:09:41,038 DEBUG [ResourceDeliveryProcessor] Request for resource 1000000210001886 and type 'MEDIA_ITEM' received
2013-03-18 10:09:41,039 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001886 (online)
2013-03-18 10:09:41,039 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-18 10:09:41,041 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 1000000210001886, format AVC_TS_MP_SD_AC3_ISO and profile Sony BD Player / SMP
2013-03-18 10:09:41,041 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file rtsp://user:pass@192.168.3.210:81
2013-03-18 10:09:41,042 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: AVC_TS_MP_SD_AC3_ISO
2013-03-18 10:09:41,042 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001886 (online)
2013-03-18 10:09:41,042 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-18 10:09:41,044 DEBUG [VideoDeliveryEngine] Delivering item '1000000210001886' for client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-18 10:09:41,044 DEBUG [VideoDeliveryEngine] Delivering file 'rtsp://user:pass@192.168.3.210:81' using transcoding
2013-03-18 10:09:41,045 DEBUG [AbstractTranscodingDeliveryEngine] No suitable transcoding job exists yet, start one for client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-18 10:09:41,045 DEBUG [FFMPEGWrapper] Invoking FFmpeg to transcode video file: rtsp://user:pass@192.168.3.210:81
2013-03-18 10:09:41,046 DEBUG [ProcessExecutor] Starting /root/.serviio/opt/bin/ffmpeg -rtsp_transport +tcp+udp -analyzeduration 10000000 -fflags +genpts -threads 1 -i rtsp://user:pass@192.168.3.210:81 -y -copyts -c:v copy -bsf:v h264_mp4toannexb -c:a ac3_fixed -b:a 64k -ar 48000 -ac 1 -map 0:0 -map 0:1 -sn -f mpegts pipe:
2013-03-18 10:09:42,061 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: AVC_TS_MP_SD_AC3_ISO
2013-03-18 10:09:42,061 DEBUG [ResourceDeliveryProcessor] Stream entity has length: 50000000000
2013-03-18 10:09:42,062 DEBUG [ResourceDeliveryProcessor] Sending file back
2013-03-18 10:09:42,062 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer
2013-03-18 10:09:42,062 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: video/vnd.dlna.mpeg-tts,Date: Mon, 18 Mar 2013 09:09:42 GMT,Server: Linux, UPnP/1.0 DLNADOC/1.50, Serviio/1.1,Cache-control: no-cache,contentFeatures.dlna.org: DLNA.ORG_PN=MPEG_TS_SD_NA;DLNA.ORG_OP=00;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=8D500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]]
2013-03-18 10:09:42,071 DEBUG [WebServer] I/O error: Broken pipe
2013-03-18 10:09:42,072 DEBUG [NonClosingPipedInputStream] Scheduling stream stop to happen in 20 seconds if there is no traffic
2013-03-18 10:09:42,102 DEBUG [WebServer] Incoming connection from /192.168.3.101:59057
2013-03-18 10:09:42,174 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:09:42,176 DEBUG [ResourceTransportRequestHandler] GET /resource/1000000210001886/MEDIA_ITEM/AVC_TS_MP_SD_AC3_ISO-1/ORIGINAL HTTP/1.1, headers = [Host: 192.168.3.200:8895,Accept: */*,getcontentFeatures.dlna.org: 1,X-AV-Physical-Unit-Info: pa="Blu-ray Disc Player",X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"]]
2013-03-18 10:09:42,176 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:09:42,178 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-18 10:09:42,178 DEBUG [ResourceDeliveryProcessor] Request for resource 1000000210001886 and type 'MEDIA_ITEM' received
2013-03-18 10:09:42,179 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001886 (online)
2013-03-18 10:09:42,179 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-18 10:09:42,181 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 1000000210001886, format AVC_TS_MP_SD_AC3_ISO and profile Sony BD Player / SMP
2013-03-18 10:09:42,181 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file rtsp://user:pass@192.168.3.210:81
2013-03-18 10:09:42,181 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: AVC_TS_MP_SD_AC3_ISO
2013-03-18 10:09:42,182 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001886 (online)
2013-03-18 10:09:42,182 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-18 10:09:42,184 DEBUG [VideoDeliveryEngine] Delivering item '1000000210001886' for client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-18 10:09:42,184 DEBUG [VideoDeliveryEngine] Delivering file 'rtsp://user:pass@192.168.3.210:81' using transcoding
2013-03-18 10:09:42,185 DEBUG [AbstractTranscodingDeliveryEngine] A suitable transcoding job already exists, re-use it for client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-18 10:09:43,191 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: AVC_TS_MP_SD_AC3_ISO
2013-03-18 10:09:43,191 DEBUG [ResourceDeliveryProcessor] Stream entity has length: 50000000000
2013-03-18 10:09:43,192 DEBUG [ResourceDeliveryProcessor] Sending file back
2013-03-18 10:09:43,192 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer
2013-03-18 10:09:43,192 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: video/vnd.dlna.mpeg-tts,Date: Mon, 18 Mar 2013 09:09:43 GMT,Server: Linux, UPnP/1.0 DLNADOC/1.50, Serviio/1.1,Cache-control: no-cache,contentFeatures.dlna.org: DLNA.ORG_PN=MPEG_TS_SD_NA;DLNA.ORG_OP=00;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=8D500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]]
2013-03-18 10:09:43,402 DEBUG [WebServer] Incoming connection from /192.168.3.101:59058
2013-03-18 10:09:43,499 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:09:43,502 DEBUG [ResourceTransportRequestHandler] HEAD /resource/1000000210001886/MEDIA_ITEM/AVC_TS_MP_SD_AC3_ISO-1/ORIGINAL HTTP/1.1, headers = [Host: 192.168.3.200:8895,Accept: */*,getcontentFeatures.dlna.org: 1,X-AV-Physical-Unit-Info: pa="Blu-ray Disc Player",X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"]]
2013-03-18 10:09:43,502 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:09:43,504 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-18 10:09:43,504 DEBUG [ResourceDeliveryProcessor] Request for resource 1000000210001886 and type 'MEDIA_ITEM' received
2013-03-18 10:09:43,505 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001886 (online)
2013-03-18 10:09:43,505 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-18 10:09:43,506 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 1000000210001886, format AVC_TS_MP_SD_AC3_ISO and profile Sony BD Player / SMP
2013-03-18 10:09:43,507 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file rtsp://user:pass@192.168.3.210:81
2013-03-18 10:09:43,507 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: AVC_TS_MP_SD_AC3_ISO
2013-03-18 10:09:43,508 DEBUG [ResourceDeliveryProcessor] Sending HEAD response back
2013-03-18 10:09:43,508 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: video/vnd.dlna.mpeg-tts,Date: Mon, 18 Mar 2013 09:09:43 GMT,Server: Linux, UPnP/1.0 DLNADOC/1.50, Serviio/1.1,Cache-control: no-cache,contentFeatures.dlna.org: DLNA.ORG_PN=MPEG_TS_SD_NA;DLNA.ORG_OP=00;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=8D500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]]
2013-03-18 10:09:43,513 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:09:43,514 DEBUG [ResourceTransportRequestHandler] GET /resource/1000000210001886/MEDIA_ITEM/AVC_TS_MP_SD_AC3_ISO-1/ORIGINAL HTTP/1.1, headers = [Host: 192.168.3.200:8895,Accept: */*,getcontentFeatures.dlna.org: 1,X-AV-Physical-Unit-Info: pa="Blu-ray Disc Player",X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"]]
2013-03-18 10:09:43,515 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:09:43,516 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-18 10:09:43,517 DEBUG [ResourceDeliveryProcessor] Request for resource 1000000210001886 and type 'MEDIA_ITEM' received
2013-03-18 10:09:43,518 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001886 (online)
2013-03-18 10:09:43,518 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-18 10:09:43,521 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 1000000210001886, format AVC_TS_MP_SD_AC3_ISO and profile Sony BD Player / SMP
2013-03-18 10:09:43,521 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file rtsp://user:pass@192.168.3.210:81
2013-03-18 10:09:43,521 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: AVC_TS_MP_SD_AC3_ISO
2013-03-18 10:09:43,522 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001886 (online)
2013-03-18 10:09:43,522 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-18 10:09:43,523 DEBUG [VideoDeliveryEngine] Delivering item '1000000210001886' for client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-18 10:09:43,524 DEBUG [VideoDeliveryEngine] Delivering file 'rtsp://user:pass@192.168.3.210:81' using transcoding
2013-03-18 10:09:43,524 DEBUG [AbstractTranscodingDeliveryEngine] A suitable transcoding job already exists, re-use it for client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-18 10:09:43,525 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: AVC_TS_MP_SD_AC3_ISO
2013-03-18 10:09:43,525 DEBUG [ResourceDeliveryProcessor] Stream entity has length: 50000000000
2013-03-18 10:09:43,526 DEBUG [ResourceDeliveryProcessor] Sending file back
2013-03-18 10:09:43,526 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer
2013-03-18 10:09:43,526 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: video/vnd.dlna.mpeg-tts,Date: Mon, 18 Mar 2013 09:09:43 GMT,Server: Linux, UPnP/1.0 DLNADOC/1.50, Serviio/1.1,Cache-control: no-cache,contentFeatures.dlna.org: DLNA.ORG_PN=MPEG_TS_SD_NA;DLNA.ORG_OP=00;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=8D500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]]
2013-03-18 10:09:43,541 DEBUG [WebServer] Incoming connection from /192.168.3.101:59059
2013-03-18 10:09:43,559 DEBUG [WebServer] I/O error: Broken pipe
2013-03-18 10:09:43,560 DEBUG [NonClosingPipedInputStream] Scheduling stream stop to happen in 20 seconds if there is no traffic
2013-03-18 10:09:43,634 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:09:43,635 DEBUG [ResourceTransportRequestHandler] GET /resource/1000000210001886/MEDIA_ITEM/AVC_TS_MP_SD_AC3_ISO-1/ORIGINAL HTTP/1.1, headers = [Host: 192.168.3.200:8895,Accept: */*,getcontentFeatures.dlna.org: 1,X-AV-Physical-Unit-Info: pa="Blu-ray Disc Player",X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"]]
2013-03-18 10:09:43,636 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:09:43,637 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-18 10:09:43,638 DEBUG [ResourceDeliveryProcessor] Request for resource 1000000210001886 and type 'MEDIA_ITEM' received
2013-03-18 10:09:43,638 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001886 (online)
2013-03-18 10:09:43,639 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-18 10:09:43,641 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 1000000210001886, format AVC_TS_MP_SD_AC3_ISO and profile Sony BD Player / SMP
2013-03-18 10:09:43,641 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file rtsp://user:pass@192.168.3.210:81
2013-03-18 10:09:43,641 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: AVC_TS_MP_SD_AC3_ISO
2013-03-18 10:09:43,642 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001886 (online)
2013-03-18 10:09:43,642 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-18 10:09:43,644 DEBUG [VideoDeliveryEngine] Delivering item '1000000210001886' for client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-18 10:09:43,644 DEBUG [VideoDeliveryEngine] Delivering file 'rtsp://user:pass@192.168.3.210:81' using transcoding
2013-03-18 10:09:43,644 DEBUG [AbstractTranscodingDeliveryEngine] A suitable transcoding job already exists, re-use it for client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-18 10:09:44,651 DEBUG [StreamBasedTranscodingDeliveryStrategy] Transcoded stream is empty, connection may have been lost
2013-03-18 10:09:44,652 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: AVC_TS_MP_SD_AC3_ISO
2013-03-18 10:09:44,653 DEBUG [ResourceDeliveryProcessor] Stream entity has length: 50000000000
2013-03-18 10:09:44,653 DEBUG [ResourceDeliveryProcessor] Sending file back
2013-03-18 10:09:44,653 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer
2013-03-18 10:09:44,654 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: video/vnd.dlna.mpeg-tts,Date: Mon, 18 Mar 2013 09:09:44 GMT,Server: Linux, UPnP/1.0 DLNADOC/1.50, Serviio/1.1,Cache-control: no-cache,contentFeatures.dlna.org: DLNA.ORG_PN=MPEG_TS_SD_NA;DLNA.ORG_OP=00;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=8D500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]]
2013-03-18 10:09:44,858 DEBUG [WebServer] I/O error: Broken pipe
2013-03-18 10:09:44,858 DEBUG [NonClosingPipedInputStream] Scheduling stream stop to happen in 20 seconds if there is no traffic
2013-03-18 10:09:45,733 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-18 10:09:50,683 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-18 10:09:51,128 DEBUG [WebServer] Incoming connection from /192.168.3.101:59060
2013-03-18 10:09:51,224 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:09:51,226 DEBUG [ResourceTransportRequestHandler] GET /resource/1000000210001886/MEDIA_ITEM/AVC_TS_MP_SD_AC3_ISO-1/ORIGINAL HTTP/1.1, headers = [Host: 192.168.3.200:8895,Accept: */*,getcontentFeatures.dlna.org: 1,X-AV-Physical-Unit-Info: pa="Blu-ray Disc Player",X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"]]
2013-03-18 10:09:51,226 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:09:51,228 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-18 10:09:51,228 DEBUG [ResourceDeliveryProcessor] Request for resource 1000000210001886 and type 'MEDIA_ITEM' received
2013-03-18 10:09:51,229 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001886 (online)
2013-03-18 10:09:51,229 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-18 10:09:51,232 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 1000000210001886, format AVC_TS_MP_SD_AC3_ISO and profile Sony BD Player / SMP
2013-03-18 10:09:51,233 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file rtsp://user:pass@192.168.3.210:81
2013-03-18 10:09:51,233 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: AVC_TS_MP_SD_AC3_ISO
2013-03-18 10:09:51,233 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001886 (online)
2013-03-18 10:09:51,233 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-18 10:09:51,241 DEBUG [VideoDeliveryEngine] Delivering item '1000000210001886' for client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-18 10:09:51,242 DEBUG [VideoDeliveryEngine] Delivering file 'rtsp://user:pass@192.168.3.210:81' using transcoding
2013-03-18 10:09:51,243 DEBUG [AbstractTranscodingDeliveryEngine] A suitable transcoding job already exists, re-use it for client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-18 10:09:51,243 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: AVC_TS_MP_SD_AC3_ISO
2013-03-18 10:09:51,243 DEBUG [ResourceDeliveryProcessor] Stream entity has length: 50000000000
2013-03-18 10:09:51,244 DEBUG [ResourceDeliveryProcessor] Sending file back
2013-03-18 10:09:51,244 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer
2013-03-18 10:09:51,244 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: video/vnd.dlna.mpeg-tts,Date: Mon, 18 Mar 2013 09:09:51 GMT,Server: Linux, UPnP/1.0 DLNADOC/1.50, Serviio/1.1,Cache-control: no-cache,contentFeatures.dlna.org: DLNA.ORG_PN=MPEG_TS_SD_NA;DLNA.ORG_OP=00;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=8D500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]]
2013-03-18 10:09:51,277 DEBUG [WebServer] I/O error: Broken pipe
2013-03-18 10:09:51,277 DEBUG [NonClosingPipedInputStream] Scheduling stream stop to happen in 20 seconds if there is no traffic
2013-03-18 10:09:54,575 DEBUG [WebServer] I/O error: Broken pipe
2013-03-18 10:09:54,575 DEBUG [NonClosingPipedInputStream] Scheduling stream stop to happen in 20 seconds if there is no traffic
2013-03-18 10:09:54,581 DEBUG [WebServer] Incoming connection from /192.168.3.101:59061
2013-03-18 10:09:54,674 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:09:54,676 DEBUG [ResourceTransportRequestHandler] GET /resource/1000000210001886/MEDIA_ITEM/AVC_TS_MP_SD_AC3_ISO-1/ORIGINAL HTTP/1.1, headers = [Host: 192.168.3.200:8895,Accept: */*,getcontentFeatures.dlna.org: 1,X-AV-Physical-Unit-Info: pa="Blu-ray Disc Player",X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"]]
2013-03-18 10:09:54,676 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:09:54,678 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-18 10:09:54,678 DEBUG [ResourceDeliveryProcessor] Request for resource 1000000210001886 and type 'MEDIA_ITEM' received
2013-03-18 10:09:54,679 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001886 (online)
2013-03-18 10:09:54,679 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-18 10:09:54,681 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 1000000210001886, format AVC_TS_MP_SD_AC3_ISO and profile Sony BD Player / SMP
2013-03-18 10:09:54,681 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file rtsp://user:pass@192.168.3.210:81
2013-03-18 10:09:54,682 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: AVC_TS_MP_SD_AC3_ISO
2013-03-18 10:09:54,682 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001886 (online)
2013-03-18 10:09:54,682 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-18 10:09:54,684 DEBUG [VideoDeliveryEngine] Delivering item '1000000210001886' for client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-18 10:09:54,684 DEBUG [VideoDeliveryEngine] Delivering file 'rtsp://user:pass@192.168.3.210:81' using transcoding
2013-03-18 10:09:54,685 DEBUG [AbstractTranscodingDeliveryEngine] A suitable transcoding job already exists, re-use it for client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-18 10:09:55,691 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: AVC_TS_MP_SD_AC3_ISO
2013-03-18 10:09:55,691 DEBUG [ResourceDeliveryProcessor] Stream entity has length: 50000000000
2013-03-18 10:09:55,692 DEBUG [ResourceDeliveryProcessor] Sending file back
2013-03-18 10:09:55,692 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer
2013-03-18 10:09:55,692 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: video/vnd.dlna.mpeg-tts,Date: Mon, 18 Mar 2013 09:09:55 GMT,Server: Linux, UPnP/1.0 DLNADOC/1.50, Serviio/1.1,Cache-control: no-cache,contentFeatures.dlna.org: DLNA.ORG_PN=MPEG_TS_SD_NA;DLNA.ORG_OP=00;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=8D500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]]
2013-03-18 10:09:55,743 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-18 10:09:58,022 DEBUG [WebServer] Incoming connection from /192.168.3.200:58413
2013-03-18 10:09:58,023 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.200
2013-03-18 10:09:58,025 DEBUG [DeviceDescriptionRequestHandler] DeviceDescription request received for device 6489fbb2-c75d-3879-9842-9162558132c2 from 192.168.3.200 (headers = [Connection: close,Cache-Control: no-cache,Accept: */*,Accept-Encoding: deflate, gzip,Accept-Language: en,Host: 192.168.3.200:8895,User-Agent: iTunes/4.7.1 (Linux; N; Linux; armv5tel-linux; EN; utf8) SqueezeCenter, Squeezebox Server, Logitech Media Server/7.7.0/33614,Icy-Metadata: 1])
2013-03-18 10:09:58,025 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.200
2013-03-18 10:09:58,026 DEBUG [RendererManager] Looking for a renderer profile for Http headers: [Connection: close,Cache-Control: no-cache,Accept: */*,Accept-Encoding: deflate, gzip,Accept-Language: en,Host: 192.168.3.200:8895,User-Agent: iTunes/4.7.1 (Linux; N; Linux; armv5tel-linux; EN; utf8) SqueezeCenter, Squeezebox Server, Logitech Media Server/7.7.0/33614,Icy-Metadata: 1]
2013-03-18 10:09:58,027 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.200
2013-03-18 10:09:58,034 DEBUG [DeviceDescriptionRequestHandler] Sending DeviceDescription XML back using profile 'Generic DLNA profile'
2013-03-18 10:09:58,988 DEBUG [WebServer] I/O error: Broken pipe
2013-03-18 10:09:58,989 DEBUG [NonClosingPipedInputStream] Scheduling stream stop to happen in 20 seconds if there is no traffic
2013-03-18 10:09:59,037 DEBUG [WebServer] Incoming connection from /192.168.3.101:59062
2013-03-18 10:09:59,135 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:09:59,136 DEBUG [ResourceTransportRequestHandler] GET /resource/1000000210001886/MEDIA_ITEM/AVC_TS_MP_SD_AC3_ISO-1/ORIGINAL HTTP/1.1, headers = [Host: 192.168.3.200:8895,Accept: */*,getcontentFeatures.dlna.org: 1,X-AV-Physical-Unit-Info: pa="Blu-ray Disc Player",X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0"]]
2013-03-18 10:09:59,137 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:09:59,138 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-18 10:09:59,139 DEBUG [ResourceDeliveryProcessor] Request for resource 1000000210001886 and type 'MEDIA_ITEM' received
2013-03-18 10:09:59,139 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001886 (online)
2013-03-18 10:09:59,139 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-18 10:09:59,142 DEBUG [VideoDeliveryEngine] Retrieving resource information for item 1000000210001886, format AVC_TS_MP_SD_AC3_ISO and profile Sony BD Player / SMP
2013-03-18 10:09:59,142 DEBUG [AbstractTranscodingDeliveryEngine] Getting media info for transcoded version of file rtsp://user:pass@192.168.3.210:81
2013-03-18 10:09:59,143 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: AVC_TS_MP_SD_AC3_ISO
2013-03-18 10:09:59,143 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000210001886 (online)
2013-03-18 10:09:59,143 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-18 10:09:59,145 DEBUG [VideoDeliveryEngine] Delivering item '1000000210001886' for client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-18 10:09:59,145 DEBUG [VideoDeliveryEngine] Delivering file 'rtsp://user:pass@192.168.3.210:81' using transcoding
2013-03-18 10:09:59,146 DEBUG [AbstractTranscodingDeliveryEngine] A suitable transcoding job already exists, re-use it for client 'IPAddress=/192.168.3.101, Profile=Sony BD Player / SMP'
2013-03-18 10:10:00,132 DEBUG [WebServer] Incoming connection from /127.0.0.1:41907
2013-03-18 10:10:00,133 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 127.0.0.1
2013-03-18 10:10:00,135 DEBUG [ServiceEventSubscriptionRequestHandler] ServiceEvent renewal request received for service ContentDirectory and subscription uuid:d94a381f-bf33-4602-a074-e9fed580b9a7
2013-03-18 10:10:00,135 DEBUG [ServiceEventSubscriptionRequestHandler] Event subscription renewed for service urn:upnp-org:serviceId:ContentDirectory and subscription d94a381f-bf33-4602-a074-e9fed580b9a7
2013-03-18 10:10:00,152 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file rtsp://user:pass@192.168.3.210:81: AVC_TS_MP_SD_AC3_ISO
2013-03-18 10:10:00,152 DEBUG [ResourceDeliveryProcessor] Stream entity has length: 50000000000
2013-03-18 10:10:00,153 DEBUG [ResourceDeliveryProcessor] Sending file back
2013-03-18 10:10:00,153 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer
2013-03-18 10:10:00,153 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: video/vnd.dlna.mpeg-tts,Date: Mon, 18 Mar 2013 09:10:00 GMT,Server: Linux, UPnP/1.0 DLNADOC/1.50, Serviio/1.1,Cache-control: no-cache,contentFeatures.dlna.org: DLNA.ORG_PN=MPEG_TS_SD_NA;DLNA.ORG_OP=00;DLNA.ORG_CI=1;DLNA.ORG_FLAGS=8D500000000000000000000000000000,transferMode.dlna.org: Streaming,realTimeInfo.dlna.org: DLNA.ORG_TLAG=*]]
2013-03-18 10:10:00,693 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-18 10:10:05,643 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-18 10:10:10,723 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-18 10:10:15,673 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-18 10:10:20,733 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-18 10:10:21,311 DEBUG [PlaylistDAOImpl] Reading all Playlists
2013-03-18 10:10:23,210 DEBUG [FeedUpdaterThread] Checking for new and expired online resources
2013-03-18 10:10:23,210 DEBUG [OnlineRepositoryDAOImpl] Reading all OnlineRepositories
2013-03-18 10:10:23,216 DEBUG [OnlineRepositoryDAOImpl] Reading an OnlineRepository (id = 21)
2013-03-18 10:10:25,683 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-18 10:10:30,743 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-18 10:10:35,693 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-18 10:10:40,643 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-18 10:10:45,703 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-18 10:10:50,654 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-18 10:10:55,713 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-18 10:10:58,022 DEBUG [WebServer] Incoming connection from /192.168.3.200:58553
2013-03-18 10:10:58,022 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.200
2013-03-18 10:10:58,024 DEBUG [DeviceDescriptionRequestHandler] DeviceDescription request received for device 6489fbb2-c75d-3879-9842-9162558132c2 from 192.168.3.200 (headers = [Connection: close,Cache-Control: no-cache,Accept: */*,Accept-Encoding: deflate, gzip,Accept-Language: en,Host: 192.168.3.200:8895,User-Agent: iTunes/4.7.1 (Linux; N; Linux; armv5tel-linux; EN; utf8) SqueezeCenter, Squeezebox Server, Logitech Media Server/7.7.0/33614,Icy-Metadata: 1])
2013-03-18 10:10:58,024 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.200
2013-03-18 10:10:58,026 DEBUG [RendererManager] Looking for a renderer profile for Http headers: [Connection: close,Cache-Control: no-cache,Accept: */*,Accept-Encoding: deflate, gzip,Accept-Language: en,Host: 192.168.3.200:8895,User-Agent: iTunes/4.7.1 (Linux; N; Linux; armv5tel-linux; EN; utf8) SqueezeCenter, Squeezebox Server, Logitech Media Server/7.7.0/33614,Icy-Metadata: 1]
2013-03-18 10:10:58,027 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.200
2013-03-18 10:10:58,033 DEBUG [DeviceDescriptionRequestHandler] Sending DeviceDescription XML back using profile 'Generic DLNA profile'
2013-03-18 10:11:00,663 DEBUG [RendererDAOImpl] Retrieving list of all stored renderers
2013-03-18 10:11:01,321 DEBUG [DiscoveryAdvertisementNotifier] Found 1 network interfaces to advertise on
2013-03-18 10:11:01,323 DEBUG [DiscoveryAdvertisementNotifier] Multicasting SSDP alive using interface eth0 (eth0) and address 192.168.3.200, timeout = 0
2013-03-18 10:11:01,325 DEBUG [DiscoveryAdvertisementNotifier] Sending 6 'alive' messages describing device 6489fbb2-c75d-3879-9842-9162558132c2
2013-03-18 10:11:01,989 DEBUG [WebServer] Incoming connection from /192.168.3.101:59068
2013-03-18 10:11:02,085 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:11:02,087 DEBUG [DeviceDescriptionRequestHandler] DeviceDescription request received for device 6489fbb2-c75d-3879-9842-9162558132c2 from 192.168.3.101 (headers = [Host: 192.168.3.200:8895,Date: Mon, 18 Mar 2013 09:11:01 GMT,User-Agent: UPnP/1.0,X-AV-Physical-Unit-Info: pa="Blu-ray Disc Player";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0";])
2013-03-18 10:11:02,087 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:11:02,089 DEBUG [RendererManager] Looking for a renderer profile for Http headers: [Host: 192.168.3.200:8895,Date: Mon, 18 Mar 2013 09:11:01 GMT,User-Agent: UPnP/1.0,X-AV-Physical-Unit-Info: pa="Blu-ray Disc Player";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0";]
2013-03-18 10:11:02,090 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:11:02,105 DEBUG [DeviceDescriptionRequestHandler] Sending DeviceDescription XML back using profile 'Sony BD Player / SMP'
2013-03-18 10:11:02,194 DEBUG [WebServer] Incoming connection from /192.168.3.101:59069
2013-03-18 10:11:02,290 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:11:02,292 DEBUG [ServiceDescriptionRequestHandler] ServiceDescription request received for service ConnectionManager
2013-03-18 10:11:02,325 DEBUG [ServiceDescriptionRequestHandler] Sending ServiceDescription XML back
2013-03-18 10:11:02,451 DEBUG [WebServer] Incoming connection from /192.168.3.101:59070
2013-03-18 10:11:02,545 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:11:02,546 DEBUG [ServiceDescriptionRequestHandler] ServiceDescription request received for service ContentDirectory
2013-03-18 10:11:02,603 DEBUG [ServiceDescriptionRequestHandler] Sending ServiceDescription XML back
2013-03-18 10:11:02,823 DEBUG [WebServer] Incoming connection from /192.168.3.101:59071
2013-03-18 10:11:02,929 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:11:02,931 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#GetSortCapabilities"' from 192.168.3.101:
2013-03-18 10:11:02,931 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:11:02,952 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message
2013-03-18 10:11:02,963 DEBUG [WebServer] Incoming connection from /192.168.3.101:59072
2013-03-18 10:11:03,060 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:11:03,062 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ConnectionManager:1#GetProtocolInfo"' from 192.168.3.101:
2013-03-18 10:11:03,063 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:11:03,077 DEBUG [ConnectionManager] Sending protocol info using profile 'Sony BD Player / SMP'
2013-03-18 10:11:03,140 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message
2013-03-18 10:11:03,301 DEBUG [DiscoveryAdvertisementNotifier] Will advertise again in 00:03:21 (advertisement duration is 1800 sec.)
2013-03-18 10:11:03,847 DEBUG [WebServer] Incoming connection from /192.168.3.101:59073
2013-03-18 10:11:03,946 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:11:03,948 DEBUG [DeviceDescriptionRequestHandler] DeviceDescription request received for device 6489fbb2-c75d-3879-9842-9162558132c2 from 192.168.3.101 (headers = [Host: 192.168.3.200:8895,Date: Mon, 18 Mar 2013 09:11:03 GMT,User-Agent: UPnP/1.0,X-AV-Physical-Unit-Info: pa="Blu-ray Disc Player";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0";])
2013-03-18 10:11:03,948 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:11:03,949 DEBUG [RendererManager] Looking for a renderer profile for Http headers: [Host: 192.168.3.200:8895,Date: Mon, 18 Mar 2013 09:11:03 GMT,User-Agent: UPnP/1.0,X-AV-Physical-Unit-Info: pa="Blu-ray Disc Player";,X-AV-Client-Info: av=5.0; cn="Sony Corporation"; mn="Blu-ray Disc Player"; mv="2.0";]
2013-03-18 10:11:03,955 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:11:03,967 DEBUG [DeviceDescriptionRequestHandler] Sending DeviceDescription XML back using profile 'Sony BD Player / SMP'
2013-03-18 10:11:04,043 DEBUG [WebServer] Incoming connection from /192.168.3.101:59074
2013-03-18 10:11:04,140 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:11:04,142 DEBUG [ServiceDescriptionRequestHandler] ServiceDescription request received for service ConnectionManager
2013-03-18 10:11:04,143 DEBUG [ServiceDescriptionRequestHandler] Sending ServiceDescription XML back
2013-03-18 10:11:04,249 DEBUG [WebServer] Incoming connection from /192.168.3.101:59075
2013-03-18 10:11:04,345 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:11:04,346 DEBUG [ServiceDescriptionRequestHandler] ServiceDescription request received for service ContentDirectory
2013-03-18 10:11:04,347 DEBUG [ServiceDescriptionRequestHandler] Sending ServiceDescription XML back
2013-03-18 10:11:04,566 DEBUG [WebServer] Incoming connection from /192.168.3.101:59076
2013-03-18 10:11:04,665 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:11:04,667 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ContentDirectory:1#GetSortCapabilities"' from 192.168.3.101:
2013-03-18 10:11:04,667 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:11:04,749 DEBUG [ServiceControlRequestHandler] Returning OK SOAP message
2013-03-18 10:11:04,781 DEBUG [WebServer] Incoming connection from /192.168.3.101:59077
2013-03-18 10:11:04,871 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:11:04,872 DEBUG [ServiceControlRequestHandler] ServiceControl request received for action '"urn:schemas-upnp-org:service:ConnectionManager:1#GetProtocolInfo"' from 192.168.3.101:
2013-03-18 10:11:04,873 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.3.101
2013-03-18 10:11:04,887 DEBUG [ConnectionManager] Sending protocol info using profile 'Sony BD Player / SMP'
Would you have any further recommendation to make it more reliable.
<<

zip

User avatar

Serviio developer / Site Admin

Posts: 16507

Joined: Sat Oct 24, 2009 12:24 pm

Location: London, UK

Post Mon Mar 18, 2013 9:32 am

Re: malformed rtsp metadata in IP Cam

the h264 stream is probably not perfect, so just remuxing it will cause you trouble. If you transcode to mpeg2 (he original behaviour), you should get better results, but with higher CPU
<<

mpi

Serviio lover

Posts: 66

Joined: Fri Nov 18, 2011 9:15 pm

Post Mon Mar 18, 2013 3:27 pm

Re: malformed rtsp metadata in IP Cam

Thanks.
It seems h264 stream is quite stable actually: VLC reports very rare frame loss.
Also once renderer gets it running, then it runs fine for hours.
How could I check h264 stream reliability?

There might be some limitations on the BDP side too with H264 handling maybe.
The whole chain (Serviio+BDP) seems to introduce a 26sec delay on the stream (compared to VLC straight into the Cam), which seems quite long, no?

Are there any parameters on the remux process I could play with?

Thanks.
<<

zip

User avatar

Serviio developer / Site Admin

Posts: 16507

Joined: Sat Oct 24, 2009 12:24 pm

Location: London, UK

Post Mon Mar 18, 2013 3:30 pm

Re: malformed rtsp metadata in IP Cam

you could use a ffmpeg wrapper and try change/add some ffmpeg parameters - I have no idea :-)
<<

mpi

Serviio lover

Posts: 66

Joined: Fri Nov 18, 2011 9:15 pm

Post Tue Mar 26, 2013 9:16 pm

Re: malformed rtsp metadata in IP Cam

Display startup-up issue pretty much seems to be on Rederer side: running Serviio from my Mac leads to the same type of problems with remuxed h264 stream.
My bdp-s570 regularly fails, whereas XMBC has no issue (I included the suggested profile change in Generic Profile to prevent transcoding in that case).
I guess h264 support by those BDP devices may not be very good.
Buffering delay is rather impressive on BDP when it happens to work: much shorter buffering when using XBMC.

EDIT: just found & installed Serviio 1.2.1: it seems to solve initial stream connection issues.
Thanks!

Return to Plugin development

Who is online

Users browsing this forum: No registered users and 2 guests

Powered by phpBB © 2000, 2002, 2005, 2007 phpBB Group.
Designed by ST Software for PTF.