.flv file will not transcode to xbox 360
Posted: Mon Oct 08, 2012 2:52 amThis file fails to play on my Xbox360 when serviio attempts to deliver it using the SBS plugin.
The symptom on the Xbox is that the xbox displays the loading progress bar over and over again but the file never plays.
But in /tmp/Serviio there is
/tmp/Serviiotranscoding-temp-1000000000250018-3-ORIGINAL.stf
which plays fine on the linux box with media player.
I can also download a .flv file with ffmpeg -i "http://videocdn.sbs.com.au/u/video/SRS_EXC_Air_Plane_Hour_Ext_61_172062_1000K.flv?v=&fp=&r=&g=" ~/mb1.flv
And ffmpeg -i ~/mb1.flv reports
the serviio log reports
From this I can see [WebServer] I/O error: Broken pipe and the trancoding and delivery job repeating again and again. Which I guess is what causes the repeating progress bar on the Xbox.
Any ideas on what causes this?
--
ffmpeg version 0.11.1.git Copyright (c) 2000-2012 the FFmpeg developers built on Aug 22 2012 00:01:08 with gcc 4.6 (Ubuntu/Linaro 4.6.3-1ubuntu5)
The symptom on the Xbox is that the xbox displays the loading progress bar over and over again but the file never plays.
- Code:
ffmpeg -i "http://videocdn.sbs.com.au/u/video/SRS_EXC_Air_Plane_Hour_Ext_61_172062_1000K.flv?v=&fp=&r=&g="
Input #0, flv, from 'http://videocdn.sbs.com.au/u/video/SRS_EXC_Air_Plane_Hour_Ext_61_172062_1000K.flv?v=&fp=&r=&g=':
Metadata:
canseektoend : false
creationdate : Wed Dec 16 14:47:05 2009
:
lastkeyframetimestamp: 147120
lasttimestamp : 147156
metadatacreator : On2 Flix SDK for Dshow_2.4.2.0
On2 : Technologies
Duration: 00:02:27.18, start: 0.000000, bitrate: 709 kb/s
Stream #0:0: Video: vp6f, yuv420p, 720x405, 1041 kb/s, 25 tbr, 1k tbn, 1k tbc
Stream #0:1: Audio: mp3, 44100 Hz, stereo, s16, 128 kb/s
But in /tmp/Serviio there is
/tmp/Serviiotranscoding-temp-1000000000250018-3-ORIGINAL.stf
which plays fine on the linux box with media player.
I can also download a .flv file with ffmpeg -i "http://videocdn.sbs.com.au/u/video/SRS_EXC_Air_Plane_Hour_Ext_61_172062_1000K.flv?v=&fp=&r=&g=" ~/mb1.flv
And ffmpeg -i ~/mb1.flv reports
- Code:
Input #0, flv, from '/home/god/mb1.flv':
Metadata:
canseektoend : false
creationdate : Wed Dec 16 14:47:05 2009
:
lastkeyframetimestamp: 147120
lasttimestamp : 147156
metadatacreator : On2 Flix SDK for Dshow_2.4.2.0
On2 : Technologies
encoder : Lavf54.25.104
Duration: 00:02:28.30, start: 0.000000, bitrate: 540 kb/s
Stream #0:0: Video: flv1, yuv420p, 720x405, 200 kb/s, 25 tbr, 1k tbn, 1k tbc
Stream #0:1: Audio: mp3, 44100 Hz, stereo, s16, 128 kb/s
the serviio log reports
- Code:
2012-10-08 13:12:27,865 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.5.15
2012-10-08 13:12:27,866 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'IPAddress=/192.168.5.15, Profile=Xbox 360'
2012-10-08 13:12:27,866 DEBUG [ResourceDeliveryProcessor] Request for resource 1000000000250018 and type 'MEDIA_ITEM' received
2012-10-08 13:12:27,866 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000000250018 (online)
2012-10-08 13:12:27,867 DEBUG [VideoDeliveryEngine] Delivering item '1000000000250018' for client 'IPAddress=/192.168.5.15, Profile=Xbox 360'
2012-10-08 13:12:27,867 DEBUG [VideoDeliveryEngine] Delivering file 'http://videocdn.sbs.com.au/u/video/SRS_EXC_Air_Plane_Hour_Ext_61_172062_1000K.flv?v=&fp=&r=&g=' using transcoding
2012-10-08 13:12:27,867 DEBUG [AbstractTranscodingDeliveryEngine] Stopping previous transcoding job of file 'transcoding-temp-1000000000210017-3-ORIGINAL.stf'
2012-10-08 13:12:27,867 DEBUG [ProcessExecutor] Stopping external process: Thread[Thread-696,5,main]
2012-10-08 13:12:27,867 DEBUG [ProcessUtils] Sending kill -9 to the Unix process: 17603
2012-10-08 13:12:27,867 DEBUG [ProcessExecutor] Starting kill -9 17603
2012-10-08 13:12:27,901 WARN [ProcessExecutor] Process ffmpeg has a return code of 137! This is a possible error.
2012-10-08 13:12:27,901 DEBUG [TranscodingJobListener] Transcoding finished; successful: false
2012-10-08 13:12:27,901 DEBUG [TranscodingJobListener] Transcoding finished; successful: true
2012-10-08 13:12:27,902 DEBUG [TranscodingJobListener] Deleted temp file '/tmp/Serviio/transcoding-temp-1000000000210017-3-ORIGINAL.stf': true
2012-10-08 13:12:27,902 DEBUG [AbstractTranscodingDeliveryEngine] No suitable transcoding job exists yet, start one for client 'IPAddress=/192.168.5.15, Profile=Xbox 360'
2012-10-08 13:12:27,902 DEBUG [FFMPEGWrapper] Invoking FFmpeg to transcode video file: http://videocdn.sbs.com.au/u/video/SRS_EXC_Air_Plane_Hour_Ext_61_172062_1000K.flv?v=&fp=&r=&g=
2012-10-08 13:12:27,902 DEBUG [ProcessExecutor] Starting ffmpeg -i http://videocdn.sbs.com.au/u/video/SRS_EXC_Air_Plane_Hour_Ext_61_172062_1000K.flv?v=&fp=&r=&g= -y -copyts -c:v wmv2 -b:v 15360k -maxrate:v 15360k -bufsize:v 15360k -r 25 -g 15 -c:a wmav2 -b:a 128k -ac 2 -map 0:0 -map 0:1 -sn -f asf /tmp/Serviio/transcoding-temp-1000000000250018-3-ORIGINAL.stf
2012-10-08 13:12:28,586 DEBUG [WebServer] I/O error: Stream Closed
2012-10-08 13:12:29,903 DEBUG [FileBasedTranscodingDeliveryStrategy] Sending transcoding stream
2012-10-08 13:12:29,903 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file http://videocdn.sbs.com.au/u/video/SRS_EXC_Air_Plane_Hour_Ext_61_172062_1000K.flv?v=&fp=&r=&g=: WMVMED_FULL
2012-10-08 13:12:29,903 DEBUG [ResourceDeliveryProcessor] Stream entity has length: 50000000000
2012-10-08 13:12:29,903 DEBUG [ResourceDeliveryProcessor] Sending file back
2012-10-08 13:12:29,903 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer
2012-10-08 13:12:29,903 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: video/x-ms-wmv,Date: Mon, 08 Oct 2012 02:12:29 GMT,Server: Linux, UPnP/1.0 DLNADOC/1.50, Serviio/1.0.1,Cache-control: no-cache,transferMode.dlna.org: Streaming]]
2012-10-08 13:12:30,115 DEBUG [DiscoveryAdvertisementNotifier] Multicasting SSDP alive using interface eth0 (eth0) and address 192.168.5.12, timeout = 0
2012-10-08 13:12:30,115 DEBUG [DiscoveryAdvertisementNotifier] Sending 6 'alive' messages describing device 7ecf17f9-8f41-3110-84ac-ac5adaebfc4a
2012-10-08 13:12:30,736 DEBUG [WebServer] I/O error: Broken pipe
2012-10-08 13:12:31,313 DEBUG [WebServer] Incoming connection from /192.168.5.15:6480
2012-10-08 13:12:31,314 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.5.15
2012-10-08 13:12:31,314 DEBUG [ResourceTransportRequestHandler] GET /resource/1000000000250018/MEDIA_ITEM/WMVMED_FULL-0/ORIGINAL HTTP/1.1, headers = [User-Agent: Xenon,Connection: Keep-alive,Host: 192.168.5.12:8895]]
2012-10-08 13:12:31,314 DEBUG [RendererDAOImpl] Reading a Renderer with ip address 192.168.5.15
2012-10-08 13:12:31,315 DEBUG [ResourceDeliveryProcessor] Resource request accepted. Using client 'IPAddress=/192.168.5.15, Profile=Xbox 360'
2012-10-08 13:12:31,315 DEBUG [ResourceDeliveryProcessor] Request for resource 1000000000250018 and type 'MEDIA_ITEM' received
2012-10-08 13:12:31,315 DEBUG [MediaResourceRetrievalStrategy] Getting information about media item 1000000000250018 (online)
2012-10-08 13:12:31,315 DEBUG [VideoDeliveryEngine] Delivering item '1000000000250018' for client 'IPAddress=/192.168.5.15, Profile=Xbox 360'
2012-10-08 13:12:31,315 DEBUG [VideoDeliveryEngine] Delivering file 'http://videocdn.sbs.com.au/u/video/SRS_EXC_Air_Plane_Hour_Ext_61_172062_1000K.flv?v=&fp=&r=&g=' using transcoding
2012-10-08 13:12:31,315 DEBUG [AbstractTranscodingDeliveryEngine] Stopping previous transcoding job of file 'transcoding-temp-1000000000250018-3-ORIGINAL.stf'
2012-10-08 13:12:31,315 DEBUG [ProcessExecutor] Stopping external process: Thread[Thread-707,5,main]
2012-10-08 13:12:31,315 DEBUG [ProcessUtils] Sending kill -9 to the Unix process: 17665
2012-10-08 13:12:31,315 DEBUG [ProcessExecutor] Starting kill -9 17665
2012-10-08 13:12:31,339 WARN [ProcessExecutor] Process ffmpeg has a return code of 137! This is a possible error.
2012-10-08 13:12:31,339 DEBUG [TranscodingJobListener] Transcoding finished; successful: true
2012-10-08 13:12:31,339 DEBUG [TranscodingJobListener] Transcoding finished; successful: false
2012-10-08 13:12:31,339 DEBUG [TranscodingJobListener] Deleted temp file '/tmp/Serviio/transcoding-temp-1000000000250018-3-ORIGINAL.stf': true
2012-10-08 13:12:31,339 DEBUG [AbstractTranscodingDeliveryEngine] No suitable transcoding job exists yet, start one for client 'IPAddress=/192.168.5.15, Profile=Xbox 360'
2012-10-08 13:12:31,340 DEBUG [FFMPEGWrapper] Invoking FFmpeg to transcode video file: http://videocdn.sbs.com.au/u/video/SRS_EXC_Air_Plane_Hour_Ext_61_172062_1000K.flv?v=&fp=&r=&g=
2012-10-08 13:12:31,340 DEBUG [ProcessExecutor] Starting ffmpeg -i http://videocdn.sbs.com.au/u/video/SRS_EXC_Air_Plane_Hour_Ext_61_172062_1000K.flv?v=&fp=&r=&g= -y -copyts -c:v wmv2 -b:v 15360k -maxrate:v 15360k -bufsize:v 15360k -r 25 -g 15 -c:a wmav2 -b:a 128k -ac 2 -map 0:0 -map 0:1 -sn -f asf /tmp/Serviio/transcoding-temp-1000000000250018-3-ORIGINAL.stf
2012-10-08 13:12:31,925 DEBUG [DiscoveryAdvertisementNotifier] Will advertise again in 00:00:37
2012-10-08 13:12:32,840 DEBUG [FileBasedTranscodingDeliveryStrategy] Sending transcoding stream
2012-10-08 13:12:32,840 DEBUG [VideoDeliveryEngine] Found Format profile for transcoded file http://videocdn.sbs.com.au/u/video/SRS_EXC_Air_Plane_Hour_Ext_61_172062_1000K.flv?v=&fp=&r=&g=: WMVMED_FULL
2012-10-08 13:12:32,841 DEBUG [ResourceDeliveryProcessor] Stream entity has length: 50000000000
2012-10-08 13:12:32,841 DEBUG [ResourceDeliveryProcessor] Sending file back
2012-10-08 13:12:32,841 DEBUG [ResourceTransportRequestHandler] Creating entity with chunked transfer
2012-10-08 13:12:32,841 DEBUG [ResourceTransportRequestHandler] HTTP/1.1 200 OK, headers = [[Content-Type: video/x-ms-wmv,Date: Mon, 08 Oct 2012 02:12:32 GMT,Server: Linux, UPnP/1.0 DLNADOC/1.50, Serviio/1.0.1,Cache-control: no-cache,transferMode.dlna.org: Streaming]]
2012-10-08 13:12:54,783 DEBUG [FeedUpdaterThread] Checking for new and expired online resources
2012-10-08 13:13:08,987 DEBUG [DiscoveryAdvertisementNotifier] Multicasting SSDP alive using interface eth0 (eth0) and address 192.168.5.12, timeout = 0
2012-10-08 13:13:08,988 DEBUG [DiscoveryAdvertisementNotifier] Sending 6 'alive' messages describing device 7ecf17f9-8f41-3110-84ac-ac5adaebfc4a
2012-10-08 13:13:10,791 DEBUG [DiscoveryAdvertisementNotifier] Will advertise again in 00:00:37
2012-10-08 13:13:45,000 DEBUG [WebServer] I/O error: Broken pipe
<etc>
From this I can see [WebServer] I/O error: Broken pipe and the trancoding and delivery job repeating again and again. Which I guess is what causes the repeating progress bar on the Xbox.
Any ideas on what causes this?
--
ffmpeg version 0.11.1.git Copyright (c) 2000-2012 the FFmpeg developers built on Aug 22 2012 00:01:08 with gcc 4.6 (Ubuntu/Linaro 4.6.3-1ubuntu5)